builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1450467728.4 results: success (0) buildid: 20151218100050 builduid: 8620ffa327464af9a0f18cc14ffc4ad4 revision: ba6c0f7881c68dcaa76c4325a2b4f09945f395f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.396314) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.396750) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.397043) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006194 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.419193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.419465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.433347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.433673) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.482659) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.482947) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.483295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.483570) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 11:42:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.3M=0s 2015-12-18 11:42:09 (47.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.627648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.627951) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022393 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.677488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:08.677822) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ba6c0f7881c68dcaa76c4325a2b4f09945f395f1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ba6c0f7881c68dcaa76c4325a2b4f09945f395f1 --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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 11:42:09,323 truncating revision to first 12 chars 2015-12-18 11:42:09,323 Setting DEBUG logging. 2015-12-18 11:42:09,323 attempt 1/10 2015-12-18 11:42:09,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ba6c0f7881c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 11:42:09,599 unpacking tar archive at: b2g-inbound-ba6c0f7881c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539957 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:09.230617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:09.230929) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:09.240261) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:09.240605) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 11:42:09.241067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-18 11:42:09.241349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:09 INFO - MultiFileLogger online at 20151218 11:42:09 in /builds/slave/test 11:42:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 11:42:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:09 INFO - {'append_to_log': False, 11:42:09 INFO - 'base_work_dir': '/builds/slave/test', 11:42:09 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 11:42:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:09 INFO - 'branch': 'B2G-Inbound-Non-PGO', 11:42:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:09 INFO - 'config_files': ('talos/linux_config.py',), 11:42:09 INFO - 'default_actions': ('clobber', 11:42:09 INFO - 'read-buildbot-config', 11:42:09 INFO - 'download-and-extract', 11:42:09 INFO - 'populate-webroot', 11:42:09 INFO - 'create-virtualenv', 11:42:09 INFO - 'install', 11:42:09 INFO - 'run-tests'), 11:42:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:09 INFO - 'download_minidump_stackwalk': True, 11:42:09 INFO - 'download_symbols': 'ondemand', 11:42:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:09 INFO - 'installer_path': 'installer.exe', 11:42:09 INFO - 'log_level': 'info', 11:42:09 INFO - 'log_name': 'talos', 11:42:09 INFO - 'log_to_console': True, 11:42:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:09 INFO - 'opt_config_files': (), 11:42:09 INFO - 'pip_index': False, 11:42:09 INFO - 'sps_profile': False, 11:42:09 INFO - 'sps_profile_interval': 0, 11:42:09 INFO - 'suite': 'dromaeojs', 11:42:09 INFO - 'system_bits': '64', 11:42:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:09 INFO - 'title': 'talos-linux64-ix-023', 11:42:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:09 INFO - 'use_talos_json': True, 11:42:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:09 INFO - 'work_dir': 'build'} 11:42:09 INFO - ##### 11:42:09 INFO - ##### Running clobber step. 11:42:09 INFO - ##### 11:42:09 INFO - Running pre-action listener: _resource_record_pre_action 11:42:09 INFO - Running main action method: clobber 11:42:09 INFO - rmtree: /builds/slave/test/build 11:42:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:10 INFO - Running post-action listener: _resource_record_post_action 11:42:10 INFO - ##### 11:42:10 INFO - ##### Running read-buildbot-config step. 11:42:10 INFO - ##### 11:42:10 INFO - Running pre-action listener: _resource_record_pre_action 11:42:10 INFO - Running main action method: read_buildbot_config 11:42:10 INFO - Using buildbot properties: 11:42:10 INFO - { 11:42:10 INFO - "project": "", 11:42:10 INFO - "product": "firefox", 11:42:10 INFO - "script_repo_revision": "production", 11:42:10 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 11:42:10 INFO - "repository": "", 11:42:10 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 11:42:10 INFO - "buildid": "20151218100050", 11:42:10 INFO - "pgo_build": "False", 11:42:10 INFO - "basedir": "/builds/slave/test", 11:42:10 INFO - "buildnumber": 791, 11:42:10 INFO - "slavename": "talos-linux64-ix-023", 11:42:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:10 INFO - "platform": "ubuntu64_hw", 11:42:10 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 11:42:10 INFO - "branch": "b2g-inbound", 11:42:10 INFO - "repo_path": "integration/b2g-inbound", 11:42:10 INFO - "revision": "ba6c0f7881c68dcaa76c4325a2b4f09945f395f1", 11:42:10 INFO - "stage_platform": "linux64", 11:42:10 INFO - "builduid": "8620ffa327464af9a0f18cc14ffc4ad4", 11:42:10 INFO - "slavebuilddir": "test" 11:42:10 INFO - } 11:42:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:42:10 INFO - Running post-action listener: _resource_record_post_action 11:42:10 INFO - ##### 11:42:10 INFO - ##### Running download-and-extract step. 11:42:10 INFO - ##### 11:42:10 INFO - Running pre-action listener: _resource_record_pre_action 11:42:10 INFO - Running main action method: download_and_extract 11:42:10 INFO - mkdir: /builds/slave/test/build/tests 11:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:10 INFO - https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/test_packages.json 11:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/test_packages.json 11:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:42:11 INFO - Downloaded 1302 bytes. 11:42:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:42:11 INFO - Using the following test package requirements: 11:42:11 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:11 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:11 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'jsshell-linux-x86_64.zip'], 11:42:11 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:11 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:11 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:11 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:11 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:11 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:11 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:11 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:11 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:11 INFO - https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:12 INFO - Downloaded 21872165 bytes. 11:42:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:42:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:42:13 INFO - Return code: 0 11:42:13 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:13 INFO - https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:14 INFO - Downloaded 21872165 bytes. 11:42:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:42:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:42:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:42:16 INFO - Return code: 0 11:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:16 INFO - https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:42:17 INFO - Downloaded 11132039 bytes. 11:42:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:42:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:42:17 INFO - Return code: 0 11:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:17 INFO - https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:42:19 INFO - Downloaded 53021969 bytes. 11:42:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:42:19 INFO - mkdir: /builds/slave/test/properties 11:42:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:19 INFO - Contents: 11:42:19 INFO - build_url:https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - Running post-action listener: set_extra_try_arguments 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running populate-webroot step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: populate_webroot 11:42:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:19 INFO - '--tppagecycles', 11:42:19 INFO - '7'], 11:42:19 INFO - 'tests': ['tsvgm']}}, 11:42:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:42:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'other': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'other_l64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'other_nol64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore']}, 11:42:19 INFO - 'svgr': {'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s'], 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}, 11:42:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--e10s', 11:42:19 INFO - '--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}}, 11:42:19 INFO - 'talos.zip': {'path': '', 11:42:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running create-virtualenv step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: create_virtualenv 11:42:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:42:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:19 INFO - Using real prefix '/usr' 11:42:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:21 INFO - Installing pip.................done. 11:42:21 INFO - Return code: 0 11:42:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:21 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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:42:21 INFO - Using env: {'DISPLAY': ':0', 11:42:21 INFO - 'HOME': '/home/cltbld', 11:42:21 INFO - 'LANG': 'en_US.UTF-8', 11:42:21 INFO - 'LANGUAGE': 'en_US:en', 11:42:21 INFO - 'LOGNAME': 'cltbld', 11:42:21 INFO - 'MAIL': '/var/mail/cltbld', 11:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:21 INFO - 'MOZ_NO_REMOTE': '1', 11:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:21 INFO - 'NO_EM_RESTART': '1', 11:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:21 INFO - 'PWD': '/builds/slave/test', 11:42:21 INFO - 'SHELL': '/bin/bash', 11:42:21 INFO - 'SHLVL': '1', 11:42:21 INFO - 'TERM': 'linux', 11:42:21 INFO - 'TMOUT': '86400', 11:42:21 INFO - 'USER': 'cltbld', 11:42:21 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:21 INFO - '_': '/tools/buildbot/bin/python'} 11:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:42:22 INFO - Cleaning up... 11:42:22 INFO - Return code: 0 11:42:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:42:22 INFO - Using env: {'DISPLAY': ':0', 11:42:22 INFO - 'HOME': '/home/cltbld', 11:42:22 INFO - 'LANG': 'en_US.UTF-8', 11:42:22 INFO - 'LANGUAGE': 'en_US:en', 11:42:22 INFO - 'LOGNAME': 'cltbld', 11:42:22 INFO - 'MAIL': '/var/mail/cltbld', 11:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:22 INFO - 'MOZ_NO_REMOTE': '1', 11:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:22 INFO - 'NO_EM_RESTART': '1', 11:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:22 INFO - 'PWD': '/builds/slave/test', 11:42:22 INFO - 'SHELL': '/bin/bash', 11:42:22 INFO - 'SHLVL': '1', 11:42:22 INFO - 'TERM': 'linux', 11:42:22 INFO - 'TMOUT': '86400', 11:42:22 INFO - 'USER': 'cltbld', 11:42:22 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:22 INFO - '_': '/tools/buildbot/bin/python'} 11:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:22 INFO - Downloading/unpacking psutil>=0.7.1 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:23 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:42:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:24 INFO - Installing collected packages: psutil 11:42:24 INFO - Running setup.py install for psutil 11:42:24 INFO - building 'psutil._psutil_linux' extension 11:42:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:42:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:42:24 INFO - building 'psutil._psutil_posix' extension 11:42:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:42:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:42:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:24 INFO - Successfully installed psutil 11:42:24 INFO - Cleaning up... 11:42:24 INFO - Return code: 0 11:42:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:24 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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:42:24 INFO - Using env: {'DISPLAY': ':0', 11:42:24 INFO - 'HOME': '/home/cltbld', 11:42:24 INFO - 'LANG': 'en_US.UTF-8', 11:42:24 INFO - 'LANGUAGE': 'en_US:en', 11:42:24 INFO - 'LOGNAME': 'cltbld', 11:42:24 INFO - 'MAIL': '/var/mail/cltbld', 11:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:24 INFO - 'MOZ_NO_REMOTE': '1', 11:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:24 INFO - 'NO_EM_RESTART': '1', 11:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:24 INFO - 'PWD': '/builds/slave/test', 11:42:24 INFO - 'SHELL': '/bin/bash', 11:42:24 INFO - 'SHLVL': '1', 11:42:24 INFO - 'TERM': 'linux', 11:42:24 INFO - 'TMOUT': '86400', 11:42:24 INFO - 'USER': 'cltbld', 11:42:24 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:24 INFO - '_': '/tools/buildbot/bin/python'} 11:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:42:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:42:26 INFO - Installing collected packages: mozsystemmonitor 11:42:26 INFO - Running setup.py install for mozsystemmonitor 11:42:26 INFO - Successfully installed mozsystemmonitor 11:42:26 INFO - Cleaning up... 11:42:26 INFO - Return code: 0 11:42:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:42:26 INFO - Using env: {'DISPLAY': ':0', 11:42:26 INFO - 'HOME': '/home/cltbld', 11:42:26 INFO - 'LANG': 'en_US.UTF-8', 11:42:26 INFO - 'LANGUAGE': 'en_US:en', 11:42:26 INFO - 'LOGNAME': 'cltbld', 11:42:26 INFO - 'MAIL': '/var/mail/cltbld', 11:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:26 INFO - 'MOZ_NO_REMOTE': '1', 11:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:26 INFO - 'NO_EM_RESTART': '1', 11:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:26 INFO - 'PWD': '/builds/slave/test', 11:42:26 INFO - 'SHELL': '/bin/bash', 11:42:26 INFO - 'SHLVL': '1', 11:42:26 INFO - 'TERM': 'linux', 11:42:26 INFO - 'TMOUT': '86400', 11:42:26 INFO - 'USER': 'cltbld', 11:42:26 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:26 INFO - '_': '/tools/buildbot/bin/python'} 11:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:29 INFO - Downloading docopt-0.6.1.tar.gz 11:42:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:29 INFO - Running setup.py install for blobuploader 11:42:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:29 INFO - Running setup.py install for requests 11:42:29 INFO - Running setup.py install for docopt 11:42:29 INFO - Successfully installed blobuploader requests docopt 11:42:29 INFO - Cleaning up... 11:42:29 INFO - Return code: 0 11:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:29 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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:42:29 INFO - Using env: {'DISPLAY': ':0', 11:42:29 INFO - 'HOME': '/home/cltbld', 11:42:29 INFO - 'LANG': 'en_US.UTF-8', 11:42:29 INFO - 'LANGUAGE': 'en_US:en', 11:42:29 INFO - 'LOGNAME': 'cltbld', 11:42:29 INFO - 'MAIL': '/var/mail/cltbld', 11:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:29 INFO - 'MOZ_NO_REMOTE': '1', 11:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:29 INFO - 'NO_EM_RESTART': '1', 11:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:29 INFO - 'PWD': '/builds/slave/test', 11:42:29 INFO - 'SHELL': '/bin/bash', 11:42:29 INFO - 'SHLVL': '1', 11:42:29 INFO - 'TERM': 'linux', 11:42:29 INFO - 'TMOUT': '86400', 11:42:29 INFO - 'USER': 'cltbld', 11:42:29 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:29 INFO - '_': '/tools/buildbot/bin/python'} 11:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:30 INFO - Running setup.py (path:/tmp/pip-K3pNgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:30 INFO - Running setup.py (path:/tmp/pip-nBnKVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:30 INFO - Running setup.py (path:/tmp/pip-WyjP7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:30 INFO - Running setup.py (path:/tmp/pip-7DUAQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:30 INFO - Running setup.py (path:/tmp/pip-3WL_SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:30 INFO - Running setup.py (path:/tmp/pip-_2vyqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:30 INFO - Running setup.py (path:/tmp/pip-KZ8eit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:30 INFO - Running setup.py (path:/tmp/pip-Xz21Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:30 INFO - Running setup.py (path:/tmp/pip-uAqbwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:30 INFO - Running setup.py (path:/tmp/pip-unBSuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:30 INFO - Running setup.py (path:/tmp/pip-8hP2b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:30 INFO - Running setup.py (path:/tmp/pip-DGCaGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:31 INFO - Running setup.py (path:/tmp/pip-MR5qAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:31 INFO - Running setup.py (path:/tmp/pip-shkdL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:31 INFO - Running setup.py (path:/tmp/pip-invflz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:31 INFO - Running setup.py (path:/tmp/pip-IFSVD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:31 INFO - Running setup.py (path:/tmp/pip-F59IbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:31 INFO - Running setup.py install for manifestparser 11:42:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for mozcrash 11:42:31 INFO - Running setup.py install for mozdebug 11:42:31 INFO - Running setup.py install for mozdevice 11:42:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:31 INFO - Running setup.py install for mozfile 11:42:31 INFO - Running setup.py install for mozhttpd 11:42:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozinfo 11:42:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozInstall 11:42:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozleak 11:42:32 INFO - Running setup.py install for mozlog 11:42:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for moznetwork 11:42:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozprocess 11:42:32 INFO - Running setup.py install for mozprofile 11:42:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozrunner 11:42:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:32 INFO - Running setup.py install for mozscreenshot 11:42:32 INFO - Running setup.py install for moztest 11:42:33 INFO - Running setup.py install for mozversion 11:42:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:33 INFO - Cleaning up... 11:42:33 INFO - Return code: 0 11:42:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:42:33 INFO - Using env: {'DISPLAY': ':0', 11:42:33 INFO - 'HOME': '/home/cltbld', 11:42:33 INFO - 'LANG': 'en_US.UTF-8', 11:42:33 INFO - 'LANGUAGE': 'en_US:en', 11:42:33 INFO - 'LOGNAME': 'cltbld', 11:42:33 INFO - 'MAIL': '/var/mail/cltbld', 11:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:33 INFO - 'MOZ_NO_REMOTE': '1', 11:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:33 INFO - 'NO_EM_RESTART': '1', 11:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:33 INFO - 'PWD': '/builds/slave/test', 11:42:33 INFO - 'SHELL': '/bin/bash', 11:42:33 INFO - 'SHLVL': '1', 11:42:33 INFO - 'TERM': 'linux', 11:42:33 INFO - 'TMOUT': '86400', 11:42:33 INFO - 'USER': 'cltbld', 11:42:33 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:33 INFO - '_': '/tools/buildbot/bin/python'} 11:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:33 INFO - Running setup.py (path:/tmp/pip-PCR9ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:33 INFO - Running setup.py (path:/tmp/pip-OI8dNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:33 INFO - Running setup.py (path:/tmp/pip-ZMrOR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:33 INFO - Running setup.py (path:/tmp/pip-ZtiDxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:33 INFO - Running setup.py (path:/tmp/pip-uf3Fj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:33 INFO - Running setup.py (path:/tmp/pip-XhxKaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:33 INFO - Running setup.py (path:/tmp/pip-9AXjEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:33 INFO - Running setup.py (path:/tmp/pip-zp54bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:33 INFO - Running setup.py (path:/tmp/pip-Vz3HyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:34 INFO - Running setup.py (path:/tmp/pip-XSDDlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:34 INFO - Running setup.py (path:/tmp/pip-BzL1l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:34 INFO - Running setup.py (path:/tmp/pip-LAv9Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:34 INFO - Running setup.py (path:/tmp/pip-5ZA6GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:34 INFO - Running setup.py (path:/tmp/pip-bxaOCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:34 INFO - Running setup.py (path:/tmp/pip-fQH1E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:34 INFO - Running setup.py (path:/tmp/pip-B8ecva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:42:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:34 INFO - Running setup.py (path:/tmp/pip-9YEUIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:42:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:36 INFO - Downloading blessings-1.5.1.tar.gz 11:42:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 11:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:36 INFO - Installing collected packages: blessings 11:42:36 INFO - Running setup.py install for blessings 11:42:36 INFO - Successfully installed blessings 11:42:36 INFO - Cleaning up... 11:42:36 INFO - Return code: 0 11:42:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:36 INFO - Reading from file tmpfile_stdout 11:42:36 INFO - Current package versions: 11:42:36 INFO - argparse == 1.2.1 11:42:36 INFO - blessings == 1.5.1 11:42:36 INFO - blobuploader == 1.2.4 11:42:36 INFO - docopt == 0.6.1 11:42:36 INFO - manifestparser == 1.1 11:42:36 INFO - mozInstall == 1.12 11:42:36 INFO - mozcrash == 0.16 11:42:36 INFO - mozdebug == 0.1 11:42:36 INFO - mozdevice == 0.47 11:42:36 INFO - mozfile == 1.2 11:42:36 INFO - mozhttpd == 0.7 11:42:36 INFO - mozinfo == 0.9 11:42:36 INFO - mozleak == 0.1 11:42:36 INFO - mozlog == 3.1 11:42:36 INFO - moznetwork == 0.27 11:42:36 INFO - mozprocess == 0.22 11:42:36 INFO - mozprofile == 0.27 11:42:36 INFO - mozrunner == 6.11 11:42:36 INFO - mozscreenshot == 0.1 11:42:36 INFO - mozsystemmonitor == 0.0 11:42:36 INFO - moztest == 0.7 11:42:36 INFO - mozversion == 1.4 11:42:36 INFO - psutil == 3.1.1 11:42:36 INFO - requests == 1.2.3 11:42:36 INFO - wsgiref == 0.1.2 11:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:42:36 INFO - Using env: {'DISPLAY': ':0', 11:42:36 INFO - 'HOME': '/home/cltbld', 11:42:36 INFO - 'LANG': 'en_US.UTF-8', 11:42:36 INFO - 'LANGUAGE': 'en_US:en', 11:42:36 INFO - 'LOGNAME': 'cltbld', 11:42:36 INFO - 'MAIL': '/var/mail/cltbld', 11:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:36 INFO - 'MOZ_NO_REMOTE': '1', 11:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:36 INFO - 'NO_EM_RESTART': '1', 11:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:36 INFO - 'PWD': '/builds/slave/test', 11:42:36 INFO - 'SHELL': '/bin/bash', 11:42:36 INFO - 'SHLVL': '1', 11:42:36 INFO - 'TERM': 'linux', 11:42:36 INFO - 'TMOUT': '86400', 11:42:36 INFO - 'USER': 'cltbld', 11:42:36 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:36 INFO - '_': '/tools/buildbot/bin/python'} 11:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:42:36 INFO - Cleaning up... 11:42:36 INFO - Return code: 0 11:42:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:42:36 INFO - Using env: {'DISPLAY': ':0', 11:42:36 INFO - 'HOME': '/home/cltbld', 11:42:36 INFO - 'LANG': 'en_US.UTF-8', 11:42:36 INFO - 'LANGUAGE': 'en_US:en', 11:42:36 INFO - 'LOGNAME': 'cltbld', 11:42:36 INFO - 'MAIL': '/var/mail/cltbld', 11:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:36 INFO - 'MOZ_NO_REMOTE': '1', 11:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:36 INFO - 'NO_EM_RESTART': '1', 11:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:36 INFO - 'PWD': '/builds/slave/test', 11:42:36 INFO - 'SHELL': '/bin/bash', 11:42:36 INFO - 'SHLVL': '1', 11:42:36 INFO - 'TERM': 'linux', 11:42:36 INFO - 'TMOUT': '86400', 11:42:36 INFO - 'USER': 'cltbld', 11:42:36 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:36 INFO - '_': '/tools/buildbot/bin/python'} 11:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:37 INFO - Downloading/unpacking jsonschema 11:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 11:42:38 INFO - Downloading/unpacking functools32 (from jsonschema) 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:39 INFO - warning: no files found matching '*.txt' 11:42:39 INFO - no previously-included directories found matching 'build' 11:42:39 INFO - no previously-included directories found matching 'dist' 11:42:39 INFO - no previously-included directories found matching '.git*' 11:42:39 INFO - Installing collected packages: jsonschema, functools32 11:42:39 INFO - Running setup.py install for functools32 11:42:39 INFO - warning: no files found matching '*.txt' 11:42:39 INFO - no previously-included directories found matching 'build' 11:42:39 INFO - no previously-included directories found matching 'dist' 11:42:39 INFO - no previously-included directories found matching '.git*' 11:42:39 INFO - Successfully installed jsonschema functools32 11:42:39 INFO - Cleaning up... 11:42:39 INFO - Return code: 0 11:42:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1104555f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c43240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, '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': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:42:39 INFO - Using env: {'DISPLAY': ':0', 11:42:39 INFO - 'HOME': '/home/cltbld', 11:42:39 INFO - 'LANG': 'en_US.UTF-8', 11:42:39 INFO - 'LANGUAGE': 'en_US:en', 11:42:39 INFO - 'LOGNAME': 'cltbld', 11:42:39 INFO - 'MAIL': '/var/mail/cltbld', 11:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:39 INFO - 'MOZ_NO_REMOTE': '1', 11:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:39 INFO - 'NO_EM_RESTART': '1', 11:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:39 INFO - 'PWD': '/builds/slave/test', 11:42:39 INFO - 'SHELL': '/bin/bash', 11:42:39 INFO - 'SHLVL': '1', 11:42:39 INFO - 'TERM': 'linux', 11:42:39 INFO - 'TMOUT': '86400', 11:42:39 INFO - 'USER': 'cltbld', 11:42:39 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:39 INFO - '_': '/tools/buildbot/bin/python'} 11:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:39 INFO - Downloading/unpacking flake8 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:42:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 11:42:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:42:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 11:42:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 11:42:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:42:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:41 INFO - no previously-included directories found matching 'docs/_build' 11:42:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:42:41 INFO - Running setup.py install for pep8 11:42:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:42 INFO - no previously-included directories found matching 'docs/_build' 11:42:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:42:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:42:42 INFO - Cleaning up... 11:42:42 INFO - Return code: 0 11:42:42 INFO - Running post-action listener: _resource_record_post_action 11:42:42 INFO - Running post-action listener: _start_resource_monitoring 11:42:42 INFO - Starting resource monitoring. 11:42:42 INFO - ##### 11:42:42 INFO - ##### Running install step. 11:42:42 INFO - ##### 11:42:42 INFO - Running pre-action listener: _resource_record_pre_action 11:42:42 INFO - Running main action method: install 11:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:42 INFO - Reading from file tmpfile_stdout 11:42:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:42 INFO - Reading from file tmpfile_stdout 11:42:42 INFO - Output received: 11:42:42 INFO - Usage: mozinstall [options] installer 11:42:42 INFO - Options: 11:42:42 INFO - -h, --help show this help message and exit 11:42:42 INFO - -d DEST, --destination=DEST 11:42:42 INFO - Directory to install application into. [default: 11:42:42 INFO - "/builds/slave/test"] 11:42:42 INFO - --app=APP Application being installed. [default: firefox] 11:42:42 INFO - mkdir: /builds/slave/test/build/application 11:42:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:42:57 INFO - Reading from file tmpfile_stdout 11:42:57 INFO - Output received: 11:42:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:42:57 INFO - Running post-action listener: _resource_record_post_action 11:42:57 INFO - ##### 11:42:57 INFO - ##### Running run-tests step. 11:42:57 INFO - ##### 11:42:57 INFO - Running pre-action listener: _resource_record_pre_action 11:42:57 INFO - Running main action method: run_tests 11:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:42:57 INFO - Python 2.7.3 11:42:57 INFO - Return code: 0 11:42:57 INFO - grabbing minidump binary from tooltool 11:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:57 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 0x1cd20b0>, '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 0x1cd2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cd3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:42:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:42:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:42:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:42:58 INFO - Return code: 0 11:42:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:42:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:42:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:42:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:42:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:42:58 INFO - Return code: 0 11:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test/build 11:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 11:42:58 INFO - Using env: {'DISPLAY': ':0', 11:42:58 INFO - 'HOME': '/home/cltbld', 11:42:58 INFO - 'LANG': 'en_US.UTF-8', 11:42:58 INFO - 'LANGUAGE': 'en_US:en', 11:42:58 INFO - 'LOGNAME': 'cltbld', 11:42:58 INFO - 'MAIL': '/var/mail/cltbld', 11:42:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:42:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:58 INFO - 'MOZ_NO_REMOTE': '1', 11:42:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:58 INFO - 'NO_EM_RESTART': '1', 11:42:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:58 INFO - 'PWD': '/builds/slave/test', 11:42:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:42:58 INFO - 'SHELL': '/bin/bash', 11:42:58 INFO - 'SHLVL': '1', 11:42:58 INFO - 'TERM': 'linux', 11:42:58 INFO - 'TMOUT': '86400', 11:42:58 INFO - 'USER': 'cltbld', 11:42:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212', 11:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:58 INFO - '_': '/tools/buildbot/bin/python'} 11:42:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 11:42:59 INFO - mozversion INFO | application_buildid: 20151218100050 11:42:59 INFO - mozversion INFO | application_changeset: ba6c0f7881c68dcaa76c4325a2b4f09945f395f1 11:42:59 INFO - mozversion INFO | application_display_name: Nightly 11:42:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:42:59 INFO - mozversion INFO | application_name: Firefox 11:42:59 INFO - mozversion INFO | application_remotingname: firefox 11:42:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:42:59 INFO - mozversion INFO | application_vendor: Mozilla 11:42:59 INFO - mozversion INFO | application_version: 46.0a1 11:42:59 INFO - mozversion INFO | platform_buildid: 20151218100050 11:42:59 INFO - mozversion INFO | platform_changeset: ba6c0f7881c68dcaa76c4325a2b4f09945f395f1 11:42:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:42:59 INFO - mozversion INFO | platform_version: 46.0a1 11:42:59 INFO - 2015-12-18 11:42:59,155 DEBUG : using testdate: 1450467779 11:42:59 INFO - 2015-12-18 11:42:59,155 DEBUG : actual date: 1450467779 11:42:59 INFO - 2015-12-18 11:42:59,167 INFO : starting webserver on 'localhost:60585' 11:42:59 INFO - 2015-12-18 11:42:59,168 INFO : Starting test suite talos-linux64-ix-023 11:42:59 INFO - 2015-12-18 11:42:59,168 INFO : Starting test dromaeo_css 11:42:59 INFO - 2015-12-18 11:42:59,168 DEBUG : operating with platform_type : linux_ 11:42:59 INFO - 2015-12-18 11:42:59,169 INFO : Initialising browser for dromaeo_css test... 11:42:59 INFO - 2015-12-18 11:42:59,184 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmproG23r/profile http://localhost:60585/getInfo.html 11:43:03 INFO - 2015-12-18 11:43:03,957 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:43:03 INFO - 2015-12-18 11:43:03,957 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:43:03 INFO - 2015-12-18 11:43:03,957 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:43:03 INFO - 2015-12-18 11:43:03,957 DEBUG : BROWSER_OUTPUT: __metrics 11:43:04 INFO - 2015-12-18 11:43:04,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:43:04 INFO - 2015-12-18 11:43:04,122 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:04 ERROR - 2015-12-18 11:43:04,137 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 11:43:04 INFO - 2015-12-18 11:43:04,954 INFO : Browser initialized. 11:43:04 INFO - 2015-12-18 11:43:04,955 INFO : Running cycle 1/1 for dromaeo_css test... 11:43:04 INFO - 2015-12-18 11:43:04,955 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmproG23r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:43:16 INFO - 2015-12-18 11:43:16,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 149626880 11:43:16 INFO - 2015-12-18 11:43:16,848 DEBUG : BROWSER_OUTPUT: 11:44:08 INFO - 2015-12-18 11:44:08,151 DEBUG : BROWSER_OUTPUT: 1450467848150 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:46:20 INFO - 2015-12-18 11:46:20,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60585/tests/dromaeo/cssquery-ext.html) 11:46:21 INFO - 2015-12-18 11:46:21,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 255565824 11:46:21 INFO - 2015-12-18 11:46:21,495 DEBUG : BROWSER_OUTPUT: 11:49:24 INFO - 2015-12-18 11:49:24,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-ext.html (next: http://localhost:60585/tests/dromaeo/cssquery-jquery.html) 11:49:24 INFO - 2015-12-18 11:49:24,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 223207424 11:49:24 INFO - 2015-12-18 11:49:24,628 DEBUG : BROWSER_OUTPUT: 11:52:26 INFO - 2015-12-18 11:52:26,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60585/tests/dromaeo/cssquery-mootools.html) 11:52:27 INFO - 2015-12-18 11:52:27,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 221474816 11:52:27 INFO - 2015-12-18 11:52:27,333 DEBUG : BROWSER_OUTPUT: 11:55:29 INFO - 2015-12-18 11:55:29,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60585/tests/dromaeo/cssquery-prototype.html) 11:55:29 INFO - 2015-12-18 11:55:29,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 209129472 11:55:29 INFO - 2015-12-18 11:55:29,869 DEBUG : BROWSER_OUTPUT: 11:58:32 INFO - 2015-12-18 11:58:32,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60585/tests/dromaeo/cssquery-yui.html) 11:58:33 INFO - 2015-12-18 11:58:33,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 214261760 11:58:33 INFO - 2015-12-18 11:58:33,304 DEBUG : BROWSER_OUTPUT: 12:01:35 INFO - 2015-12-18 12:01:35,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/dromaeo/cssquery-yui.html (next: http://localhost:60585/tests/dromaeo/cssquery-dojo.html) 12:01:36 INFO - 2015-12-18 12:01:36,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 261210112 12:01:36 INFO - 2015-12-18 12:01:36,136 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,136 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:01:36 INFO - 2015-12-18 12:01:36,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:01:36 INFO - 2015-12-18 12:01:36,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:01:36 INFO - 2015-12-18 12:01:36,138 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:01:36 INFO - 2015-12-18 12:01:36,139 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.3019099938515;2710.2546799630086;2711.5254830404674;2723.9727602723965;2737.876795544201;4538.727676339414;4665.3235280884255;4726.598239149672;4788.8802779930475;4799.688020278684;4653.464851542065;4674.766261686919;4771.1888978873585;4776.188048031834;4780.90438191236;4200.600942910419;4318.093200427914;4331.3719510670935;4421.867343979669;4529.977350113245;4458.799354029076;4517.774111294439;4541.841035563756;4542.114287713897;4573.474050484204;4200.705950583476;4267.295896177127;4313.396124542566;4371.628411585019;4391.077873646538;4389.429374181368;4412.294032954744;4415.7350558966245;4428.269335559628;4450.332450132506;4368.650507959355;4399.5160532341415;4399.912001759947;4436.73379597222;4440.111977604492;4377.949292169888;4486.865394038184;4494.865154045384;4553.908921821579;4646.4424269087585;5100.056489549445;5110.463401342842;5112.105381558213;5115.258287548322;5154.994776018678;5130.4356520782685;5134.691918484866;5142;5143.04853602081;5147.639665223436;4455.309427038782;4552.544745525454;4555.840545580889;4557.772111394417;4771.785269662873;5197.766100525486;5198.2722418861385;5203.843884683465;5229.398619158769;5237.057329680618;4968.8509344719;4975.726335051534;4978.701277923336;4990.101781679333;5021.623378246573;4786.880327991758;4892.09496243189;4893.363862697826;4931.3835770528685;5088.542031217208;5025.849224523197;5034.395872495324;5036.194208926628;5064.569511591556;5077.593792496591;5067.949320506747;5081.339425874687;5082.161443361878;5084.084864724385;5085.821996230115;3953.2291203215095;4086.67306615476;4092.570280120604;4148.170365926766;4303.870883873489;3690.4279836625365;3723.069232691827;3747.45661879026;3762.0218743126984;3771.0949372150485;4352.978235108804;4403.911921761547;4404.779761011937;4410.338449232577;4418.911621767546;4919;5038.874028149326;5042.697438153649;5154.871128221749;5197.22041693749;4330.155619654137;4340.110277393127;4375.212461756914;4376.846810361686;4397.868063958086;4543.386642803245;4545.2954792007295;4557.225271703818;4558.430196225472;4589.059242855206;4489.236829739018;4616.030633566988;4804.927926081042;4805;4861.465238823726;4906.582940450102;4979.551840334388;5015.072211640858;5035.672681275705;5073.898522029613;4837.637177211653;4884.1941079722865;4884.877878053077;4885.828995985124;4931.16170251051;4751.453582838018;4875.90248195027;5069;5085.4406015337545;5136.101182293159;4860;4922.384701912261;5006.1739812930455;5013.122703526941;5033.0688822567945;4910.533499317559;4978.6763860348965;4982.875428114181;4989.376327959005;5027.74861256943;4680.46174689915;4784.6889952153;4956.058348913695;4987.750612469435;4991.700497970133;4697.483276839614;4821.349117869043;4873.707577545217;4883.804647814048;4908;4980.576650984707;5032.421271553671;5033.99320135967;5034.270030845581;5075.796968121382;4559.886002849956;4676.018036212434;4919.0899683558655;4937.259411088222;4979.975100124476 12:01:36 INFO - 2015-12-18 12:01:36,143 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.1327755256902;569.6411260905629;573.4351663611345;575.3584753000406;578.1154833105347;26733;31573.21066973324;32297;32456.513152302676;32573.348533029326;38397.808010959976;39086.60913390865;39311.803440982825;39314;39449.80275098627;7048.612326322051;7161.391281741058;7804.297613214823;7954.323882469997;7968.482048666818;10125.3924764514;10370.481475926212;10375.79248415035;10382.273240873143;10383.325083869524;9923.950380248089;10026.59893604255;10053.346532475402;10063.446510441923;10067.697969060904;7160.355567998905;7332.816679582999;7334.779956601257;9904.257180711404;10007.24945629077;9755.365901216399;9876.061774131445;9885.555150018194;9891.159251463634;9898.653547125889;36406.81796591027;36985;37005.25989480222;37025.444618330745;37030.81484592587;2832.7712755405755;2865.3266482376625;2952;3431.4338134207824;3503.3518799022263;27981;28190.85904570464;28205.153845384466;28215.717842821516;28622.713772862422;3394.915127121817;3404.2000129969438;3441.105312618712;3514.61339252682;3518.313928783888;213135;214636;215109;215195;215208;49506.504934950906;50716.49283507118;52075.218871716956;52181.478185218424;52588.47411525836;45410.77294613506;45516.3172552412;45650.31524527135;45723;45795.31307030397;13958.232297223547;14156;14166.504172353918;14170.433182672783;14185.645358866112;10706.946465267623;10822.837657435144;10870.782584348426;10894.836577451344;10911.23621346514;17544.298228070733;17631.118444077743;17760;17774.822251777317;17793.466196014142;7583.924160758432;7647.770566883002;7748.4188685848785;7761.72833950809;7870.527768333918;867.1631875240423;927.2072378116748;1002.3384566186282;1005.261133067195;1053.2258789789498;25764.742352576235;26017;26098.086566970065;26134.215973520826;26142.215733528024;992.3400938376044;1038.9324693894873;1067.7223921780394;1073.9624113156;1086.397049637443;13699.726005480034;14248.430062797372;14305.356258968372;14345.426182952773;14372.712545749026;265369;270965;271116;271522;271648.98457107815;44760.77619611881;44910.10179796386;44975.10049798986;45062.09875802466;45069.774651126536;1235.456399184356;1246.987530124687;1249.188027781949;1251.1179618369029;1262.715888925003;20822.687659684812;24153.275401737978;25502.617460737732;25609;25752.13924783592;38281.6171838278;38817;38824.41763373495;38834.223315534095;38868.416973744854;203987;204384;205082;205115;205394;24012.27963161108;24355.756442435348;27784.166475005783;28076.29809254785;28100.71899280981;31861.68138318587;32050.19874503156;32172.83913580417;32679.673203267663;32851.50722739209;28664.426711466072;29656.555151673172;29744;29998.25004374821;30002;30441.543376849808;31213.8439307802;31876.681233188297;32405.675943240265;32408.351832962737;29418;29585.852070739507;31951.562179702432;32398.83800580982;32457.51313730343;24719.62920556229;25900.35249118787;28219.71780282171;28447.28881777972;28457;22758.431039224153;22782.89278289265;22804.657930131394;22945.54108917779;23151 12:01:36 INFO - 2015-12-18 12:01:36,143 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.09671597441405;316.1779373628565;317.88079470198676;320.12286335440893;323.3145731050173;12476;12810.10329276951;15582.142982135978;15922.885398022128;16050.1172435516;12625.936870315658;12661.936690316536;12668.68328291791;15157.621059473491;15371.615709607266;4794.113089078532;4894.290327902452;4960.627952903528;5028.723420211887;5029.371328583927;3725.329440700673;3847.5960024197334;3849.671863207189;4904.06822703687;5513.641613295123;5623.80316688916;5631.267935168443;5647.774089036434;5650.7174641267975;5655.4061823508555;5462.180672899077;5581.720913954286;5587.497125258747;5589.469000444951;5610.186522954169;4885.633577481668;4909.680870743426;4917.40991081069;4938.530839570235;4938.703677779309;18947.715784263248;19248.23007079715;19502.902485487622;19507.414777556554;19708.50728731779;1923.6345094432013;1953.0722906619385;1958.226500532296;1984.1468168687459;1995.6407846587608;12755.553555625509;12767.467903851504;12870.871291287061;12935.741285174337;13092.86907130926;1743.564108972757;1789.8568114550806;1811.148760082759;1916.865819392643;1996.2613832881782;55619.721901390236;57790.42209577892;58257.70871145617;58948.41051589515;59236.70381648064;9811.166050885611;9841.655542055994;9846.704598862045;9868.210543156674;9936.304458687822;12537.623871283877;12558.623241302776;12564.560240391542;12573.37133143339;12580.81128783069;6956.826079348057;7033.8944915826305;7084;7108.822279442952;7121.501494895308;6666.96666516674;6684.9331506685285;6707.3628005339415;6847.931520684829;6861.897071543931;3975.5229372475487;3996.0609256824623;4150.27370210218;4159.230542349615;4164.895877603084;1611.7743515907782;1642.6386195037073;1657.5607464022044;1697.3719723702063;1735.9045252511232;372.67949563375475;375.82899780599763;377.3302388260859;404.79557823299047;839.2698352433422;9023.413478124032;9697.806043879084;14992.925035374972;15697;16201.756973645404;821.557183658264;831.0484495252902;876.1282523888772;879.6437442835662;896.5382827843666;8533;8780.824383512294;8878.378513503993;9377.437353758796;9429.198518125899;494902;496660;497065;510542;514535;69275.3072469279;69474.65262673654;70898.64550677317;72220.27779722135;72695.2730472699;1104.4256986367045;1106.1040557148574;1113.287496002559;1136.8067428537167;1137.3346592243631;14500.564983050524;14668.266586670838;14831.40674373013;14838.40646374133;15088.54734357971;34132.658673412945;34416.82791586026;34434.13914652054;34554.481682774276;35325.82337088298;44738.77630611826;44800.10399792051;45572.54427455815;45670.771646141555;47951;8614.095519970313;8754.737357879274;8765.912340876765;12084.516619335129;12418.254904705747;16856.831431685525;17124.40064597783;17182.742258865877;17259.654806904044;17772.822271777633;11731.941340293244;12085.456154473246;12401;14251.35868885882;14964.625884352978;8322.79193020155;8559.828803423772;8815.823683526422;13379.86620133825;13439.193648381128;9250.02874698147;9269.165775080275;9305.302102342486;9488.905110948803;9676.22590192797;13643.931780341432;13928.651783705489;14288.142711437347;14382.208978505863;14519.78220326717;14592.343344549734;15062.698746025237;15133.54599362021;15145.394184232948;15284.847151528342 12:01:36 INFO - 2015-12-18 12:01:36,144 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1232.1621297517684;1643.7863077799884;1674.3972170018792;1710.4013595241659;1721.311475409836;5797.478226959573;6857.691403886824;7036.085308909847;7040.119985001875;7065.046218760466;6982.197047339558;7152.535085219457;7154.427645788337;7161.462890283224;7164.176119746231;1740.8346207110367;1764.4265613675543;2012.30575451469;2037.623039737646;2066.4110728442397;2047.191359413031;2060.34069097888;2061.3403710812545;2061.9587608247903;2064.6799746039387;1992.5715971066218;2005.1678553400322;2051.0052624477116;2053.4558342039372;2054.147528775564;1972.0534143611146;1983.2761042219631;1997.3508609701832;2019.8586098973005;2024.2712623455545;2037.2971324892887;2054.2707338894625;2055.1779288284656;2056.5269987902716;2057.660486019805;7036.507444478889;7131.750388736369;7165.605891675956;7171.031910692042;7173.784786456415;4167.312393455076;4227.175700738358;4245.10852720929;4251.2347777400055;4254.7021708480415;2645.537031019564;2742.9725702742917;2749.3676454415595;2760.061579063128;2767.750902418792;864.822711344173;870.7648934787635;887.5029983209423;891.572045418203;907.7322189953913;9264.166225039711;9276.953615231881;9281.489518076436;9282;9284.164425201696;3746.569144548357;3812.14226798968;3833.9041523962123;3844.9807750961068;3856.6721828644318;8129.065157506844;8139.226773456512;8160.551169685606;8161.714339998071;8176.959115204386;4240.618344349024;4247.723897946624;4256.446661933929;4258.914821703611;4261.786910654455;3840.577536470986;3850.7497012694084;3852.325842977468;3858.78776667286;3860.575336712959;2954.926126846803;2993.371392007703;3238.109519882004;3431.897043088711;3438.1404648837793;1056.8573242612304;1073.7100982734619;1080.5407701726735;1085.2945585369416;1091.93994330311;887.5652404682576;915.1397686174975;967.4098799732158;1185.1526158796503;1187.9821802672966;6640.601563906181;6677.065210870482;6715.7985260442265;6765.086713293741;6775.322467753185;1028.1312291114145;1030.6650338639972;1030.99484502577;1032.1845741863995;1043.113353649392;4939.604831613534;4959.305697202394;4961.3798275215595;4997.350344455271;5012.899742005139;8271.958640206882;8384.245417912296;8659.263962563127;8665.13348665141;8677.132286771272;8541.27399171065;8590.957045214735;8594.097619749962;8598.656053757779;8598.87101693475;6618.7021584028835;6715.992601109872;6730.764423245163;6778.084958530535;6791.336122649884;6169.413905678954;6215.9378406215355;6226.750929962932;6227.097070924781;6244.718987645658;7479.102507699111;7615.086189657277;7668.6165691716305;7685.961570192113;7747.690092396241;7779.949706789511;7903.960480197562;7944.6424910880305;7951.960240198993;8051.436399451982;6244.65654389013;6291.370862913672;6291.937080629135;6292.2134733158355;6294.213223347082;5586.888262234814;6198.690065496798;6427.710753016219;6462.515311351762;6480.319566445455;6316.11574379578;6340;6375.6812159392775;6457.5479716419395;6507.023946408077;6280.654563999024;6409.102725618511;6472.417482426604;6474.125992990886;6474.514411419068;6419.550631455753;6538.803835884931;6539.574927629689;6545.37818907203;6558.442532384801;5780.450857168562;5814.04068328721;5823.592348535732;5827.650340979555;5832.62087964281;5837.912431313449;6019.157317975574;6042.758289668364;6051.243594550681;6077.4834139098675 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.3114387757138;296.21059875431973;299.57161259399066;301.0216795414903;302.09522480171887;5227.921581176281;5239.030779305826;5290.550303224226;5378.515933565978;5453.536449401806;5265.078611243036;5346.705931173784;5353.170258609912;5354.946450535494;5366.651167674098;3903.551091624471;4128.69034822388;4129.4012368206595;4130.112025914428;4132.338825787874;3974.682025437958;4001.1197536541913;4051.027753339207;4057.4725285712816;4127.318992366256;4062.309407400749;4062.6546743526687;4066.471358723362;4068.532118806331;4070.837166513336;3851.961480385188;3931.960680393188;3952.3083460394314;4061.4720086388875;4077.87766367008;3513.0690367052753;3513.49054387115;3515.5254040704435;3541.3625547401457;3541.8760343388117;5127.282180494733;5142.820001299937;5144.176931690949;5144.254083157958;5153.304303918961;4655.813767449298;4656.32483289921;4658.045100754337;4662.650301227388;4663.417072865892;5353.491418315254;5534.225208470777;5549.861253468655;5552.3892371839065;5568.136938774496;3805.1058001369656;3810.90472738181;3810.9809450952844;3811.161544460242;3816.484774555427;5775.566832487538;5863.5309175265875;5867.677277749722;5869.178315035899;5871.6183448075735;3944.9802750986637;3959.544652364957;3959.762414255154;3961.6830653547645;3963.2271707016853;3688.207035487383;3736.4208547675153;4017.979910100431;4020.3567429211184;4025.3156963316305;4446.688731788809;4493.236149854532;4535.229011068126;4608.400907881954;4617.746023968714;5554.638948468337;5555.2778138841695;5564.054110801174;5564.916526252109;5572.832815015556;1380.703148823008;1401.0262867307326;1401.054288355356;1401.3623801170443;1402.7615305398108;902.6795487601938;906.959186836594;926.2404828041076;941.6186444489992;946.536197263336;4891.51084891508;4901.656884018156;4903.289023091632;4903.95096049035;4909.631777616693;5774.335951365562;5776.191333213354;5781.4507621775865;5781.88436231273;5791.507721843606;4889.144399730033;4890.388701412324;4890.706557606555;4896.608271338285;4917.262410638433;3032.863521141554;3082.5222090576;3119.594452721132;3120.7035331643456;3121.938540896106;5483.725813709299;5509.779608815603;5512.5589952803675;5514.172874068841;5514.696691681996;5995.46040856325;6000.939990600038;6007.519398448114;6010.459058684652;6012.969935150296;5485.094959331665;5490.533304669068;5496.780128794963;5498.505134537911;5500.367457742251;5688.971555142198;5830.737616807169;5832.475077242899;5832.766689332549;5836.182934389104;5663.830085097454;5678.716064196691;5679.318481782213;5683.033884239772;5683.261176047087;5474.042042642602;5475.534579560782;5475.917861232165;5479.369872464717;5479.863003424946;3890.105275786528;3928.2339943710704;3974.4237085623;3978.960210397859;3981.343078392033;5580.748866301107;5725.055365864752;5812.505936995402;5844.47399734026;5846.736896839738;5479.75341109659;5510.614257001971;5516.613837031369;5519.862003449785;5523.143912693539;5608.579356548194;5628.183913332462;5629.88740225185;5631.774729010794;5632.042552766122;5371.301730774974;5479.205515200353;5491.917621235764;5505.229267902577;5508.338999319947;5645.435456454322;5645.463680950304;5646.265985421869;5648.63283886546;5653.886922261614;5509.090999985118;5509.228707980806;5513.779448822002;5518.117101263779;5526.723663816873 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.6548994522848;690.7513295213726;773.5861314196906;783.839312940847;784.3842583571895;10304.124149447296;10523.263371563993;10524.842127368096;11724.648260552198;12068.93965530171;11613.941930290357;11667.299962002264;11670.066394688425;11682.299062056261;11685.006774424184;626;631.7346714379971;776.491398134223;788.0149812734082;791.5883740454974;792.2552800367665;792.5918152151646;798.8881556582083;800.131856935226;801.6112185589984;822.2805045585113;828.0642873552907;829.7303376402663;830.0454477351034;832.0431503770652;640.6316368088368;649.0588646462625;806.7620052084591;816.3877092180865;818.950862948225;609.4058293164173;611.1230384398402;611.7552978808468;612.1980205930246;612.2683393344954;10847;10860.837087443695;10898.509567069501;10953.068989135932;10968.287061340987;9885.802283954281;10068.446235457048;10373.325733827278;10520.736981575445;10727;8320.875186872201;8589.656413743443;8950.418222815497;9058.818823623556;9736.561854716554;3129.702678245563;3151.086185006345;3251.040942921844;3258.4949332853444;3278.704916557497;41023;41545.1690966179;41675;41827.1634567307;42000.94997625053;8232.300254478316;8504.659813607386;8701.30389568833;8853.335999800041;9091.86267800856;13618.114822536503;13621.727565448635;13625.182489050689;13634.1137826041;13638;6178.876422471615;6184.6598437085495;6254.6872656366995;6309.463695585835;6451.1936007999;3617.276544691072;3668.834902429397;3682.0978860179425;3684.1526448916898;3697.408414653696;2490.7384724604017;2526.166365099513;2530.127106148376;2541.440883005736;2542.720300766914;455.2533844495031;458.71330418488446;465.995340046602;468.57827954840235;473.15305602970295;463.24722326219893;551.4513059505817;556.7383329834971;592.1147883913577;618.4125081172904;7164.21193668696;7359.6688149033425;7399.371053460516;7527.9247207528315;7553.660085296065;489.5862995768641;490.11289565885863;494.9851504454872;513.8509832148635;524.2686452398882;3378.729701623864;3392.118049307198;3444.913877153041;3479.54765880439;3533.8939831805087;44799.77600112044;46705.76647116811;47265.76367118211;47269.76365118152;47407.28889066667;41439.5496157633;41447;41751.791241043604;41991.7900410496;42005.15989680251;38641.806790965864;39267;40128.79935600362;40260.798696006335;41689.58310416857;7336.193018768038;7461;7501.849963000818;7587.924120758722;7722.38220942312;30745.385092298475;30774.69225307808;31462.056138315886;31481.21296967594;31720.889768858902;36610.63389366072;38017;38191.61808381881;38312.233755325295;38769.80615096907;9558.23534117255;9922.553485093333;9999.900001000187;10089.192864570963;10235.641752538626;10767.138628909825;10773.784524309312;10794.082502987334;10941.617043403443;11208.71978200519;9867.703968880945;9926;10037.046480584333;10446.320989135682;10475.790484190426;9804.901950980684;9833.065858743408;9986.201103911815;10089.344192627455;10430.37417754937;9079.273658107468;9181.816363672555;9188.49463279526;9202.631894724404;9679.225661947168;8981.326400519856;9278.675246366345;9347.766305842408;9385.15533601979;9400.29497787655;8649.8702519461;8942.95561441051;8971.416857904216;9044.81910361776;9136.725898223063 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 12:01:36 INFO - 2015-12-18 12:01:36,145 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: __startTimestamp1450468896135__endTimestamp 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,146 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4669.67 Median:4788.88 stddev:488.82 (10.2%) stddev-sans-first:463.51 12:01:36 INFO - 2015-12-18 12:01:36,147 DEBUG : BROWSER_OUTPUT: Values: 2634.3 2710.3 2711.5 2724.0 2737.9 4538.7 4665.3 4726.6 4788.9 4799.7 4653.5 4674.8 4771.2 4776.2 4780.9 4200.6 4318.1 4331.4 4421.9 4530.0 4458.8 4517.8 4541.8 4542.1 4573.5 4200.7 4267.3 4313.4 4371.6 4391.1 4389.4 4412.3 4415.7 4428.3 4450.3 4368.7 4399.5 4399.9 4436.7 4440.1 4377.9 4486.9 4494.9 4553.9 4646.4 5100.1 5110.5 5112.1 5115.3 5155.0 5130.4 5134.7 5142.0 5143.0 5147.6 4455.3 4552.5 4555.8 4557.8 4771.8 5197.8 5198.3 5203.8 5229.4 5237.1 4968.9 4975.7 4978.7 4990.1 5021.6 4786.9 4892.1 4893.4 4931.4 5088.5 5025.8 5034.4 5036.2 5064.6 5077.6 5067.9 5081.3 5082.2 5084.1 5085.8 3953.2 4086.7 4092.6 4148.2 4303.9 3690.4 3723.1 3747.5 3762.0 3771.1 4353.0 4403.9 4404.8 4410.3 4418.9 4919.0 5038.9 5042.7 5154.9 5197.2 4330.2 4340.1 4375.2 4376.8 4397.9 4543.4 4545.3 4557.2 4558.4 4589.1 4489.2 4616.0 4804.9 4805.0 4861.5 4906.6 4979.6 5015.1 5035.7 5073.9 4837.6 4884.2 4884.9 4885.8 4931.2 4751.5 4875.9 5069.0 5085.4 5136.1 4860.0 4922.4 5006.2 5013.1 5033.1 4910.5 4978.7 4982.9 4989.4 5027.7 4680.5 4784.7 4956.1 4987.8 4991.7 4697.5 4821.3 4873.7 4883.8 4908.0 4980.6 5032.4 5034.0 5034.3 5075.8 4559.9 4676.0 4919.1 4937.3 4980.0 12:01:36 INFO - 2015-12-18 12:01:36,147 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,147 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38291.17 Median:29041.21 stddev:60169.22 (207.2%) stddev-sans-first:60271.33 12:01:36 INFO - 2015-12-18 12:01:36,147 DEBUG : BROWSER_OUTPUT: Values: 563.1 569.6 573.4 575.4 578.1 26733.0 31573.2 32297.0 32456.5 32573.3 38397.8 39086.6 39311.8 39314.0 39449.8 7048.6 7161.4 7804.3 7954.3 7968.5 10125.4 10370.5 10375.8 10382.3 10383.3 9924.0 10026.6 10053.3 10063.4 10067.7 7160.4 7332.8 7334.8 9904.3 10007.2 9755.4 9876.1 9885.6 9891.2 9898.7 36406.8 36985.0 37005.3 37025.4 37030.8 2832.8 2865.3 2952.0 3431.4 3503.4 27981.0 28190.9 28205.2 28215.7 28622.7 3394.9 3404.2 3441.1 3514.6 3518.3 213135.0 214636.0 215109.0 215195.0 215208.0 49506.5 50716.5 52075.2 52181.5 52588.5 45410.8 45516.3 45650.3 45723.0 45795.3 13958.2 14156.0 14166.5 14170.4 14185.6 10706.9 10822.8 10870.8 10894.8 10911.2 17544.3 17631.1 17760.0 17774.8 17793.5 7583.9 7647.8 7748.4 7761.7 7870.5 867.2 927.2 1002.3 1005.3 1053.2 25764.7 26017.0 26098.1 26134.2 26142.2 992.3 1038.9 1067.7 1074.0 1086.4 13699.7 14248.4 14305.4 14345.4 14372.7 265369.0 270965.0 271116.0 271522.0 271649.0 44760.8 44910.1 44975.1 45062.1 45069.8 1235.5 1247.0 1249.2 1251.1 1262.7 20822.7 24153.3 25502.6 25609.0 25752.1 38281.6 38817.0 38824.4 38834.2 38868.4 203987.0 204384.0 205082.0 205115.0 205394.0 24012.3 24355.8 27784.2 28076.3 28100.7 31861.7 32050.2 32172.8 32679.7 32851.5 28664.4 29656.6 29744.0 29998.3 30002.0 30441.5 31213.8 31876.7 32405.7 32408.4 29418.0 29585.9 31951.6 32398.8 32457.5 24719.6 25900.4 28219.7 28447.3 28457.0 22758.4 22782.9 22804.7 22945.5 23151.0 12:01:36 INFO - 2015-12-18 12:01:36,147 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,148 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27026.53 Median:2112.46 stddev:82106.71 (3886.8%) stddev-sans-first:82312.54 12:01:36 INFO - 2015-12-18 12:01:36,148 DEBUG : BROWSER_OUTPUT: Values: 313.1 316.2 317.9 320.1 323.3 12476.0 12810.1 15582.1 15922.9 16050.1 12625.9 12661.9 12668.7 15157.6 15371.6 4794.1 4894.3 4960.6 5028.7 5029.4 3725.3 3847.6 3849.7 4904.1 5513.6 5623.8 5631.3 5647.8 5650.7 5655.4 5462.2 5581.7 5587.5 5589.5 5610.2 4885.6 4909.7 4917.4 4938.5 4938.7 18947.7 19248.2 19502.9 19507.4 19708.5 1923.6 1953.1 1958.2 1984.1 1995.6 12755.6 12767.5 12870.9 12935.7 13092.9 1743.6 1789.9 1811.1 1916.9 1996.3 55619.7 57790.4 58257.7 58948.4 59236.7 9811.2 9841.7 9846.7 9868.2 9936.3 12537.6 12558.6 12564.6 12573.4 12580.8 6956.8 7033.9 7084.0 7108.8 7121.5 6667.0 6684.9 6707.4 6847.9 6861.9 3975.5 3996.1 4150.3 4159.2 4164.9 1611.8 1642.6 1657.6 1697.4 1735.9 372.7 375.8 377.3 404.8 839.3 9023.4 9697.8 14992.9 15697.0 16201.8 821.6 831.0 876.1 879.6 896.5 8533.0 8780.8 8878.4 9377.4 9429.2 494902.0 496660.0 497065.0 510542.0 514535.0 69275.3 69474.7 70898.6 72220.3 72695.3 1104.4 1106.1 1113.3 1136.8 1137.3 14500.6 14668.3 14831.4 14838.4 15088.5 34132.7 34416.8 34434.1 34554.5 35325.8 44738.8 44800.1 45572.5 45670.8 47951.0 8614.1 8754.7 8765.9 12084.5 12418.3 16856.8 17124.4 17182.7 17259.7 17772.8 11731.9 12085.5 12401.0 14251.4 14964.6 8322.8 8559.8 8815.8 13379.9 13439.2 9250.0 9269.2 9305.3 9488.9 9676.2 13643.9 13928.7 14288.1 14382.2 14519.8 14592.3 15062.7 15133.5 15145.4 15284.8 12:01:36 INFO - 2015-12-18 12:01:36,148 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,148 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4922.94 Median:6207.31 stddev:2547.68 (41.0%) stddev-sans-first:2539.72 12:01:36 INFO - 2015-12-18 12:01:36,149 DEBUG : BROWSER_OUTPUT: Values: 1232.2 1643.8 1674.4 1710.4 1721.3 5797.5 6857.7 7036.1 7040.1 7065.0 6982.2 7152.5 7154.4 7161.5 7164.2 1740.8 1764.4 2012.3 2037.6 2066.4 2047.2 2060.3 2061.3 2062.0 2064.7 1992.6 2005.2 2051.0 2053.5 2054.1 1972.1 1983.3 1997.4 2019.9 2024.3 2037.3 2054.3 2055.2 2056.5 2057.7 7036.5 7131.8 7165.6 7171.0 7173.8 4167.3 4227.2 4245.1 4251.2 4254.7 2645.5 2743.0 2749.4 2760.1 2767.8 864.8 870.8 887.5 891.6 907.7 9264.2 9277.0 9281.5 9282.0 9284.2 3746.6 3812.1 3833.9 3845.0 3856.7 8129.1 8139.2 8160.6 8161.7 8177.0 4240.6 4247.7 4256.4 4258.9 4261.8 3840.6 3850.7 3852.3 3858.8 3860.6 2954.9 2993.4 3238.1 3431.9 3438.1 1056.9 1073.7 1080.5 1085.3 1091.9 887.6 915.1 967.4 1185.2 1188.0 6640.6 6677.1 6715.8 6765.1 6775.3 1028.1 1030.7 1031.0 1032.2 1043.1 4939.6 4959.3 4961.4 4997.4 5012.9 8272.0 8384.2 8659.3 8665.1 8677.1 8541.3 8591.0 8594.1 8598.7 8598.9 6618.7 6716.0 6730.8 6778.1 6791.3 6169.4 6215.9 6226.8 6227.1 6244.7 7479.1 7615.1 7668.6 7686.0 7747.7 7779.9 7904.0 7944.6 7952.0 8051.4 6244.7 6291.4 6291.9 6292.2 6294.2 5586.9 6198.7 6427.7 6462.5 6480.3 6316.1 6340.0 6375.7 6457.5 6507.0 6280.7 6409.1 6472.4 6474.1 6474.5 6419.6 6538.8 6539.6 6545.4 6558.4 5780.5 5814.0 5823.6 5827.7 5832.6 5837.9 6019.2 6042.8 6051.2 6077.5 12:01:36 INFO - 2015-12-18 12:01:36,149 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,150 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4611.79 Median:5353.33 stddev:1379.51 (25.8%) stddev-sans-first:1344.69 12:01:36 INFO - 2015-12-18 12:01:36,150 DEBUG : BROWSER_OUTPUT: Values: 289.3 296.2 299.6 301.0 302.1 5227.9 5239.0 5290.6 5378.5 5453.5 5265.1 5346.7 5353.2 5354.9 5366.7 3903.6 4128.7 4129.4 4130.1 4132.3 3974.7 4001.1 4051.0 4057.5 4127.3 4062.3 4062.7 4066.5 4068.5 4070.8 3852.0 3932.0 3952.3 4061.5 4077.9 3513.1 3513.5 3515.5 3541.4 3541.9 5127.3 5142.8 5144.2 5144.3 5153.3 4655.8 4656.3 4658.0 4662.7 4663.4 5353.5 5534.2 5549.9 5552.4 5568.1 3805.1 3810.9 3811.0 3811.2 3816.5 5775.6 5863.5 5867.7 5869.2 5871.6 3945.0 3959.5 3959.8 3961.7 3963.2 3688.2 3736.4 4018.0 4020.4 4025.3 4446.7 4493.2 4535.2 4608.4 4617.7 5554.6 5555.3 5564.1 5564.9 5572.8 1380.7 1401.0 1401.1 1401.4 1402.8 902.7 907.0 926.2 941.6 946.5 4891.5 4901.7 4903.3 4904.0 4909.6 5774.3 5776.2 5781.5 5781.9 5791.5 4889.1 4890.4 4890.7 4896.6 4917.3 3032.9 3082.5 3119.6 3120.7 3121.9 5483.7 5509.8 5512.6 5514.2 5514.7 5995.5 6000.9 6007.5 6010.5 6013.0 5485.1 5490.5 5496.8 5498.5 5500.4 5689.0 5830.7 5832.5 5832.8 5836.2 5663.8 5678.7 5679.3 5683.0 5683.3 5474.0 5475.5 5475.9 5479.4 5479.9 3890.1 3928.2 3974.4 3979.0 3981.3 5580.7 5725.1 5812.5 5844.5 5846.7 5479.8 5510.6 5516.6 5519.9 5523.1 5608.6 5628.2 5629.9 5631.8 5632.0 5371.3 5479.2 5491.9 5505.2 5508.3 5645.4 5645.5 5646.3 5648.6 5653.9 5509.1 5509.2 5513.8 5518.1 5526.7 12:01:36 INFO - 2015-12-18 12:01:36,150 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,150 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11748.59 Median:23940.22 stddev:13370.82 (55.9%) stddev-sans-first:13382.41 12:01:36 INFO - 2015-12-18 12:01:36,152 DEBUG : BROWSER_OUTPUT: Values: 663.7 690.8 773.6 783.8 784.4 10304.1 10523.3 10524.8 11724.6 12068.9 11613.9 11667.3 11670.1 11682.3 11685.0 626.0 631.7 776.5 788.0 791.6 792.3 792.6 798.9 800.1 801.6 822.3 828.1 829.7 830.0 832.0 640.6 649.1 806.8 816.4 819.0 609.4 611.1 611.8 612.2 612.3 10847.0 10860.8 10898.5 10953.1 10968.3 9885.8 10068.4 10373.3 10520.7 10727.0 8320.9 8589.7 8950.4 9058.8 9736.6 3129.7 3151.1 3251.0 3258.5 3278.7 41023.0 41545.2 41675.0 41827.2 42000.9 8232.3 8504.7 8701.3 8853.3 9091.9 13618.1 13621.7 13625.2 13634.1 13638.0 6178.9 6184.7 6254.7 6309.5 6451.2 3617.3 3668.8 3682.1 3684.2 3697.4 2490.7 2526.2 2530.1 2541.4 2542.7 455.3 458.7 466.0 468.6 473.2 463.2 551.5 556.7 592.1 618.4 7164.2 7359.7 7399.4 7527.9 7553.7 489.6 490.1 495.0 513.9 524.3 3378.7 3392.1 3444.9 3479.5 3533.9 44799.8 46705.8 47265.8 47269.8 47407.3 41439.5 41447.0 41751.8 41991.8 42005.2 38641.8 39267.0 40128.8 40260.8 41689.6 7336.2 7461.0 7501.8 7587.9 7722.4 30745.4 30774.7 31462.1 31481.2 31720.9 36610.6 38017.0 38191.6 38312.2 38769.8 9558.2 9922.6 9999.9 10089.2 10235.6 10767.1 10773.8 10794.1 10941.6 11208.7 9867.7 9926.0 10037.0 10446.3 10475.8 9804.9 9833.1 9986.2 10089.3 10430.4 9079.3 9181.8 9188.5 9202.6 9679.2 8981.3 9278.7 9347.8 9385.2 9400.3 8649.9 8943.0 8971.4 9044.8 9136.7 12:01:36 INFO - 2015-12-18 12:01:36,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:01:36 INFO - 2015-12-18 12:01:36,152 DEBUG : BROWSER_OUTPUT: 12:01:36 INFO - 2015-12-18 12:01:36,882 INFO : Browser exited with error code: 0 12:01:36 INFO - 2015-12-18 12:01:36,904 INFO : Completed test dromaeo_css (00:18:37) 12:01:36 INFO - 2015-12-18 12:01:36,904 INFO : Starting test kraken 12:01:36 INFO - 2015-12-18 12:01:36,904 DEBUG : operating with platform_type : linux_ 12:01:36 INFO - 2015-12-18 12:01:36,904 INFO : Initialising browser for kraken test... 12:01:36 INFO - 2015-12-18 12:01:36,910 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoRMYY/profile http://localhost:60585/getInfo.html 12:01:41 INFO - 2015-12-18 12:01:41,370 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:01:41 INFO - 2015-12-18 12:01:41,370 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:01:41 INFO - 2015-12-18 12:01:41,370 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:01:41 INFO - 2015-12-18 12:01:41,370 DEBUG : BROWSER_OUTPUT: __metrics 12:01:41 INFO - 2015-12-18 12:01:41,458 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] 12:01:41 INFO - 2015-12-18 12:01:41,519 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] 12:01:42 INFO - 2015-12-18 12:01:42,329 INFO : Browser initialized. 12:01:42 INFO - 2015-12-18 12:01:42,330 INFO : Running cycle 1/1 for kraken test... 12:01:42 INFO - 2015-12-18 12:01:42,330 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoRMYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:01:54 INFO - 2015-12-18 12:01:54,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 150183936 12:01:54 INFO - 2015-12-18 12:01:54,330 DEBUG : BROWSER_OUTPUT: 12:01:56 INFO - 2015-12-18 12:01:56,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60585/tests/kraken/driver.html?testName=audio-beat-detection) 12:01:57 INFO - 2015-12-18 12:01:57,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 185008128 12:01:57 INFO - 2015-12-18 12:01:57,477 DEBUG : BROWSER_OUTPUT: 12:02:00 INFO - 2015-12-18 12:02:00,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60585/tests/kraken/driver.html?testName=audio-dft) 12:02:00 INFO - 2015-12-18 12:02:00,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 177315840 12:02:00 INFO - 2015-12-18 12:02:00,761 DEBUG : BROWSER_OUTPUT: 12:02:03 INFO - 2015-12-18 12:02:03,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60585/tests/kraken/driver.html?testName=audio-fft) 12:02:04 INFO - 2015-12-18 12:02:04,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 163663872 12:02:04 INFO - 2015-12-18 12:02:04,343 DEBUG : BROWSER_OUTPUT: 12:02:06 INFO - 2015-12-18 12:02:06,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60585/tests/kraken/driver.html?testName=audio-oscillator) 12:02:06 INFO - 2015-12-18 12:02:06,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 164368384 12:02:06 INFO - 2015-12-18 12:02:06,933 DEBUG : BROWSER_OUTPUT: 12:02:09 INFO - 2015-12-18 12:02:09,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:09 INFO - 2015-12-18 12:02:09,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 164257792 12:02:09 INFO - 2015-12-18 12:02:09,733 DEBUG : BROWSER_OUTPUT: 12:02:12 INFO - 2015-12-18 12:02:12,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60585/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:13 INFO - 2015-12-18 12:02:13,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 165183488 12:02:13 INFO - 2015-12-18 12:02:13,265 DEBUG : BROWSER_OUTPUT: 12:02:16 INFO - 2015-12-18 12:02:16,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60585/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:17 INFO - 2015-12-18 12:02:17,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 164536320 12:02:17 INFO - 2015-12-18 12:02:17,337 DEBUG : BROWSER_OUTPUT: 12:02:20 INFO - 2015-12-18 12:02:20,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60585/tests/kraken/driver.html?testName=json-parse-financial) 12:02:20 INFO - 2015-12-18 12:02:20,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 164859904 12:02:20 INFO - 2015-12-18 12:02:20,777 DEBUG : BROWSER_OUTPUT: 12:02:22 INFO - 2015-12-18 12:02:22,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:23 INFO - 2015-12-18 12:02:23,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 177451008 12:02:23 INFO - 2015-12-18 12:02:23,126 DEBUG : BROWSER_OUTPUT: 12:02:24 INFO - 2015-12-18 12:02:24,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:25 INFO - 2015-12-18 12:02:25,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 176586752 12:02:25 INFO - 2015-12-18 12:02:25,577 DEBUG : BROWSER_OUTPUT: 12:02:27 INFO - 2015-12-18 12:02:27,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:28 INFO - 2015-12-18 12:02:28,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 187588608 12:02:28 INFO - 2015-12-18 12:02:28,296 DEBUG : BROWSER_OUTPUT: 12:02:30 INFO - 2015-12-18 12:02:30,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:31 INFO - 2015-12-18 12:02:31,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 193769472 12:02:31 INFO - 2015-12-18 12:02:31,392 DEBUG : BROWSER_OUTPUT: 12:02:33 INFO - 2015-12-18 12:02:33,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:34 INFO - 2015-12-18 12:02:34,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 190705664 12:02:34 INFO - 2015-12-18 12:02:34,520 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60585/tests/kraken/driver.html?testName=ai-astar) 12:02:36 INFO - 2015-12-18 12:02:36,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 249245696 12:02:36 INFO - 2015-12-18 12:02:36,555 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,559 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:02:36 INFO - 2015-12-18 12:02:36,559 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:02:36 INFO - 2015-12-18 12:02:36,559 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:02:36 INFO - 2015-12-18 12:02:36,559 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;111;111;112;103;111;112;103 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;129;152;169;131;153;154;130;173;130 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;167;162;162;165;166;162;162 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;80;91;73;72;72;119;91;73 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;129;94;94;94;134;93;94;128 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;109;110;109;109 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;146;147;146;147;147;146 12:02:36 INFO - 2015-12-18 12:02:36,560 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;96;95;96;95;96 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;73;71;72;73;72;83;70;71 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;69;69;68;68;67 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;81;83;82;84;92;83;82;88;82 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;131;126;131;119;123;128;124;124;118 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;139;146;147;148;135;148;144;145;134 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;69;75;70;70;71;70;69;69;70 12:02:36 INFO - 2015-12-18 12:02:36,561 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:02:36 INFO - 2015-12-18 12:02:36,562 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:02:36 INFO - 2015-12-18 12:02:36,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,968 12:02:36 INFO - 2015-12-18 12:02:36,562 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:02:36 INFO - 2015-12-18 12:02:36,562 DEBUG : BROWSER_OUTPUT: __startTimestamp1450468956557__endTimestamp 12:02:36 INFO - 2015-12-18 12:02:36,562 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,565 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:02:36 INFO - 2015-12-18 12:02:36,565 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.81 (3.4%) stddev-sans-first:3.98 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 111.0 111.0 112.0 103.0 111.0 112.0 103.0 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:17.30 (11.3%) stddev-sans-first:17.42 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: Values: 164.0 129.0 152.0 169.0 131.0 153.0 154.0 130.0 173.0 130.0 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:2.23 (1.4%) stddev-sans-first:2.26 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 167.0 162.0 162.0 165.0 166.0 162.0 162.0 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.00 stddev:15.26 (20.9%) stddev-sans-first:15.79 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 80.0 91.0 73.0 72.0 72.0 119.0 91.0 73.0 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:94.00 stddev:17.76 (18.9%) stddev-sans-first:18.41 12:02:36 INFO - 2015-12-18 12:02:36,566 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 129.0 94.0 94.0 94.0 134.0 93.0 94.0 128.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.50 stddev:3.70 (5.1%) stddev-sans-first:3.92 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 73.0 71.0 72.0 73.0 72.0 83.0 70.0 71.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 67.0 12:02:36 INFO - 2015-12-18 12:02:36,567 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.38 (4.0%) stddev-sans-first:3.59 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: Values: 84.0 81.0 83.0 82.0 84.0 92.0 83.0 82.0 88.0 82.0 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:4.40 (3.5%) stddev-sans-first:4.65 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: Values: 126.0 131.0 126.0 131.0 119.0 123.0 128.0 124.0 124.0 118.0 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:145.50 stddev:5.61 (3.9%) stddev-sans-first:5.49 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: Values: 136.0 139.0 146.0 147.0 148.0 135.0 148.0 144.0 145.0 134.0 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:1.96 (2.8%) stddev-sans-first:1.87 12:02:36 INFO - 2015-12-18 12:02:36,568 DEBUG : BROWSER_OUTPUT: Values: 73.0 69.0 75.0 70.0 70.0 71.0 70.0 69.0 69.0 70.0 12:02:36 INFO - 2015-12-18 12:02:36,569 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:02:36 INFO - 2015-12-18 12:02:36,569 DEBUG : BROWSER_OUTPUT: 12:02:37 INFO - 2015-12-18 12:02:37,438 INFO : Browser exited with error code: 0 12:02:37 INFO - 2015-12-18 12:02:37,489 INFO : Completed test kraken (00:01:00) 12:02:37 INFO - 2015-12-18 12:02:37,489 INFO : Starting test v8_7 12:02:37 INFO - 2015-12-18 12:02:37,490 DEBUG : operating with platform_type : linux_ 12:02:37 INFO - 2015-12-18 12:02:37,490 INFO : Initialising browser for v8_7 test... 12:02:37 INFO - 2015-12-18 12:02:37,496 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwr1bjT/profile http://localhost:60585/getInfo.html 12:02:42 INFO - 2015-12-18 12:02:42,016 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:02:42 INFO - 2015-12-18 12:02:42,016 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:02:42 INFO - 2015-12-18 12:02:42,016 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:02:42 INFO - 2015-12-18 12:02:42,016 DEBUG : BROWSER_OUTPUT: __metrics 12:02:42 INFO - 2015-12-18 12:02:42,165 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] 12:02:42 INFO - 2015-12-18 12:02:42,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] 12:02:42 ERROR - 2015-12-18 12:02:42,249 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:02:43 INFO - 2015-12-18 12:02:43,166 INFO : Browser initialized. 12:02:43 INFO - 2015-12-18 12:02:43,166 INFO : Running cycle 1/1 for v8_7 test... 12:02:43 INFO - 2015-12-18 12:02:43,166 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwr1bjT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:55 INFO - 2015-12-18 12:02:55,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 150044672 12:02:55 INFO - 2015-12-18 12:02:55,119 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60585/tests/v8_7/run.html (next: http://localhost:60585/tests/v8_7/run.html) 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 450269184 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:03:16 INFO - 2015-12-18 12:03:16,761 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6451880072884 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.46280067126608 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2024.2914979757086 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |7;RegExp;27405.405405405407 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |8;Splay;614.3470263641938 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: __startTimestamp1450468996754__endTimestamp 12:03:16 INFO - 2015-12-18 12:03:16,762 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.65 Median:165.65 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: Values: 165.6 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.46 Median:186.46 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: Values: 186.5 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,763 DEBUG : BROWSER_OUTPUT: Values: 278.7 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: Values: 5196.9 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: Values: 2024.3 12:03:16 INFO - 2015-12-18 12:03:16,764 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: Values: 789.3 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: Values: 12268.3 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27405.41 Median:27405.41 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: Values: 27405.4 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.35 Median:614.35 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: Values: 614.3 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: Values: 4845.4 12:03:16 INFO - 2015-12-18 12:03:16,765 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:03:16 INFO - 2015-12-18 12:03:16,766 DEBUG : BROWSER_OUTPUT: 12:03:17 INFO - 2015-12-18 12:03:17,646 INFO : Browser exited with error code: 0 12:03:17 INFO - 2015-12-18 12:03:17,663 INFO : Completed test v8_7 (00:00:40) 12:03:17 INFO - 2015-12-18 12:03:17,817 INFO : Completed test suite (00:20:18) 12:03:17 INFO - 2015-12-18 12:03:17,817 DEBUG : Working with test: dromaeo_css 12:03:17 INFO - 2015-12-18 12:03:17,817 DEBUG : Generating results file: dromaeo_css 12:03:17 INFO - 2015-12-18 12:03:17,819 DEBUG : Working with test: kraken 12:03:17 INFO - 2015-12-18 12:03:17,819 DEBUG : Generating results file: kraken 12:03:17 INFO - 2015-12-18 12:03:17,819 INFO : javascript benchmark 12:03:17 INFO - 2015-12-18 12:03:17,819 DEBUG : Working with test: v8_7 12:03:17 INFO - 2015-12-18 12:03:17,819 DEBUG : Generating results file: v8_7 12:03:17 INFO - 2015-12-18 12:03:17,820 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:17 INFO - 2015-12-18 12:03:17,888 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 12:03:17 INFO - 2015-12-18 12:03:17,888 DEBUG : process_Request line: dromaeo_css 6235.59 graph.html#tests=[[72,203,35]] 12:03:17 INFO - 2015-12-18 12:03:17,888 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:17 INFO - 2015-12-18 12:03:17,919 DEBUG : process_Request line: kraken 1521.00 graph.html#tests=[[232,203,35]] 12:03:17 INFO - 2015-12-18 12:03:17,919 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:03:17 INFO - 2015-12-18 12:03:17,949 DEBUG : process_Request line: v8_7 19679.09 graph.html#tests=[[230,203,35]] 12:03:17 INFO - 2015-12-18 12:03:17,950 INFO : javascript benchmark 12:03:18 INFO - 2015-12-18 12:03:17,954 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.3019099938515, 2710.2546799630086, 2711.5254830404674, 2723.9727602723965, 2737.876795544201, 4538.727676339414, 4665.3235280884255, 4726.598239149672, 4788.8802779930475, 4799.688020278684, 4653.464851542065, 4674.766261686919, 4771.1888978873585, 4776.188048031834, 4780.90438191236, 4200.600942910419, 4318.093200427914, 4331.3719510670935, 4421.867343979669, 4529.977350113245, 4458.799354029076, 4517.774111294439, 4541.841035563756, 4542.114287713897, 4573.474050484204, 4200.705950583476, 4267.295896177127, 4313.396124542566, 4371.628411585019, 4391.077873646538, 4389.429374181368, 4412.294032954744, 4415.7350558966245, 4428.269335559628, 4450.332450132506, 4368.650507959355, 4399.5160532341415, 4399.912001759947, 4436.73379597222, 4440.111977604492, 4377.949292169888, 4486.865394038184, 4494.865154045384, 4553.908921821579, 4646.4424269087585, 5100.056489549445, 5110.463401342842, 5112.105381558213, 5115.258287548322, 5154.994776018678, 5130.4356520782685, 5134.691918484866, 5142.0, 5143.04853602081, 5147.639665223436, 4455.309427038782, 4552.544745525454, 4555.840545580889, 4557.772111394417, 4771.785269662873, 5197.766100525486, 5198.2722418861385, 5203.843884683465, 5229.398619158769, 5237.057329680618, 4968.8509344719, 4975.726335051534, 4978.701277923336, 4990.101781679333, 5021.623378246573, 4786.880327991758, 4892.09496243189, 4893.363862697826, 4931.3835770528685, 5088.542031217208, 5025.849224523197, 5034.395872495324, 5036.194208926628, 5064.569511591556, 5077.593792496591, 5067.949320506747, 5081.339425874687, 5082.161443361878, 5084.084864724385, 5085.821996230115, 3953.2291203215095, 4086.67306615476, 4092.570280120604, 4148.170365926766, 4303.870883873489, 3690.4279836625365, 3723.069232691827, 3747.45661879026, 3762.0218743126984, 3771.0949372150485, 4352.978235108804, 4403.911921761547, 4404.779761011937, 4410.338449232577, 4418.911621767546, 4919.0, 5038.874028149326, 5042.697438153649, 5154.871128221749, 5197.22041693749, 4330.155619654137, 4340.110277393127, 4375.212461756914, 4376.846810361686, 4397.868063958086, 4543.386642803245, 4545.2954792007295, 4557.225271703818, 4558.430196225472, 4589.059242855206, 4489.236829739018, 4616.030633566988, 4804.927926081042, 4805.0, 4861.465238823726, 4906.582940450102, 4979.551840334388, 5015.072211640858, 5035.672681275705, 5073.898522029613, 4837.637177211653, 4884.1941079722865, 4884.877878053077, 4885.828995985124, 4931.16170251051, 4751.453582838018, 4875.90248195027, 5069.0, 5085.4406015337545, 5136.101182293159, 4860.0, 4922.384701912261, 5006.1739812930455, 5013.122703526941, 5033.0688822567945, 4910.533499317559, 4978.6763860348965, 4982.875428114181, 4989.376327959005, 5027.74861256943, 4680.46174689915, 4784.6889952153, 4956.058348913695, 4987.750612469435, 4991.700497970133, 4697.483276839614, 4821.349117869043, 4873.707577545217, 4883.804647814048, 4908.0, 4980.576650984707, 5032.421271553671, 5033.99320135967, 5034.270030845581, 5075.796968121382, 4559.886002849956, 4676.018036212434, 4919.0899683558655, 4937.259411088222, 4979.975100124476], "unit": "score", "name": "dojo.html", "value": 4639.475725281262}, {"lowerIsBetter": false, "replicates": [563.1327755256902, 569.6411260905629, 573.4351663611345, 575.3584753000406, 578.1154833105347, 26733.0, 31573.21066973324, 32297.0, 32456.513152302676, 32573.348533029326, 38397.808010959976, 39086.60913390865, 39311.803440982825, 39314.0, 39449.80275098627, 7048.612326322051, 7161.391281741058, 7804.297613214823, 7954.323882469997, 7968.482048666818, 10125.3924764514, 10370.481475926212, 10375.79248415035, 10382.273240873143, 10383.325083869524, 9923.950380248089, 10026.59893604255, 10053.346532475402, 10063.446510441923, 10067.697969060904, 7160.355567998905, 7332.816679582999, 7334.779956601257, 9904.257180711404, 10007.24945629077, 9755.365901216399, 9876.061774131445, 9885.555150018194, 9891.159251463634, 9898.653547125889, 36406.81796591027, 36985.0, 37005.25989480222, 37025.444618330745, 37030.81484592587, 2832.7712755405755, 2865.3266482376625, 2952.0, 3431.4338134207824, 3503.3518799022263, 27981.0, 28190.85904570464, 28205.153845384466, 28215.717842821516, 28622.713772862422, 3394.915127121817, 3404.2000129969438, 3441.105312618712, 3514.61339252682, 3518.313928783888, 213135.0, 214636.0, 215109.0, 215195.0, 215208.0, 49506.504934950906, 50716.49283507118, 52075.218871716956, 52181.478185218424, 52588.47411525836, 45410.77294613506, 45516.3172552412, 45650.31524527135, 45723.0, 45795.31307030397, 13958.232297223547, 14156.0, 14166.504172353918, 14170.433182672783, 14185.645358866112, 10706.946465267623, 10822.837657435144, 10870.782584348426, 10894.836577451344, 10911.23621346514, 17544.298228070733, 17631.118444077743, 17760.0, 17774.822251777317, 17793.466196014142, 7583.924160758432, 7647.770566883002, 7748.4188685848785, 7761.72833950809, 7870.527768333918, 867.1631875240423, 927.2072378116748, 1002.3384566186282, 1005.261133067195, 1053.2258789789498, 25764.742352576235, 26017.0, 26098.086566970065, 26134.215973520826, 26142.215733528024, 992.3400938376044, 1038.9324693894873, 1067.7223921780394, 1073.9624113156, 1086.397049637443, 13699.726005480034, 14248.430062797372, 14305.356258968372, 14345.426182952773, 14372.712545749026, 265369.0, 270965.0, 271116.0, 271522.0, 271648.98457107815, 44760.77619611881, 44910.10179796386, 44975.10049798986, 45062.09875802466, 45069.774651126536, 1235.456399184356, 1246.987530124687, 1249.188027781949, 1251.1179618369029, 1262.715888925003, 20822.687659684812, 24153.275401737978, 25502.617460737732, 25609.0, 25752.13924783592, 38281.6171838278, 38817.0, 38824.41763373495, 38834.223315534095, 38868.416973744854, 203987.0, 204384.0, 205082.0, 205115.0, 205394.0, 24012.27963161108, 24355.756442435348, 27784.166475005783, 28076.29809254785, 28100.71899280981, 31861.68138318587, 32050.19874503156, 32172.83913580417, 32679.673203267663, 32851.50722739209, 28664.426711466072, 29656.555151673172, 29744.0, 29998.25004374821, 30002.0, 30441.543376849808, 31213.8439307802, 31876.681233188297, 32405.675943240265, 32408.351832962737, 29418.0, 29585.852070739507, 31951.562179702432, 32398.83800580982, 32457.51313730343, 24719.62920556229, 25900.35249118787, 28219.71780282171, 28447.28881777972, 28457.0, 22758.431039224153, 22782.89278289265, 22804.657930131394, 22945.54108917779, 23151.0], "unit": "score", "name": "ext.html", "value": 16642.1431015102}, {"lowerIsBetter": false, "replicates": [313.09671597441405, 316.1779373628565, 317.88079470198676, 320.12286335440893, 323.3145731050173, 12476.0, 12810.10329276951, 15582.142982135978, 15922.885398022128, 16050.1172435516, 12625.936870315658, 12661.936690316536, 12668.68328291791, 15157.621059473491, 15371.615709607266, 4794.113089078532, 4894.290327902452, 4960.627952903528, 5028.723420211887, 5029.371328583927, 3725.329440700673, 3847.5960024197334, 3849.671863207189, 4904.06822703687, 5513.641613295123, 5623.80316688916, 5631.267935168443, 5647.774089036434, 5650.7174641267975, 5655.4061823508555, 5462.180672899077, 5581.720913954286, 5587.497125258747, 5589.469000444951, 5610.186522954169, 4885.633577481668, 4909.680870743426, 4917.40991081069, 4938.530839570235, 4938.703677779309, 18947.715784263248, 19248.23007079715, 19502.902485487622, 19507.414777556554, 19708.50728731779, 1923.6345094432013, 1953.0722906619385, 1958.226500532296, 1984.1468168687459, 1995.6407846587608, 12755.553555625509, 12767.467903851504, 12870.871291287061, 12935.741285174337, 13092.86907130926, 1743.564108972757, 1789.8568114550806, 1811.148760082759, 1916.865819392643, 1996.2613832881782, 55619.721901390236, 57790.42209577892, 58257.70871145617, 58948.41051589515, 59236.70381648064, 9811.166050885611, 9841.655542055994, 9846.704598862045, 9868.210543156674, 9936.304458687822, 12537.623871283877, 12558.623241302776, 12564.560240391542, 12573.37133143339, 12580.81128783069, 6956.826079348057, 7033.8944915826305, 7084.0, 7108.822279442952, 7121.501494895308, 6666.96666516674, 6684.9331506685285, 6707.3628005339415, 6847.931520684829, 6861.897071543931, 3975.5229372475487, 3996.0609256824623, 4150.27370210218, 4159.230542349615, 4164.895877603084, 1611.7743515907782, 1642.6386195037073, 1657.5607464022044, 1697.3719723702063, 1735.9045252511232, 372.67949563375475, 375.82899780599763, 377.3302388260859, 404.79557823299047, 839.2698352433422, 9023.413478124032, 9697.806043879084, 14992.925035374972, 15697.0, 16201.756973645404, 821.557183658264, 831.0484495252902, 876.1282523888772, 879.6437442835662, 896.5382827843666, 8533.0, 8780.824383512294, 8878.378513503993, 9377.437353758796, 9429.198518125899, 494902.0, 496660.0, 497065.0, 510542.0, 514535.0, 69275.3072469279, 69474.65262673654, 70898.64550677317, 72220.27779722135, 72695.2730472699, 1104.4256986367045, 1106.1040557148574, 1113.287496002559, 1136.8067428537167, 1137.3346592243631, 14500.564983050524, 14668.266586670838, 14831.40674373013, 14838.40646374133, 15088.54734357971, 34132.658673412945, 34416.82791586026, 34434.13914652054, 34554.481682774276, 35325.82337088298, 44738.77630611826, 44800.10399792051, 45572.54427455815, 45670.771646141555, 47951.0, 8614.095519970313, 8754.737357879274, 8765.912340876765, 12084.516619335129, 12418.254904705747, 16856.831431685525, 17124.40064597783, 17182.742258865877, 17259.654806904044, 17772.822271777633, 11731.941340293244, 12085.456154473246, 12401.0, 14251.35868885882, 14964.625884352978, 8322.79193020155, 8559.828803423772, 8815.823683526422, 13379.86620133825, 13439.193648381128, 9250.02874698147, 9269.165775080275, 9305.302102342486, 9488.905110948803, 9676.22590192797, 13643.931780341432, 13928.651783705489, 14288.142711437347, 14382.208978505863, 14519.78220326717, 14592.343344549734, 15062.698746025237, 15133.54599362021, 15145.394184232948, 15284.847151528342], "unit": "score", "name": "jquery.html", "value": 8248.722266668774}, {"lowerIsBetter": false, "replicates": [1232.1621297517684, 1643.7863077799884, 1674.3972170018792, 1710.4013595241659, 1721.311475409836, 5797.478226959573, 6857.691403886824, 7036.085308909847, 7040.119985001875, 7065.046218760466, 6982.197047339558, 7152.535085219457, 7154.427645788337, 7161.462890283224, 7164.176119746231, 1740.8346207110367, 1764.4265613675543, 2012.30575451469, 2037.623039737646, 2066.4110728442397, 2047.191359413031, 2060.34069097888, 2061.3403710812545, 2061.9587608247903, 2064.6799746039387, 1992.5715971066218, 2005.1678553400322, 2051.0052624477116, 2053.4558342039372, 2054.147528775564, 1972.0534143611146, 1983.2761042219631, 1997.3508609701832, 2019.8586098973005, 2024.2712623455545, 2037.2971324892887, 2054.2707338894625, 2055.1779288284656, 2056.5269987902716, 2057.660486019805, 7036.507444478889, 7131.750388736369, 7165.605891675956, 7171.031910692042, 7173.784786456415, 4167.312393455076, 4227.175700738358, 4245.10852720929, 4251.2347777400055, 4254.7021708480415, 2645.537031019564, 2742.9725702742917, 2749.3676454415595, 2760.061579063128, 2767.750902418792, 864.822711344173, 870.7648934787635, 887.5029983209423, 891.572045418203, 907.7322189953913, 9264.166225039711, 9276.953615231881, 9281.489518076436, 9282.0, 9284.164425201696, 3746.569144548357, 3812.14226798968, 3833.9041523962123, 3844.9807750961068, 3856.6721828644318, 8129.065157506844, 8139.226773456512, 8160.551169685606, 8161.714339998071, 8176.959115204386, 4240.618344349024, 4247.723897946624, 4256.446661933929, 4258.914821703611, 4261.786910654455, 3840.577536470986, 3850.7497012694084, 3852.325842977468, 3858.78776667286, 3860.575336712959, 2954.926126846803, 2993.371392007703, 3238.109519882004, 3431.897043088711, 3438.1404648837793, 1056.8573242612304, 1073.7100982734619, 1080.5407701726735, 1085.2945585369416, 1091.93994330311, 887.5652404682576, 915.1397686174975, 967.4098799732158, 1185.1526158796503, 1187.9821802672966, 6640.601563906181, 6677.065210870482, 6715.7985260442265, 6765.086713293741, 6775.322467753185, 1028.1312291114145, 1030.6650338639972, 1030.99484502577, 1032.1845741863995, 1043.113353649392, 4939.604831613534, 4959.305697202394, 4961.3798275215595, 4997.350344455271, 5012.899742005139, 8271.958640206882, 8384.245417912296, 8659.263962563127, 8665.13348665141, 8677.132286771272, 8541.27399171065, 8590.957045214735, 8594.097619749962, 8598.656053757779, 8598.87101693475, 6618.7021584028835, 6715.992601109872, 6730.764423245163, 6778.084958530535, 6791.336122649884, 6169.413905678954, 6215.9378406215355, 6226.750929962932, 6227.097070924781, 6244.718987645658, 7479.102507699111, 7615.086189657277, 7668.6165691716305, 7685.961570192113, 7747.690092396241, 7779.949706789511, 7903.960480197562, 7944.6424910880305, 7951.960240198993, 8051.436399451982, 6244.65654389013, 6291.370862913672, 6291.937080629135, 6292.2134733158355, 6294.213223347082, 5586.888262234814, 6198.690065496798, 6427.710753016219, 6462.515311351762, 6480.319566445455, 6316.11574379578, 6340.0, 6375.6812159392775, 6457.5479716419395, 6507.023946408077, 6280.654563999024, 6409.102725618511, 6472.417482426604, 6474.125992990886, 6474.514411419068, 6419.550631455753, 6538.803835884931, 6539.574927629689, 6545.37818907203, 6558.442532384801, 5780.450857168562, 5814.04068328721, 5823.592348535732, 5827.650340979555, 5832.62087964281, 5837.912431313449, 6019.157317975574, 6042.758289668364, 6051.243594550681, 6077.4834139098675], "unit": "score", "name": "mootools.html", "value": 4049.2576996610537}, {"lowerIsBetter": false, "replicates": [289.3114387757138, 296.21059875431973, 299.57161259399066, 301.0216795414903, 302.09522480171887, 5227.921581176281, 5239.030779305826, 5290.550303224226, 5378.515933565978, 5453.536449401806, 5265.078611243036, 5346.705931173784, 5353.170258609912, 5354.946450535494, 5366.651167674098, 3903.551091624471, 4128.69034822388, 4129.4012368206595, 4130.112025914428, 4132.338825787874, 3974.682025437958, 4001.1197536541913, 4051.027753339207, 4057.4725285712816, 4127.318992366256, 4062.309407400749, 4062.6546743526687, 4066.471358723362, 4068.532118806331, 4070.837166513336, 3851.961480385188, 3931.960680393188, 3952.3083460394314, 4061.4720086388875, 4077.87766367008, 3513.0690367052753, 3513.49054387115, 3515.5254040704435, 3541.3625547401457, 3541.8760343388117, 5127.282180494733, 5142.820001299937, 5144.176931690949, 5144.254083157958, 5153.304303918961, 4655.813767449298, 4656.32483289921, 4658.045100754337, 4662.650301227388, 4663.417072865892, 5353.491418315254, 5534.225208470777, 5549.861253468655, 5552.3892371839065, 5568.136938774496, 3805.1058001369656, 3810.90472738181, 3810.9809450952844, 3811.161544460242, 3816.484774555427, 5775.566832487538, 5863.5309175265875, 5867.677277749722, 5869.178315035899, 5871.6183448075735, 3944.9802750986637, 3959.544652364957, 3959.762414255154, 3961.6830653547645, 3963.2271707016853, 3688.207035487383, 3736.4208547675153, 4017.979910100431, 4020.3567429211184, 4025.3156963316305, 4446.688731788809, 4493.236149854532, 4535.229011068126, 4608.400907881954, 4617.746023968714, 5554.638948468337, 5555.2778138841695, 5564.054110801174, 5564.916526252109, 5572.832815015556, 1380.703148823008, 1401.0262867307326, 1401.054288355356, 1401.3623801170443, 1402.7615305398108, 902.6795487601938, 906.959186836594, 926.2404828041076, 941.6186444489992, 946.536197263336, 4891.51084891508, 4901.656884018156, 4903.289023091632, 4903.95096049035, 4909.631777616693, 5774.335951365562, 5776.191333213354, 5781.4507621775865, 5781.88436231273, 5791.507721843606, 4889.144399730033, 4890.388701412324, 4890.706557606555, 4896.608271338285, 4917.262410638433, 3032.863521141554, 3082.5222090576, 3119.594452721132, 3120.7035331643456, 3121.938540896106, 5483.725813709299, 5509.779608815603, 5512.5589952803675, 5514.172874068841, 5514.696691681996, 5995.46040856325, 6000.939990600038, 6007.519398448114, 6010.459058684652, 6012.969935150296, 5485.094959331665, 5490.533304669068, 5496.780128794963, 5498.505134537911, 5500.367457742251, 5688.971555142198, 5830.737616807169, 5832.475077242899, 5832.766689332549, 5836.182934389104, 5663.830085097454, 5678.716064196691, 5679.318481782213, 5683.033884239772, 5683.261176047087, 5474.042042642602, 5475.534579560782, 5475.917861232165, 5479.369872464717, 5479.863003424946, 3890.105275786528, 3928.2339943710704, 3974.4237085623, 3978.960210397859, 3981.343078392033, 5580.748866301107, 5725.055365864752, 5812.505936995402, 5844.47399734026, 5846.736896839738, 5479.75341109659, 5510.614257001971, 5516.613837031369, 5519.862003449785, 5523.143912693539, 5608.579356548194, 5628.183913332462, 5629.88740225185, 5631.774729010794, 5632.042552766122, 5371.301730774974, 5479.205515200353, 5491.917621235764, 5505.229267902577, 5508.338999319947, 5645.435456454322, 5645.463680950304, 5646.265985421869, 5648.63283886546, 5653.886922261614, 5509.090999985118, 5509.228707980806, 5513.779448822002, 5518.117101263779, 5526.723663816873], "unit": "score", "name": "prototype.html", "value": 4163.789174663347}, {"lowerIsBetter": false, "replicates": [663.6548994522848, 690.7513295213726, 773.5861314196906, 783.839312940847, 784.3842583571895, 10304.124149447296, 10523.263371563993, 10524.842127368096, 11724.648260552198, 12068.93965530171, 11613.941930290357, 11667.299962002264, 11670.066394688425, 11682.299062056261, 11685.006774424184, 626.0, 631.7346714379971, 776.491398134223, 788.0149812734082, 791.5883740454974, 792.2552800367665, 792.5918152151646, 798.8881556582083, 800.131856935226, 801.6112185589984, 822.2805045585113, 828.0642873552907, 829.7303376402663, 830.0454477351034, 832.0431503770652, 640.6316368088368, 649.0588646462625, 806.7620052084591, 816.3877092180865, 818.950862948225, 609.4058293164173, 611.1230384398402, 611.7552978808468, 612.1980205930246, 612.2683393344954, 10847.0, 10860.837087443695, 10898.509567069501, 10953.068989135932, 10968.287061340987, 9885.802283954281, 10068.446235457048, 10373.325733827278, 10520.736981575445, 10727.0, 8320.875186872201, 8589.656413743443, 8950.418222815497, 9058.818823623556, 9736.561854716554, 3129.702678245563, 3151.086185006345, 3251.040942921844, 3258.4949332853444, 3278.704916557497, 41023.0, 41545.1690966179, 41675.0, 41827.1634567307, 42000.94997625053, 8232.300254478316, 8504.659813607386, 8701.30389568833, 8853.335999800041, 9091.86267800856, 13618.114822536503, 13621.727565448635, 13625.182489050689, 13634.1137826041, 13638.0, 6178.876422471615, 6184.6598437085495, 6254.6872656366995, 6309.463695585835, 6451.1936007999, 3617.276544691072, 3668.834902429397, 3682.0978860179425, 3684.1526448916898, 3697.408414653696, 2490.7384724604017, 2526.166365099513, 2530.127106148376, 2541.440883005736, 2542.720300766914, 455.2533844495031, 458.71330418488446, 465.995340046602, 468.57827954840235, 473.15305602970295, 463.24722326219893, 551.4513059505817, 556.7383329834971, 592.1147883913577, 618.4125081172904, 7164.21193668696, 7359.6688149033425, 7399.371053460516, 7527.9247207528315, 7553.660085296065, 489.5862995768641, 490.11289565885863, 494.9851504454872, 513.8509832148635, 524.2686452398882, 3378.729701623864, 3392.118049307198, 3444.913877153041, 3479.54765880439, 3533.8939831805087, 44799.77600112044, 46705.76647116811, 47265.76367118211, 47269.76365118152, 47407.28889066667, 41439.5496157633, 41447.0, 41751.791241043604, 41991.7900410496, 42005.15989680251, 38641.806790965864, 39267.0, 40128.79935600362, 40260.798696006335, 41689.58310416857, 7336.193018768038, 7461.0, 7501.849963000818, 7587.924120758722, 7722.38220942312, 30745.385092298475, 30774.69225307808, 31462.056138315886, 31481.21296967594, 31720.889768858902, 36610.63389366072, 38017.0, 38191.61808381881, 38312.233755325295, 38769.80615096907, 9558.23534117255, 9922.553485093333, 9999.900001000187, 10089.192864570963, 10235.641752538626, 10767.138628909825, 10773.784524309312, 10794.082502987334, 10941.617043403443, 11208.71978200519, 9867.703968880945, 9926.0, 10037.046480584333, 10446.320989135682, 10475.790484190426, 9804.901950980684, 9833.065858743408, 9986.201103911815, 10089.344192627455, 10430.37417754937, 9079.273658107468, 9181.816363672555, 9188.49463279526, 9202.631894724404, 9679.225661947168, 8981.326400519856, 9278.675246366345, 9347.766305842408, 9385.15533601979, 9400.29497787655, 8649.8702519461, 8942.95561441051, 8971.416857904216, 9044.81910361776, 9136.725898223063], "unit": "score", "name": "yui.html", "value": 5473.8160801934755}], "name": "dromaeo_css", "value": 6235.588154186557}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 111.0, 111.0, 112.0, 103.0, 111.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [164.0, 129.0, 152.0, 169.0, 131.0, 153.0, 154.0, 130.0, 173.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 167.0, 162.0, 162.0, 165.0, 166.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 80.0, 91.0, 73.0, 72.0, 72.0, 119.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 129.0, 94.0, 94.0, 94.0, 134.0, 93.0, 94.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 71.0, 72.0, 73.0, 72.0, 83.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 82.0, 84.0, 92.0, 83.0, 82.0, 88.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [126.0, 131.0, 126.0, 131.0, 119.0, 123.0, 128.0, 124.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [136.0, 139.0, 146.0, 147.0, 148.0, 135.0, 148.0, 144.0, 145.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 75.0, 70.0, 70.0, 71.0, 70.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1521.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6451880072884], "unit": "score", "name": "Richards", "value": 213.11817399999993}, {"lowerIsBetter": false, "replicates": [186.46280067126608], "unit": "score", "name": "DeltaBlue", "value": 354.59083400000003}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [27405.405405405407], "unit": "score", "name": "RegExp", "value": 33.241070019723885}, {"lowerIsBetter": false, "replicates": [614.3470263641938], "unit": "score", "name": "Splay", "value": 132.64652794411182}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19679.0850787767}]} 12:03:18 INFO - RETURN: dromaeo_css: 6235.59 12:03:18 INFO - RETURN: kraken: 1521.00 12:03:18 INFO - RETURN: v8_7: 19679.09 12:03:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19679.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6235.59"}}} 12:03:18 INFO - Return code: 0 12:03:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:03:18 ERROR - # TBPL SUCCESS # 12:03:18 INFO - Running post-action listener: _resource_record_post_action 12:03:18 INFO - Running post-run listener: _resource_record_post_run 12:03:19 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545837056; Read time: 8; Write time: 508576 12:03:19 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 226914304; Read time: 0; Write time: 334892 12:03:19 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318058496; Read time: 8; Write time: 173636 12:03:19 INFO - Running post-run listener: _upload_blobber_files 12:03:19 INFO - Blob upload gear active. 12:03:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:03:19 INFO - Copying logs to upload dir... 12:03:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.365157 ========= master_lag: 2.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-18 12:03:20.774390) ========= ========= Started set props: build_url (results: 0, elapsed: 14 secs) (at 2015-12-18 12:03:20.779191) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009945 build_url: 'https://queue.taskcluster.net/v1/task/_GNtG9nrTwenD6maXot1QA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 14.99 ========= ========= Finished set props: build_url (results: 0, elapsed: 14 secs) (at 2015-12-18 12:03:35.777527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:03:35.777829) ========= 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=e10134013339c31d8d0c4708000001d6-1450467728.327111-266041212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:03:35.949368) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2015-12-18 12:03:35.949688) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2015-12-18 12:03:37.571008) ========= ========= Total master_lag: 17.44 =========