builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1449770264.37 results: success (0) buildid: 20151210085453 builduid: 9e10ebd8713c488886db737e60aa1182 revision: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.372512) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.373021) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.373365) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006240 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.405073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.405441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.461688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.462059) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004799 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.512023) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.512375) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.512777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.513119) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 09:57:44-- 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% 219M=0s 2015-12-10 09:57:44 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.720614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.720954) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018166 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.773811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:44.774185) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 --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 bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 --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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 09:57:45,023 truncating revision to first 12 chars 2015-12-10 09:57:45,023 Setting DEBUG logging. 2015-12-10 09:57:45,023 attempt 1/10 2015-12-10 09:57:45,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfa8b0451cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 09:57:45,473 unpacking tar archive at: fx-team-bfa8b0451cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733143 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:45.521195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:45.521529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:45.533009) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:45.533420) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 09:57:45.533938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-10 09:57:45.534301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:45 INFO - MultiFileLogger online at 20151210 09:57:45 in /builds/slave/test 09:57:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:57:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:45 INFO - {'append_to_log': False, 09:57:45 INFO - 'base_work_dir': '/builds/slave/test', 09:57:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:57:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:45 INFO - 'branch': 'Fx-Team-Non-PGO', 09:57:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:45 INFO - 'config_files': ('talos/linux_config.py',), 09:57:45 INFO - 'default_actions': ('clobber', 09:57:45 INFO - 'read-buildbot-config', 09:57:45 INFO - 'download-and-extract', 09:57:45 INFO - 'populate-webroot', 09:57:45 INFO - 'create-virtualenv', 09:57:45 INFO - 'install', 09:57:45 INFO - 'run-tests'), 09:57:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:45 INFO - 'download_minidump_stackwalk': True, 09:57:45 INFO - 'download_symbols': 'ondemand', 09:57:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:45 INFO - 'installer_path': 'installer.exe', 09:57:45 INFO - 'log_level': 'info', 09:57:45 INFO - 'log_name': 'talos', 09:57:45 INFO - 'log_to_console': True, 09:57:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:45 INFO - 'opt_config_files': (), 09:57:45 INFO - 'pip_index': False, 09:57:45 INFO - 'sps_profile': False, 09:57:45 INFO - 'sps_profile_interval': 0, 09:57:45 INFO - 'suite': 'dromaeojs', 09:57:45 INFO - 'system_bits': '64', 09:57:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:45 INFO - 'title': 'talos-linux64-ix-017', 09:57:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:45 INFO - 'use_talos_json': True, 09:57:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:45 INFO - 'work_dir': 'build'} 09:57:45 INFO - ##### 09:57:45 INFO - ##### Running clobber step. 09:57:45 INFO - ##### 09:57:45 INFO - Running pre-action listener: _resource_record_pre_action 09:57:45 INFO - Running main action method: clobber 09:57:45 INFO - rmtree: /builds/slave/test/build 09:57:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:46 INFO - Running post-action listener: _resource_record_post_action 09:57:46 INFO - ##### 09:57:46 INFO - ##### Running read-buildbot-config step. 09:57:46 INFO - ##### 09:57:46 INFO - Running pre-action listener: _resource_record_pre_action 09:57:46 INFO - Running main action method: read_buildbot_config 09:57:46 INFO - Using buildbot properties: 09:57:46 INFO - { 09:57:46 INFO - "properties": { 09:57:46 INFO - "buildnumber": 2198, 09:57:46 INFO - "product": "firefox", 09:57:46 INFO - "script_repo_revision": "production", 09:57:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:57:46 INFO - "repository": "", 09:57:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:57:46 INFO - "buildid": "20151210085453", 09:57:46 INFO - "slavename": "talos-linux64-ix-017", 09:57:46 INFO - "pgo_build": "False", 09:57:46 INFO - "basedir": "/builds/slave/test", 09:57:46 INFO - "project": "", 09:57:46 INFO - "platform": "ubuntu64_hw", 09:57:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:46 INFO - "slavebuilddir": "test", 09:57:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:57:46 INFO - "branch": "fx-team", 09:57:46 INFO - "repo_path": "integration/fx-team", 09:57:46 INFO - "stage_platform": "linux64", 09:57:46 INFO - "builduid": "9e10ebd8713c488886db737e60aa1182", 09:57:46 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:57:46 INFO - }, 09:57:46 INFO - "sourcestamp": { 09:57:46 INFO - "repository": "", 09:57:46 INFO - "hasPatch": false, 09:57:46 INFO - "project": "", 09:57:46 INFO - "branch": "fx-team-linux64-talos", 09:57:46 INFO - "changes": [ 09:57:46 INFO - { 09:57:46 INFO - "category": null, 09:57:46 INFO - "files": [ 09:57:46 INFO - { 09:57:46 INFO - "url": null, 09:57:46 INFO - "name": "https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:57:46 INFO - } 09:57:46 INFO - ], 09:57:46 INFO - "repository": "", 09:57:46 INFO - "rev": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0", 09:57:46 INFO - "who": "gijskruitbosch@gmail.com", 09:57:46 INFO - "when": 1449770259, 09:57:46 INFO - "number": 7258530, 09:57:46 INFO - "comments": "Bug 1224605 - also show the OSK when tapping in focused inputs, r=masayuki", 09:57:46 INFO - "project": "", 09:57:46 INFO - "at": "Thu 10 Dec 2015 09:57:39", 09:57:46 INFO - "branch": "fx-team-linux64-talos", 09:57:46 INFO - "revlink": "", 09:57:46 INFO - "properties": [ 09:57:46 INFO - [ 09:57:46 INFO - "buildid", 09:57:46 INFO - "20151210085453", 09:57:46 INFO - "Change" 09:57:46 INFO - ], 09:57:46 INFO - [ 09:57:46 INFO - "builduid", 09:57:46 INFO - "9e10ebd8713c488886db737e60aa1182", 09:57:46 INFO - "Change" 09:57:46 INFO - ], 09:57:46 INFO - [ 09:57:46 INFO - "pgo_build", 09:57:46 INFO - "False", 09:57:46 INFO - "Change" 09:57:46 INFO - ] 09:57:46 INFO - ], 09:57:46 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:57:46 INFO - } 09:57:46 INFO - ], 09:57:46 INFO - "revision": "bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0" 09:57:46 INFO - } 09:57:46 INFO - } 09:57:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:57:46 INFO - Running post-action listener: _resource_record_post_action 09:57:46 INFO - ##### 09:57:46 INFO - ##### Running download-and-extract step. 09:57:46 INFO - ##### 09:57:46 INFO - Running pre-action listener: _resource_record_pre_action 09:57:46 INFO - Running main action method: download_and_extract 09:57:46 INFO - mkdir: /builds/slave/test/build/tests 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json 09:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json 09:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:57:47 INFO - Downloaded 1302 bytes. 09:57:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:57:47 INFO - Using the following test package requirements: 09:57:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'jsshell-linux-x86_64.zip'], 09:57:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:57:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:57:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:57:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:57:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:47 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:49 INFO - Downloaded 21866925 bytes. 09:57:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:57:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:57:50 INFO - Return code: 0 09:57:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:50 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:54 INFO - Downloaded 21866925 bytes. 09:57:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:57:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:57:55 INFO - Return code: 0 09:57:55 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')]} 09:57:55 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:56 INFO - Downloaded 11132038 bytes. 09:57:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:57:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:57:56 INFO - Return code: 0 09:57:56 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')]} 09:57:56 INFO - https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:58 INFO - Downloaded 57727468 bytes. 09:57:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:58 INFO - mkdir: /builds/slave/test/properties 09:57:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:58 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:58 INFO - Contents: 09:57:58 INFO - build_url:https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:58 INFO - Running post-action listener: _resource_record_post_action 09:57:58 INFO - Running post-action listener: set_extra_try_arguments 09:57:58 INFO - ##### 09:57:58 INFO - ##### Running populate-webroot step. 09:57:58 INFO - ##### 09:57:58 INFO - Running pre-action listener: _resource_record_pre_action 09:57:58 INFO - Running main action method: populate_webroot 09:57:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:58 INFO - '--tppagecycles', 09:57:58 INFO - '7'], 09:57:58 INFO - 'tests': ['tsvgm']}}, 09:57:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'tests': ['damp', 'tps']}, 09:57:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['damp', 'tps']}, 09:57:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:58 INFO - 'other': {'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'other_l64': {'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:58 INFO - 'ts_paint', 09:57:58 INFO - 'tpaint', 09:57:58 INFO - 'sessionrestore', 09:57:58 INFO - 'sessionrestore_no_auto_restore']}, 09:57:58 INFO - 'svgr': {'tests': ['tsvgx', 09:57:58 INFO - 'tsvgr_opacity', 09:57:58 INFO - 'tart', 09:57:58 INFO - 'tscrollx', 09:57:58 INFO - 'cart']}, 09:57:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['tsvgx', 09:57:58 INFO - 'tsvgr_opacity', 09:57:58 INFO - 'tart', 09:57:58 INFO - 'tscrollx', 09:57:58 INFO - 'cart']}, 09:57:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'tests': ['tp5o']}, 09:57:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'talos_options': ['--e10s'], 09:57:58 INFO - 'tests': ['tp5o']}, 09:57:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'talos_options': ['--xperf_path', 09:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:58 INFO - 'tests': ['tp5n']}, 09:57:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:58 INFO - 'talos_options': ['--e10s', 09:57:58 INFO - '--xperf_path', 09:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:58 INFO - 'tests': ['tp5n']}}, 09:57:58 INFO - 'talos.zip': {'path': '', 09:57:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:58 INFO - Running post-action listener: _resource_record_post_action 09:57:58 INFO - ##### 09:57:58 INFO - ##### Running create-virtualenv step. 09:57:58 INFO - ##### 09:57:58 INFO - Running pre-action listener: _resource_record_pre_action 09:57:58 INFO - Running main action method: create_virtualenv 09:57:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:58 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 09:57:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:58 INFO - Using real prefix '/usr' 09:57:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:00 INFO - Installing pip.................done. 09:58:00 INFO - Return code: 0 09:58:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:00 INFO - Using env: {'DISPLAY': ':0', 09:58:00 INFO - 'HOME': '/home/cltbld', 09:58:00 INFO - 'LANG': 'en_US.UTF-8', 09:58:00 INFO - 'LANGUAGE': 'en_US:en', 09:58:00 INFO - 'LOGNAME': 'cltbld', 09:58:00 INFO - 'MAIL': '/var/mail/cltbld', 09:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:00 INFO - 'MOZ_NO_REMOTE': '1', 09:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:00 INFO - 'NO_EM_RESTART': '1', 09:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:00 INFO - 'PWD': '/builds/slave/test', 09:58:00 INFO - 'SHELL': '/bin/bash', 09:58:00 INFO - 'SHLVL': '1', 09:58:00 INFO - 'TERM': 'linux', 09:58:00 INFO - 'TMOUT': '86400', 09:58:00 INFO - 'USER': 'cltbld', 09:58:00 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:00 INFO - '_': '/tools/buildbot/bin/python'} 09:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:00 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 09:58:00 INFO - Cleaning up... 09:58:00 INFO - Return code: 0 09:58:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:58:00 INFO - Using env: {'DISPLAY': ':0', 09:58:00 INFO - 'HOME': '/home/cltbld', 09:58:00 INFO - 'LANG': 'en_US.UTF-8', 09:58:00 INFO - 'LANGUAGE': 'en_US:en', 09:58:00 INFO - 'LOGNAME': 'cltbld', 09:58:00 INFO - 'MAIL': '/var/mail/cltbld', 09:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:00 INFO - 'MOZ_NO_REMOTE': '1', 09:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:00 INFO - 'NO_EM_RESTART': '1', 09:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:00 INFO - 'PWD': '/builds/slave/test', 09:58:00 INFO - 'SHELL': '/bin/bash', 09:58:00 INFO - 'SHLVL': '1', 09:58:00 INFO - 'TERM': 'linux', 09:58:00 INFO - 'TMOUT': '86400', 09:58:00 INFO - 'USER': 'cltbld', 09:58:00 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:00 INFO - '_': '/tools/buildbot/bin/python'} 09:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:01 INFO - Downloading/unpacking psutil>=0.7.1 09:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:58:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:02 INFO - Installing collected packages: psutil 09:58:02 INFO - Running setup.py install for psutil 09:58:03 INFO - building 'psutil._psutil_linux' extension 09:58:03 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 09:58:03 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 09:58:03 INFO - building 'psutil._psutil_posix' extension 09:58:03 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 09:58:03 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 09:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:03 INFO - Successfully installed psutil 09:58:03 INFO - Cleaning up... 09:58:03 INFO - Return code: 0 09:58:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:58:03 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')]} 09:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 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')]} 09:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:03 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:03 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 09:58:03 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 09:58:03 INFO - Using env: {'DISPLAY': ':0', 09:58:03 INFO - 'HOME': '/home/cltbld', 09:58:03 INFO - 'LANG': 'en_US.UTF-8', 09:58:03 INFO - 'LANGUAGE': 'en_US:en', 09:58:03 INFO - 'LOGNAME': 'cltbld', 09:58:03 INFO - 'MAIL': '/var/mail/cltbld', 09:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:03 INFO - 'MOZ_NO_REMOTE': '1', 09:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:03 INFO - 'NO_EM_RESTART': '1', 09:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:03 INFO - 'PWD': '/builds/slave/test', 09:58:03 INFO - 'SHELL': '/bin/bash', 09:58:03 INFO - 'SHLVL': '1', 09:58:03 INFO - 'TERM': 'linux', 09:58:03 INFO - 'TMOUT': '86400', 09:58:03 INFO - 'USER': 'cltbld', 09:58:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:03 INFO - '_': '/tools/buildbot/bin/python'} 09:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:03 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 09:58:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:58:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:58:05 INFO - Installing collected packages: mozsystemmonitor 09:58:05 INFO - Running setup.py install for mozsystemmonitor 09:58:05 INFO - Successfully installed mozsystemmonitor 09:58:05 INFO - Cleaning up... 09:58:05 INFO - Return code: 0 09:58:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:05 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 09:58:05 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 09:58:05 INFO - Using env: {'DISPLAY': ':0', 09:58:05 INFO - 'HOME': '/home/cltbld', 09:58:05 INFO - 'LANG': 'en_US.UTF-8', 09:58:05 INFO - 'LANGUAGE': 'en_US:en', 09:58:05 INFO - 'LOGNAME': 'cltbld', 09:58:05 INFO - 'MAIL': '/var/mail/cltbld', 09:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:05 INFO - 'MOZ_NO_REMOTE': '1', 09:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:05 INFO - 'NO_EM_RESTART': '1', 09:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:05 INFO - 'PWD': '/builds/slave/test', 09:58:05 INFO - 'SHELL': '/bin/bash', 09:58:05 INFO - 'SHLVL': '1', 09:58:05 INFO - 'TERM': 'linux', 09:58:05 INFO - 'TMOUT': '86400', 09:58:05 INFO - 'USER': 'cltbld', 09:58:05 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:05 INFO - '_': '/tools/buildbot/bin/python'} 09:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:05 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 09:58:05 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 09:58:05 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 09:58:05 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 09:58:05 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 09:58:05 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 09:58:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:08 INFO - Downloading docopt-0.6.1.tar.gz 09:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:08 INFO - Running setup.py install for blobuploader 09:58:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:08 INFO - Running setup.py install for requests 09:58:08 INFO - Running setup.py install for docopt 09:58:08 INFO - Successfully installed blobuploader requests docopt 09:58:08 INFO - Cleaning up... 09:58:08 INFO - Return code: 0 09:58:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:08 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')]} 09:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:08 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')]} 09:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:08 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:08 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 09:58:08 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 09:58:08 INFO - Using env: {'DISPLAY': ':0', 09:58:08 INFO - 'HOME': '/home/cltbld', 09:58:08 INFO - 'LANG': 'en_US.UTF-8', 09:58:08 INFO - 'LANGUAGE': 'en_US:en', 09:58:08 INFO - 'LOGNAME': 'cltbld', 09:58:08 INFO - 'MAIL': '/var/mail/cltbld', 09:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:08 INFO - 'MOZ_NO_REMOTE': '1', 09:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:08 INFO - 'NO_EM_RESTART': '1', 09:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:08 INFO - 'PWD': '/builds/slave/test', 09:58:08 INFO - 'SHELL': '/bin/bash', 09:58:08 INFO - 'SHLVL': '1', 09:58:08 INFO - 'TERM': 'linux', 09:58:08 INFO - 'TMOUT': '86400', 09:58:08 INFO - 'USER': 'cltbld', 09:58:08 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:08 INFO - '_': '/tools/buildbot/bin/python'} 09:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:09 INFO - Running setup.py (path:/tmp/pip-5wtcCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:09 INFO - Running setup.py (path:/tmp/pip-Z5Vt2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:09 INFO - Running setup.py (path:/tmp/pip-H80kjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:09 INFO - Running setup.py (path:/tmp/pip-ZqHaXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:09 INFO - Running setup.py (path:/tmp/pip-zgI047-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:09 INFO - Running setup.py (path:/tmp/pip-H_sioI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:09 INFO - Running setup.py (path:/tmp/pip-RbcBAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:09 INFO - Running setup.py (path:/tmp/pip-iA6mkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:09 INFO - Running setup.py (path:/tmp/pip-XvM6to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:09 INFO - Running setup.py (path:/tmp/pip-sewDDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:09 INFO - Running setup.py (path:/tmp/pip-Il5cT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:09 INFO - Running setup.py (path:/tmp/pip-z8xiEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:09 INFO - Running setup.py (path:/tmp/pip-hvdjFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:09 INFO - Running setup.py (path:/tmp/pip-3FbZmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:10 INFO - Running setup.py (path:/tmp/pip-wbVe4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:10 INFO - Running setup.py (path:/tmp/pip-wjxRFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:10 INFO - Running setup.py (path:/tmp/pip-lf1xeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:10 INFO - Running setup.py install for manifestparser 09:58:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozcrash 09:58:10 INFO - Running setup.py install for mozdebug 09:58:10 INFO - Running setup.py install for mozdevice 09:58:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozfile 09:58:10 INFO - Running setup.py install for mozhttpd 09:58:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozinfo 09:58:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:10 INFO - Running setup.py install for mozInstall 09:58:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Running setup.py install for mozleak 09:58:11 INFO - Running setup.py install for mozlog 09:58:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Running setup.py install for moznetwork 09:58:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Running setup.py install for mozprocess 09:58:11 INFO - Running setup.py install for mozprofile 09:58:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Running setup.py install for mozrunner 09:58:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:11 INFO - Running setup.py install for mozscreenshot 09:58:11 INFO - Running setup.py install for moztest 09:58:11 INFO - Running setup.py install for mozversion 09:58:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:12 INFO - Cleaning up... 09:58:12 INFO - Return code: 0 09:58:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:12 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')]} 09:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:12 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')]} 09:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:12 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:12 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 09:58:12 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 09:58:12 INFO - Using env: {'DISPLAY': ':0', 09:58:12 INFO - 'HOME': '/home/cltbld', 09:58:12 INFO - 'LANG': 'en_US.UTF-8', 09:58:12 INFO - 'LANGUAGE': 'en_US:en', 09:58:12 INFO - 'LOGNAME': 'cltbld', 09:58:12 INFO - 'MAIL': '/var/mail/cltbld', 09:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:12 INFO - 'MOZ_NO_REMOTE': '1', 09:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:12 INFO - 'NO_EM_RESTART': '1', 09:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:12 INFO - 'PWD': '/builds/slave/test', 09:58:12 INFO - 'SHELL': '/bin/bash', 09:58:12 INFO - 'SHLVL': '1', 09:58:12 INFO - 'TERM': 'linux', 09:58:12 INFO - 'TMOUT': '86400', 09:58:12 INFO - 'USER': 'cltbld', 09:58:12 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:12 INFO - '_': '/tools/buildbot/bin/python'} 09:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:12 INFO - Running setup.py (path:/tmp/pip-3k7O9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:12 INFO - Running setup.py (path:/tmp/pip-7dy4oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:12 INFO - Running setup.py (path:/tmp/pip-EdP2q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:12 INFO - Running setup.py (path:/tmp/pip-uahtl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:12 INFO - Running setup.py (path:/tmp/pip-3K66DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:12 INFO - Running setup.py (path:/tmp/pip-zMBk3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:12 INFO - Running setup.py (path:/tmp/pip-iFhrtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:12 INFO - Running setup.py (path:/tmp/pip-k8Crwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:12 INFO - Running setup.py (path:/tmp/pip-ZVru09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:12 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)) 09:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:12 INFO - Running setup.py (path:/tmp/pip-87yDFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:13 INFO - Running setup.py (path:/tmp/pip-rIrnvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:13 INFO - Running setup.py (path:/tmp/pip-yIm2qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:13 INFO - Running setup.py (path:/tmp/pip-s0HIc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:13 INFO - Running setup.py (path:/tmp/pip-VLjiL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:13 INFO - Running setup.py (path:/tmp/pip-3NncZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:13 INFO - Running setup.py (path:/tmp/pip-YUuHBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:13 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)) 09:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:13 INFO - Running setup.py (path:/tmp/pip-NRq5zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:13 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)) 09:58:13 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)) 09:58:13 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)) 09:58:13 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)) 09:58:13 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)) 09:58:13 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)) 09:58:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:15 INFO - Downloading blessings-1.5.1.tar.gz 09:58:15 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 09:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:15 INFO - Installing collected packages: blessings 09:58:15 INFO - Running setup.py install for blessings 09:58:15 INFO - Successfully installed blessings 09:58:15 INFO - Cleaning up... 09:58:15 INFO - Return code: 0 09:58:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:15 INFO - Reading from file tmpfile_stdout 09:58:15 INFO - Current package versions: 09:58:15 INFO - argparse == 1.2.1 09:58:15 INFO - blessings == 1.5.1 09:58:15 INFO - blobuploader == 1.2.4 09:58:15 INFO - docopt == 0.6.1 09:58:15 INFO - manifestparser == 1.1 09:58:15 INFO - mozInstall == 1.12 09:58:15 INFO - mozcrash == 0.16 09:58:15 INFO - mozdebug == 0.1 09:58:15 INFO - mozdevice == 0.47 09:58:15 INFO - mozfile == 1.2 09:58:15 INFO - mozhttpd == 0.7 09:58:15 INFO - mozinfo == 0.9 09:58:15 INFO - mozleak == 0.1 09:58:15 INFO - mozlog == 3.1 09:58:15 INFO - moznetwork == 0.27 09:58:15 INFO - mozprocess == 0.22 09:58:15 INFO - mozprofile == 0.27 09:58:15 INFO - mozrunner == 6.11 09:58:15 INFO - mozscreenshot == 0.1 09:58:15 INFO - mozsystemmonitor == 0.0 09:58:15 INFO - moztest == 0.7 09:58:15 INFO - mozversion == 1.4 09:58:15 INFO - psutil == 3.1.1 09:58:15 INFO - requests == 1.2.3 09:58:15 INFO - wsgiref == 0.1.2 09:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:15 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:15 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 09:58:15 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 09:58:15 INFO - Using env: {'DISPLAY': ':0', 09:58:15 INFO - 'HOME': '/home/cltbld', 09:58:15 INFO - 'LANG': 'en_US.UTF-8', 09:58:15 INFO - 'LANGUAGE': 'en_US:en', 09:58:15 INFO - 'LOGNAME': 'cltbld', 09:58:15 INFO - 'MAIL': '/var/mail/cltbld', 09:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:15 INFO - 'MOZ_NO_REMOTE': '1', 09:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:15 INFO - 'NO_EM_RESTART': '1', 09:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:15 INFO - 'PWD': '/builds/slave/test', 09:58:15 INFO - 'SHELL': '/bin/bash', 09:58:15 INFO - 'SHLVL': '1', 09:58:15 INFO - 'TERM': 'linux', 09:58:15 INFO - 'TMOUT': '86400', 09:58:15 INFO - 'USER': 'cltbld', 09:58:15 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:15 INFO - '_': '/tools/buildbot/bin/python'} 09:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 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)) 09:58:15 INFO - Cleaning up... 09:58:15 INFO - Return code: 0 09:58:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:15 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:15 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 09:58:15 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 09:58:15 INFO - Using env: {'DISPLAY': ':0', 09:58:15 INFO - 'HOME': '/home/cltbld', 09:58:15 INFO - 'LANG': 'en_US.UTF-8', 09:58:15 INFO - 'LANGUAGE': 'en_US:en', 09:58:15 INFO - 'LOGNAME': 'cltbld', 09:58:15 INFO - 'MAIL': '/var/mail/cltbld', 09:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:15 INFO - 'MOZ_NO_REMOTE': '1', 09:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:15 INFO - 'NO_EM_RESTART': '1', 09:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:15 INFO - 'PWD': '/builds/slave/test', 09:58:15 INFO - 'SHELL': '/bin/bash', 09:58:15 INFO - 'SHLVL': '1', 09:58:15 INFO - 'TERM': 'linux', 09:58:15 INFO - 'TMOUT': '86400', 09:58:15 INFO - 'USER': 'cltbld', 09:58:15 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:15 INFO - '_': '/tools/buildbot/bin/python'} 09:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:16 INFO - Downloading/unpacking jsonschema 09:58:16 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 09:58:16 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 09:58:16 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 09:58:16 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 09:58:16 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 09:58:16 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 09:58:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:17 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 09:58:17 INFO - Downloading/unpacking functools32 (from jsonschema) 09:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:18 INFO - warning: no files found matching '*.txt' 09:58:18 INFO - no previously-included directories found matching 'build' 09:58:18 INFO - no previously-included directories found matching 'dist' 09:58:18 INFO - no previously-included directories found matching '.git*' 09:58:18 INFO - Installing collected packages: jsonschema, functools32 09:58:18 INFO - Running setup.py install for functools32 09:58:18 INFO - warning: no files found matching '*.txt' 09:58:18 INFO - no previously-included directories found matching 'build' 09:58:18 INFO - no previously-included directories found matching 'dist' 09:58:18 INFO - no previously-included directories found matching '.git*' 09:58:18 INFO - Successfully installed jsonschema functools32 09:58:18 INFO - Cleaning up... 09:58:18 INFO - Return code: 0 09:58:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:18 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 0x7f97f7589f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c12240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, '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': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', '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 09:58:18 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 09:58:18 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 09:58:18 INFO - Using env: {'DISPLAY': ':0', 09:58:18 INFO - 'HOME': '/home/cltbld', 09:58:18 INFO - 'LANG': 'en_US.UTF-8', 09:58:18 INFO - 'LANGUAGE': 'en_US:en', 09:58:18 INFO - 'LOGNAME': 'cltbld', 09:58:18 INFO - 'MAIL': '/var/mail/cltbld', 09:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:18 INFO - 'MOZ_NO_REMOTE': '1', 09:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:18 INFO - 'NO_EM_RESTART': '1', 09:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:18 INFO - 'PWD': '/builds/slave/test', 09:58:18 INFO - 'SHELL': '/bin/bash', 09:58:18 INFO - 'SHLVL': '1', 09:58:18 INFO - 'TERM': 'linux', 09:58:18 INFO - 'TMOUT': '86400', 09:58:18 INFO - 'USER': 'cltbld', 09:58:18 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:18 INFO - '_': '/tools/buildbot/bin/python'} 09:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:18 INFO - Downloading/unpacking flake8 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:23 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 09:58:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:23 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 09:58:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 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 09:58:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:23 INFO - no previously-included directories found matching 'docs/_build' 09:58:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:23 INFO - Running setup.py install for pep8 09:58:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:23 INFO - no previously-included directories found matching 'docs/_build' 09:58:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:23 INFO - Cleaning up... 09:58:23 INFO - Return code: 0 09:58:23 INFO - Running post-action listener: _resource_record_post_action 09:58:23 INFO - Running post-action listener: _start_resource_monitoring 09:58:24 INFO - Starting resource monitoring. 09:58:24 INFO - ##### 09:58:24 INFO - ##### Running install step. 09:58:24 INFO - ##### 09:58:24 INFO - Running pre-action listener: _resource_record_pre_action 09:58:24 INFO - Running main action method: install 09:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:24 INFO - Reading from file tmpfile_stdout 09:58:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:24 INFO - Reading from file tmpfile_stdout 09:58:24 INFO - Output received: 09:58:24 INFO - Usage: mozinstall [options] installer 09:58:24 INFO - Options: 09:58:24 INFO - -h, --help show this help message and exit 09:58:24 INFO - -d DEST, --destination=DEST 09:58:24 INFO - Directory to install application into. [default: 09:58:24 INFO - "/builds/slave/test"] 09:58:24 INFO - --app=APP Application being installed. [default: firefox] 09:58:24 INFO - mkdir: /builds/slave/test/build/application 09:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:58:38 INFO - Reading from file tmpfile_stdout 09:58:38 INFO - Output received: 09:58:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:38 INFO - Running post-action listener: _resource_record_post_action 09:58:38 INFO - ##### 09:58:38 INFO - ##### Running run-tests step. 09:58:38 INFO - ##### 09:58:38 INFO - Running pre-action listener: _resource_record_pre_action 09:58:38 INFO - Running main action method: run_tests 09:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:38 INFO - Python 2.7.3 09:58:38 INFO - Return code: 0 09:58:38 INFO - grabbing minidump binary from tooltool 09:58:38 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')]} 09:58:38 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 0x2ca10b0>, '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 0x2ca1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:38 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 09:58:38 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 09:58:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:38 INFO - Return code: 0 09:58:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:39 INFO - Return code: 0 09:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test/build 09:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 09:58:39 INFO - Using env: {'DISPLAY': ':0', 09:58:39 INFO - 'HOME': '/home/cltbld', 09:58:39 INFO - 'LANG': 'en_US.UTF-8', 09:58:39 INFO - 'LANGUAGE': 'en_US:en', 09:58:39 INFO - 'LOGNAME': 'cltbld', 09:58:39 INFO - 'MAIL': '/var/mail/cltbld', 09:58:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:39 INFO - 'MOZ_NO_REMOTE': '1', 09:58:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:39 INFO - 'NO_EM_RESTART': '1', 09:58:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:39 INFO - 'PWD': '/builds/slave/test', 09:58:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:39 INFO - 'SHELL': '/bin/bash', 09:58:39 INFO - 'SHLVL': '1', 09:58:39 INFO - 'TERM': 'linux', 09:58:39 INFO - 'TMOUT': '86400', 09:58:39 INFO - 'USER': 'cltbld', 09:58:39 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683', 09:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:39 INFO - '_': '/tools/buildbot/bin/python'} 09:58:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 09:58:40 INFO - mozversion INFO | application_buildid: 20151210085453 09:58:40 INFO - mozversion INFO | application_changeset: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 09:58:40 INFO - mozversion INFO | application_display_name: Nightly 09:58:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:40 INFO - mozversion INFO | application_name: Firefox 09:58:40 INFO - mozversion INFO | application_remotingname: firefox 09:58:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:58:40 INFO - mozversion INFO | application_vendor: Mozilla 09:58:40 INFO - mozversion INFO | application_version: 45.0a1 09:58:40 INFO - mozversion INFO | platform_buildid: 20151210085453 09:58:40 INFO - mozversion INFO | platform_changeset: bfa8b0451cfcc7d2825c9147e78c48657c9cd1c0 09:58:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:58:40 INFO - mozversion INFO | platform_version: 45.0a1 09:58:40 INFO - 2015-12-10 09:58:40,095 DEBUG : using testdate: 1449770320 09:58:40 INFO - 2015-12-10 09:58:40,095 DEBUG : actual date: 1449770320 09:58:40 INFO - 2015-12-10 09:58:40,107 INFO : starting webserver on 'localhost:56081' 09:58:40 INFO - 2015-12-10 09:58:40,108 INFO : Starting test suite talos-linux64-ix-017 09:58:40 INFO - 2015-12-10 09:58:40,108 INFO : Starting test dromaeo_css 09:58:40 INFO - 2015-12-10 09:58:40,108 DEBUG : operating with platform_type : linux_ 09:58:40 INFO - 2015-12-10 09:58:40,109 INFO : Initialising browser for dromaeo_css test... 09:58:40 INFO - 2015-12-10 09:58:40,125 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgq08k/profile http://localhost:56081/getInfo.html 09:58:44 INFO - 2015-12-10 09:58:44,327 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:58:44 INFO - 2015-12-10 09:58:44,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:58:44 INFO - 2015-12-10 09:58:44,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:58:44 INFO - 2015-12-10 09:58:44,327 DEBUG : BROWSER_OUTPUT: __metrics 09:58:44 INFO - 2015-12-10 09:58:44,489 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] 09:58:44 INFO - 2015-12-10 09:58:44,550 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:58:45 INFO - 2015-12-10 09:58:45,545 INFO : Browser initialized. 09:58:45 INFO - 2015-12-10 09:58:45,546 INFO : Running cycle 1/1 for dromaeo_css test... 09:58:45 INFO - 2015-12-10 09:58:45,546 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgq08k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:58:57 INFO - 2015-12-10 09:58:57,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 142839808 09:58:57 INFO - 2015-12-10 09:58:57,661 DEBUG : BROWSER_OUTPUT: 09:59:48 INFO - 2015-12-10 09:59:48,884 DEBUG : BROWSER_OUTPUT: 1449770388879 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:02:00 INFO - 2015-12-10 10:02:00,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56081/tests/dromaeo/cssquery-ext.html) 10:02:01 INFO - 2015-12-10 10:02:01,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 245338112 10:02:01 INFO - 2015-12-10 10:02:01,781 DEBUG : BROWSER_OUTPUT: 10:05:04 INFO - 2015-12-10 10:05:04,369 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-ext.html (next: http://localhost:56081/tests/dromaeo/cssquery-jquery.html) 10:05:04 INFO - 2015-12-10 10:05:04,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 220123136 10:05:04 INFO - 2015-12-10 10:05:04,943 DEBUG : BROWSER_OUTPUT: 10:08:06 INFO - 2015-12-10 10:08:06,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56081/tests/dromaeo/cssquery-mootools.html) 10:08:07 INFO - 2015-12-10 10:08:07,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 218701824 10:08:07 INFO - 2015-12-10 10:08:07,535 DEBUG : BROWSER_OUTPUT: 10:11:09 INFO - 2015-12-10 10:11:09,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56081/tests/dromaeo/cssquery-prototype.html) 10:11:10 INFO - 2015-12-10 10:11:10,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 201756672 10:11:10 INFO - 2015-12-10 10:11:10,026 DEBUG : BROWSER_OUTPUT: 10:14:12 INFO - 2015-12-10 10:14:12,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56081/tests/dromaeo/cssquery-yui.html) 10:14:13 INFO - 2015-12-10 10:14:13,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 204607488 10:14:13 INFO - 2015-12-10 10:14:13,421 DEBUG : BROWSER_OUTPUT: 10:17:15 INFO - 2015-12-10 10:17:15,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/dromaeo/cssquery-yui.html (next: http://localhost:56081/tests/dromaeo/cssquery-dojo.html) 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 271609856 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:16 INFO - 2015-12-10 10:17:16,237 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:16 INFO - 2015-12-10 10:17:16,241 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2600.1029644772552;2689.8789554470045;2696.11028360641;2697.8651067446635;2708.444768822391;4512.7969241384135;4578.359029735835;4650.813967441302;4651.813927442899;4669.6731228814;4543.727376357421;4621.0757848430285;4657.161710892038;4663.813447462106;4668.719876807394;4253.425787518676;4286.528481867;4342.3052311630145;4425.712328698624;4437.600615944564;4179.331306990882;4353.303471444569;4385.8464953726625;4443.777811109431;4445.599896009358;4141.358089496133;4247.490301163849;4266.445362102938;4310.073334233155;4314.633256173229;4334.783260836945;4339.414179085815;4341.131773645252;4345.065810850682;4365.388845561624;4318.784060796979;4325.199838029975;4331.0255192581735;4334.739915605074;4358.346248062784;4441.400410944513;4537.455505339348;4553.385292985437;4559.17934771741;4715.646326525524;4999.550040496373;5009.073321435546;5009.799608015675;5011.724355160465;5054.191329387317;5026.371703537058;5036.420811606676;5036.974815125901;5039.924401133986;5041.571466425358;4412.470503539564;4504.954950450519;4535.455745310518;4544.227481328182;4629.537046295411;5112.71880046601;5185.533302002762;5186.247994040843;5190.6107041971245;5231.241469986907;4944.851654450372;4970.204767237225;4970.875728106754;4975.925361119586;5017.949820501822;4804.351412559329;4811.302361157613;4916.827911023097;4932.1861892788;4938.259261110862;4910.8281210157475;4937.11131996237;4938;4938.506149385104;4976.950230497649;4919.409670839451;4921.557059864629;4926.211806111077;4927.260910863399;4978.452370239271;4028.4762980812893;4045.0494133878515;4116.91766164675;4139.648129908992;4152.958470415318;3605.134767655744;3635.5273814404486;3636.1091532574687;3661.707063434919;3667.156553992597;4309.525952145262;4327.913441731148;4329.242382583036;4334.111507141029;4368.126374725068;4666.230072038075;4824.204006338915;4825.782839772219;4846.61227101831;5032.169692000852;4304.5910638489295;4326.718763280377;4344.391785150082;4355.06366131277;4363.345498175299;4440.555944405533;4444.044530425974;4450.332450132506;4454.1982443159895;4488.663350248745;4546.227141385906;4647.4655414626395;4650.255959046536;4753.786079626356;4760.071786001766;4946.0355230729665;4994.550490455731;5002.874928126826;5045.369328833895;5045.974770126273;4744.810207591658;4752.287156926489;4755.714657120584;4756.476787553297;4791.113643975876;4780.306855506002;4921.876953076202;4960.280759289811;4964.776585053609;5010.899782004412;4902.068606964665;4935.531124543163;4951.282064100757;4953.851384458472;4988.850334489971;4816.847988821268;4818.855434336975;4832.299316599003;4832.395950506187;4860.562549370574;4667.509911459384;4784.784684689267;4827.42070951488;4827.493113223061;4866.367372241586;4681.7190968542;4706.670533062653;4774.40319960005;4783.569478746929;4825.252085926687;4855.732934688484;4859.052484765437;4860.78126484302;4864.829730959399;4914.803407863646;4533.773311334486;4715.292706094114;4763.16644587189;4768.189407800613;4796.832110876103 10:17:16 INFO - 2015-12-10 10:17:16,241 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.0342603286576;570.9029464990952;576.4235764235764;580.022661814842;589.9115132730088;27125.321866953313;27650.86174569127;27661;35914.64085359146;36756.081097972565;40222.396664050066;40683.79658101705;40831;40850.59149408505;40872.79563602185;7798.610069496531;7974.960125199366;8017.879731804028;8021.077576078767;8022.277994980451;7227.530210536298;7398.445116616248;10044.799104017915;10261.640842570512;10278.486075696186;10044.899551004506;10133.391996480197;10135.44255065971;10144.087032167103;10148.340357876714;7233.095863017123;7423.62881855905;10007.74980625483;10024.298299119064;10120.392776433364;9965.601375944954;10178.745531361701;10179.389236645826;10182.13451856593;10187.54156062979;37412;37910.810445947594;37962;37968.43047354292;37970.81014594909;2669.092508547084;2770.3766652503227;2840.8437535935514;2888.3068063664778;3078.415101130778;27070.1878943632;27306.31734206641;27326.5901011485;27405.588916166274;27547.173584792487;3420.8289585520624;3431.8284085795613;3459.2735525539665;3525.5593050868642;3550;212444;214161;214403;215618.99999999843;216549.91725041432;51685.7415712919;57123;57423.42576574264;57768.422315776304;57812;46869.76565117221;62272.68863655653;62858.685706571174;63357.366426335146;63428;13667.726645467035;13971.371288292052;13974.860251397558;13977.811885989804;13986.30068496571;9673.516324183762;9927.553260103168;10318.1745460363;10357.4303413313;10646.680599582025;19322.71015934762;19548;19637.109011577275;19688.31090911811;19724.40826775199;7612.429067819936;7862.8427431451055;7958.3893355184455;7960.4825686330205;8004.599770011476;773.3272053313653;777.9105402878628;793.4445887878508;891.7458524320538;1029.2537910015178;26299.660556008428;26658.01751453284;26964.191074267805;27093.1872043839;27101.457970840474;906.6418764588083;966.1739212972948;1063.8563793887881;1068.9946550267198;1084.162066285341;14046.648833779238;14102.224377659328;15183.924080379747;16318;16664.75002874958;312381;319364;319995;320816;321133;43228;43853.34219986703;49311.75344123256;49642.50357496379;55290.17064744032;1127.7913585986619;1137.6928229378186;1168.9941550292194;1171.6953592066125;1176.4294317256124;26129.477410452066;26735;26814.329641758333;27175.86412067927;27674.5848812272;37626.43560346542;38746.6125338743;43848.56151438445;44863;45158.32262515999;167140;167205;167859;168624;168825;29699.257518562208;29999.250018749706;30037;30113.247168820955;30126.69873301239;38722.2255554893;39871.40192897167;39888.60111398965;40306.1938761229;40427.3935890956;33501.32997339991;34054.31891362109;34128.31743365069;34449.827750861084;34566.30867382588;34382.14044648904;34496.827515862264;34593.6162553495;34684.82657586696;38056;32715;33326.33347332991;33487;33603.32793344168;33772.46706497072;28991.42017159603;29289.560656589743;30363.392732145676;30479.847600761856;30689.232769180948;24833;25567.360815979748;25848.224553263433;27047.1885843425;27154.592681110193 10:17:16 INFO - 2015-12-10 10:17:16,245 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.2837028055942;342.6984253856606;344.63985135533363;345.3956372649045;346.02421172294123;12660.43028063737;13146.868531314683;15185.696286074271;15269.16019618922;15559.92220038901;12640.178388404747;15233.162176080312;15750.212489375543;15885.285162167702;15931.291680414328;4912.501686985468;5084.3644544431945;5088.771005304751;5090.694558326494;5093;3764.2095160016293;3887.3391523441082;5058.317127187819;5117.02776472469;5118.3857937047605;5563.276774019372;5723.771049158028;5733.971330143343;5774.797882074128;5780.132980053005;5558.610897237195;5582.972085139589;5594.216809646653;5597.608167428281;5710.314762228539;4833.830815921426;4860.756962151913;4863;4866.51334866514;4904.779284932187;18901.243950241973;18940.526486837938;19126;19645.01774911249;19684.901575492175;1864.6736821056397;1871.5321169707572;1878.6524492968845;1928.7781905080956;1954.9413517594494;12444.564440244638;12564.81152782709;12566;12573.245605263623;13040;1753.2986805277862;1754.4380748705548;1768.8938663680221;1784.7455518228194;1794.874358794885;53024.73487632537;55213.44786552164;55662;56054.43945560574;56321.43678563203;8612.913870861212;8858.689945851993;9720;9721.076497732704;9745.707628771148;12196.14626976121;12348.259104453582;12370;12382.442790074288;12407.565735199225;6782.694778734969;6884.4148247399535;6896.827579310457;6900.447964162855;6902;6132.7546898124465;6207.720652570645;6215.96892015537;6216.906746398808;6412.67936603168;5672.659640421588;5770.88458230833;5785.190073389729;5803.593748437654;5880.235569375954;1493.3056128900114;1508.6530098077503;1646.2098192867252;1696.177353983317;1735.6962531556926;810.4529442626203;836.393614629401;843.8649816029406;918.7289749523907;927.823713494434;15693.372265109268;15850.286737096858;16373.754393684105;16385.016898986098;16673;768.9423293252917;790.6679194738224;825.3356048381111;902;919.1957037592107;6054.969725151346;9139.725808225763;9238.86141707875;9317.487538185329;9473.810523789485;446246;461136;464551;464915;466836;62406.37593624006;62640.68679656664;62744.372556273855;63221;63479.36520634734;1026.296986564206;1054.330500132406;1070.892910708923;1081.8431327457474;1082.6697857153645;13884.09753366028;14625.780613291023;14671.413143474569;14817;15068.246587670354;32729.18177045593;33411.164720882174;34017.65982340145;34053.82973085218;34361.656383435846;42830.571694282655;43270;45658.31512527381;45924;46016.7699161502;8466.661333546836;8614.78463038429;8639.136086391562;8660.523671198145;8727.040025597305;15750.842491575397;15919.602009949844;15939.681206376039;16226.837731622532;16349.264283107526;13095.672608184872;13239.404226809624;13644;13955.651108722363;14128.293585320898;12413.503459861866;12715.745685086062;13550.728985420434;13644.727105458034;13947.651308716957;11157.55369785232;11507.136964727511;11521.462281818662;13965.860341396456;14404;8823.250023748053;8836.248918841971;8855.424397414148;8894.110588941054;9072.047435019493;9693.41839489633;12734.61796146117;13578.864211358155;13893.444262229397;13963.930180349033 10:17:16 INFO - 2015-12-10 10:17:16,246 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1438.3671184678747;1621.262325641833;1693.7798086248786;1698.354625242408;1730.0571188702147;5886.764529418823;6887.3457021583;7019.052427922229;7022.683979220941;7031.789046328606;6937.653117344125;7070.85858282834;7127.8218044548785;7138.107736532934;7149.42804575634;2031.360121561707;2060.165632918663;2064.783197764236;2066.4833791552114;2066.628006958747;2058.166442590753;2080.4070839810656;2087.0503920716037;2099.8425118116124;2100.737407824022;2011.2055737983487;2054.9589008219828;2084.7810979847127;2085.9478513037143;2087.269455690511;2057.495913501194;2076.4497408186844;2080.219917530926;2080.490279881431;2084.0830034784644;2015.415529496459;2047.037892190668;2047.6109539187507;2052.353508644787;2052.98973505133;6977.1278590176225;7128.28717128283;7130.928690713078;7137.750178743771;7143.321384468467;4101.733387329844;4169.666426685888;4176.895577610554;4189.853355132555;4191.97904010478;2605.101240072172;2608.1914606471864;2627.487639910218;2661.5342315094977;2675.9063432779953;841.6549214821955;849.8937632795901;861.8836457078277;862.5385418800975;869.0483920107472;9340.206082482997;9364.063593640649;9374;9380.484073375894;9382.202512786422;3832.7125465590193;3843.2889915365186;3914.4911161549385;3919.2553414851086;3922.097917478996;8060.596970151469;8094.554799485967;8095;8095.069067057246;8102.473339233049;4233.047564298008;4249.2988656871885;4251.277282861921;4252.213340532012;4259.148170365939;3317.552130462405;3419.9740077976508;3705.110773414361;3883.08747444356;3888.4556162137324;3386.068831071475;3404.3191361727754;3408.403529382348;3436.244026314207;3442.6557344265875;1089.3790539392628;1101.5208384352832;1103.1175059952166;1108.667399780079;1112.3993043756282;928.382625553999;932.0772435289015;932.0818993291603;958.5159494455255;1164.0222213340664;6364.745410183541;6377.649229292433;6388.552801303864;6391.744330226832;6411.134496842959;439.4594648582198;442.5950255516167;443.20887216318715;447.28657790823587;447.9574440428219;5200.947990520122;5233.607479439057;5242.606804489678;5261.947380526222;5264.5525130363585;8103.351731861437;8187;8359.540225287546;8368.874466883002;8369.49783013021;8210.917890821134;8215.383846211558;8224;8292.087870334259;8303.750887473265;6135.723892424851;6369.490440764727;6413.903791443132;6421.967890160519;6424.38968298011;6672.566283191772;6753.527253092237;6759.695813688298;6760.526763126534;6760.93239067603;7442.516236444614;7640.197779233101;7648.120466146464;7736.419768517496;7747.1090824555895;7620.466567340233;7797.376209903307;7884.960575197088;7905.169957154416;7907.209279072047;5266.605004624592;5372.570194384518;5388.703621300866;6026.276846778414;6118.694065296806;5726.570507212059;6369.840753981188;6373.745050198126;6383.297837237993;6394.4564712;6134.877302454015;6225.28409232944;6225.564210505402;6285.779997700059;6414.93585064162;6059.757609695563;6060.606060606046;6089.604175728564;6106.664133472702;6202.534809889186;6125.724342404514;6164.321924588381;6178.876422471615;6179.721912513858;6184.350643182581;5845.298564172326;5855.912161317498;5877.882442351214;5895.20414744004;5896.941030589639;5796.449337312949;5827.446392592697;5911.261092363455;5914;5920.407959204045 10:17:16 INFO - 2015-12-10 10:17:16,247 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.0757666387526;304.2530587407914;307.24877674086866;308.7761373004572;313.9529070639405;5145.253938178967;5246.317978662773;5333.973330133349;5369.704666243355;5378;5185.481451854813;5238.030964271612;5260.158374660055;5270.420253772091;5284.762185701643;3868.0909986153233;3974.5230572331216;4092.017915700233;4096.406021126935;4097.590240975908;3988.441618173458;4055.756654600719;4055.9797201013953;4060;4064.2887494688457;4057.2088442753675;4060.878173654795;4061.8984525386954;4069.125138095309;4081.3469844824835;3848.749831260973;3942.2706799241946;4004.619561141687;4058.1680755445063;4065.89835254121;3596.37063513884;3606.242689035306;3610.6028336882923;3615.5480564929385;3633.200695846936;5042.142835717937;5047.167217409123;5054.090263752523;5060.696358218519;5071.087204303224;4708.034852855157;4729.905401891943;4732.1482133216;4733.431988161408;4742.525747425264;5331.466853314676;5496.615236933416;5507.008738427082;5515.365732940683;5549.667019978814;3986.4817573715522;3997.2605068062503;3997.420374045776;4000.0199951011896;4004.2191772604356;5726.3700992890745;5814.418558144152;5825.388334224887;5825.504832089277;5829.358770535237;4129.318662420667;4130.6282434581035;4132.152908653718;4132.8140233689555;4134.979325103415;4088.9795551022053;4136.131412403369;4169.45797046382;4172;4188.497380314382;4718.0328032753205;4720.858374248778;4727.078219747185;4729.763511824395;4737.715737055788;5540.556755459554;5543.8891222176135;5545.057340252167;5545.861353466115;5547.667139971614;1446.3997441061842;1475.6310922269433;1477.7340078785921;1477.807884974968;1478.6894752101964;1015.7105225010985;1015.8019186258756;1022.4785359466725;1031.128696251666;1044.9425281609585;4847.660663753503;4848.248521479177;4856.368672072608;4866.197077482176;4869.488703686133;5672.432756724294;5694.9430505695245;5710.143478478179;5721.485066344049;5726.885462290731;4797.64017698674;4815;4841.298011788271;4862.246351815475;4865.245886887538;2845.1180134158476;2949.5575663650625;3042.6196725409322;3051.359214564922;3084.151858238957;5459.426760190123;5464.26232458621;5466.1527463243265;5466.617336786387;5470.480304371078;5911.054231322968;5925.992581261196;5932.822015339547;5935.851603709942;5936;5400.351957765093;5433.646812957145;5444.210589464506;5449.427810080043;5460.5085542301385;5585.5252303553025;5743.396943320891;5744.305429898107;5756.971215143897;5763.97118014424;5622.634528755618;5640.60515763909;5648.63283886546;5654.575906806924;5655.943440565707;5387.084195686664;5439.673619582838;5447.891042179213;5451.672899626035;5458.235846981346;4111.527174374865;4118.5263694674295;4119.0937993641355;4121.216968775923;4128.793560322032;5572.77708891656;5765.5675824314185;5766.826995190151;5776.989026920356;5781.479666830005;5555.749991250323;5558.610897237317;5559.916601251065;5566.053770859045;5573.804916827891;5552.833414997556;5561.4716601922755;5565.860853478695;5570.749316280858;5572.693501857275;5300.231466437268;5433.755481003285;5437.265969094122;5441.619086663895;5442.619016668795;5582.692951887523;5594.748236329294;5595.132754423071;5596.86007849807;5598.972005139948;5249.422563517934;5284.180951952453;5389.27244821944;5456.972715136399;5473.808416705556 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: |5;yui.html;637.9792332268371;664.3754870421803;735.3308489274759;735.4226931858492;766.8657984852649;11522.942385288083;11606.419679016048;11638.941805290962;11689.941550292258;11711.999999999989;11864.584739534119;11995.160338776268;12004.099692523052;12022.63932082039;12027.51889924402;629.2134831460675;634.9206349206349;635.2630948100204;794.8648729715933;800.359712230215;803.863343231652;810.8864758933724;811.975640730776;812.0823469479479;815.9592020398986;837.2255663511258;849.647396330522;850.9531975741331;853.3599800149888;855.3841234311317;832.5837081459271;832.7210384521193;832.8292699996487;832.9625166867505;836.3601844588894;481.6123020968119;486.75905426813597;613.978510752126;623.3548277532777;624.0670198053894;11807.881921180764;11903.047756179485;11909.404529773563;11961.342126183057;11976;10636.893631063667;10711.83932241017;10929.672109836718;11138.832917506244;11999.820002699966;8395.118512556215;8577.699780507652;8615.181557752003;9417.246620270362;9494.145526902612;3216.6140063192333;3262.6247981482197;3274.4269752793166;3296.0770984124483;3342.548755917944;39832.601673983176;40032.59967400347;40296.395554066716;40368;40411;9016.8647470288;9200.263978881674;9330.90669093314;9364.765880853032;9574.904250957541;15663.37346506127;15663.451779187903;15676.451324203597;15689.607759806097;15726.370945162294;6304.590201636879;6307;6340.461060809791;6347.270063942613;6523.967380163163;2741.4791189674297;2813.9155825325274;2858.9285267868468;2879.510483217858;2944.8969286074885;2769.612254284402;2804.747572718424;2805.803593748418;2808.9859550702117;2812;479.72415860880136;530.1596968804411;536.0538649284017;539.0674133748637;547.6440313796064;430.47912026448347;444.27804817172097;461.6514531528674;526.4367127173887;545.3374150407274;6945.062416573698;6948;7001.8446956252665;7010.263922288188;7084.681189346492;428.88634511854383;445.89075676459476;498.4218306764136;548.4816848078607;556.5714399912046;3128.9834289356168;3298.455754800479;3360.2103505676146;3373.089265898243;3422.6748458896864;47525;48129.51870481321;48205.75897120492;48266;48438.27342589864;41545;42043.36934945978;42311;42786.14427711428;43153.35269970953;39787.2042559153;40590.79704601458;40712;40876.59123408787;40939.59060409417;6777.186737591521;6814.2163651180745;6855.897161542481;6958.234594194736;7006.474514411338;30387.2403189922;30471.695283046887;30765.23086922845;31587.684123158473;31745.20636984094;37646;37920;38546.80726596349;38616.6138338613;38639.22721545609;9691.854622180532;9910.653127140804;9987.450690212108;10086.94956525242;10133.79732405333;10697.946510267398;10740.227862402617;10990.725231869268;11048.558057677603;11224.214304998899;10014.499275036073;10279.691609251735;10307.587696492355;10322.298569604265;10459.320144190604;10146.18830493544;10213.489325533545;10568.682939511827;10608.469576520989;10692.946535267585;8995.640174393213;9226.953865230631;9860.406910627546;10162.847557286499;10472.581096756045;7154.534955227893;7917.920820791949;8050.919490805017;8069.559684018436;8294.253517183482;8027.759167224993;8792.604332805167;8799.164079412445;9012.143846334588;9056.27549796028 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771436236__endTimestamp 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,248 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4594.10 Median:4715.29 stddev:472.89 (10.0%) stddev-sans-first:447.72 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: Values: 2600.1 2689.9 2696.1 2697.9 2708.4 4512.8 4578.4 4650.8 4651.8 4669.7 4543.7 4621.1 4657.2 4663.8 4668.7 4253.4 4286.5 4342.3 4425.7 4437.6 4179.3 4353.3 4385.8 4443.8 4445.6 4141.4 4247.5 4266.4 4310.1 4314.6 4334.8 4339.4 4341.1 4345.1 4365.4 4318.8 4325.2 4331.0 4334.7 4358.3 4441.4 4537.5 4553.4 4559.2 4715.6 4999.6 5009.1 5009.8 5011.7 5054.2 5026.4 5036.4 5037.0 5039.9 5041.6 4412.5 4505.0 4535.5 4544.2 4629.5 5112.7 5185.5 5186.2 5190.6 5231.2 4944.9 4970.2 4970.9 4975.9 5017.9 4804.4 4811.3 4916.8 4932.2 4938.3 4910.8 4937.1 4938.0 4938.5 4977.0 4919.4 4921.6 4926.2 4927.3 4978.5 4028.5 4045.0 4116.9 4139.6 4153.0 3605.1 3635.5 3636.1 3661.7 3667.2 4309.5 4327.9 4329.2 4334.1 4368.1 4666.2 4824.2 4825.8 4846.6 5032.2 4304.6 4326.7 4344.4 4355.1 4363.3 4440.6 4444.0 4450.3 4454.2 4488.7 4546.2 4647.5 4650.3 4753.8 4760.1 4946.0 4994.6 5002.9 5045.4 5046.0 4744.8 4752.3 4755.7 4756.5 4791.1 4780.3 4921.9 4960.3 4964.8 5010.9 4902.1 4935.5 4951.3 4953.9 4988.9 4816.8 4818.9 4832.3 4832.4 4860.6 4667.5 4784.8 4827.4 4827.5 4866.4 4681.7 4706.7 4774.4 4783.6 4825.3 4855.7 4859.1 4860.8 4864.8 4914.8 4533.8 4715.3 4763.2 4768.2 4796.8 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40277.71 Median:315872.50 stddev:63352.04 (20.1%) stddev-sans-first:63459.54 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: Values: 553.0 570.9 576.4 580.0 589.9 27125.3 27650.9 27661.0 35914.6 36756.1 40222.4 40683.8 40831.0 40850.6 40872.8 7798.6 7975.0 8017.9 8021.1 8022.3 7227.5 7398.4 10044.8 10261.6 10278.5 10044.9 10133.4 10135.4 10144.1 10148.3 7233.1 7423.6 10007.7 10024.3 10120.4 9965.6 10178.7 10179.4 10182.1 10187.5 37412.0 37910.8 37962.0 37968.4 37970.8 2669.1 2770.4 2840.8 2888.3 3078.4 27070.2 27306.3 27326.6 27405.6 27547.2 3420.8 3431.8 3459.3 3525.6 3550.0 212444.0 214161.0 214403.0 215619.0 216549.9 51685.7 57123.0 57423.4 57768.4 57812.0 46869.8 62272.7 62858.7 63357.4 63428.0 13667.7 13971.4 13974.9 13977.8 13986.3 9673.5 9927.6 10318.2 10357.4 10646.7 19322.7 19548.0 19637.1 19688.3 19724.4 7612.4 7862.8 7958.4 7960.5 8004.6 773.3 777.9 793.4 891.7 1029.3 26299.7 26658.0 26964.2 27093.2 27101.5 906.6 966.2 1063.9 1069.0 1084.2 14046.6 14102.2 15183.9 16318.0 16664.8 312381.0 319364.0 319995.0 320816.0 321133.0 43228.0 43853.3 49311.8 49642.5 55290.2 1127.8 1137.7 1169.0 1171.7 1176.4 26129.5 26735.0 26814.3 27175.9 27674.6 37626.4 38746.6 43848.6 44863.0 45158.3 167140.0 167205.0 167859.0 168624.0 168825.0 29699.3 29999.3 30037.0 30113.2 30126.7 38722.2 39871.4 39888.6 40306.2 40427.4 33501.3 34054.3 34128.3 34449.8 34566.3 34382.1 34496.8 34593.6 34684.8 38056.0 32715.0 33326.3 33487.0 33603.3 33772.5 28991.4 29289.6 30363.4 30479.8 30689.2 24833.0 25567.4 25848.2 27047.2 27154.6 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25518.20 Median:23358.96 stddev:75147.19 (321.7%) stddev-sans-first:75334.21 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: Values: 340.3 342.7 344.6 345.4 346.0 12660.4 13146.9 15185.7 15269.2 15559.9 12640.2 15233.2 15750.2 15885.3 15931.3 4912.5 5084.4 5088.8 5090.7 5093.0 3764.2 3887.3 5058.3 5117.0 5118.4 5563.3 5723.8 5734.0 5774.8 5780.1 5558.6 5583.0 5594.2 5597.6 5710.3 4833.8 4860.8 4863.0 4866.5 4904.8 18901.2 18940.5 19126.0 19645.0 19684.9 1864.7 1871.5 1878.7 1928.8 1954.9 12444.6 12564.8 12566.0 12573.2 13040.0 1753.3 1754.4 1768.9 1784.7 1794.9 53024.7 55213.4 55662.0 56054.4 56321.4 8612.9 8858.7 9720.0 9721.1 9745.7 12196.1 12348.3 12370.0 12382.4 12407.6 6782.7 6884.4 6896.8 6900.4 6902.0 6132.8 6207.7 6216.0 6216.9 6412.7 5672.7 5770.9 5785.2 5803.6 5880.2 1493.3 1508.7 1646.2 1696.2 1735.7 810.5 836.4 843.9 918.7 927.8 15693.4 15850.3 16373.8 16385.0 16673.0 768.9 790.7 825.3 902.0 919.2 6055.0 9139.7 9238.9 9317.5 9473.8 446246.0 461136.0 464551.0 464915.0 466836.0 62406.4 62640.7 62744.4 63221.0 63479.4 1026.3 1054.3 1070.9 1081.8 1082.7 13884.1 14625.8 14671.4 14817.0 15068.2 32729.2 33411.2 34017.7 34053.8 34361.7 42830.6 43270.0 45658.3 45924.0 46016.8 8466.7 8614.8 8639.1 8660.5 8727.0 15750.8 15919.6 15939.7 16226.8 16349.3 13095.7 13239.4 13644.0 13955.7 14128.3 12413.5 12715.7 13550.7 13644.7 13947.7 11157.6 11507.1 11521.5 13965.9 14404.0 8823.3 8836.2 8855.4 8894.1 9072.0 9693.4 12734.6 13578.9 13893.4 13963.9 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,250 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4851.00 Median:5973.34 stddev:2518.63 (42.2%) stddev-sans-first:2512.64 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: Values: 1438.4 1621.3 1693.8 1698.4 1730.1 5886.8 6887.3 7019.1 7022.7 7031.8 6937.7 7070.9 7127.8 7138.1 7149.4 2031.4 2060.2 2064.8 2066.5 2066.6 2058.2 2080.4 2087.1 2099.8 2100.7 2011.2 2055.0 2084.8 2085.9 2087.3 2057.5 2076.4 2080.2 2080.5 2084.1 2015.4 2047.0 2047.6 2052.4 2053.0 6977.1 7128.3 7130.9 7137.8 7143.3 4101.7 4169.7 4176.9 4189.9 4192.0 2605.1 2608.2 2627.5 2661.5 2675.9 841.7 849.9 861.9 862.5 869.0 9340.2 9364.1 9374.0 9380.5 9382.2 3832.7 3843.3 3914.5 3919.3 3922.1 8060.6 8094.6 8095.0 8095.1 8102.5 4233.0 4249.3 4251.3 4252.2 4259.1 3317.6 3420.0 3705.1 3883.1 3888.5 3386.1 3404.3 3408.4 3436.2 3442.7 1089.4 1101.5 1103.1 1108.7 1112.4 928.4 932.1 932.1 958.5 1164.0 6364.7 6377.6 6388.6 6391.7 6411.1 439.5 442.6 443.2 447.3 448.0 5200.9 5233.6 5242.6 5261.9 5264.6 8103.4 8187.0 8359.5 8368.9 8369.5 8210.9 8215.4 8224.0 8292.1 8303.8 6135.7 6369.5 6413.9 6422.0 6424.4 6672.6 6753.5 6759.7 6760.5 6760.9 7442.5 7640.2 7648.1 7736.4 7747.1 7620.5 7797.4 7885.0 7905.2 7907.2 5266.6 5372.6 5388.7 6026.3 6118.7 5726.6 6369.8 6373.7 6383.3 6394.5 6134.9 6225.3 6225.6 6285.8 6414.9 6059.8 6060.6 6089.6 6106.7 6202.5 6125.7 6164.3 6178.9 6179.7 6184.4 5845.3 5855.9 5877.9 5895.2 5896.9 5796.4 5827.4 5911.3 5914.0 5920.4 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4613.34 Median:5165.37 stddev:1338.77 (25.9%) stddev-sans-first:1302.79 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: Values: 300.1 304.3 307.2 308.8 314.0 5145.3 5246.3 5334.0 5369.7 5378.0 5185.5 5238.0 5260.2 5270.4 5284.8 3868.1 3974.5 4092.0 4096.4 4097.6 3988.4 4055.8 4056.0 4060.0 4064.3 4057.2 4060.9 4061.9 4069.1 4081.3 3848.7 3942.3 4004.6 4058.2 4065.9 3596.4 3606.2 3610.6 3615.5 3633.2 5042.1 5047.2 5054.1 5060.7 5071.1 4708.0 4729.9 4732.1 4733.4 4742.5 5331.5 5496.6 5507.0 5515.4 5549.7 3986.5 3997.3 3997.4 4000.0 4004.2 5726.4 5814.4 5825.4 5825.5 5829.4 4129.3 4130.6 4132.2 4132.8 4135.0 4089.0 4136.1 4169.5 4172.0 4188.5 4718.0 4720.9 4727.1 4729.8 4737.7 5540.6 5543.9 5545.1 5545.9 5547.7 1446.4 1475.6 1477.7 1477.8 1478.7 1015.7 1015.8 1022.5 1031.1 1044.9 4847.7 4848.2 4856.4 4866.2 4869.5 5672.4 5694.9 5710.1 5721.5 5726.9 4797.6 4815.0 4841.3 4862.2 4865.2 2845.1 2949.6 3042.6 3051.4 3084.2 5459.4 5464.3 5466.2 5466.6 5470.5 5911.1 5926.0 5932.8 5935.9 5936.0 5400.4 5433.6 5444.2 5449.4 5460.5 5585.5 5743.4 5744.3 5757.0 5764.0 5622.6 5640.6 5648.6 5654.6 5655.9 5387.1 5439.7 5447.9 5451.7 5458.2 4111.5 4118.5 4119.1 4121.2 4128.8 5572.8 5765.6 5766.8 5777.0 5781.5 5555.7 5558.6 5559.9 5566.1 5573.8 5552.8 5561.5 5565.9 5570.7 5572.7 5300.2 5433.8 5437.3 5441.6 5442.6 5582.7 5594.7 5595.1 5596.9 5599.0 5249.4 5284.2 5389.3 5457.0 5473.8 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11874.19 Median:21798.82 stddev:13500.46 (61.9%) stddev-sans-first:13511.96 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: Values: 638.0 664.4 735.3 735.4 766.9 11522.9 11606.4 11638.9 11689.9 11712.0 11864.6 11995.2 12004.1 12022.6 12027.5 629.2 634.9 635.3 794.9 800.4 803.9 810.9 812.0 812.1 816.0 837.2 849.6 851.0 853.4 855.4 832.6 832.7 832.8 833.0 836.4 481.6 486.8 614.0 623.4 624.1 11807.9 11903.0 11909.4 11961.3 11976.0 10636.9 10711.8 10929.7 11138.8 11999.8 8395.1 8577.7 8615.2 9417.2 9494.1 3216.6 3262.6 3274.4 3296.1 3342.5 39832.6 40032.6 40296.4 40368.0 40411.0 9016.9 9200.3 9330.9 9364.8 9574.9 15663.4 15663.5 15676.5 15689.6 15726.4 6304.6 6307.0 6340.5 6347.3 6524.0 2741.5 2813.9 2858.9 2879.5 2944.9 2769.6 2804.7 2805.8 2809.0 2812.0 479.7 530.2 536.1 539.1 547.6 430.5 444.3 461.7 526.4 545.3 6945.1 6948.0 7001.8 7010.3 7084.7 428.9 445.9 498.4 548.5 556.6 3129.0 3298.5 3360.2 3373.1 3422.7 47525.0 48129.5 48205.8 48266.0 48438.3 41545.0 42043.4 42311.0 42786.1 43153.4 39787.2 40590.8 40712.0 40876.6 40939.6 6777.2 6814.2 6855.9 6958.2 7006.5 30387.2 30471.7 30765.2 31587.7 31745.2 37646.0 37920.0 38546.8 38616.6 38639.2 9691.9 9910.7 9987.5 10086.9 10133.8 10697.9 10740.2 10990.7 11048.6 11224.2 10014.5 10279.7 10307.6 10322.3 10459.3 10146.2 10213.5 10568.7 10608.5 10692.9 8995.6 9227.0 9860.4 10162.8 10472.6 7154.5 7917.9 8050.9 8069.6 8294.3 8027.8 8792.6 8799.2 9012.1 9056.3 10:17:16 INFO - 2015-12-10 10:17:16,252 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:16 INFO - 2015-12-10 10:17:16,253 DEBUG : BROWSER_OUTPUT: 10:17:16 INFO - 2015-12-10 10:17:16,971 INFO : Browser exited with error code: 0 10:17:16 INFO - 2015-12-10 10:17:16,994 INFO : Completed test dromaeo_css (00:18:36) 10:17:16 INFO - 2015-12-10 10:17:16,994 INFO : Starting test kraken 10:17:16 INFO - 2015-12-10 10:17:16,994 DEBUG : operating with platform_type : linux_ 10:17:16 INFO - 2015-12-10 10:17:16,994 INFO : Initialising browser for kraken test... 10:17:17 INFO - 2015-12-10 10:17:17,001 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOXCKrB/profile http://localhost:56081/getInfo.html 10:17:20 INFO - 2015-12-10 10:17:20,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:20 INFO - 2015-12-10 10:17:20,937 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:20 INFO - 2015-12-10 10:17:20,937 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:17:20 INFO - 2015-12-10 10:17:20,937 DEBUG : BROWSER_OUTPUT: __metrics 10:17:20 INFO - 2015-12-10 10:17:20,998 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:17:21 INFO - 2015-12-10 10:17:21,074 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:21 ERROR - 2015-12-10 10:17:21,081 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:17:21 INFO - 2015-12-10 10:17:21,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:17:21 INFO - 2015-12-10 10:17:21,971 INFO : Browser initialized. 10:17:21 INFO - 2015-12-10 10:17:21,972 INFO : Running cycle 1/1 for kraken test... 10:17:21 INFO - 2015-12-10 10:17:21,972 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOXCKrB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:17:33 INFO - 2015-12-10 10:17:33,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 141193216 10:17:33 INFO - 2015-12-10 10:17:33,987 DEBUG : BROWSER_OUTPUT: 10:17:36 INFO - 2015-12-10 10:17:36,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:37 INFO - 2015-12-10 10:17:37,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 173776896 10:17:37 INFO - 2015-12-10 10:17:37,212 DEBUG : BROWSER_OUTPUT: 10:17:39 INFO - 2015-12-10 10:17:39,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-dft) 10:17:40 INFO - 2015-12-10 10:17:40,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 163344384 10:17:40 INFO - 2015-12-10 10:17:40,478 DEBUG : BROWSER_OUTPUT: 10:17:43 INFO - 2015-12-10 10:17:43,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-fft) 10:17:44 INFO - 2015-12-10 10:17:44,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 151330816 10:17:44 INFO - 2015-12-10 10:17:44,063 DEBUG : BROWSER_OUTPUT: 10:17:46 INFO - 2015-12-10 10:17:46,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56081/tests/kraken/driver.html?testName=audio-oscillator) 10:17:46 INFO - 2015-12-10 10:17:46,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 153866240 10:17:46 INFO - 2015-12-10 10:17:46,676 DEBUG : BROWSER_OUTPUT: 10:17:48 INFO - 2015-12-10 10:17:48,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:49 INFO - 2015-12-10 10:17:49,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 155770880 10:17:49 INFO - 2015-12-10 10:17:49,470 DEBUG : BROWSER_OUTPUT: 10:17:52 INFO - 2015-12-10 10:17:52,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:53 INFO - 2015-12-10 10:17:53,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 155832320 10:17:53 INFO - 2015-12-10 10:17:53,051 DEBUG : BROWSER_OUTPUT: 10:17:56 INFO - 2015-12-10 10:17:56,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56081/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:57 INFO - 2015-12-10 10:17:57,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 156975104 10:17:57 INFO - 2015-12-10 10:17:57,012 DEBUG : BROWSER_OUTPUT: 10:17:59 INFO - 2015-12-10 10:17:59,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56081/tests/kraken/driver.html?testName=json-parse-financial) 10:18:00 INFO - 2015-12-10 10:18:00,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 156250112 10:18:00 INFO - 2015-12-10 10:18:00,443 DEBUG : BROWSER_OUTPUT: 10:18:02 INFO - 2015-12-10 10:18:02,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:02 INFO - 2015-12-10 10:18:02,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 165523456 10:18:02 INFO - 2015-12-10 10:18:02,806 DEBUG : BROWSER_OUTPUT: 10:18:04 INFO - 2015-12-10 10:18:04,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:05 INFO - 2015-12-10 10:18:05,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 164143104 10:18:05 INFO - 2015-12-10 10:18:05,307 DEBUG : BROWSER_OUTPUT: 10:18:07 INFO - 2015-12-10 10:18:07,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:08 INFO - 2015-12-10 10:18:08,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 180170752 10:18:08 INFO - 2015-12-10 10:18:08,035 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-10 10:18:10,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:11 INFO - 2015-12-10 10:18:11,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 184168448 10:18:11 INFO - 2015-12-10 10:18:11,150 DEBUG : BROWSER_OUTPUT: 10:18:13 INFO - 2015-12-10 10:18:13,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:14 INFO - 2015-12-10 10:18:14,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 181985280 10:18:14 INFO - 2015-12-10 10:18:14,314 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56081/tests/kraken/driver.html?testName=ai-astar) 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 239173632 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:16 INFO - 2015-12-10 10:18:16,300 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;105;112;113;111;104;112;113;105 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;135;153;164;135;150;150;132;166;130 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;161;165;162;164;164;162;161 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;91;71;73;72;108;97;74 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;126;95;95;96;130;94;95;125 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;110;109;109;109 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;147;146;146;146;146;146 10:18:16 INFO - 2015-12-10 10:18:16,301 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;71;71;71;70;71;81;70;70 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;69;69;69;68;68;69 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;83;86;86;83;84;86;83 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;124;119;120;123;118;122;120;130;127 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;143;147;147;146;134;149;149;143;134 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;68;68;68;68;67;68;70;68 10:18:16 INFO - 2015-12-10 10:18:16,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:16 INFO - 2015-12-10 10:18:16,303 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:18:16 INFO - 2015-12-10 10:18:16,303 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 10:18:16 INFO - 2015-12-10 10:18:16,303 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:18:16 INFO - 2015-12-10 10:18:16,303 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771496298__endTimestamp 10:18:16 INFO - 2015-12-10 10:18:16,303 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:3.90 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 105.0 112.0 113.0 111.0 104.0 112.0 113.0 105.0 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,311 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:151.50 stddev:13.21 (8.7%) stddev-sans-first:13.69 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: Values: 155.0 135.0 153.0 164.0 135.0 150.0 150.0 132.0 166.0 130.0 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.90 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 161.0 165.0 162.0 164.0 164.0 162.0 161.0 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:73.50 stddev:13.10 (17.8%) stddev-sans-first:13.45 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 91.0 71.0 73.0 72.0 108.0 97.0 74.0 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:95.00 stddev:15.51 (16.3%) stddev-sans-first:16.06 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 126.0 95.0 95.0 96.0 130.0 94.0 95.0 125.0 10:18:16 INFO - 2015-12-10 10:18:16,312 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.60 Median:71.00 stddev:3.34 (4.7%) stddev-sans-first:3.49 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 71.0 71.0 70.0 71.0 81.0 70.0 70.0 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,313 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 83.0 86.0 86.0 83.0 84.0 86.0 83.0 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.50 stddev:3.98 (3.3%) stddev-sans-first:3.94 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: Values: 118.0 124.0 119.0 120.0 123.0 118.0 122.0 120.0 130.0 127.0 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:146.50 stddev:6.00 (4.1%) stddev-sans-first:5.83 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: Values: 136.0 143.0 147.0 147.0 146.0 134.0 149.0 149.0 143.0 134.0 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 68.0 67.0 68.0 70.0 68.0 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:16 INFO - 2015-12-10 10:18:16,314 DEBUG : BROWSER_OUTPUT: 10:18:17 INFO - 2015-12-10 10:18:17,223 INFO : Browser exited with error code: 0 10:18:17 INFO - 2015-12-10 10:18:17,271 INFO : Completed test kraken (00:01:00) 10:18:17 INFO - 2015-12-10 10:18:17,271 INFO : Starting test v8_7 10:18:17 INFO - 2015-12-10 10:18:17,271 DEBUG : operating with platform_type : linux_ 10:18:17 INFO - 2015-12-10 10:18:17,271 INFO : Initialising browser for v8_7 test... 10:18:17 INFO - 2015-12-10 10:18:17,277 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5bS6Vz/profile http://localhost:56081/getInfo.html 10:18:21 INFO - 2015-12-10 10:18:21,104 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:18:21 INFO - 2015-12-10 10:18:21,104 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:18:21 INFO - 2015-12-10 10:18:21,104 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:18:21 INFO - 2015-12-10 10:18:21,105 DEBUG : BROWSER_OUTPUT: __metrics 10:18:21 INFO - 2015-12-10 10:18:21,169 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:18:21 INFO - 2015-12-10 10:18:21,229 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:21 ERROR - 2015-12-10 10:18:21,237 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:18:22 INFO - 2015-12-10 10:18:22,098 INFO : Browser initialized. 10:18:22 INFO - 2015-12-10 10:18:22,098 INFO : Running cycle 1/1 for v8_7 test... 10:18:22 INFO - 2015-12-10 10:18:22,099 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5bS6Vz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:18:34 INFO - 2015-12-10 10:18:34,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 143032320 10:18:34 INFO - 2015-12-10 10:18:34,113 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56081/tests/v8_7/run.html (next: http://localhost:56081/tests/v8_7/run.html) 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 440320000 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:55 INFO - 2015-12-10 10:18:55,727 DEBUG : BROWSER_OUTPUT: |0;Richards;165.23463317911435 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.15040953090096 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 10:18:55 INFO - 2015-12-10 10:18:55,728 DEBUG : BROWSER_OUTPUT: |8;Splay;614.6281499692686 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: __startTimestamp1449771535725__endTimestamp 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,729 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.23 Median:165.23 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: Values: 165.2 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: Values: 186.2 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: Values: 278.2 10:18:55 INFO - 2015-12-10 10:18:55,730 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,731 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,731 DEBUG : BROWSER_OUTPUT: Values: 5181.3 10:18:55 INFO - 2015-12-10 10:18:55,731 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,731 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,731 DEBUG : BROWSER_OUTPUT: Values: 1998.0 10:18:55 INFO - 2015-12-10 10:18:55,732 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,732 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,732 DEBUG : BROWSER_OUTPUT: Values: 794.3 10:18:55 INFO - 2015-12-10 10:18:55,732 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: Values: 12444.4 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: Values: 27027.0 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.63 Median:614.63 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,733 DEBUG : BROWSER_OUTPUT: Values: 614.6 10:18:55 INFO - 2015-12-10 10:18:55,734 DEBUG : BROWSER_OUTPUT: 10:18:55 INFO - 2015-12-10 10:18:55,734 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:18:55 INFO - 2015-12-10 10:18:55,734 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:18:55 INFO - 2015-12-10 10:18:55,734 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:55 INFO - 2015-12-10 10:18:55,734 DEBUG : BROWSER_OUTPUT: 10:18:56 INFO - 2015-12-10 10:18:56,667 INFO : Browser exited with error code: 0 10:18:56 INFO - 2015-12-10 10:18:56,679 INFO : Completed test v8_7 (00:00:39) 10:18:56 INFO - 2015-12-10 10:18:56,790 INFO : Completed test suite (00:20:16) 10:18:56 INFO - 2015-12-10 10:18:56,790 DEBUG : Working with test: dromaeo_css 10:18:56 INFO - 2015-12-10 10:18:56,790 DEBUG : Generating results file: dromaeo_css 10:18:56 INFO - 2015-12-10 10:18:56,792 DEBUG : Working with test: kraken 10:18:56 INFO - 2015-12-10 10:18:56,792 DEBUG : Generating results file: kraken 10:18:56 INFO - 2015-12-10 10:18:56,792 INFO : javascript benchmark 10:18:56 INFO - 2015-12-10 10:18:56,792 DEBUG : Working with test: v8_7 10:18:56 INFO - 2015-12-10 10:18:56,792 DEBUG : Generating results file: v8_7 10:18:56 INFO - 2015-12-10 10:18:56,793 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:56 INFO - 2015-12-10 10:18:56,842 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:18:56 INFO - 2015-12-10 10:18:56,842 DEBUG : process_Request line: dromaeo_css 6244.50 graph.html#tests=[[72,132,35]] 10:18:56 INFO - 2015-12-10 10:18:56,842 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:56 INFO - 2015-12-10 10:18:56,869 DEBUG : process_Request line: kraken 1513.00 graph.html#tests=[[232,132,35]] 10:18:56 INFO - 2015-12-10 10:18:56,869 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:56 INFO - 2015-12-10 10:18:56,900 DEBUG : process_Request line: v8_7 19710.32 graph.html#tests=[[230,132,35]] 10:18:56 INFO - 2015-12-10 10:18:56,901 INFO : javascript benchmark 10:18:56 INFO - 2015-12-10 10:18:56,905 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2600.1029644772552, 2689.8789554470045, 2696.11028360641, 2697.8651067446635, 2708.444768822391, 4512.7969241384135, 4578.359029735835, 4650.813967441302, 4651.813927442899, 4669.6731228814, 4543.727376357421, 4621.0757848430285, 4657.161710892038, 4663.813447462106, 4668.719876807394, 4253.425787518676, 4286.528481867, 4342.3052311630145, 4425.712328698624, 4437.600615944564, 4179.331306990882, 4353.303471444569, 4385.8464953726625, 4443.777811109431, 4445.599896009358, 4141.358089496133, 4247.490301163849, 4266.445362102938, 4310.073334233155, 4314.633256173229, 4334.783260836945, 4339.414179085815, 4341.131773645252, 4345.065810850682, 4365.388845561624, 4318.784060796979, 4325.199838029975, 4331.0255192581735, 4334.739915605074, 4358.346248062784, 4441.400410944513, 4537.455505339348, 4553.385292985437, 4559.17934771741, 4715.646326525524, 4999.550040496373, 5009.073321435546, 5009.799608015675, 5011.724355160465, 5054.191329387317, 5026.371703537058, 5036.420811606676, 5036.974815125901, 5039.924401133986, 5041.571466425358, 4412.470503539564, 4504.954950450519, 4535.455745310518, 4544.227481328182, 4629.537046295411, 5112.71880046601, 5185.533302002762, 5186.247994040843, 5190.6107041971245, 5231.241469986907, 4944.851654450372, 4970.204767237225, 4970.875728106754, 4975.925361119586, 5017.949820501822, 4804.351412559329, 4811.302361157613, 4916.827911023097, 4932.1861892788, 4938.259261110862, 4910.8281210157475, 4937.11131996237, 4938.0, 4938.506149385104, 4976.950230497649, 4919.409670839451, 4921.557059864629, 4926.211806111077, 4927.260910863399, 4978.452370239271, 4028.4762980812893, 4045.0494133878515, 4116.91766164675, 4139.648129908992, 4152.958470415318, 3605.134767655744, 3635.5273814404486, 3636.1091532574687, 3661.707063434919, 3667.156553992597, 4309.525952145262, 4327.913441731148, 4329.242382583036, 4334.111507141029, 4368.126374725068, 4666.230072038075, 4824.204006338915, 4825.782839772219, 4846.61227101831, 5032.169692000852, 4304.5910638489295, 4326.718763280377, 4344.391785150082, 4355.06366131277, 4363.345498175299, 4440.555944405533, 4444.044530425974, 4450.332450132506, 4454.1982443159895, 4488.663350248745, 4546.227141385906, 4647.4655414626395, 4650.255959046536, 4753.786079626356, 4760.071786001766, 4946.0355230729665, 4994.550490455731, 5002.874928126826, 5045.369328833895, 5045.974770126273, 4744.810207591658, 4752.287156926489, 4755.714657120584, 4756.476787553297, 4791.113643975876, 4780.306855506002, 4921.876953076202, 4960.280759289811, 4964.776585053609, 5010.899782004412, 4902.068606964665, 4935.531124543163, 4951.282064100757, 4953.851384458472, 4988.850334489971, 4816.847988821268, 4818.855434336975, 4832.299316599003, 4832.395950506187, 4860.562549370574, 4667.509911459384, 4784.784684689267, 4827.42070951488, 4827.493113223061, 4866.367372241586, 4681.7190968542, 4706.670533062653, 4774.40319960005, 4783.569478746929, 4825.252085926687, 4855.732934688484, 4859.052484765437, 4860.78126484302, 4864.829730959399, 4914.803407863646, 4533.773311334486, 4715.292706094114, 4763.16644587189, 4768.189407800613, 4796.832110876103], "unit": "ms", "name": "dojo.html", "value": 4565.074527506828}, {"lowerIsBetter": false, "replicates": [553.0342603286576, 570.9029464990952, 576.4235764235764, 580.022661814842, 589.9115132730088, 27125.321866953313, 27650.86174569127, 27661.0, 35914.64085359146, 36756.081097972565, 40222.396664050066, 40683.79658101705, 40831.0, 40850.59149408505, 40872.79563602185, 7798.610069496531, 7974.960125199366, 8017.879731804028, 8021.077576078767, 8022.277994980451, 7227.530210536298, 7398.445116616248, 10044.799104017915, 10261.640842570512, 10278.486075696186, 10044.899551004506, 10133.391996480197, 10135.44255065971, 10144.087032167103, 10148.340357876714, 7233.095863017123, 7423.62881855905, 10007.74980625483, 10024.298299119064, 10120.392776433364, 9965.601375944954, 10178.745531361701, 10179.389236645826, 10182.13451856593, 10187.54156062979, 37412.0, 37910.810445947594, 37962.0, 37968.43047354292, 37970.81014594909, 2669.092508547084, 2770.3766652503227, 2840.8437535935514, 2888.3068063664778, 3078.415101130778, 27070.1878943632, 27306.31734206641, 27326.5901011485, 27405.588916166274, 27547.173584792487, 3420.8289585520624, 3431.8284085795613, 3459.2735525539665, 3525.5593050868642, 3550.0, 212444.0, 214161.0, 214403.0, 215618.99999999843, 216549.91725041432, 51685.7415712919, 57123.0, 57423.42576574264, 57768.422315776304, 57812.0, 46869.76565117221, 62272.68863655653, 62858.685706571174, 63357.366426335146, 63428.0, 13667.726645467035, 13971.371288292052, 13974.860251397558, 13977.811885989804, 13986.30068496571, 9673.516324183762, 9927.553260103168, 10318.1745460363, 10357.4303413313, 10646.680599582025, 19322.71015934762, 19548.0, 19637.109011577275, 19688.31090911811, 19724.40826775199, 7612.429067819936, 7862.8427431451055, 7958.3893355184455, 7960.4825686330205, 8004.599770011476, 773.3272053313653, 777.9105402878628, 793.4445887878508, 891.7458524320538, 1029.2537910015178, 26299.660556008428, 26658.01751453284, 26964.191074267805, 27093.1872043839, 27101.457970840474, 906.6418764588083, 966.1739212972948, 1063.8563793887881, 1068.9946550267198, 1084.162066285341, 14046.648833779238, 14102.224377659328, 15183.924080379747, 16318.0, 16664.75002874958, 312381.0, 319364.0, 319995.0, 320816.0, 321133.0, 43228.0, 43853.34219986703, 49311.75344123256, 49642.50357496379, 55290.17064744032, 1127.7913585986619, 1137.6928229378186, 1168.9941550292194, 1171.6953592066125, 1176.4294317256124, 26129.477410452066, 26735.0, 26814.329641758333, 27175.86412067927, 27674.5848812272, 37626.43560346542, 38746.6125338743, 43848.56151438445, 44863.0, 45158.32262515999, 167140.0, 167205.0, 167859.0, 168624.0, 168825.0, 29699.257518562208, 29999.250018749706, 30037.0, 30113.247168820955, 30126.69873301239, 38722.2255554893, 39871.40192897167, 39888.60111398965, 40306.1938761229, 40427.3935890956, 33501.32997339991, 34054.31891362109, 34128.31743365069, 34449.827750861084, 34566.30867382588, 34382.14044648904, 34496.827515862264, 34593.6162553495, 34684.82657586696, 38056.0, 32715.0, 33326.33347332991, 33487.0, 33603.32793344168, 33772.46706497072, 28991.42017159603, 29289.560656589743, 30363.392732145676, 30479.847600761856, 30689.232769180948, 24833.0, 25567.360815979748, 25848.224553263433, 27047.1885843425, 27154.592681110193], "unit": "ms", "name": "ext.html", "value": 17275.123924026622}, {"lowerIsBetter": false, "replicates": [340.2837028055942, 342.6984253856606, 344.63985135533363, 345.3956372649045, 346.02421172294123, 12660.43028063737, 13146.868531314683, 15185.696286074271, 15269.16019618922, 15559.92220038901, 12640.178388404747, 15233.162176080312, 15750.212489375543, 15885.285162167702, 15931.291680414328, 4912.501686985468, 5084.3644544431945, 5088.771005304751, 5090.694558326494, 5093.0, 3764.2095160016293, 3887.3391523441082, 5058.317127187819, 5117.02776472469, 5118.3857937047605, 5563.276774019372, 5723.771049158028, 5733.971330143343, 5774.797882074128, 5780.132980053005, 5558.610897237195, 5582.972085139589, 5594.216809646653, 5597.608167428281, 5710.314762228539, 4833.830815921426, 4860.756962151913, 4863.0, 4866.51334866514, 4904.779284932187, 18901.243950241973, 18940.526486837938, 19126.0, 19645.01774911249, 19684.901575492175, 1864.6736821056397, 1871.5321169707572, 1878.6524492968845, 1928.7781905080956, 1954.9413517594494, 12444.564440244638, 12564.81152782709, 12566.0, 12573.245605263623, 13040.0, 1753.2986805277862, 1754.4380748705548, 1768.8938663680221, 1784.7455518228194, 1794.874358794885, 53024.73487632537, 55213.44786552164, 55662.0, 56054.43945560574, 56321.43678563203, 8612.913870861212, 8858.689945851993, 9720.0, 9721.076497732704, 9745.707628771148, 12196.14626976121, 12348.259104453582, 12370.0, 12382.442790074288, 12407.565735199225, 6782.694778734969, 6884.4148247399535, 6896.827579310457, 6900.447964162855, 6902.0, 6132.7546898124465, 6207.720652570645, 6215.96892015537, 6216.906746398808, 6412.67936603168, 5672.659640421588, 5770.88458230833, 5785.190073389729, 5803.593748437654, 5880.235569375954, 1493.3056128900114, 1508.6530098077503, 1646.2098192867252, 1696.177353983317, 1735.6962531556926, 810.4529442626203, 836.393614629401, 843.8649816029406, 918.7289749523907, 927.823713494434, 15693.372265109268, 15850.286737096858, 16373.754393684105, 16385.016898986098, 16673.0, 768.9423293252917, 790.6679194738224, 825.3356048381111, 902.0, 919.1957037592107, 6054.969725151346, 9139.725808225763, 9238.86141707875, 9317.487538185329, 9473.810523789485, 446246.0, 461136.0, 464551.0, 464915.0, 466836.0, 62406.37593624006, 62640.68679656664, 62744.372556273855, 63221.0, 63479.36520634734, 1026.296986564206, 1054.330500132406, 1070.892910708923, 1081.8431327457474, 1082.6697857153645, 13884.09753366028, 14625.780613291023, 14671.413143474569, 14817.0, 15068.246587670354, 32729.18177045593, 33411.164720882174, 34017.65982340145, 34053.82973085218, 34361.656383435846, 42830.571694282655, 43270.0, 45658.31512527381, 45924.0, 46016.7699161502, 8466.661333546836, 8614.78463038429, 8639.136086391562, 8660.523671198145, 8727.040025597305, 15750.842491575397, 15919.602009949844, 15939.681206376039, 16226.837731622532, 16349.264283107526, 13095.672608184872, 13239.404226809624, 13644.0, 13955.651108722363, 14128.293585320898, 12413.503459861866, 12715.745685086062, 13550.728985420434, 13644.727105458034, 13947.651308716957, 11157.55369785232, 11507.136964727511, 11521.462281818662, 13965.860341396456, 14404.0, 8823.250023748053, 8836.248918841971, 8855.424397414148, 8894.110588941054, 9072.047435019493, 9693.41839489633, 12734.61796146117, 13578.864211358155, 13893.444262229397, 13963.930180349033], "unit": "ms", "name": "jquery.html", "value": 8330.5161256115}, {"lowerIsBetter": false, "replicates": [1438.3671184678747, 1621.262325641833, 1693.7798086248786, 1698.354625242408, 1730.0571188702147, 5886.764529418823, 6887.3457021583, 7019.052427922229, 7022.683979220941, 7031.789046328606, 6937.653117344125, 7070.85858282834, 7127.8218044548785, 7138.107736532934, 7149.42804575634, 2031.360121561707, 2060.165632918663, 2064.783197764236, 2066.4833791552114, 2066.628006958747, 2058.166442590753, 2080.4070839810656, 2087.0503920716037, 2099.8425118116124, 2100.737407824022, 2011.2055737983487, 2054.9589008219828, 2084.7810979847127, 2085.9478513037143, 2087.269455690511, 2057.495913501194, 2076.4497408186844, 2080.219917530926, 2080.490279881431, 2084.0830034784644, 2015.415529496459, 2047.037892190668, 2047.6109539187507, 2052.353508644787, 2052.98973505133, 6977.1278590176225, 7128.28717128283, 7130.928690713078, 7137.750178743771, 7143.321384468467, 4101.733387329844, 4169.666426685888, 4176.895577610554, 4189.853355132555, 4191.97904010478, 2605.101240072172, 2608.1914606471864, 2627.487639910218, 2661.5342315094977, 2675.9063432779953, 841.6549214821955, 849.8937632795901, 861.8836457078277, 862.5385418800975, 869.0483920107472, 9340.206082482997, 9364.063593640649, 9374.0, 9380.484073375894, 9382.202512786422, 3832.7125465590193, 3843.2889915365186, 3914.4911161549385, 3919.2553414851086, 3922.097917478996, 8060.596970151469, 8094.554799485967, 8095.0, 8095.069067057246, 8102.473339233049, 4233.047564298008, 4249.2988656871885, 4251.277282861921, 4252.213340532012, 4259.148170365939, 3317.552130462405, 3419.9740077976508, 3705.110773414361, 3883.08747444356, 3888.4556162137324, 3386.068831071475, 3404.3191361727754, 3408.403529382348, 3436.244026314207, 3442.6557344265875, 1089.3790539392628, 1101.5208384352832, 1103.1175059952166, 1108.667399780079, 1112.3993043756282, 928.382625553999, 932.0772435289015, 932.0818993291603, 958.5159494455255, 1164.0222213340664, 6364.745410183541, 6377.649229292433, 6388.552801303864, 6391.744330226832, 6411.134496842959, 439.4594648582198, 442.5950255516167, 443.20887216318715, 447.28657790823587, 447.9574440428219, 5200.947990520122, 5233.607479439057, 5242.606804489678, 5261.947380526222, 5264.5525130363585, 8103.351731861437, 8187.0, 8359.540225287546, 8368.874466883002, 8369.49783013021, 8210.917890821134, 8215.383846211558, 8224.0, 8292.087870334259, 8303.750887473265, 6135.723892424851, 6369.490440764727, 6413.903791443132, 6421.967890160519, 6424.38968298011, 6672.566283191772, 6753.527253092237, 6759.695813688298, 6760.526763126534, 6760.93239067603, 7442.516236444614, 7640.197779233101, 7648.120466146464, 7736.419768517496, 7747.1090824555895, 7620.466567340233, 7797.376209903307, 7884.960575197088, 7905.169957154416, 7907.209279072047, 5266.605004624592, 5372.570194384518, 5388.703621300866, 6026.276846778414, 6118.694065296806, 5726.570507212059, 6369.840753981188, 6373.745050198126, 6383.297837237993, 6394.4564712, 6134.877302454015, 6225.28409232944, 6225.564210505402, 6285.779997700059, 6414.93585064162, 6059.757609695563, 6060.606060606046, 6089.604175728564, 6106.664133472702, 6202.534809889186, 6125.724342404514, 6164.321924588381, 6178.876422471615, 6179.721912513858, 6184.350643182581, 5845.298564172326, 5855.912161317498, 5877.882442351214, 5895.20414744004, 5896.941030589639, 5796.449337312949, 5827.446392592697, 5911.261092363455, 5914.0, 5920.407959204045], "unit": "ms", "name": "mootools.html", "value": 3929.3013044491818}, {"lowerIsBetter": false, "replicates": [300.0757666387526, 304.2530587407914, 307.24877674086866, 308.7761373004572, 313.9529070639405, 5145.253938178967, 5246.317978662773, 5333.973330133349, 5369.704666243355, 5378.0, 5185.481451854813, 5238.030964271612, 5260.158374660055, 5270.420253772091, 5284.762185701643, 3868.0909986153233, 3974.5230572331216, 4092.017915700233, 4096.406021126935, 4097.590240975908, 3988.441618173458, 4055.756654600719, 4055.9797201013953, 4060.0, 4064.2887494688457, 4057.2088442753675, 4060.878173654795, 4061.8984525386954, 4069.125138095309, 4081.3469844824835, 3848.749831260973, 3942.2706799241946, 4004.619561141687, 4058.1680755445063, 4065.89835254121, 3596.37063513884, 3606.242689035306, 3610.6028336882923, 3615.5480564929385, 3633.200695846936, 5042.142835717937, 5047.167217409123, 5054.090263752523, 5060.696358218519, 5071.087204303224, 4708.034852855157, 4729.905401891943, 4732.1482133216, 4733.431988161408, 4742.525747425264, 5331.466853314676, 5496.615236933416, 5507.008738427082, 5515.365732940683, 5549.667019978814, 3986.4817573715522, 3997.2605068062503, 3997.420374045776, 4000.0199951011896, 4004.2191772604356, 5726.3700992890745, 5814.418558144152, 5825.388334224887, 5825.504832089277, 5829.358770535237, 4129.318662420667, 4130.6282434581035, 4132.152908653718, 4132.8140233689555, 4134.979325103415, 4088.9795551022053, 4136.131412403369, 4169.45797046382, 4172.0, 4188.497380314382, 4718.0328032753205, 4720.858374248778, 4727.078219747185, 4729.763511824395, 4737.715737055788, 5540.556755459554, 5543.8891222176135, 5545.057340252167, 5545.861353466115, 5547.667139971614, 1446.3997441061842, 1475.6310922269433, 1477.7340078785921, 1477.807884974968, 1478.6894752101964, 1015.7105225010985, 1015.8019186258756, 1022.4785359466725, 1031.128696251666, 1044.9425281609585, 4847.660663753503, 4848.248521479177, 4856.368672072608, 4866.197077482176, 4869.488703686133, 5672.432756724294, 5694.9430505695245, 5710.143478478179, 5721.485066344049, 5726.885462290731, 4797.64017698674, 4815.0, 4841.298011788271, 4862.246351815475, 4865.245886887538, 2845.1180134158476, 2949.5575663650625, 3042.6196725409322, 3051.359214564922, 3084.151858238957, 5459.426760190123, 5464.26232458621, 5466.1527463243265, 5466.617336786387, 5470.480304371078, 5911.054231322968, 5925.992581261196, 5932.822015339547, 5935.851603709942, 5936.0, 5400.351957765093, 5433.646812957145, 5444.210589464506, 5449.427810080043, 5460.5085542301385, 5585.5252303553025, 5743.396943320891, 5744.305429898107, 5756.971215143897, 5763.97118014424, 5622.634528755618, 5640.60515763909, 5648.63283886546, 5654.575906806924, 5655.943440565707, 5387.084195686664, 5439.673619582838, 5447.891042179213, 5451.672899626035, 5458.235846981346, 4111.527174374865, 4118.5263694674295, 4119.0937993641355, 4121.216968775923, 4128.793560322032, 5572.77708891656, 5765.5675824314185, 5766.826995190151, 5776.989026920356, 5781.479666830005, 5555.749991250323, 5558.610897237317, 5559.916601251065, 5566.053770859045, 5573.804916827891, 5552.833414997556, 5561.4716601922755, 5565.860853478695, 5570.749316280858, 5572.693501857275, 5300.231466437268, 5433.755481003285, 5437.265969094122, 5441.619086663895, 5442.619016668795, 5582.692951887523, 5594.748236329294, 5595.132754423071, 5596.86007849807, 5598.972005139948, 5249.422563517934, 5284.180951952453, 5389.27244821944, 5456.972715136399, 5473.808416705556], "unit": "ms", "name": "prototype.html", "value": 4188.553888435575}, {"lowerIsBetter": false, "replicates": [637.9792332268371, 664.3754870421803, 735.3308489274759, 735.4226931858492, 766.8657984852649, 11522.942385288083, 11606.419679016048, 11638.941805290962, 11689.941550292258, 11711.999999999989, 11864.584739534119, 11995.160338776268, 12004.099692523052, 12022.63932082039, 12027.51889924402, 629.2134831460675, 634.9206349206349, 635.2630948100204, 794.8648729715933, 800.359712230215, 803.863343231652, 810.8864758933724, 811.975640730776, 812.0823469479479, 815.9592020398986, 837.2255663511258, 849.647396330522, 850.9531975741331, 853.3599800149888, 855.3841234311317, 832.5837081459271, 832.7210384521193, 832.8292699996487, 832.9625166867505, 836.3601844588894, 481.6123020968119, 486.75905426813597, 613.978510752126, 623.3548277532777, 624.0670198053894, 11807.881921180764, 11903.047756179485, 11909.404529773563, 11961.342126183057, 11976.0, 10636.893631063667, 10711.83932241017, 10929.672109836718, 11138.832917506244, 11999.820002699966, 8395.118512556215, 8577.699780507652, 8615.181557752003, 9417.246620270362, 9494.145526902612, 3216.6140063192333, 3262.6247981482197, 3274.4269752793166, 3296.0770984124483, 3342.548755917944, 39832.601673983176, 40032.59967400347, 40296.395554066716, 40368.0, 40411.0, 9016.8647470288, 9200.263978881674, 9330.90669093314, 9364.765880853032, 9574.904250957541, 15663.37346506127, 15663.451779187903, 15676.451324203597, 15689.607759806097, 15726.370945162294, 6304.590201636879, 6307.0, 6340.461060809791, 6347.270063942613, 6523.967380163163, 2741.4791189674297, 2813.9155825325274, 2858.9285267868468, 2879.510483217858, 2944.8969286074885, 2769.612254284402, 2804.747572718424, 2805.803593748418, 2808.9859550702117, 2812.0, 479.72415860880136, 530.1596968804411, 536.0538649284017, 539.0674133748637, 547.6440313796064, 430.47912026448347, 444.27804817172097, 461.6514531528674, 526.4367127173887, 545.3374150407274, 6945.062416573698, 6948.0, 7001.8446956252665, 7010.263922288188, 7084.681189346492, 428.88634511854383, 445.89075676459476, 498.4218306764136, 548.4816848078607, 556.5714399912046, 3128.9834289356168, 3298.455754800479, 3360.2103505676146, 3373.089265898243, 3422.6748458896864, 47525.0, 48129.51870481321, 48205.75897120492, 48266.0, 48438.27342589864, 41545.0, 42043.36934945978, 42311.0, 42786.14427711428, 43153.35269970953, 39787.2042559153, 40590.79704601458, 40712.0, 40876.59123408787, 40939.59060409417, 6777.186737591521, 6814.2163651180745, 6855.897161542481, 6958.234594194736, 7006.474514411338, 30387.2403189922, 30471.695283046887, 30765.23086922845, 31587.684123158473, 31745.20636984094, 37646.0, 37920.0, 38546.80726596349, 38616.6138338613, 38639.22721545609, 9691.854622180532, 9910.653127140804, 9987.450690212108, 10086.94956525242, 10133.79732405333, 10697.946510267398, 10740.227862402617, 10990.725231869268, 11048.558057677603, 11224.214304998899, 10014.499275036073, 10279.691609251735, 10307.587696492355, 10322.298569604265, 10459.320144190604, 10146.18830493544, 10213.489325533545, 10568.682939511827, 10608.469576520989, 10692.946535267585, 8995.640174393213, 9226.953865230631, 9860.406910627546, 10162.847557286499, 10472.581096756045, 7154.534955227893, 7917.920820791949, 8050.919490805017, 8069.559684018436, 8294.253517183482, 8027.759167224993, 8792.604332805167, 8799.164079412445, 9012.143846334588, 9056.27549796028], "unit": "ms", "name": "yui.html", "value": 5482.979846468034}], "name": "dromaeo_css", "value": 6244.4989118808935}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 105.0, 112.0, 113.0, 111.0, 104.0, 112.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 153.0, 164.0, 135.0, 150.0, 150.0, 132.0, 166.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 161.0, 165.0, 162.0, 164.0, 164.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 91.0, 71.0, 73.0, 72.0, 108.0, 97.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 126.0, 95.0, 95.0, 96.0, 130.0, 94.0, 95.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 71.0, 71.0, 70.0, 71.0, 81.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 83.0, 86.0, 86.0, 83.0, 84.0, 86.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 119.0, 120.0, 123.0, 118.0, 122.0, 120.0, 130.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 147.0, 147.0, 146.0, 134.0, 149.0, 149.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1513.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.23463317911435], "unit": "score", "name": "Richards", "value": 213.64770399999995}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [614.6281499692686], "unit": "score", "name": "Splay", "value": 132.585857}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19710.3199953404}]} 10:18:56 INFO - RETURN: dromaeo_css: 6244.50 10:18:56 INFO - RETURN: kraken: 1513.00 10:18:56 INFO - RETURN: v8_7: 19710.32 10:18:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19710.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1513.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6244.50"}}} 10:18:56 INFO - Return code: 0 10:18:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:57 ERROR - # TBPL SUCCESS # 10:18:57 INFO - Running post-action listener: _resource_record_post_action 10:18:57 INFO - Running post-run listener: _resource_record_post_run 10:18:58 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 510681088; Read time: 56; Write time: 419464 10:18:58 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 232235008; Read time: 0; Write time: 285340 10:18:58 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276684800; Read time: 56; Write time: 133948 10:18:58 INFO - Running post-run listener: _upload_blobber_files 10:18:58 INFO - Blob upload gear active. 10:18:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:18:58 INFO - Copying logs to upload dir... 10:18:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.428402 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-10 10:18:57.981576) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 10:18:57.985544) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009975 build_url: 'https://queue.taskcluster.net/v1/task/qiBaB5uRTeu7IF2ZOG_quQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 10:18:58.037605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 10:18:58.038072) ========= 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=6587686cb2da90a5f91b3170000001be-1449770263.811312-352537683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 10:18:58.089084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 10:18:58.089444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 10:18:58.089781) ========= ========= Total master_lag: 0.24 =========