builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1450207213.23 results: success (0) buildid: 20151215103151 builduid: 4278ecf146464238a03879b51284eee7 revision: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.234779) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.235218) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.235513) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006213 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.257890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.258249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.271896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.272197) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.321069) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.321377) ========= 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:20:13.321729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.321995) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 11:20:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2015-12-15 11:20:13 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.523547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.523851) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:13.574119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 11:20:13.574474) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 11:20:13,774 truncating revision to first 12 chars 2015-12-15 11:20:13,774 Setting DEBUG logging. 2015-12-15 11:20:13,774 attempt 1/10 2015-12-15 11:20:13,774 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:20:14,785 unpacking tar archive at: fx-team-0ac99e7e0440/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 11:20:14.894312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:14.894631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:14.903331) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 11:20:14.903630) ========= 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:20:14.904025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-15 11:20:14.904360) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:15 INFO - MultiFileLogger online at 20151215 11:20:15 in /builds/slave/test 11:20:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:20:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:15 INFO - {'append_to_log': False, 11:20:15 INFO - 'base_work_dir': '/builds/slave/test', 11:20:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:20:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:15 INFO - 'branch': 'Fx-Team-Non-PGO', 11:20:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:15 INFO - 'config_files': ('talos/linux_config.py',), 11:20:15 INFO - 'default_actions': ('clobber', 11:20:15 INFO - 'read-buildbot-config', 11:20:15 INFO - 'download-and-extract', 11:20:15 INFO - 'populate-webroot', 11:20:15 INFO - 'create-virtualenv', 11:20:15 INFO - 'install', 11:20:15 INFO - 'run-tests'), 11:20:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:15 INFO - 'download_minidump_stackwalk': True, 11:20:15 INFO - 'download_symbols': 'ondemand', 11:20:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:15 INFO - 'installer_path': 'installer.exe', 11:20:15 INFO - 'log_level': 'info', 11:20:15 INFO - 'log_name': 'talos', 11:20:15 INFO - 'log_to_console': True, 11:20:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:15 INFO - 'opt_config_files': (), 11:20:15 INFO - 'pip_index': False, 11:20:15 INFO - 'sps_profile': False, 11:20:15 INFO - 'sps_profile_interval': 0, 11:20:15 INFO - 'suite': 'dromaeojs-e10s', 11:20:15 INFO - 'system_bits': '64', 11:20:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:15 INFO - 'title': 'talos-linux64-ix-047', 11:20:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:15 INFO - 'use_talos_json': True, 11:20:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:15 INFO - 'work_dir': 'build'} 11:20:15 INFO - ##### 11:20:15 INFO - ##### Running clobber step. 11:20:15 INFO - ##### 11:20:15 INFO - Running pre-action listener: _resource_record_pre_action 11:20:15 INFO - Running main action method: clobber 11:20:15 INFO - rmtree: /builds/slave/test/build 11:20:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:15 INFO - Running post-action listener: _resource_record_post_action 11:20:15 INFO - ##### 11:20:15 INFO - ##### Running read-buildbot-config step. 11:20:15 INFO - ##### 11:20:15 INFO - Running pre-action listener: _resource_record_pre_action 11:20:15 INFO - Running main action method: read_buildbot_config 11:20:15 INFO - Using buildbot properties: 11:20:15 INFO - { 11:20:15 INFO - "properties": { 11:20:15 INFO - "buildnumber": 575, 11:20:15 INFO - "product": "firefox", 11:20:15 INFO - "script_repo_revision": "production", 11:20:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:20:15 INFO - "repository": "", 11:20:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:20:15 INFO - "buildid": "20151215103151", 11:20:15 INFO - "slavename": "talos-linux64-ix-047", 11:20:15 INFO - "pgo_build": "False", 11:20:15 INFO - "basedir": "/builds/slave/test", 11:20:15 INFO - "project": "", 11:20:15 INFO - "platform": "ubuntu64_hw", 11:20:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:15 INFO - "slavebuilddir": "test", 11:20:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:20:15 INFO - "branch": "fx-team", 11:20:15 INFO - "repo_path": "integration/fx-team", 11:20:15 INFO - "stage_platform": "linux64", 11:20:15 INFO - "builduid": "4278ecf146464238a03879b51284eee7", 11:20:15 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:20:15 INFO - }, 11:20:15 INFO - "sourcestamp": { 11:20:15 INFO - "repository": "", 11:20:15 INFO - "hasPatch": false, 11:20:15 INFO - "project": "", 11:20:15 INFO - "branch": "fx-team-linux64-talos", 11:20:15 INFO - "changes": [ 11:20:15 INFO - { 11:20:15 INFO - "category": null, 11:20:15 INFO - "files": [ 11:20:15 INFO - { 11:20:15 INFO - "url": null, 11:20:15 INFO - "name": "https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 11:20:15 INFO - } 11:20:15 INFO - ], 11:20:15 INFO - "repository": "", 11:20:15 INFO - "rev": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1", 11:20:15 INFO - "who": "s.kaspari@gmail.com", 11:20:15 INFO - "when": 1450206647, 11:20:15 INFO - "number": 7362908, 11:20:15 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:20:15 INFO - "project": "", 11:20:15 INFO - "at": "Tue 15 Dec 2015 11:10:47", 11:20:15 INFO - "branch": "fx-team-linux64-talos", 11:20:15 INFO - "revlink": "", 11:20:15 INFO - "properties": [ 11:20:15 INFO - [ 11:20:15 INFO - "buildid", 11:20:15 INFO - "20151215103151", 11:20:15 INFO - "Change" 11:20:15 INFO - ], 11:20:15 INFO - [ 11:20:15 INFO - "builduid", 11:20:15 INFO - "4278ecf146464238a03879b51284eee7", 11:20:15 INFO - "Change" 11:20:15 INFO - ], 11:20:15 INFO - [ 11:20:15 INFO - "pgo_build", 11:20:15 INFO - "False", 11:20:15 INFO - "Change" 11:20:15 INFO - ] 11:20:15 INFO - ], 11:20:15 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:20:15 INFO - } 11:20:15 INFO - ], 11:20:15 INFO - "revision": "0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1" 11:20:15 INFO - } 11:20:15 INFO - } 11:20:15 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:20:15 INFO - Running post-action listener: _resource_record_post_action 11:20:15 INFO - ##### 11:20:15 INFO - ##### Running download-and-extract step. 11:20:15 INFO - ##### 11:20:15 INFO - Running pre-action listener: _resource_record_pre_action 11:20:15 INFO - Running main action method: download_and_extract 11:20:15 INFO - mkdir: /builds/slave/test/build/tests 11:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:15 INFO - https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json 11:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/test_packages.json 11:20:15 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:20:15 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:20:16 INFO - Downloaded 1302 bytes. 11:20:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:20:16 INFO - Using the following test package requirements: 11:20:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'jsshell-linux-x86_64.zip'], 11:20:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:16 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:20:16 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:20:16 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:20:16 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:20:16 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:20:16 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:20:17 INFO - Downloaded 21863279 bytes. 11:20:17 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:20:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:20:17 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:20:18 INFO - Return code: 0 11:20:18 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:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:18 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:20:18 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:20:18 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:20:18 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:20:18 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:20:19 INFO - Downloaded 21863279 bytes. 11:20:19 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:20:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:20:19 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:20:20 INFO - Return code: 0 11:20: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:20:20 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:20:20 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:20:20 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:20:20 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:20:20 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:20:21 INFO - Downloaded 11132052 bytes. 11:20:21 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:20:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:21 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:20:22 INFO - Return code: 0 11:20: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:20:22 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:20:22 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:20:22 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:20:22 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:20:22 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:20:23 INFO - Downloaded 57738640 bytes. 11:20:23 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:20:23 INFO - mkdir: /builds/slave/test/properties 11:20:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:23 INFO - Contents: 11:20:23 INFO - build_url:https://queue.taskcluster.net/v1/task/luvbk6DYTuiSvPZOVW9U6Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:20:23 INFO - Running post-action listener: _resource_record_post_action 11:20:23 INFO - Running post-action listener: set_extra_try_arguments 11:20:23 INFO - ##### 11:20:23 INFO - ##### Running populate-webroot step. 11:20:23 INFO - ##### 11:20:23 INFO - Running pre-action listener: _resource_record_pre_action 11:20:23 INFO - Running main action method: populate_webroot 11:20:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:23 INFO - '--tppagecycles', 11:20:23 INFO - '7'], 11:20:23 INFO - 'tests': ['tsvgm']}}, 11:20:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:20:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'tests': ['damp', 'tps']}, 11:20:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['damp', 'tps']}, 11:20:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:20:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:23 INFO - 'other': {'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'other_l64': {'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'other_nol64': {'tests': ['a11yr', 11:20:23 INFO - 'ts_paint', 11:20:23 INFO - 'tpaint', 11:20:23 INFO - 'sessionrestore', 11:20:23 INFO - 'sessionrestore_no_auto_restore']}, 11:20:23 INFO - 'svgr': {'tests': ['tsvgx', 11:20:23 INFO - 'tsvgr_opacity', 11:20:23 INFO - 'tart', 11:20:23 INFO - 'tscrollx', 11:20:23 INFO - 'cart']}, 11:20:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['tsvgx', 11:20:23 INFO - 'tsvgr_opacity', 11:20:23 INFO - 'tart', 11:20:23 INFO - 'tscrollx', 11:20:23 INFO - 'cart']}, 11:20:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'tests': ['tp5o']}, 11:20:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'talos_options': ['--e10s'], 11:20:23 INFO - 'tests': ['tp5o']}, 11:20:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'talos_options': ['--xperf_path', 11:20:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:23 INFO - 'tests': ['tp5n']}, 11:20:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:23 INFO - 'talos_options': ['--e10s', 11:20:23 INFO - '--xperf_path', 11:20:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:23 INFO - 'tests': ['tp5n']}}, 11:20:23 INFO - 'talos.zip': {'path': '', 11:20:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:23 INFO - Running post-action listener: _resource_record_post_action 11:20:23 INFO - ##### 11:20:23 INFO - ##### Running create-virtualenv step. 11:20:23 INFO - ##### 11:20:23 INFO - Running pre-action listener: _resource_record_pre_action 11:20:23 INFO - Running main action method: create_virtualenv 11:20:23 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:23 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:20:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:23 INFO - Using real prefix '/usr' 11:20:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:26 INFO - Installing pip.................done. 11:20:26 INFO - Return code: 0 11:20:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:26 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:26 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:20:26 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:20:26 INFO - Using env: {'DISPLAY': ':0', 11:20:26 INFO - 'HOME': '/home/cltbld', 11:20:26 INFO - 'LANG': 'en_US.UTF-8', 11:20:26 INFO - 'LANGUAGE': 'en_US:en', 11:20:26 INFO - 'LOGNAME': 'cltbld', 11:20:26 INFO - 'MAIL': '/var/mail/cltbld', 11:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:26 INFO - 'MOZ_NO_REMOTE': '1', 11:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:26 INFO - 'NO_EM_RESTART': '1', 11:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:26 INFO - 'PWD': '/builds/slave/test', 11:20:26 INFO - 'SHELL': '/bin/bash', 11:20:26 INFO - 'SHLVL': '1', 11:20:26 INFO - 'TERM': 'linux', 11:20:26 INFO - 'TMOUT': '86400', 11:20:26 INFO - 'USER': 'cltbld', 11:20:26 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:26 INFO - '_': '/tools/buildbot/bin/python'} 11:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:26 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:20:26 INFO - Cleaning up... 11:20:26 INFO - Return code: 0 11:20:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:26 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:26 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:20:26 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:20:26 INFO - Using env: {'DISPLAY': ':0', 11:20:26 INFO - 'HOME': '/home/cltbld', 11:20:26 INFO - 'LANG': 'en_US.UTF-8', 11:20:26 INFO - 'LANGUAGE': 'en_US:en', 11:20:26 INFO - 'LOGNAME': 'cltbld', 11:20:26 INFO - 'MAIL': '/var/mail/cltbld', 11:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:26 INFO - 'MOZ_NO_REMOTE': '1', 11:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:26 INFO - 'NO_EM_RESTART': '1', 11:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:26 INFO - 'PWD': '/builds/slave/test', 11:20:26 INFO - 'SHELL': '/bin/bash', 11:20:26 INFO - 'SHLVL': '1', 11:20:26 INFO - 'TERM': 'linux', 11:20:26 INFO - 'TMOUT': '86400', 11:20:26 INFO - 'USER': 'cltbld', 11:20:26 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:26 INFO - '_': '/tools/buildbot/bin/python'} 11:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:26 INFO - Downloading/unpacking psutil>=0.7.1 11:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:20:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:28 INFO - Installing collected packages: psutil 11:20:28 INFO - Running setup.py install for psutil 11:20:28 INFO - building 'psutil._psutil_linux' extension 11:20:28 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:20:28 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:20:28 INFO - building 'psutil._psutil_posix' extension 11:20:28 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:20:29 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:20:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:29 INFO - Successfully installed psutil 11:20:29 INFO - Cleaning up... 11:20:29 INFO - Return code: 0 11:20:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:29 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:29 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:20:29 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:20:29 INFO - Using env: {'DISPLAY': ':0', 11:20:29 INFO - 'HOME': '/home/cltbld', 11:20:29 INFO - 'LANG': 'en_US.UTF-8', 11:20:29 INFO - 'LANGUAGE': 'en_US:en', 11:20:29 INFO - 'LOGNAME': 'cltbld', 11:20:29 INFO - 'MAIL': '/var/mail/cltbld', 11:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:29 INFO - 'MOZ_NO_REMOTE': '1', 11:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:29 INFO - 'NO_EM_RESTART': '1', 11:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:29 INFO - 'PWD': '/builds/slave/test', 11:20:29 INFO - 'SHELL': '/bin/bash', 11:20:29 INFO - 'SHLVL': '1', 11:20:29 INFO - 'TERM': 'linux', 11:20:29 INFO - 'TMOUT': '86400', 11:20:29 INFO - 'USER': 'cltbld', 11:20:29 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:29 INFO - '_': '/tools/buildbot/bin/python'} 11:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:29 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:20:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:20:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:31 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:20:31 INFO - Installing collected packages: mozsystemmonitor 11:20:31 INFO - Running setup.py install for mozsystemmonitor 11:20:31 INFO - Successfully installed mozsystemmonitor 11:20:31 INFO - Cleaning up... 11:20:31 INFO - Return code: 0 11:20:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:31 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:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:31 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:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:31 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:31 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:20:31 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:20:31 INFO - Using env: {'DISPLAY': ':0', 11:20:31 INFO - 'HOME': '/home/cltbld', 11:20:31 INFO - 'LANG': 'en_US.UTF-8', 11:20:31 INFO - 'LANGUAGE': 'en_US:en', 11:20:31 INFO - 'LOGNAME': 'cltbld', 11:20:31 INFO - 'MAIL': '/var/mail/cltbld', 11:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:31 INFO - 'MOZ_NO_REMOTE': '1', 11:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:31 INFO - 'NO_EM_RESTART': '1', 11:20:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:31 INFO - 'PWD': '/builds/slave/test', 11:20:31 INFO - 'SHELL': '/bin/bash', 11:20:31 INFO - 'SHLVL': '1', 11:20:31 INFO - 'TERM': 'linux', 11:20:31 INFO - 'TMOUT': '86400', 11:20:31 INFO - 'USER': 'cltbld', 11:20:31 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:31 INFO - '_': '/tools/buildbot/bin/python'} 11:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:31 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:20:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:33 INFO - Downloading docopt-0.6.1.tar.gz 11:20:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:33 INFO - Running setup.py install for blobuploader 11:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:34 INFO - Running setup.py install for requests 11:20:34 INFO - Running setup.py install for docopt 11:20:34 INFO - Successfully installed blobuploader requests docopt 11:20:34 INFO - Cleaning up... 11:20:34 INFO - Return code: 0 11:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20: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:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20: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:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:34 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:34 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:20:34 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:20:34 INFO - Using env: {'DISPLAY': ':0', 11:20:34 INFO - 'HOME': '/home/cltbld', 11:20:34 INFO - 'LANG': 'en_US.UTF-8', 11:20:34 INFO - 'LANGUAGE': 'en_US:en', 11:20:34 INFO - 'LOGNAME': 'cltbld', 11:20:34 INFO - 'MAIL': '/var/mail/cltbld', 11:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:34 INFO - 'MOZ_NO_REMOTE': '1', 11:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:34 INFO - 'NO_EM_RESTART': '1', 11:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:34 INFO - 'PWD': '/builds/slave/test', 11:20:34 INFO - 'SHELL': '/bin/bash', 11:20:34 INFO - 'SHLVL': '1', 11:20:34 INFO - 'TERM': 'linux', 11:20:34 INFO - 'TMOUT': '86400', 11:20:34 INFO - 'USER': 'cltbld', 11:20:34 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:34 INFO - '_': '/tools/buildbot/bin/python'} 11:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:34 INFO - Running setup.py (path:/tmp/pip-7gUu9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:34 INFO - Running setup.py (path:/tmp/pip-uFphaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:34 INFO - Running setup.py (path:/tmp/pip-qrOklF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:34 INFO - Running setup.py (path:/tmp/pip-RSvo11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:35 INFO - Running setup.py (path:/tmp/pip-eAiYeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:35 INFO - Running setup.py (path:/tmp/pip-tcJF87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:35 INFO - Running setup.py (path:/tmp/pip-ukBCa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:35 INFO - Running setup.py (path:/tmp/pip-p8ZcB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:35 INFO - Running setup.py (path:/tmp/pip-kLznrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:35 INFO - Running setup.py (path:/tmp/pip-pJZJlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:35 INFO - Running setup.py (path:/tmp/pip-MuxYBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:35 INFO - Running setup.py (path:/tmp/pip-7emYQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:35 INFO - Running setup.py (path:/tmp/pip-ReW9q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:35 INFO - Running setup.py (path:/tmp/pip-Tbyu96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:35 INFO - Running setup.py (path:/tmp/pip-T09vQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:35 INFO - Running setup.py (path:/tmp/pip-_aI6pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:35 INFO - Running setup.py (path:/tmp/pip-Xw3_fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:35 INFO - Running setup.py install for manifestparser 11:20:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for mozcrash 11:20:36 INFO - Running setup.py install for mozdebug 11:20:36 INFO - Running setup.py install for mozdevice 11:20:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for mozfile 11:20:36 INFO - Running setup.py install for mozhttpd 11:20:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for mozinfo 11:20:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for mozInstall 11:20:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for mozleak 11:20:36 INFO - Running setup.py install for mozlog 11:20:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:36 INFO - Running setup.py install for moznetwork 11:20:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Running setup.py install for mozprocess 11:20:37 INFO - Running setup.py install for mozprofile 11:20:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Running setup.py install for mozrunner 11:20:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Running setup.py install for mozscreenshot 11:20:37 INFO - Running setup.py install for moztest 11:20:37 INFO - Running setup.py install for mozversion 11:20:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:37 INFO - Cleaning up... 11:20:37 INFO - Return code: 0 11:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:37 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:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:37 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:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:37 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:37 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:20:37 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:20:37 INFO - Using env: {'DISPLAY': ':0', 11:20:37 INFO - 'HOME': '/home/cltbld', 11:20:37 INFO - 'LANG': 'en_US.UTF-8', 11:20:37 INFO - 'LANGUAGE': 'en_US:en', 11:20:37 INFO - 'LOGNAME': 'cltbld', 11:20:37 INFO - 'MAIL': '/var/mail/cltbld', 11:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:37 INFO - 'MOZ_NO_REMOTE': '1', 11:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:37 INFO - 'NO_EM_RESTART': '1', 11:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:37 INFO - 'PWD': '/builds/slave/test', 11:20:37 INFO - 'SHELL': '/bin/bash', 11:20:37 INFO - 'SHLVL': '1', 11:20:37 INFO - 'TERM': 'linux', 11:20:37 INFO - 'TMOUT': '86400', 11:20:37 INFO - 'USER': 'cltbld', 11:20:37 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:37 INFO - '_': '/tools/buildbot/bin/python'} 11:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:37 INFO - Running setup.py (path:/tmp/pip-gHpene-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:38 INFO - Running setup.py (path:/tmp/pip-Cu1zPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:38 INFO - Running setup.py (path:/tmp/pip-2KOvb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:38 INFO - Running setup.py (path:/tmp/pip-FKQHCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:38 INFO - Running setup.py (path:/tmp/pip-yEh1Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:38 INFO - Running setup.py (path:/tmp/pip-DYtJey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:38 INFO - Running setup.py (path:/tmp/pip-sjdUmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:38 INFO - Running setup.py (path:/tmp/pip-Snhh1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:38 INFO - Running setup.py (path:/tmp/pip-AKP7HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:38 INFO - Running setup.py (path:/tmp/pip-1YbU16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:38 INFO - Running setup.py (path:/tmp/pip-lTvssd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:38 INFO - Running setup.py (path:/tmp/pip-EH8qjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:38 INFO - Running setup.py (path:/tmp/pip-oVsHhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:38 INFO - Running setup.py (path:/tmp/pip-zDNK3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:38 INFO - Running setup.py (path:/tmp/pip-WkojN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:38 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:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:39 INFO - Running setup.py (path:/tmp/pip-LYlVJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:39 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:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:39 INFO - Running setup.py (path:/tmp/pip-rSZmDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:39 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:20:39 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:20:39 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:20:39 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:20:39 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:20:39 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:20:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:40 INFO - Downloading blessings-1.5.1.tar.gz 11:20:40 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:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:40 INFO - Installing collected packages: blessings 11:20:40 INFO - Running setup.py install for blessings 11:20:40 INFO - Successfully installed blessings 11:20:40 INFO - Cleaning up... 11:20:41 INFO - Return code: 0 11:20:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:41 INFO - Reading from file tmpfile_stdout 11:20:41 INFO - Current package versions: 11:20:41 INFO - argparse == 1.2.1 11:20:41 INFO - blessings == 1.5.1 11:20:41 INFO - blobuploader == 1.2.4 11:20:41 INFO - docopt == 0.6.1 11:20:41 INFO - manifestparser == 1.1 11:20:41 INFO - mozInstall == 1.12 11:20:41 INFO - mozcrash == 0.16 11:20:41 INFO - mozdebug == 0.1 11:20:41 INFO - mozdevice == 0.47 11:20:41 INFO - mozfile == 1.2 11:20:41 INFO - mozhttpd == 0.7 11:20:41 INFO - mozinfo == 0.9 11:20:41 INFO - mozleak == 0.1 11:20:41 INFO - mozlog == 3.1 11:20:41 INFO - moznetwork == 0.27 11:20:41 INFO - mozprocess == 0.22 11:20:41 INFO - mozprofile == 0.27 11:20:41 INFO - mozrunner == 6.11 11:20:41 INFO - mozscreenshot == 0.1 11:20:41 INFO - mozsystemmonitor == 0.0 11:20:41 INFO - moztest == 0.7 11:20:41 INFO - mozversion == 1.4 11:20:41 INFO - psutil == 3.1.1 11:20:41 INFO - requests == 1.2.3 11:20:41 INFO - wsgiref == 0.1.2 11:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:41 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:20:41 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:20:41 INFO - Using env: {'DISPLAY': ':0', 11:20:41 INFO - 'HOME': '/home/cltbld', 11:20:41 INFO - 'LANG': 'en_US.UTF-8', 11:20:41 INFO - 'LANGUAGE': 'en_US:en', 11:20:41 INFO - 'LOGNAME': 'cltbld', 11:20:41 INFO - 'MAIL': '/var/mail/cltbld', 11:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:41 INFO - 'MOZ_NO_REMOTE': '1', 11:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:41 INFO - 'NO_EM_RESTART': '1', 11:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:41 INFO - 'PWD': '/builds/slave/test', 11:20:41 INFO - 'SHELL': '/bin/bash', 11:20:41 INFO - 'SHLVL': '1', 11:20:41 INFO - 'TERM': 'linux', 11:20:41 INFO - 'TMOUT': '86400', 11:20:41 INFO - 'USER': 'cltbld', 11:20:41 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:41 INFO - '_': '/tools/buildbot/bin/python'} 11:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 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:20:41 INFO - Cleaning up... 11:20:41 INFO - Return code: 0 11:20:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:20:41 INFO - Using env: {'DISPLAY': ':0', 11:20:41 INFO - 'HOME': '/home/cltbld', 11:20:41 INFO - 'LANG': 'en_US.UTF-8', 11:20:41 INFO - 'LANGUAGE': 'en_US:en', 11:20:41 INFO - 'LOGNAME': 'cltbld', 11:20:41 INFO - 'MAIL': '/var/mail/cltbld', 11:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:41 INFO - 'MOZ_NO_REMOTE': '1', 11:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:41 INFO - 'NO_EM_RESTART': '1', 11:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:41 INFO - 'PWD': '/builds/slave/test', 11:20:41 INFO - 'SHELL': '/bin/bash', 11:20:41 INFO - 'SHLVL': '1', 11:20:41 INFO - 'TERM': 'linux', 11:20:41 INFO - 'TMOUT': '86400', 11:20:41 INFO - 'USER': 'cltbld', 11:20:41 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:41 INFO - '_': '/tools/buildbot/bin/python'} 11:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:41 INFO - Downloading/unpacking jsonschema 11:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:43 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:20:43 INFO - Downloading/unpacking functools32 (from jsonschema) 11:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 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:20:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:43 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:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:43 INFO - warning: no files found matching '*.txt' 11:20:43 INFO - no previously-included directories found matching 'build' 11:20:43 INFO - no previously-included directories found matching 'dist' 11:20:43 INFO - no previously-included directories found matching '.git*' 11:20:43 INFO - Installing collected packages: jsonschema, functools32 11:20:43 INFO - Running setup.py install for functools32 11:20:43 INFO - warning: no files found matching '*.txt' 11:20:43 INFO - no previously-included directories found matching 'build' 11:20:43 INFO - no previously-included directories found matching 'dist' 11:20:43 INFO - no previously-included directories found matching '.git*' 11:20:43 INFO - Successfully installed jsonschema functools32 11:20:43 INFO - Cleaning up... 11:20:43 INFO - Return code: 0 11:20:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:20:43 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:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 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:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:43 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 0x7f99d5766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, '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': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', '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:20:43 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:20:43 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:20:43 INFO - Using env: {'DISPLAY': ':0', 11:20:43 INFO - 'HOME': '/home/cltbld', 11:20:43 INFO - 'LANG': 'en_US.UTF-8', 11:20:43 INFO - 'LANGUAGE': 'en_US:en', 11:20:43 INFO - 'LOGNAME': 'cltbld', 11:20:43 INFO - 'MAIL': '/var/mail/cltbld', 11:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:43 INFO - 'MOZ_NO_REMOTE': '1', 11:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:43 INFO - 'NO_EM_RESTART': '1', 11:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:43 INFO - 'PWD': '/builds/slave/test', 11:20:43 INFO - 'SHELL': '/bin/bash', 11:20:43 INFO - 'SHLVL': '1', 11:20:43 INFO - 'TERM': 'linux', 11:20:43 INFO - 'TMOUT': '86400', 11:20:43 INFO - 'USER': 'cltbld', 11:20:43 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:43 INFO - '_': '/tools/buildbot/bin/python'} 11:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:44 INFO - Downloading/unpacking flake8 11:20:44 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:20:44 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:20:44 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:20:44 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:20:44 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:20:44 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:20:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:20:45 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:20:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:20:45 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:20:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:46 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:20:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:20:46 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:20:46 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:20:46 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:20:46 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:20:46 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:20:46 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:20:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:46 INFO - no previously-included directories found matching 'docs/_build' 11:20:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:20:46 INFO - Running setup.py install for pep8 11:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:46 INFO - no previously-included directories found matching 'docs/_build' 11:20:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:20:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:20:46 INFO - Cleaning up... 11:20:46 INFO - Return code: 0 11:20:46 INFO - Running post-action listener: _resource_record_post_action 11:20:46 INFO - Running post-action listener: _start_resource_monitoring 11:20:46 INFO - Starting resource monitoring. 11:20:46 INFO - ##### 11:20:46 INFO - ##### Running install step. 11:20:46 INFO - ##### 11:20:46 INFO - Running pre-action listener: _resource_record_pre_action 11:20:46 INFO - Running main action method: install 11:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:46 INFO - Reading from file tmpfile_stdout 11:20:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:46 INFO - Reading from file tmpfile_stdout 11:20:46 INFO - Output received: 11:20:46 INFO - Usage: mozinstall [options] installer 11:20:46 INFO - Options: 11:20:46 INFO - -h, --help show this help message and exit 11:20:46 INFO - -d DEST, --destination=DEST 11:20:46 INFO - Directory to install application into. [default: 11:20:46 INFO - "/builds/slave/test"] 11:20:46 INFO - --app=APP Application being installed. [default: firefox] 11:20:46 INFO - mkdir: /builds/slave/test/build/application 11:20:46 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:20:46 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:21:01 INFO - Reading from file tmpfile_stdout 11:21:01 INFO - Output received: 11:21:01 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:01 INFO - Running post-action listener: _resource_record_post_action 11:21:01 INFO - ##### 11:21:01 INFO - ##### Running run-tests step. 11:21:01 INFO - ##### 11:21:01 INFO - Running pre-action listener: _resource_record_pre_action 11:21:01 INFO - Running main action method: run_tests 11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:01 INFO - Python 2.7.3 11:21:01 INFO - Return code: 0 11:21:01 INFO - grabbing minidump binary from tooltool 11:21:01 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:21:01 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 0x174d0b0>, '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 0x174dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:01 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:21:01 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:21:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:01 INFO - Return code: 0 11:21:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:21:02 INFO - Return code: 0 11:21:02 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-e10s', '--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-047', '--webServer', 'localhost'] in /builds/slave/test/build 11:21:02 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-e10s --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-047 --webServer localhost 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 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-e10s', '--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-047', '--webServer', 'localhost'] with output_timeout 3600 11:21:02 INFO - mozversion INFO | application_buildid: 20151215103151 11:21:02 INFO - mozversion INFO | application_changeset: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 11:21:02 INFO - mozversion INFO | application_display_name: Nightly 11:21:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:02 INFO - mozversion INFO | application_name: Firefox 11:21:02 INFO - mozversion INFO | application_remotingname: firefox 11:21:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:21:02 INFO - mozversion INFO | application_vendor: Mozilla 11:21:02 INFO - mozversion INFO | application_version: 46.0a1 11:21:02 INFO - mozversion INFO | platform_buildid: 20151215103151 11:21:02 INFO - mozversion INFO | platform_changeset: 0ac99e7e0440294dbddbbbb7ca67b5630c9f11e1 11:21:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:21:02 INFO - mozversion INFO | platform_version: 46.0a1 11:21:02 INFO - 2015-12-15 11:21:02,677 DEBUG : using testdate: 1450207262 11:21:02 INFO - 2015-12-15 11:21:02,677 DEBUG : actual date: 1450207262 11:21:02 INFO - 2015-12-15 11:21:02,781 INFO : starting webserver on 'localhost:36131' 11:21:02 INFO - 2015-12-15 11:21:02,782 INFO : Starting test suite talos-linux64-ix-047.e 11:21:02 INFO - 2015-12-15 11:21:02,782 INFO : Starting test dromaeo_css 11:21:02 INFO - 2015-12-15 11:21:02,782 DEBUG : operating with platform_type : linux_ 11:21:02 INFO - 2015-12-15 11:21:02,783 INFO : Initialising browser for dromaeo_css test... 11:21:02 INFO - 2015-12-15 11:21:02,796 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnSbffK/profile http://localhost:36131/getInfo.html 11:21:07 INFO - 2015-12-15 11:21:07,504 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:21:07 INFO - 2015-12-15 11:21:07,505 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:21:07 INFO - 2015-12-15 11:21:07,505 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:21:07 INFO - 2015-12-15 11:21:07,505 DEBUG : BROWSER_OUTPUT: __metrics 11:21:07 INFO - 2015-12-15 11:21:07,626 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:21:08 INFO - 2015-12-15 11:21:08,494 INFO : Browser initialized. 11:21:08 INFO - 2015-12-15 11:21:08,494 INFO : Running cycle 1/1 for dromaeo_css test... 11:21:08 INFO - 2015-12-15 11:21:08,495 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnSbffK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:21:20 INFO - 2015-12-15 11:21:20,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 143593472 11:21:20 INFO - 2015-12-15 11:21:20,496 DEBUG : BROWSER_OUTPUT: 11:22:10 INFO - 2015-12-15 11:22:10,134 DEBUG : BROWSER_OUTPUT: 1450207330130 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:24:22 INFO - 2015-12-15 11:24:22,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36131/tests/dromaeo/cssquery-ext.html) 11:24:23 INFO - 2015-12-15 11:24:23,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 147750912 11:24:23 INFO - 2015-12-15 11:24:23,230 DEBUG : BROWSER_OUTPUT: 11:27:25 INFO - 2015-12-15 11:27:25,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-ext.html (next: http://localhost:36131/tests/dromaeo/cssquery-jquery.html) 11:27:25 INFO - 2015-12-15 11:27:25,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 146685952 11:27:25 INFO - 2015-12-15 11:27:25,961 DEBUG : BROWSER_OUTPUT: 11:30:27 INFO - 2015-12-15 11:30:27,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36131/tests/dromaeo/cssquery-mootools.html) 11:30:28 INFO - 2015-12-15 11:30:28,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 145739776 11:30:28 INFO - 2015-12-15 11:30:28,391 DEBUG : BROWSER_OUTPUT: 11:33:30 INFO - 2015-12-15 11:33:30,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36131/tests/dromaeo/cssquery-prototype.html) 11:33:30 INFO - 2015-12-15 11:33:30,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 144060416 11:33:30 INFO - 2015-12-15 11:33:30,749 DEBUG : BROWSER_OUTPUT: 11:36:33 INFO - 2015-12-15 11:36:33,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36131/tests/dromaeo/cssquery-yui.html) 11:36:34 INFO - 2015-12-15 11:36:34,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 144498688 11:36:34 INFO - 2015-12-15 11:36:34,039 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/dromaeo/cssquery-yui.html (next: http://localhost:36131/tests/dromaeo/cssquery-dojo.html) 11:39:36 INFO - 2015-12-15 11:39:36,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 147701760 11:39:36 INFO - 2015-12-15 11:39:36,634 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,634 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2656;2713.6065270535787;2749.7937654675893;2753.779697624189;2761.4062976460064;4638.489766125724;4795.1608468518;4810.711357318563;4812.109759694455;4830.613550915927;4639.443266807979;4684.578387945085;4718.551737584932;4849.151398505265;4871.610271178306;4403.251447253974;4520.841770538032;4552.317152427146;4569.611583015431;4594.74728889911;4437.977810110945;4444.17782710198;4484.327350897375;4488.214562451574;4523.796429160696;4222.050038741289;4335.913281734379;4454.242778727624;4460.7323560586465;4588.908221835562;4303;4387.780610969471;4387.934180987288;4390.209762242795;4391.824327026915;4389.18800021997;4407.471103467572;4442.777861106932;4450.977745111286;4453.287474004143;4436.4676238851225;4566.634669226487;4591.931121033187;4715.24556071027;4733.763311834429;4997.0505603935135;5010.198368261097;5072.771725272371;5095.668781529189;5142.254373115915;5189.818356357509;5196.376434827807;5206.193040078794;5207.973960130213;5249.370075590953;4594.977025114853;4700.130475861976;4819.662623616348;4820.060088282821;4825.227963525819;5279.313689220377;5361.678299302054;5370.758315875795;5372.140457526777;5421.430749771296;5172.793088276502;5186.481351864783;5187.84436466899;5189.221616757441;5243.737813109329;4894.730789806595;5015.724135172528;5042.596592272609;5227;5287.603429742785;5105.821296254613;5141.100307446182;5143.485651434827;5157.07172708916;5190.6107041972;5123.590112790967;5137.40919794221;5140.640155189176;5156.994386094675;5202.1416466282635;4095.24238015968;4189.979050104791;4191.350340697197;4296.892577685583;4309.116631090619;3728.7762734236035;3734.981325093357;3759.6992240620684;3788.3749181384765;3789.4694742736037;4457.977710111493;4460.710053846555;4479.7984090716;4485;4525.185466616041;4868.610511159099;4950.084234416572;4992.750362481861;5003.2995380646735;5067.771950262247;4447.933281000787;4490.910181796346;4514.751688657156;4522.932156017662;4541.977290113528;4609.492955774862;4620.97689511557;4624.121416930772;4626.074785043005;4673.088747694167;4628.884277893079;4756.334113224082;4796.37647105874;4904.5340692634145;4947;5201.973990130025;5209.53114219722;5221.477852214748;5224.9738751306;5225.5819534437915;4920.237363208708;4921.3356196912955;4925.236588328815;4935.777889994887;4949.1586430306215;4925.605951523941;4952.727599982036;5012.223105418666;5043.949560504348;5086.516780905956;5157.226416037624;5160.48395160481;5171.3018742469285;5171.371622398008;5213.843584692465;4776.904461910673;4991.176455884738;4997.375328083989;4998.6750861193905;5007.048660754445;4842.297866809364;4883.072216278895;4952.628552858478;5012.248162775612;5032.672876263031;4843.200871856246;4863.659543831898;4873.390826146731;4884.194107972145;4910.042541704476;4779.4742578317055;4913.803447862046;5012.874678133076;5034.924476132787;5063.392392912874;4853.0779151961015;4917.877053073702;4930.852074437773;4946.777395017305;4981.850544483671 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.587577254945;553.9972300138498;555.1921953557575;573.2089716191655;577.517772659829;34614.134646633815;35585.82207088964;35596.11009724752;35734.82132589333;35778.46332305014;39017.60982390175;39594.61418850341;39701.02989701028;39773.204535909266;39778.60221397785;7861.095973963011;8026.277635012848;8052.677892884278;8085.595720213995;8088.029436467632;7724.343430808388;7868.763937081868;7905.565193914333;7907.2488113629115;7912.881306780403;7939.047314322261;7996.840063198732;8033.598320084002;8042.396820238476;8043.798905027392;7988.800279992988;8009.439339246255;8058.4761990471015;8064.23389777976;8078.757637270862;7831.295183433518;7973.441859069868;7975.401844861659;7981.640826162837;7998.600069996477;35524.64475355239;35972.64027359719;36026.27947441037;36046.819765901004;36108.81945590281;2899.0143351260463;2969.7624190064744;3016.215783896203;3135.5453459248283;3287.474004159347;26068;26682.466350673072;26779.866100669566;26876.73123268762;27082.187534373803;3105.363400502914;3172.4924012157944;3176.8411579421168;3190.6968837960358;3212.710856022946;210093;210587;211309.99999999846;211318;211476;50506.242406363934;50924.236136457985;50981.235281470064;51112.74443627758;51126;47645.52354476411;48752.26871596929;61448;62604.373956260766;62678.686606567586;12793.872061279455;12974;12994.610161694975;13021.283829389286;13063.738725225443;9428.434293942386;9434.90565094354;9476.715698528917;9511.524423778783;9524.90475095254;17902;18027.54931126706;18053.368132115313;18087.638247234983;18139.81860181381;7171.569705817667;7289.562626242442;7293.380062694624;7318.121825380988;7334.66993985272;847.766864112374;859.3254295378098;874.8600223964136;889.9243564296978;1004.5278719002057;22173.667394989086;22266.77733222647;22630;22845.771542284365;25505.48989020246;950.9207049998301;975.492743773234;981.9312648114707;1033.1734612310122;1063.8616979792578;14045.859541404456;14064.85935140656;14301.57095287143;14310.713785724227;14379.928100359431;252917;258548;259275;259721;260419;45055.77472112618;45153;45328.3200751989;45391.31913021241;45403;1184.7500886564585;1223.8103094020441;1224.4979558381021;1227.1532642476664;1235.4193529041336;25875.611865822404;25955.610665840406;26536.734632653428;26641.067562635213;26700.198994030212;41878.16243675171;42348.78825605852;42723.86380681016;42810.1437971245;42912.35631465468;198215;199511;199715;199939;199954;27804.582931256453;28536.85731571329;28661.42677146487;28747.28131796722;28949;33032.50451243185;33077.503837441975;33478.83260583682;33983.660163398046;34007.659923400446;28590;29165.708342917147;29195.70804292015;29210.123696289145;29680.257993550335;30668.386632267677;31016.689833102282;31413.52879706852;31499.212519686276;31759.84120079385;30786.84606576953;31224.687753122176;31263.84368078145;31471.842640787567;31689.366212675155;26211.73788262093;28736.712632873405;28781.136565903056;28784.280392990342;28893.855530722212;22887.542249155256;23036.654450182927;30467.39065218639;32354.83822580872;32699.019029429157 11:39:36 INFO - 2015-12-15 11:39:36,635 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.66466700965526;335.9714424273938;338.27102593910104;338.9068006298268;339.60266488208794;15169.54491365258;15295.235238238085;15952.36190552378;16008.279627416765;16581.005139691595;14071.718565628707;14139.505117320896;14363.784543231859;14390.928045359784;14442;4518.819247230115;4570.725756454607;4637.443506779191;4648.604868586174;4666.603338716213;5107.948920510785;5133.974330128344;5140.0490909181735;5143.4599367066485;5148.794048238066;3273.852676629557;3378.6959173674363;5096.515830996068;5115;5171.0692075426405;5163.199704045879;5193.376794784613;5213.739313034371;5222.955408918194;5226.137687281594;5026.84919452417;5030.974845125787;5040.16837221858;5200.817971370984;5214.191800270926;11354.545818167264;11639.418029098511;11706.53173873044;12825.679358016125;18533.443996680122;1894.1760334254643;1902.1345287893976;1910.6847370183903;1987.2647120565339;1989.234144854227;9347.112024357675;9373.953130234306;9580.520973951345;11480;12421.130520863453;1733.2893513659465;1744.180235289412;1794.1477798045823;1796.4790210838842;1817.1277786662345;52068.739656301856;52873;54671;54720.45279547193;55033.1745023825;9769;9919.256055795844;9970.651027214013;9974.750631234132;10034.09693127622;12553.811692824615;12558.560450384193;12612.495500180074;12615.432305546272;12624.873751262554;6847.109875716125;6860.142482189726;6930.3762661359715;6938.653067346612;6943.861122777516;6481.384268494486;6504.739810407626;6504.837379065467;6524.575902566318;6535.379138981884;4109.56849530795;4129.607687269705;4136.462259906193;4166.895827604334;4203.033302340479;1794.9820501795075;1798.6312805874763;1804.927802887896;1811.7191835265292;1827.8080801515916;368.54116624802293;374.3542389378301;399.11396699327446;909.6770646420558;952.3714348529937;9849.60601575929;9879.259055570861;9924.35491693052;9962.352447090916;10033.197344212445;398.1976317719797;401.5482582095143;402.4385981555772;403.67302484987255;405.5154090861451;5306.602004849652;5691.9146212806845;5728.570357223225;9028.954855225813;9216.308776841764;468096;478009;484289;493137;497587;69434;72515.63742181256;72835.63582182056;72937.27062729411;73261;1026.8049070676548;1033.6278939581744;1054.1145437832258;1074.1374237656714;1076.155218153761;13847.653808654864;14097.627314526582;14819;15192.46826361072;15218.467353642569;29395.55906661359;29573.26066848346;32550.186245344055;33152.66847331496;33458.33083338368;41550.792246038574;41729.37405938852;42812;42994;46619.533804662875;8666.913330866611;8936.687215947411;9087.454752714593;9144.725658230263;9148.176664100263;10683.679489615324;10709.143268538342;10724.8927510727;12615.621531354074;16849.663006739553;10728.89271107279;13753.449862005407;13913.234772087633;14013.229272390117;14139.64650883695;12512.93743531313;13338.333083345988;13589.388477518733;13938.512152074629;14412;14184.219867907364;14254.857451425352;14488.203148826495;14493.92753036228;14499.492517761828;8911.331650126396;8980.416272942239;8991.910080899108;9269.304802139732;9316.20812230968;11260.605878794202;13946.093503922213;14056.859431405965;14070.718585628434;14155.079919805592 11:39:36 INFO - 2015-12-15 11:39:36,636 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1465.626265302349;1648.2994727240923;1697.7198762204237;1715.7597936288914;1740.773699419075;6016.2479690038745;6177.166082578862;7123.53697009694;7412.258774122585;7419.406447484202;6851.314868513146;6985.057017302663;7028.472864535168;7053.36519713227;7068.61122638256;2029.6752519596866;2051.712760213571;2053.38398480456;2056.465319017059;2057.609054279682;2041.9489512762225;2044.3049363216503;2050.282401159597;2080.209520382253;2088.2691058129685;2012.8490363222743;2015.959680806383;2026.189524190321;2047.140201115535;2048.641487739647;2067.6588362920174;2072.5647614000927;2080.5318803269297;2081.8022287882777;2092;2015.6472617291915;2032.6442872497255;2055.2395613622907;2055.6710926251726;2068.9551776352996;7184.784456466262;7242;7263.709451621929;7289.125304963385;7292.453066020017;4118.19695159444;4163.084121493267;4189.162167566499;4216.367544868263;4216.85241016566;2669.466106778652;2672.599110133476;2711.8915243390243;2767.4465106978687;2768.792340574465;868.2576397180446;876.9079246679134;881.9162179592928;897.4166791585457;906.8005038891433;9747.415155090717;9797.951010244904;9842.015798420101;9853.655122070693;9870.555824987965;3750.306193354238;3751.8311675974646;3795.2978698940783;3865.555461121951;3885.300645883768;8463.942007249094;8520.786980325542;8538.06081331053;8539.573021348908;8571.742847714579;3998.260321840469;4010.298197815429;4014.337634290368;4036.0313524754433;4043.9191216175514;3071.8003329783937;3129.4367013937253;3645.489631451599;3663.5603727552866;3676.7058635309113;3300.273939733255;3372.6458721834347;3406.199543107368;3412;3414.8463319150696;1121.3720316622716;1131.0216662586804;1136.5567428702811;1139.6182278936649;1144.1704764046;929.7350255177378;972.9173020293213;1165.6910918606577;1188.3167178872184;1200.5737963023175;6731.562448440835;6738.663066846736;6753.223379311344;6794.45644348451;6816.488763342769;1063.1760385700989;1071.255477443185;1074.9516271767789;1086.2721976275914;1097.3306283167262;5411.431799661058;5435.130379139318;5464.3442786865035;5468.48049435303;5506.779728810883;8558.957205213934;8564.914350856412;8780.868286975701;8801.823963520821;8865.202131808168;8634.913650863411;8684.478931264144;8752.431091979;8769.561521923879;8776.341774366949;6861.4853885958755;6885.896711549331;6938.5143039986715;6976.895346569806;7010.719571217094;6673.9332606673315;6712.093867327848;6717.227518835396;6729.394354508117;6745.865082698417;7663.080430348394;7690.384769218337;7869.724559640385;7964.283214510722;8000;7874.606269686607;8010.879836802569;8104.554249516334;8129.959350203211;8204;5129.48705129499;5889.411058894077;6004.249468816398;6107.328193898757;6114.602550834182;6775.93224067753;6783.18601767791;6807.523473357016;6813.591184528944;6844.897326540006;6216.564840461125;6547.886859234037;6589.505787066085;6605.801825945229;6605.834854128685;6241.750329986931;6333.936660633519;6392.520560957853;6450.903236451551;6456.160699109086;6566.967165164144;6581.440577550962;6604.405603495708;6637.668116594247;6653;5968.522518198447;6007;6015.879682406415;6016.578839481194;6059.515238780975;6053.545984051302;6057.182280392267;6086.421789929949;6089.725962331794;6092.573519853568 11:39:36 INFO - 2015-12-15 11:39:36,637 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.51699213290203;296.9257685578605;299.17577075157936;299.2772454522329;305.2597451180886;5523.337199536057;5573.27547418835;5602.1596760485945;5664.980303545365;5697.746495770934;5499.752511136999;5522.199281104237;5560;5603.2435621191125;5613.382527921935;4120.793960301988;4278.828846846122;4280.614744672979;4285.742855428684;4287.892802679942;4226.556211597784;4228;4240.5971432714;4264.552222016675;4270.402143699869;4200;4204.390363397306;4207.326827707568;4216.367544868279;4227.577242275778;4196.782932949441;4200.264953633102;4202.075543380452;4202.831886724527;4209.494860616745;3626.492291079251;3639.7998110103936;3641.326354624403;3646.398344273192;3649.5255616769914;5258.947410525884;5270.209468579706;5382.542483888874;5411.64824286424;5415.9458405415835;4797.784099715521;4801.591864691505;4801.831935882227;4802.183628783116;4804.663673542854;5888.941110588882;5899.469047785677;5901.4098590141075;5902.203202567642;5902.439268269508;3827.7511961722676;3902.3366027775064;3916.608339166089;3922.490076290064;3930.4104384342577;6135.32511423743;6184.134221209034;6189.721462534152;6189.721462534197;6193.752249910043;4083.9795801020805;4085.142120154801;4088.6729061674996;4091.6726661867574;4092.877213683594;4147.19129769692;4147.97926010368;4151.066010147692;4152.211079894811;4158.792060396968;4706.0823139487475;4801.807927682923;4807.399075115611;4814.6870453420415;4818.638602104857;5855.707214639251;5859.062549991981;5860.970695146582;5865.853353666193;5885.588008839341;1446.4142022480912;1452.847451017628;1460.2990564529086;1462.0788902991048;1462.6855226126222;936.9578368973413;958.6117622362954;959.472290240365;973.4110862927968;973.6056896956744;5038.168702164176;5051.494850514919;5071.290019397287;5071.771770270347;5075.264086707407;6056.9697151513965;6079.392060793885;6086.330503644595;6087.878242435127;6088.086786981899;5027.2207807789855;5042.117629414838;5054.064997975386;5063.772130254148;5068.391792984866;3213.1645772099423;3265.869365225412;3286.76992610515;3299.818509981926;3313.022658315803;5640.746166422521;5665.405132461115;5671.319441667027;5722.570807189394;5723.570732195102;6313.873722525615;6352.777652782131;6362.395572420613;6367.872642547123;6370.617762934239;5749.281339832521;5754.05058165398;5762.020456522485;5765.423457654285;5772.105323674753;6130.049842274455;6143.907841382294;6156.230471191101;6157.415045570664;6167.629942203482;5869.559783016205;6045.727942242522;6053.697315134137;6066.3630318815885;6079.118527813531;5783.479486846204;5788.131780232999;5804.21643078179;5806.709664516842;5807.593468457168;4050.270951228807;4085.4893138357706;4087.1212689271947;4087.6321131098343;4089.4070359798257;6035.6076855004285;6119.3268740437625;6159.784407545714;6168.383161683796;6168.568200225941;5914.142449344735;5922.289325280822;5936.050231962865;5936.22829032223;5940.55445841555;5887.735051922759;5907.822765317047;5923.674197919156;5926.111083337534;5938.673372964528;5610.49505544503;5769.249997500298;5774.393688662798;5776.162456443708;5797.652140871562;5933.991221492443;5936.257967754031;5938.435848594377;5948.405159484017;5965.9105113422465;5787.565932554991;5795.942040579709;5803.883922321615;5811.651300921958;5812.418758124154 11:39:36 INFO - 2015-12-15 11:39:36,637 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.3137942401629;703.8557095795366;744.263179452342;744.5193719361981;775.5656832173983;10373.844392334111;10545.525451354688;10562.102221311197;10592.894071059287;10614.681559553206;10854.565817367296;11001.559937602486;11043.226974111816;11049.834252486198;11054.668359949215;765.8085478630343;784.6390660296271;785.5208322923013;801.8436404901047;802.4222559756965;774.423054824154;782.374100719425;783.8118851475633;784.3333166808196;787.5707739282076;808.2079562029215;810.4205493072452;822.2229992656942;823.7858156879195;826.1531929772002;809.1463506001166;809.6154326694832;816.7345612675874;816.7713040348682;816.8570500162507;603.8912995660779;609.7317180440637;609.7560975609747;612.2224774536314;613.0436519030327;10560.841587376195;10635.46822658864;10702.892971070267;10721.83917241242;10821.188410869216;10887.18346124036;11121.443927803577;11190.944045279803;11232.10143188543;11262.099032077414;9354.625814967394;9446.38598491096;9460.668876589287;9523.666671666459;9748.415095094317;3145.3709258148233;3204.6635103314047;3208.1498402923244;3210.951835722466;3217.2439476722952;38025;38789.80605096985;38983;38983.41524877129;39094;8519.361047921431;8533.658653653909;8627.698030569025;8810.06178640698;8853.424527405698;14831.184284864436;14836.035657682216;14881;14883.33025013877;14934.32795524204;5905.143754155623;5929.37741537141;6019.187409699634;6020.909686354708;6157.907631385533;3372.15696075981;3468.1156305142026;3511.4908338290807;3528.788272703646;3619.4027985382645;2531.556977528962;2552.0812507497285;2555.8722063897103;2567.833090849089;2570.910018149356;473.06333459749203;476.69491525423757;477.3722554840374;481.8843477565429;484.980600775965;503.92693059506166;542.6988021647944;546.7402983582766;560.0231183920766;560.140184816305;7176.892346614805;7182.3535881770895;7207;7246.927530724625;7342.339189472973;500.4620033463968;515.5617724933851;527.6280222443245;538.3996843519448;539.0009197630349;3334.2664613785414;3383.678550537695;3951.6245956634075;3988.74073185242;4083.571225021389;44917.32624010643;45146.54853451424;48017.519824801304;48047.519524805;48650.51349486531;41706.58293417027;41837.37243941343;41911.580884191375;41938.161236775704;42070.15859682789;39710;39804.402933956015;39880.00299992581;40072.198556028714;40441.79779101086;7738.92261077382;7873.803154921173;7996.800079997814;8064.556449395105;8077;28780.712192877803;29322;29428.55857162187;30372.69627303787;32419.675803241666;37479.25041499209;37951;38403.807980961035;38479;39015.41476877906;9381.296402769683;9485.430874147572;9872.40765554069;10030.147437467896;10094.394336339843;10813.837792432962;10852.45737713127;11029.338239705643;11221.438928053727;11475.081993440672;10531.78936421252;10849.67450976472;11254.493547790533;11409.372484513431;11664.125190610908;10377.504583306492;10468.267221294436;10574.206934479791;10745.462726863781;10996.175286853359;9430;9551.808963820824;10579.94710026445;10627.681169564925;10631.681049568526;8616.35377346689;8798.956005219932;8802.635591483331;8837.248833849195;9000.909990900007;8081.555514446762;8549.727601701952;8681.2186903179;8900.198982091642;8927.910720892707 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,334 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208376628__endTimestamp 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,638 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4740.05 Median:4863.66 stddev:499.66 (10.3%) stddev-sans-first:473.69 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: Values: 2656.0 2713.6 2749.8 2753.8 2761.4 4638.5 4795.2 4810.7 4812.1 4830.6 4639.4 4684.6 4718.6 4849.2 4871.6 4403.3 4520.8 4552.3 4569.6 4594.7 4438.0 4444.2 4484.3 4488.2 4523.8 4222.1 4335.9 4454.2 4460.7 4588.9 4303.0 4387.8 4387.9 4390.2 4391.8 4389.2 4407.5 4442.8 4451.0 4453.3 4436.5 4566.6 4591.9 4715.2 4733.8 4997.1 5010.2 5072.8 5095.7 5142.3 5189.8 5196.4 5206.2 5208.0 5249.4 4595.0 4700.1 4819.7 4820.1 4825.2 5279.3 5361.7 5370.8 5372.1 5421.4 5172.8 5186.5 5187.8 5189.2 5243.7 4894.7 5015.7 5042.6 5227.0 5287.6 5105.8 5141.1 5143.5 5157.1 5190.6 5123.6 5137.4 5140.6 5157.0 5202.1 4095.2 4190.0 4191.4 4296.9 4309.1 3728.8 3735.0 3759.7 3788.4 3789.5 4458.0 4460.7 4479.8 4485.0 4525.2 4868.6 4950.1 4992.8 5003.3 5067.8 4447.9 4490.9 4514.8 4522.9 4542.0 4609.5 4621.0 4624.1 4626.1 4673.1 4628.9 4756.3 4796.4 4904.5 4947.0 5202.0 5209.5 5221.5 5225.0 5225.6 4920.2 4921.3 4925.2 4935.8 4949.2 4925.6 4952.7 5012.2 5043.9 5086.5 5157.2 5160.5 5171.3 5171.4 5213.8 4776.9 4991.2 4997.4 4998.7 5007.0 4842.3 4883.1 4952.6 5012.2 5032.7 4843.2 4863.7 4873.4 4884.2 4910.0 4779.5 4913.8 5012.9 5034.9 5063.4 4853.1 4917.9 4930.9 4946.8 4981.9 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38144.30 Median:32526.93 stddev:58348.56 (179.4%) stddev-sans-first:58443.97 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: Values: 553.6 554.0 555.2 573.2 577.5 34614.1 35585.8 35596.1 35734.8 35778.5 39017.6 39594.6 39701.0 39773.2 39778.6 7861.1 8026.3 8052.7 8085.6 8088.0 7724.3 7868.8 7905.6 7907.2 7912.9 7939.0 7996.8 8033.6 8042.4 8043.8 7988.8 8009.4 8058.5 8064.2 8078.8 7831.3 7973.4 7975.4 7981.6 7998.6 35524.6 35972.6 36026.3 36046.8 36108.8 2899.0 2969.8 3016.2 3135.5 3287.5 26068.0 26682.5 26779.9 26876.7 27082.2 3105.4 3172.5 3176.8 3190.7 3212.7 210093.0 210587.0 211310.0 211318.0 211476.0 50506.2 50924.2 50981.2 51112.7 51126.0 47645.5 48752.3 61448.0 62604.4 62678.7 12793.9 12974.0 12994.6 13021.3 13063.7 9428.4 9434.9 9476.7 9511.5 9524.9 17902.0 18027.5 18053.4 18087.6 18139.8 7171.6 7289.6 7293.4 7318.1 7334.7 847.8 859.3 874.9 889.9 1004.5 22173.7 22266.8 22630.0 22845.8 25505.5 950.9 975.5 981.9 1033.2 1063.9 14045.9 14064.9 14301.6 14310.7 14379.9 252917.0 258548.0 259275.0 259721.0 260419.0 45055.8 45153.0 45328.3 45391.3 45403.0 1184.8 1223.8 1224.5 1227.2 1235.4 25875.6 25955.6 26536.7 26641.1 26700.2 41878.2 42348.8 42723.9 42810.1 42912.4 198215.0 199511.0 199715.0 199939.0 199954.0 27804.6 28536.9 28661.4 28747.3 28949.0 33032.5 33077.5 33478.8 33983.7 34007.7 28590.0 29165.7 29195.7 29210.1 29680.3 30668.4 31016.7 31413.5 31499.2 31759.8 30786.8 31224.7 31263.8 31471.8 31689.4 26211.7 28736.7 28781.1 28784.3 28893.9 22887.5 23036.7 30467.4 32354.8 32699.0 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25777.05 Median:401.99 stddev:79159.84 (19691.8%) stddev-sans-first:79358.85 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: Values: 333.7 336.0 338.3 338.9 339.6 15169.5 15295.2 15952.4 16008.3 16581.0 14071.7 14139.5 14363.8 14390.9 14442.0 4518.8 4570.7 4637.4 4648.6 4666.6 5107.9 5134.0 5140.0 5143.5 5148.8 3273.9 3378.7 5096.5 5115.0 5171.1 5163.2 5193.4 5213.7 5223.0 5226.1 5026.8 5031.0 5040.2 5200.8 5214.2 11354.5 11639.4 11706.5 12825.7 18533.4 1894.2 1902.1 1910.7 1987.3 1989.2 9347.1 9374.0 9580.5 11480.0 12421.1 1733.3 1744.2 1794.1 1796.5 1817.1 52068.7 52873.0 54671.0 54720.5 55033.2 9769.0 9919.3 9970.7 9974.8 10034.1 12553.8 12558.6 12612.5 12615.4 12624.9 6847.1 6860.1 6930.4 6938.7 6943.9 6481.4 6504.7 6504.8 6524.6 6535.4 4109.6 4129.6 4136.5 4166.9 4203.0 1795.0 1798.6 1804.9 1811.7 1827.8 368.5 374.4 399.1 909.7 952.4 9849.6 9879.3 9924.4 9962.4 10033.2 398.2 401.5 402.4 403.7 405.5 5306.6 5691.9 5728.6 9029.0 9216.3 468096.0 478009.0 484289.0 493137.0 497587.0 69434.0 72515.6 72835.6 72937.3 73261.0 1026.8 1033.6 1054.1 1074.1 1076.2 13847.7 14097.6 14819.0 15192.5 15218.5 29395.6 29573.3 32550.2 33152.7 33458.3 41550.8 41729.4 42812.0 42994.0 46619.5 8666.9 8936.7 9087.5 9144.7 9148.2 10683.7 10709.1 10724.9 12615.6 16849.7 10728.9 13753.4 13913.2 14013.2 14139.6 12512.9 13338.3 13589.4 13938.5 14412.0 14184.2 14254.9 14488.2 14493.9 14499.5 8911.3 8980.4 8991.9 9269.3 9316.2 11260.6 13946.1 14056.9 14070.7 14155.1 11:39:36 INFO - 2015-12-15 11:39:36,640 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,641 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5015.09 Median:6091.15 stddev:2628.45 (43.2%) stddev-sans-first:2622.29 11:39:36 INFO - 2015-12-15 11:39:36,641 DEBUG : BROWSER_OUTPUT: Values: 1465.6 1648.3 1697.7 1715.8 1740.8 6016.2 6177.2 7123.5 7412.3 7419.4 6851.3 6985.1 7028.5 7053.4 7068.6 2029.7 2051.7 2053.4 2056.5 2057.6 2041.9 2044.3 2050.3 2080.2 2088.3 2012.8 2016.0 2026.2 2047.1 2048.6 2067.7 2072.6 2080.5 2081.8 2092.0 2015.6 2032.6 2055.2 2055.7 2069.0 7184.8 7242.0 7263.7 7289.1 7292.5 4118.2 4163.1 4189.2 4216.4 4216.9 2669.5 2672.6 2711.9 2767.4 2768.8 868.3 876.9 881.9 897.4 906.8 9747.4 9798.0 9842.0 9853.7 9870.6 3750.3 3751.8 3795.3 3865.6 3885.3 8463.9 8520.8 8538.1 8539.6 8571.7 3998.3 4010.3 4014.3 4036.0 4043.9 3071.8 3129.4 3645.5 3663.6 3676.7 3300.3 3372.6 3406.2 3412.0 3414.8 1121.4 1131.0 1136.6 1139.6 1144.2 929.7 972.9 1165.7 1188.3 1200.6 6731.6 6738.7 6753.2 6794.5 6816.5 1063.2 1071.3 1075.0 1086.3 1097.3 5411.4 5435.1 5464.3 5468.5 5506.8 8559.0 8564.9 8780.9 8801.8 8865.2 8634.9 8684.5 8752.4 8769.6 8776.3 6861.5 6885.9 6938.5 6976.9 7010.7 6673.9 6712.1 6717.2 6729.4 6745.9 7663.1 7690.4 7869.7 7964.3 8000.0 7874.6 8010.9 8104.6 8130.0 8204.0 5129.5 5889.4 6004.2 6107.3 6114.6 6775.9 6783.2 6807.5 6813.6 6844.9 6216.6 6547.9 6589.5 6605.8 6605.8 6241.8 6333.9 6392.5 6450.9 6456.2 6567.0 6581.4 6604.4 6637.7 6653.0 5968.5 6007.0 6015.9 6016.6 6059.5 6053.5 6057.2 6086.4 6089.7 6092.6 11:39:36 INFO - 2015-12-15 11:39:36,641 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,642 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4840.27 Median:5602.70 stddev:1465.43 (26.2%) stddev-sans-first:1429.27 11:39:36 INFO - 2015-12-15 11:39:36,642 DEBUG : BROWSER_OUTPUT: Values: 294.5 296.9 299.2 299.3 305.3 5523.3 5573.3 5602.2 5665.0 5697.7 5499.8 5522.2 5560.0 5603.2 5613.4 4120.8 4278.8 4280.6 4285.7 4287.9 4226.6 4228.0 4240.6 4264.6 4270.4 4200.0 4204.4 4207.3 4216.4 4227.6 4196.8 4200.3 4202.1 4202.8 4209.5 3626.5 3639.8 3641.3 3646.4 3649.5 5258.9 5270.2 5382.5 5411.6 5415.9 4797.8 4801.6 4801.8 4802.2 4804.7 5888.9 5899.5 5901.4 5902.2 5902.4 3827.8 3902.3 3916.6 3922.5 3930.4 6135.3 6184.1 6189.7 6189.7 6193.8 4084.0 4085.1 4088.7 4091.7 4092.9 4147.2 4148.0 4151.1 4152.2 4158.8 4706.1 4801.8 4807.4 4814.7 4818.6 5855.7 5859.1 5861.0 5865.9 5885.6 1446.4 1452.8 1460.3 1462.1 1462.7 937.0 958.6 959.5 973.4 973.6 5038.2 5051.5 5071.3 5071.8 5075.3 6057.0 6079.4 6086.3 6087.9 6088.1 5027.2 5042.1 5054.1 5063.8 5068.4 3213.2 3265.9 3286.8 3299.8 3313.0 5640.7 5665.4 5671.3 5722.6 5723.6 6313.9 6352.8 6362.4 6367.9 6370.6 5749.3 5754.1 5762.0 5765.4 5772.1 6130.0 6143.9 6156.2 6157.4 6167.6 5869.6 6045.7 6053.7 6066.4 6079.1 5783.5 5788.1 5804.2 5806.7 5807.6 4050.3 4085.5 4087.1 4087.6 4089.4 6035.6 6119.3 6159.8 6168.4 6168.6 5914.1 5922.3 5936.1 5936.2 5940.6 5887.7 5907.8 5923.7 5926.1 5938.7 5610.5 5769.2 5774.4 5776.2 5797.7 5934.0 5936.3 5938.4 5948.4 5965.9 5787.6 5795.9 5803.9 5811.7 5812.4 11:39:36 INFO - 2015-12-15 11:39:36,642 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2015-12-15 11:39:36,642 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11745.79 Median:45031.94 stddev:13197.94 (29.3%) stddev-sans-first:13208.61 11:39:36 INFO - 2015-12-15 11:39:36,643 DEBUG : BROWSER_OUTPUT: Values: 641.3 703.9 744.3 744.5 775.6 10373.8 10545.5 10562.1 10592.9 10614.7 10854.6 11001.6 11043.2 11049.8 11054.7 765.8 784.6 785.5 801.8 802.4 774.4 782.4 783.8 784.3 787.6 808.2 810.4 822.2 823.8 826.2 809.1 809.6 816.7 816.8 816.9 603.9 609.7 609.8 612.2 613.0 10560.8 10635.5 10702.9 10721.8 10821.2 10887.2 11121.4 11190.9 11232.1 11262.1 9354.6 9446.4 9460.7 9523.7 9748.4 3145.4 3204.7 3208.1 3211.0 3217.2 38025.0 38789.8 38983.0 38983.4 39094.0 8519.4 8533.7 8627.7 8810.1 8853.4 14831.2 14836.0 14881.0 14883.3 14934.3 5905.1 5929.4 6019.2 6020.9 6157.9 3372.2 3468.1 3511.5 3528.8 3619.4 2531.6 2552.1 2555.9 2567.8 2570.9 473.1 476.7 477.4 481.9 485.0 503.9 542.7 546.7 560.0 560.1 7176.9 7182.4 7207.0 7246.9 7342.3 500.5 515.6 527.6 538.4 539.0 3334.3 3383.7 3951.6 3988.7 4083.6 44917.3 45146.5 48017.5 48047.5 48650.5 41706.6 41837.4 41911.6 41938.2 42070.2 39710.0 39804.4 39880.0 40072.2 40441.8 7738.9 7873.8 7996.8 8064.6 8077.0 28780.7 29322.0 29428.6 30372.7 32419.7 37479.3 37951.0 38403.8 38479.0 39015.4 9381.3 9485.4 9872.4 10030.1 10094.4 10813.8 10852.5 11029.3 11221.4 11475.1 10531.8 10849.7 11254.5 11409.4 11664.1 10377.5 10468.3 10574.2 10745.5 10996.2 9430.0 9551.8 10579.9 10627.7 10631.7 8616.4 8799.0 8802.6 8837.2 9000.9 8081.6 8549.7 8681.2 8900.2 8927.9 11:39:36 INFO - 2015-12-15 11:39:36,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:39:36 INFO - 2015-12-15 11:39:36,643 DEBUG : BROWSER_OUTPUT: 11:39:37 INFO - 2015-12-15 11:39:37,255 INFO : Browser exited with error code: 0 11:39:37 INFO - 2015-12-15 11:39:37,276 INFO : Completed test dromaeo_css (00:18:34) 11:39:37 INFO - 2015-12-15 11:39:37,276 INFO : Starting test kraken 11:39:37 INFO - 2015-12-15 11:39:37,276 DEBUG : operating with platform_type : linux_ 11:39:37 INFO - 2015-12-15 11:39:37,276 INFO : Initialising browser for kraken test... 11:39:37 INFO - 2015-12-15 11:39:37,282 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXUSiW/profile http://localhost:36131/getInfo.html 11:39:42 INFO - 2015-12-15 11:39:42,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:39:42 INFO - 2015-12-15 11:39:42,062 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:39:42 INFO - 2015-12-15 11:39:42,062 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:39:42 INFO - 2015-12-15 11:39:42,062 DEBUG : BROWSER_OUTPUT: __metrics 11:39:42 INFO - 2015-12-15 11:39:42,219 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:39:43 INFO - 2015-12-15 11:39:43,102 INFO : Browser initialized. 11:39:43 INFO - 2015-12-15 11:39:43,103 INFO : Running cycle 1/1 for kraken test... 11:39:43 INFO - 2015-12-15 11:39:43,103 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJXUSiW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:39:55 INFO - 2015-12-15 11:39:55,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 143142912 11:39:55 INFO - 2015-12-15 11:39:55,141 DEBUG : BROWSER_OUTPUT: 11:39:57 INFO - 2015-12-15 11:39:57,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:58 INFO - 2015-12-15 11:39:58,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 11:39:58 INFO - 2015-12-15 11:39:58,330 DEBUG : BROWSER_OUTPUT: 11:40:01 INFO - 2015-12-15 11:40:01,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-dft) 11:40:01 INFO - 2015-12-15 11:40:01,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 142458880 11:40:01 INFO - 2015-12-15 11:40:01,695 DEBUG : BROWSER_OUTPUT: 11:40:04 INFO - 2015-12-15 11:40:04,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-fft) 11:40:05 INFO - 2015-12-15 11:40:05,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 137654272 11:40:05 INFO - 2015-12-15 11:40:05,167 DEBUG : BROWSER_OUTPUT: 11:40:07 INFO - 2015-12-15 11:40:07,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36131/tests/kraken/driver.html?testName=audio-oscillator) 11:40:07 INFO - 2015-12-15 11:40:07,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 138543104 11:40:07 INFO - 2015-12-15 11:40:07,858 DEBUG : BROWSER_OUTPUT: 11:40:10 INFO - 2015-12-15 11:40:10,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:10 INFO - 2015-12-15 11:40:10,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 140206080 11:40:10 INFO - 2015-12-15 11:40:10,700 DEBUG : BROWSER_OUTPUT: 11:40:13 INFO - 2015-12-15 11:40:13,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:14 INFO - 2015-12-15 11:40:14,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 11:40:14 INFO - 2015-12-15 11:40:14,339 DEBUG : BROWSER_OUTPUT: 11:40:17 INFO - 2015-12-15 11:40:17,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36131/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:18 INFO - 2015-12-15 11:40:18,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 138362880 11:40:18 INFO - 2015-12-15 11:40:18,454 DEBUG : BROWSER_OUTPUT: 11:40:21 INFO - 2015-12-15 11:40:21,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36131/tests/kraken/driver.html?testName=json-parse-financial) 11:40:21 INFO - 2015-12-15 11:40:21,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 11:40:21 INFO - 2015-12-15 11:40:21,987 DEBUG : BROWSER_OUTPUT: 11:40:23 INFO - 2015-12-15 11:40:23,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:24 INFO - 2015-12-15 11:40:24,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 11:40:24 INFO - 2015-12-15 11:40:24,335 DEBUG : BROWSER_OUTPUT: 11:40:26 INFO - 2015-12-15 11:40:26,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:26 INFO - 2015-12-15 11:40:26,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 140148736 11:40:26 INFO - 2015-12-15 11:40:26,852 DEBUG : BROWSER_OUTPUT: 11:40:29 INFO - 2015-12-15 11:40:29,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:29 INFO - 2015-12-15 11:40:29,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 141705216 11:40:29 INFO - 2015-12-15 11:40:29,606 DEBUG : BROWSER_OUTPUT: 11:40:32 INFO - 2015-12-15 11:40:32,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:32 INFO - 2015-12-15 11:40:32,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 140341248 11:40:32 INFO - 2015-12-15 11:40:32,808 DEBUG : BROWSER_OUTPUT: 11:40:35 INFO - 2015-12-15 11:40:35,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:36 INFO - 2015-12-15 11:40:36,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 140386304 11:40:36 INFO - 2015-12-15 11:40:36,012 DEBUG : BROWSER_OUTPUT: 11:40:37 INFO - 2015-12-15 11:40:37,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36131/tests/kraken/driver.html?testName=ai-astar) 11:40:38 INFO - 2015-12-15 11:40:38,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 141312000 11:40:38 INFO - 2015-12-15 11:40:38,016 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,019 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:40:38 INFO - 2015-12-15 11:40:38,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:40:38 INFO - 2015-12-15 11:40:38,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:40:38 INFO - 2015-12-15 11:40:38,020 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:40:38 INFO - 2015-12-15 11:40:38,020 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;114;113;114;124;113;114;112;114 11:40:38 INFO - 2015-12-15 11:40:38,020 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;139;152;171;130;152;167;136;165;133 11:40:38 INFO - 2015-12-15 11:40:38,020 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;163;162;162;167;162;165;161 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;72;75;146;74;79;72;73;147 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;131;95;95;95;134;94;96;128 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;109;110;111;110;111 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;147;148;147;147;148;148 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 11:40:38 INFO - 2015-12-15 11:40:38,021 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;73;71;71;70;72;77;69;69 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;68;68;68;69;68;68;70;68;70 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;84;85;85;86;85;84;86 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;142;120;129;121;124;131;122;128;118;132 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;147;147;152;150;138;148;149;149;134 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;69;71;70;70;70;68;71;70 11:40:38 INFO - 2015-12-15 11:40:38,022 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:40:38 INFO - 2015-12-15 11:40:38,023 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:40:38 INFO - 2015-12-15 11:40:38,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,819 11:40:38 INFO - 2015-12-15 11:40:38,023 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:40:38 INFO - 2015-12-15 11:40:38,023 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208438018__endTimestamp 11:40:38 INFO - 2015-12-15 11:40:38,023 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:3.98 (3.5%) stddev-sans-first:4.21 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 114.0 113.0 114.0 124.0 113.0 114.0 112.0 114.0 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.50 stddev:15.68 (9.9%) stddev-sans-first:15.68 11:40:38 INFO - 2015-12-15 11:40:38,031 DEBUG : BROWSER_OUTPUT: Values: 166.0 139.0 152.0 171.0 130.0 152.0 167.0 136.0 165.0 133.0 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.79 (1.1%) stddev-sans-first:1.87 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 163.0 162.0 162.0 167.0 162.0 165.0 161.0 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:73.50 stddev:30.69 (41.8%) stddev-sans-first:31.98 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 72.0 75.0 146.0 74.0 79.0 72.0 73.0 147.0 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.52 (18.4%) stddev-sans-first:18.16 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 131.0 95.0 95.0 95.0 134.0 94.0 96.0 128.0 11:40:38 INFO - 2015-12-15 11:40:38,032 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 110.0 111.0 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 148.0 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:71.50 stddev:2.32 (3.2%) stddev-sans-first:2.46 11:40:38 INFO - 2015-12-15 11:40:38,033 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 71.0 71.0 70.0 72.0 77.0 69.0 69.0 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 68.0 68.0 69.0 68.0 68.0 70.0 68.0 70.0 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 84.0 85.0 85.0 86.0 85.0 84.0 86.0 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:128.50 stddev:7.23 (5.6%) stddev-sans-first:5.12 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: Values: 142.0 120.0 129.0 121.0 124.0 131.0 122.0 128.0 118.0 132.0 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,034 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:148.50 stddev:6.16 (4.1%) stddev-sans-first:5.96 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: Values: 138.0 147.0 147.0 152.0 150.0 138.0 148.0 149.0 149.0 134.0 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:0.94 (1.3%) stddev-sans-first:1.00 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 71.0 70.0 70.0 70.0 68.0 71.0 70.0 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:40:38 INFO - 2015-12-15 11:40:38,035 DEBUG : BROWSER_OUTPUT: 11:40:38 INFO - 2015-12-15 11:40:38,963 INFO : Browser exited with error code: 0 11:40:39 INFO - 2015-12-15 11:40:39,016 INFO : Completed test kraken (00:01:01) 11:40:39 INFO - 2015-12-15 11:40:39,017 INFO : Starting test v8_7 11:40:39 INFO - 2015-12-15 11:40:39,017 DEBUG : operating with platform_type : linux_ 11:40:39 INFO - 2015-12-15 11:40:39,017 INFO : Initialising browser for v8_7 test... 11:40:39 INFO - 2015-12-15 11:40:39,023 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPx7AvU/profile http://localhost:36131/getInfo.html 11:40:43 INFO - 2015-12-15 11:40:43,708 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:40:43 INFO - 2015-12-15 11:40:43,709 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:40:43 INFO - 2015-12-15 11:40:43,709 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:40:43 INFO - 2015-12-15 11:40:43,709 DEBUG : BROWSER_OUTPUT: __metrics 11:40:43 INFO - 2015-12-15 11:40:43,830 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:40:44 INFO - 2015-12-15 11:40:44,774 INFO : Browser initialized. 11:40:44 INFO - 2015-12-15 11:40:44,775 INFO : Running cycle 1/1 for v8_7 test... 11:40:44 INFO - 2015-12-15 11:40:44,775 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPx7AvU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:40:56 INFO - 2015-12-15 11:40:56,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 143233024 11:40:56 INFO - 2015-12-15 11:40:56,870 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36131/tests/v8_7/run.html (next: http://localhost:36131/tests/v8_7/run.html) 11:41:18 INFO - 2015-12-15 11:41:18,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 138244096 11:41:18 INFO - 2015-12-15 11:41:18,565 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: |0;Richards;164.69038208168644 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.93459875963165 11:41:18 INFO - 2015-12-15 11:41:18,567 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1118.5682326621925 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |5;Earley;715.8196134574088 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |8;Splay;592.4170616113744 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:41:18 INFO - 2015-12-15 11:41:18,568 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: __startTimestamp1450208478566__endTimestamp 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.69 Median:164.69 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,569 DEBUG : BROWSER_OUTPUT: Values: 164.7 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: Values: 187.9 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,570 DEBUG : BROWSER_OUTPUT: Values: 278.1 11:41:18 INFO - 2015-12-15 11:41:18,571 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,571 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,571 DEBUG : BROWSER_OUTPUT: Values: 5229.2 11:41:18 INFO - 2015-12-15 11:41:18,571 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,571 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1118.57 Median:1118.57 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,572 DEBUG : BROWSER_OUTPUT: Values: 1118.6 11:41:18 INFO - 2015-12-15 11:41:18,572 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,572 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.82 Median:715.82 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,573 DEBUG : BROWSER_OUTPUT: Values: 715.8 11:41:18 INFO - 2015-12-15 11:41:18,573 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,573 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: Values: 12382.7 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: Values: 27162.2 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:592.42 Median:592.42 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: Values: 592.4 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:41:18 INFO - 2015-12-15 11:41:18,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:18 INFO - 2015-12-15 11:41:18,575 DEBUG : BROWSER_OUTPUT: 11:41:19 INFO - 2015-12-15 11:41:19,518 INFO : Browser exited with error code: 0 11:41:19 INFO - 2015-12-15 11:41:19,537 INFO : Completed test v8_7 (00:00:40) 11:41:19 INFO - 2015-12-15 11:41:19,591 INFO : Completed test suite (00:20:16) 11:41:19 INFO - 2015-12-15 11:41:19,591 DEBUG : Working with test: dromaeo_css 11:41:19 INFO - 2015-12-15 11:41:19,591 DEBUG : Generating results file: dromaeo_css 11:41:19 INFO - 2015-12-15 11:41:19,592 DEBUG : Working with test: kraken 11:41:19 INFO - 2015-12-15 11:41:19,593 DEBUG : Generating results file: kraken 11:41:19 INFO - 2015-12-15 11:41:19,593 INFO : javascript benchmark 11:41:19 INFO - 2015-12-15 11:41:19,593 DEBUG : Working with test: v8_7 11:41:19 INFO - 2015-12-15 11:41:19,593 DEBUG : Generating results file: v8_7 11:41:19 INFO - 2015-12-15 11:41:19,593 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:19 INFO - 2015-12-15 11:41:19,648 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:41:19 INFO - 2015-12-15 11:41:19,648 DEBUG : process_Request line: dromaeo_css 6242.87 graph.html#tests=[[72,132,43]] 11:41:19 INFO - 2015-12-15 11:41:19,648 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:19 INFO - 2015-12-15 11:41:19,676 DEBUG : process_Request line: kraken 1542.70 graph.html#tests=[[232,132,43]] 11:41:19 INFO - 2015-12-15 11:41:19,677 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:41:19 INFO - 2015-12-15 11:41:19,714 DEBUG : process_Request line: v8_7 21158.24 graph.html#tests=[[230,132,43]] 11:41:19 INFO - 2015-12-15 11:41:19,715 INFO : javascript benchmark 11:41:19 INFO - 2015-12-15 11:41:19,719 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2656.0, 2713.6065270535787, 2749.7937654675893, 2753.779697624189, 2761.4062976460064, 4638.489766125724, 4795.1608468518, 4810.711357318563, 4812.109759694455, 4830.613550915927, 4639.443266807979, 4684.578387945085, 4718.551737584932, 4849.151398505265, 4871.610271178306, 4403.251447253974, 4520.841770538032, 4552.317152427146, 4569.611583015431, 4594.74728889911, 4437.977810110945, 4444.17782710198, 4484.327350897375, 4488.214562451574, 4523.796429160696, 4222.050038741289, 4335.913281734379, 4454.242778727624, 4460.7323560586465, 4588.908221835562, 4303.0, 4387.780610969471, 4387.934180987288, 4390.209762242795, 4391.824327026915, 4389.18800021997, 4407.471103467572, 4442.777861106932, 4450.977745111286, 4453.287474004143, 4436.4676238851225, 4566.634669226487, 4591.931121033187, 4715.24556071027, 4733.763311834429, 4997.0505603935135, 5010.198368261097, 5072.771725272371, 5095.668781529189, 5142.254373115915, 5189.818356357509, 5196.376434827807, 5206.193040078794, 5207.973960130213, 5249.370075590953, 4594.977025114853, 4700.130475861976, 4819.662623616348, 4820.060088282821, 4825.227963525819, 5279.313689220377, 5361.678299302054, 5370.758315875795, 5372.140457526777, 5421.430749771296, 5172.793088276502, 5186.481351864783, 5187.84436466899, 5189.221616757441, 5243.737813109329, 4894.730789806595, 5015.724135172528, 5042.596592272609, 5227.0, 5287.603429742785, 5105.821296254613, 5141.100307446182, 5143.485651434827, 5157.07172708916, 5190.6107041972, 5123.590112790967, 5137.40919794221, 5140.640155189176, 5156.994386094675, 5202.1416466282635, 4095.24238015968, 4189.979050104791, 4191.350340697197, 4296.892577685583, 4309.116631090619, 3728.7762734236035, 3734.981325093357, 3759.6992240620684, 3788.3749181384765, 3789.4694742736037, 4457.977710111493, 4460.710053846555, 4479.7984090716, 4485.0, 4525.185466616041, 4868.610511159099, 4950.084234416572, 4992.750362481861, 5003.2995380646735, 5067.771950262247, 4447.933281000787, 4490.910181796346, 4514.751688657156, 4522.932156017662, 4541.977290113528, 4609.492955774862, 4620.97689511557, 4624.121416930772, 4626.074785043005, 4673.088747694167, 4628.884277893079, 4756.334113224082, 4796.37647105874, 4904.5340692634145, 4947.0, 5201.973990130025, 5209.53114219722, 5221.477852214748, 5224.9738751306, 5225.5819534437915, 4920.237363208708, 4921.3356196912955, 4925.236588328815, 4935.777889994887, 4949.1586430306215, 4925.605951523941, 4952.727599982036, 5012.223105418666, 5043.949560504348, 5086.516780905956, 5157.226416037624, 5160.48395160481, 5171.3018742469285, 5171.371622398008, 5213.843584692465, 4776.904461910673, 4991.176455884738, 4997.375328083989, 4998.6750861193905, 5007.048660754445, 4842.297866809364, 4883.072216278895, 4952.628552858478, 5012.248162775612, 5032.672876263031, 4843.200871856246, 4863.659543831898, 4873.390826146731, 4884.194107972145, 4910.042541704476, 4779.4742578317055, 4913.803447862046, 5012.874678133076, 5034.924476132787, 5063.392392912874, 4853.0779151961015, 4917.877053073702, 4930.852074437773, 4946.777395017305, 4981.850544483671], "unit": "score", "name": "dojo.html", "value": 4708.7199924218385}, {"lowerIsBetter": false, "replicates": [553.587577254945, 553.9972300138498, 555.1921953557575, 573.2089716191655, 577.517772659829, 34614.134646633815, 35585.82207088964, 35596.11009724752, 35734.82132589333, 35778.46332305014, 39017.60982390175, 39594.61418850341, 39701.02989701028, 39773.204535909266, 39778.60221397785, 7861.095973963011, 8026.277635012848, 8052.677892884278, 8085.595720213995, 8088.029436467632, 7724.343430808388, 7868.763937081868, 7905.565193914333, 7907.2488113629115, 7912.881306780403, 7939.047314322261, 7996.840063198732, 8033.598320084002, 8042.396820238476, 8043.798905027392, 7988.800279992988, 8009.439339246255, 8058.4761990471015, 8064.23389777976, 8078.757637270862, 7831.295183433518, 7973.441859069868, 7975.401844861659, 7981.640826162837, 7998.600069996477, 35524.64475355239, 35972.64027359719, 36026.27947441037, 36046.819765901004, 36108.81945590281, 2899.0143351260463, 2969.7624190064744, 3016.215783896203, 3135.5453459248283, 3287.474004159347, 26068.0, 26682.466350673072, 26779.866100669566, 26876.73123268762, 27082.187534373803, 3105.363400502914, 3172.4924012157944, 3176.8411579421168, 3190.6968837960358, 3212.710856022946, 210093.0, 210587.0, 211309.99999999846, 211318.0, 211476.0, 50506.242406363934, 50924.236136457985, 50981.235281470064, 51112.74443627758, 51126.0, 47645.52354476411, 48752.26871596929, 61448.0, 62604.373956260766, 62678.686606567586, 12793.872061279455, 12974.0, 12994.610161694975, 13021.283829389286, 13063.738725225443, 9428.434293942386, 9434.90565094354, 9476.715698528917, 9511.524423778783, 9524.90475095254, 17902.0, 18027.54931126706, 18053.368132115313, 18087.638247234983, 18139.81860181381, 7171.569705817667, 7289.562626242442, 7293.380062694624, 7318.121825380988, 7334.66993985272, 847.766864112374, 859.3254295378098, 874.8600223964136, 889.9243564296978, 1004.5278719002057, 22173.667394989086, 22266.77733222647, 22630.0, 22845.771542284365, 25505.48989020246, 950.9207049998301, 975.492743773234, 981.9312648114707, 1033.1734612310122, 1063.8616979792578, 14045.859541404456, 14064.85935140656, 14301.57095287143, 14310.713785724227, 14379.928100359431, 252917.0, 258548.0, 259275.0, 259721.0, 260419.0, 45055.77472112618, 45153.0, 45328.3200751989, 45391.31913021241, 45403.0, 1184.7500886564585, 1223.8103094020441, 1224.4979558381021, 1227.1532642476664, 1235.4193529041336, 25875.611865822404, 25955.610665840406, 26536.734632653428, 26641.067562635213, 26700.198994030212, 41878.16243675171, 42348.78825605852, 42723.86380681016, 42810.1437971245, 42912.35631465468, 198215.0, 199511.0, 199715.0, 199939.0, 199954.0, 27804.582931256453, 28536.85731571329, 28661.42677146487, 28747.28131796722, 28949.0, 33032.50451243185, 33077.503837441975, 33478.83260583682, 33983.660163398046, 34007.659923400446, 28590.0, 29165.708342917147, 29195.70804292015, 29210.123696289145, 29680.257993550335, 30668.386632267677, 31016.689833102282, 31413.52879706852, 31499.212519686276, 31759.84120079385, 30786.84606576953, 31224.687753122176, 31263.84368078145, 31471.842640787567, 31689.366212675155, 26211.73788262093, 28736.712632873405, 28781.136565903056, 28784.280392990342, 28893.855530722212, 22887.542249155256, 23036.654450182927, 30467.39065218639, 32354.83822580872, 32699.019029429157], "unit": "score", "name": "ext.html", "value": 16344.350340324654}, {"lowerIsBetter": false, "replicates": [333.66466700965526, 335.9714424273938, 338.27102593910104, 338.9068006298268, 339.60266488208794, 15169.54491365258, 15295.235238238085, 15952.36190552378, 16008.279627416765, 16581.005139691595, 14071.718565628707, 14139.505117320896, 14363.784543231859, 14390.928045359784, 14442.0, 4518.819247230115, 4570.725756454607, 4637.443506779191, 4648.604868586174, 4666.603338716213, 5107.948920510785, 5133.974330128344, 5140.0490909181735, 5143.4599367066485, 5148.794048238066, 3273.852676629557, 3378.6959173674363, 5096.515830996068, 5115.0, 5171.0692075426405, 5163.199704045879, 5193.376794784613, 5213.739313034371, 5222.955408918194, 5226.137687281594, 5026.84919452417, 5030.974845125787, 5040.16837221858, 5200.817971370984, 5214.191800270926, 11354.545818167264, 11639.418029098511, 11706.53173873044, 12825.679358016125, 18533.443996680122, 1894.1760334254643, 1902.1345287893976, 1910.6847370183903, 1987.2647120565339, 1989.234144854227, 9347.112024357675, 9373.953130234306, 9580.520973951345, 11480.0, 12421.130520863453, 1733.2893513659465, 1744.180235289412, 1794.1477798045823, 1796.4790210838842, 1817.1277786662345, 52068.739656301856, 52873.0, 54671.0, 54720.45279547193, 55033.1745023825, 9769.0, 9919.256055795844, 9970.651027214013, 9974.750631234132, 10034.09693127622, 12553.811692824615, 12558.560450384193, 12612.495500180074, 12615.432305546272, 12624.873751262554, 6847.109875716125, 6860.142482189726, 6930.3762661359715, 6938.653067346612, 6943.861122777516, 6481.384268494486, 6504.739810407626, 6504.837379065467, 6524.575902566318, 6535.379138981884, 4109.56849530795, 4129.607687269705, 4136.462259906193, 4166.895827604334, 4203.033302340479, 1794.9820501795075, 1798.6312805874763, 1804.927802887896, 1811.7191835265292, 1827.8080801515916, 368.54116624802293, 374.3542389378301, 399.11396699327446, 909.6770646420558, 952.3714348529937, 9849.60601575929, 9879.259055570861, 9924.35491693052, 9962.352447090916, 10033.197344212445, 398.1976317719797, 401.5482582095143, 402.4385981555772, 403.67302484987255, 405.5154090861451, 5306.602004849652, 5691.9146212806845, 5728.570357223225, 9028.954855225813, 9216.308776841764, 468096.0, 478009.0, 484289.0, 493137.0, 497587.0, 69434.0, 72515.63742181256, 72835.63582182056, 72937.27062729411, 73261.0, 1026.8049070676548, 1033.6278939581744, 1054.1145437832258, 1074.1374237656714, 1076.155218153761, 13847.653808654864, 14097.627314526582, 14819.0, 15192.46826361072, 15218.467353642569, 29395.55906661359, 29573.26066848346, 32550.186245344055, 33152.66847331496, 33458.33083338368, 41550.792246038574, 41729.37405938852, 42812.0, 42994.0, 46619.533804662875, 8666.913330866611, 8936.687215947411, 9087.454752714593, 9144.725658230263, 9148.176664100263, 10683.679489615324, 10709.143268538342, 10724.8927510727, 12615.621531354074, 16849.663006739553, 10728.89271107279, 13753.449862005407, 13913.234772087633, 14013.229272390117, 14139.64650883695, 12512.93743531313, 13338.333083345988, 13589.388477518733, 13938.512152074629, 14412.0, 14184.219867907364, 14254.857451425352, 14488.203148826495, 14493.92753036228, 14499.492517761828, 8911.331650126396, 8980.416272942239, 8991.910080899108, 9269.304802139732, 9316.20812230968, 11260.605878794202, 13946.093503922213, 14056.859431405965, 14070.718585628434, 14155.079919805592], "unit": "score", "name": "jquery.html", "value": 7742.262429691914}, {"lowerIsBetter": false, "replicates": [1465.626265302349, 1648.2994727240923, 1697.7198762204237, 1715.7597936288914, 1740.773699419075, 6016.2479690038745, 6177.166082578862, 7123.53697009694, 7412.258774122585, 7419.406447484202, 6851.314868513146, 6985.057017302663, 7028.472864535168, 7053.36519713227, 7068.61122638256, 2029.6752519596866, 2051.712760213571, 2053.38398480456, 2056.465319017059, 2057.609054279682, 2041.9489512762225, 2044.3049363216503, 2050.282401159597, 2080.209520382253, 2088.2691058129685, 2012.8490363222743, 2015.959680806383, 2026.189524190321, 2047.140201115535, 2048.641487739647, 2067.6588362920174, 2072.5647614000927, 2080.5318803269297, 2081.8022287882777, 2092.0, 2015.6472617291915, 2032.6442872497255, 2055.2395613622907, 2055.6710926251726, 2068.9551776352996, 7184.784456466262, 7242.0, 7263.709451621929, 7289.125304963385, 7292.453066020017, 4118.19695159444, 4163.084121493267, 4189.162167566499, 4216.367544868263, 4216.85241016566, 2669.466106778652, 2672.599110133476, 2711.8915243390243, 2767.4465106978687, 2768.792340574465, 868.2576397180446, 876.9079246679134, 881.9162179592928, 897.4166791585457, 906.8005038891433, 9747.415155090717, 9797.951010244904, 9842.015798420101, 9853.655122070693, 9870.555824987965, 3750.306193354238, 3751.8311675974646, 3795.2978698940783, 3865.555461121951, 3885.300645883768, 8463.942007249094, 8520.786980325542, 8538.06081331053, 8539.573021348908, 8571.742847714579, 3998.260321840469, 4010.298197815429, 4014.337634290368, 4036.0313524754433, 4043.9191216175514, 3071.8003329783937, 3129.4367013937253, 3645.489631451599, 3663.5603727552866, 3676.7058635309113, 3300.273939733255, 3372.6458721834347, 3406.199543107368, 3412.0, 3414.8463319150696, 1121.3720316622716, 1131.0216662586804, 1136.5567428702811, 1139.6182278936649, 1144.1704764046, 929.7350255177378, 972.9173020293213, 1165.6910918606577, 1188.3167178872184, 1200.5737963023175, 6731.562448440835, 6738.663066846736, 6753.223379311344, 6794.45644348451, 6816.488763342769, 1063.1760385700989, 1071.255477443185, 1074.9516271767789, 1086.2721976275914, 1097.3306283167262, 5411.431799661058, 5435.130379139318, 5464.3442786865035, 5468.48049435303, 5506.779728810883, 8558.957205213934, 8564.914350856412, 8780.868286975701, 8801.823963520821, 8865.202131808168, 8634.913650863411, 8684.478931264144, 8752.431091979, 8769.561521923879, 8776.341774366949, 6861.4853885958755, 6885.896711549331, 6938.5143039986715, 6976.895346569806, 7010.719571217094, 6673.9332606673315, 6712.093867327848, 6717.227518835396, 6729.394354508117, 6745.865082698417, 7663.080430348394, 7690.384769218337, 7869.724559640385, 7964.283214510722, 8000.0, 7874.606269686607, 8010.879836802569, 8104.554249516334, 8129.959350203211, 8204.0, 5129.48705129499, 5889.411058894077, 6004.249468816398, 6107.328193898757, 6114.602550834182, 6775.93224067753, 6783.18601767791, 6807.523473357016, 6813.591184528944, 6844.897326540006, 6216.564840461125, 6547.886859234037, 6589.505787066085, 6605.801825945229, 6605.834854128685, 6241.750329986931, 6333.936660633519, 6392.520560957853, 6450.903236451551, 6456.160699109086, 6566.967165164144, 6581.440577550962, 6604.405603495708, 6637.668116594247, 6653.0, 5968.522518198447, 6007.0, 6015.879682406415, 6016.578839481194, 6059.515238780975, 6053.545984051302, 6057.182280392267, 6086.421789929949, 6089.725962331794, 6092.573519853568], "unit": "score", "name": "mootools.html", "value": 4121.498459121118}, {"lowerIsBetter": false, "replicates": [294.51699213290203, 296.9257685578605, 299.17577075157936, 299.2772454522329, 305.2597451180886, 5523.337199536057, 5573.27547418835, 5602.1596760485945, 5664.980303545365, 5697.746495770934, 5499.752511136999, 5522.199281104237, 5560.0, 5603.2435621191125, 5613.382527921935, 4120.793960301988, 4278.828846846122, 4280.614744672979, 4285.742855428684, 4287.892802679942, 4226.556211597784, 4228.0, 4240.5971432714, 4264.552222016675, 4270.402143699869, 4200.0, 4204.390363397306, 4207.326827707568, 4216.367544868279, 4227.577242275778, 4196.782932949441, 4200.264953633102, 4202.075543380452, 4202.831886724527, 4209.494860616745, 3626.492291079251, 3639.7998110103936, 3641.326354624403, 3646.398344273192, 3649.5255616769914, 5258.947410525884, 5270.209468579706, 5382.542483888874, 5411.64824286424, 5415.9458405415835, 4797.784099715521, 4801.591864691505, 4801.831935882227, 4802.183628783116, 4804.663673542854, 5888.941110588882, 5899.469047785677, 5901.4098590141075, 5902.203202567642, 5902.439268269508, 3827.7511961722676, 3902.3366027775064, 3916.608339166089, 3922.490076290064, 3930.4104384342577, 6135.32511423743, 6184.134221209034, 6189.721462534152, 6189.721462534197, 6193.752249910043, 4083.9795801020805, 4085.142120154801, 4088.6729061674996, 4091.6726661867574, 4092.877213683594, 4147.19129769692, 4147.97926010368, 4151.066010147692, 4152.211079894811, 4158.792060396968, 4706.0823139487475, 4801.807927682923, 4807.399075115611, 4814.6870453420415, 4818.638602104857, 5855.707214639251, 5859.062549991981, 5860.970695146582, 5865.853353666193, 5885.588008839341, 1446.4142022480912, 1452.847451017628, 1460.2990564529086, 1462.0788902991048, 1462.6855226126222, 936.9578368973413, 958.6117622362954, 959.472290240365, 973.4110862927968, 973.6056896956744, 5038.168702164176, 5051.494850514919, 5071.290019397287, 5071.771770270347, 5075.264086707407, 6056.9697151513965, 6079.392060793885, 6086.330503644595, 6087.878242435127, 6088.086786981899, 5027.2207807789855, 5042.117629414838, 5054.064997975386, 5063.772130254148, 5068.391792984866, 3213.1645772099423, 3265.869365225412, 3286.76992610515, 3299.818509981926, 3313.022658315803, 5640.746166422521, 5665.405132461115, 5671.319441667027, 5722.570807189394, 5723.570732195102, 6313.873722525615, 6352.777652782131, 6362.395572420613, 6367.872642547123, 6370.617762934239, 5749.281339832521, 5754.05058165398, 5762.020456522485, 5765.423457654285, 5772.105323674753, 6130.049842274455, 6143.907841382294, 6156.230471191101, 6157.415045570664, 6167.629942203482, 5869.559783016205, 6045.727942242522, 6053.697315134137, 6066.3630318815885, 6079.118527813531, 5783.479486846204, 5788.131780232999, 5804.21643078179, 5806.709664516842, 5807.593468457168, 4050.270951228807, 4085.4893138357706, 4087.1212689271947, 4087.6321131098343, 4089.4070359798257, 6035.6076855004285, 6119.3268740437625, 6159.784407545714, 6168.383161683796, 6168.568200225941, 5914.142449344735, 5922.289325280822, 5936.050231962865, 5936.22829032223, 5940.55445841555, 5887.735051922759, 5907.822765317047, 5923.674197919156, 5926.111083337534, 5938.673372964528, 5610.49505544503, 5769.249997500298, 5774.393688662798, 5776.162456443708, 5797.652140871562, 5933.991221492443, 5936.257967754031, 5938.435848594377, 5948.405159484017, 5965.9105113422465, 5787.565932554991, 5795.942040579709, 5803.883922321615, 5811.651300921958, 5812.418758124154], "unit": "score", "name": "prototype.html", "value": 4359.812392908651}, {"lowerIsBetter": false, "replicates": [641.3137942401629, 703.8557095795366, 744.263179452342, 744.5193719361981, 775.5656832173983, 10373.844392334111, 10545.525451354688, 10562.102221311197, 10592.894071059287, 10614.681559553206, 10854.565817367296, 11001.559937602486, 11043.226974111816, 11049.834252486198, 11054.668359949215, 765.8085478630343, 784.6390660296271, 785.5208322923013, 801.8436404901047, 802.4222559756965, 774.423054824154, 782.374100719425, 783.8118851475633, 784.3333166808196, 787.5707739282076, 808.2079562029215, 810.4205493072452, 822.2229992656942, 823.7858156879195, 826.1531929772002, 809.1463506001166, 809.6154326694832, 816.7345612675874, 816.7713040348682, 816.8570500162507, 603.8912995660779, 609.7317180440637, 609.7560975609747, 612.2224774536314, 613.0436519030327, 10560.841587376195, 10635.46822658864, 10702.892971070267, 10721.83917241242, 10821.188410869216, 10887.18346124036, 11121.443927803577, 11190.944045279803, 11232.10143188543, 11262.099032077414, 9354.625814967394, 9446.38598491096, 9460.668876589287, 9523.666671666459, 9748.415095094317, 3145.3709258148233, 3204.6635103314047, 3208.1498402923244, 3210.951835722466, 3217.2439476722952, 38025.0, 38789.80605096985, 38983.0, 38983.41524877129, 39094.0, 8519.361047921431, 8533.658653653909, 8627.698030569025, 8810.06178640698, 8853.424527405698, 14831.184284864436, 14836.035657682216, 14881.0, 14883.33025013877, 14934.32795524204, 5905.143754155623, 5929.37741537141, 6019.187409699634, 6020.909686354708, 6157.907631385533, 3372.15696075981, 3468.1156305142026, 3511.4908338290807, 3528.788272703646, 3619.4027985382645, 2531.556977528962, 2552.0812507497285, 2555.8722063897103, 2567.833090849089, 2570.910018149356, 473.06333459749203, 476.69491525423757, 477.3722554840374, 481.8843477565429, 484.980600775965, 503.92693059506166, 542.6988021647944, 546.7402983582766, 560.0231183920766, 560.140184816305, 7176.892346614805, 7182.3535881770895, 7207.0, 7246.927530724625, 7342.339189472973, 500.4620033463968, 515.5617724933851, 527.6280222443245, 538.3996843519448, 539.0009197630349, 3334.2664613785414, 3383.678550537695, 3951.6245956634075, 3988.74073185242, 4083.571225021389, 44917.32624010643, 45146.54853451424, 48017.519824801304, 48047.519524805, 48650.51349486531, 41706.58293417027, 41837.37243941343, 41911.580884191375, 41938.161236775704, 42070.15859682789, 39710.0, 39804.402933956015, 39880.00299992581, 40072.198556028714, 40441.79779101086, 7738.92261077382, 7873.803154921173, 7996.800079997814, 8064.556449395105, 8077.0, 28780.712192877803, 29322.0, 29428.55857162187, 30372.69627303787, 32419.675803241666, 37479.25041499209, 37951.0, 38403.807980961035, 38479.0, 39015.41476877906, 9381.296402769683, 9485.430874147572, 9872.40765554069, 10030.147437467896, 10094.394336339843, 10813.837792432962, 10852.45737713127, 11029.338239705643, 11221.438928053727, 11475.081993440672, 10531.78936421252, 10849.67450976472, 11254.493547790533, 11409.372484513431, 11664.125190610908, 10377.504583306492, 10468.267221294436, 10574.206934479791, 10745.462726863781, 10996.175286853359, 9430.0, 9551.808963820824, 10579.94710026445, 10627.681169564925, 10631.681049568526, 8616.35377346689, 8798.956005219932, 8802.635591483331, 8837.248833849195, 9000.909990900007, 8081.555514446762, 8549.727601701952, 8681.2186903179, 8900.198982091642, 8927.910720892707], "unit": "score", "name": "yui.html", "value": 5528.463656592294}], "name": "dromaeo_css", "value": 6242.872633415295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 114.0, 113.0, 114.0, 124.0, 113.0, 114.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [166.0, 139.0, 152.0, 171.0, 130.0, 152.0, 167.0, 136.0, 165.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 163.0, 162.0, 162.0, 167.0, 162.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 75.0, 146.0, 74.0, 79.0, 72.0, 73.0, 147.0], "unit": "score", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 131.0, 95.0, 95.0, 95.0, 134.0, 94.0, 96.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 71.0, 71.0, 70.0, 72.0, 77.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 86.0, 85.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [142.0, 120.0, 129.0, 121.0, 124.0, 131.0, 122.0, 128.0, 118.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 147.0, 152.0, 150.0, 138.0, 148.0, 149.0, 149.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 71.0, 70.0, 70.0, 70.0, 68.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1542.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.69038208168644], "unit": "score", "name": "Richards", "value": 214.35374400000003}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1118.5682326621925], "unit": "score", "name": "RayTrace", "value": 661.550166}, {"lowerIsBetter": false, "replicates": [715.8196134574088], "unit": "score", "name": "Earley", "value": 931.0488110000001}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [592.4170616113744], "unit": "score", "name": "Splay", "value": 137.55680799999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21158.23521686157}]} 11:41:19 INFO - RETURN: dromaeo_css: 6242.87 11:41:19 INFO - RETURN: kraken: 1542.70 11:41:19 INFO - RETURN: v8_7: 21158.24 11:41:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21158.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6242.87"}}} 11:41:19 INFO - Return code: 0 11:41:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:41:19 INFO - # TBPL SUCCESS # 11:41:19 INFO - Running post-action listener: _resource_record_post_action 11:41:19 INFO - Running post-run listener: _resource_record_post_run 11:41:20 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507871232; Read time: 20; Write time: 360428 11:41:20 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231034880; Read time: 0; Write time: 227940 11:41:20 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269475840; Read time: 20; Write time: 129932 11:41:20 INFO - Running post-run listener: _upload_blobber_files 11:41:20 INFO - Blob upload gear active. 11:41:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:41:20 INFO - Copying logs to upload dir... 11:41:20 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.894716 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-15 11:41:20.819724) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 11:41:20.823667) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 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.010133 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:41:20.874390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:41:20.874722) ========= 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=f5f5a079460e1a9be8676904000001c1-1450207212.765725-79848632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 11:41:20.924139) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 11:41:20.924525) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 11:41:20.924823) ========= ========= Total master_lag: 0.22 =========