builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1450700600.84 results: success (0) buildid: 20151221024234 builduid: 6be33dab8b714e0cbaa67afa839159f5 revision: ad9a8dfbf99ed97c0e79094cedd8561d1ef79207 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.836505) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.837020) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.837308) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006225 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.859704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.860025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.873162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.873429) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.922768) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.923075) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.923426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:20.923698) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 04:23:21-- 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% 73.2M=0s 2015-12-21 04:23:21 (73.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.072748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.073070) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.123020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.123364) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ad9a8dfbf99ed97c0e79094cedd8561d1ef79207 --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 ad9a8dfbf99ed97c0e79094cedd8561d1ef79207 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 04:23:21,747 truncating revision to first 12 chars 2015-12-21 04:23:21,747 Setting DEBUG logging. 2015-12-21 04:23:21,747 attempt 1/10 2015-12-21 04:23:21,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ad9a8dfbf99e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 04:23:22,088 unpacking tar archive at: b2g-inbound-ad9a8dfbf99e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.761924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.762319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.771624) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.771917) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:23:21.772356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-21 04:23:21.772639) ========= /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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:22 INFO - MultiFileLogger online at 20151221 04:23:22 in /builds/slave/test 04:23:22 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 04:23:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:22 INFO - {'append_to_log': False, 04:23:22 INFO - 'base_work_dir': '/builds/slave/test', 04:23:22 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 04:23:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:22 INFO - 'branch': 'B2G-Inbound-Non-PGO', 04:23:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:22 INFO - 'config_files': ('talos/linux_config.py',), 04:23:22 INFO - 'default_actions': ('clobber', 04:23:22 INFO - 'read-buildbot-config', 04:23:22 INFO - 'download-and-extract', 04:23:22 INFO - 'populate-webroot', 04:23:22 INFO - 'create-virtualenv', 04:23:22 INFO - 'install', 04:23:22 INFO - 'run-tests'), 04:23:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:22 INFO - 'download_minidump_stackwalk': True, 04:23:22 INFO - 'download_symbols': 'ondemand', 04:23:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:22 INFO - 'installer_path': 'installer.exe', 04:23:22 INFO - 'log_level': 'info', 04:23:22 INFO - 'log_name': 'talos', 04:23:22 INFO - 'log_to_console': True, 04:23:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:22 INFO - 'opt_config_files': (), 04:23:22 INFO - 'pip_index': False, 04:23:22 INFO - 'sps_profile': False, 04:23:22 INFO - 'sps_profile_interval': 0, 04:23:22 INFO - 'suite': 'dromaeojs', 04:23:22 INFO - 'system_bits': '64', 04:23:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:22 INFO - 'title': 'talos-linux64-ix-035', 04:23:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:22 INFO - 'use_talos_json': True, 04:23:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:22 INFO - 'work_dir': 'build'} 04:23:22 INFO - ##### 04:23:22 INFO - ##### Running clobber step. 04:23:22 INFO - ##### 04:23:22 INFO - Running pre-action listener: _resource_record_pre_action 04:23:22 INFO - Running main action method: clobber 04:23:22 INFO - rmtree: /builds/slave/test/build 04:23:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:22 INFO - Running post-action listener: _resource_record_post_action 04:23:22 INFO - ##### 04:23:22 INFO - ##### Running read-buildbot-config step. 04:23:22 INFO - ##### 04:23:22 INFO - Running pre-action listener: _resource_record_pre_action 04:23:22 INFO - Running main action method: read_buildbot_config 04:23:22 INFO - Using buildbot properties: 04:23:22 INFO - { 04:23:22 INFO - "project": "", 04:23:22 INFO - "product": "firefox", 04:23:22 INFO - "script_repo_revision": "production", 04:23:22 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:23:22 INFO - "repository": "", 04:23:22 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 04:23:22 INFO - "buildid": "20151221024234", 04:23:22 INFO - "pgo_build": "False", 04:23:22 INFO - "basedir": "/builds/slave/test", 04:23:22 INFO - "buildnumber": 792, 04:23:22 INFO - "slavename": "talos-linux64-ix-035", 04:23:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:23:22 INFO - "platform": "ubuntu64_hw", 04:23:22 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 04:23:22 INFO - "branch": "b2g-inbound", 04:23:22 INFO - "repo_path": "integration/b2g-inbound", 04:23:22 INFO - "revision": "ad9a8dfbf99ed97c0e79094cedd8561d1ef79207", 04:23:22 INFO - "stage_platform": "linux64", 04:23:22 INFO - "builduid": "6be33dab8b714e0cbaa67afa839159f5", 04:23:22 INFO - "slavebuilddir": "test" 04:23:22 INFO - } 04:23:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:23:22 INFO - Running post-action listener: _resource_record_post_action 04:23:22 INFO - ##### 04:23:22 INFO - ##### Running download-and-extract step. 04:23:22 INFO - ##### 04:23:22 INFO - Running pre-action listener: _resource_record_pre_action 04:23:22 INFO - Running main action method: download_and_extract 04:23:22 INFO - mkdir: /builds/slave/test/build/tests 04:23: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')]} 04:23:22 INFO - https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:23:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/test_packages.json 04:23:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/test_packages.json 04:23:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:23:23 INFO - Downloaded 1302 bytes. 04:23:23 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:23:23 INFO - Using the following test package requirements: 04:23:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'jsshell-linux-x86_64.zip'], 04:23:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:23 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')]} 04:23:23 INFO - https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:25 INFO - Downloaded 21872165 bytes. 04:23:25 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 04:23:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:25 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 04:23:26 INFO - Return code: 0 04:23:26 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 04:23: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')]} 04:23:26 INFO - https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:27 INFO - Downloaded 21872165 bytes. 04:23:27 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 04:23:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:23:27 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 04:23:29 INFO - Return code: 0 04:23: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')]} 04:23:29 INFO - https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:29 INFO - Downloaded 11132039 bytes. 04:23:29 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 04:23:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:29 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 04:23:30 INFO - Return code: 0 04:23:30 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')]} 04:23:30 INFO - https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K7CWWMQXQzualM44bW5FcQ/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 04:23:31 INFO - Downloaded 53021807 bytes. 04:23:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:23:31 INFO - mkdir: /builds/slave/test/properties 04:23:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:31 INFO - Contents: 04:23:31 INFO - build_url:https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:23:31 INFO - Running post-action listener: _resource_record_post_action 04:23:31 INFO - Running post-action listener: set_extra_try_arguments 04:23:31 INFO - ##### 04:23:31 INFO - ##### Running populate-webroot step. 04:23:31 INFO - ##### 04:23:31 INFO - Running pre-action listener: _resource_record_pre_action 04:23:31 INFO - Running main action method: populate_webroot 04:23:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:31 INFO - '--tppagecycles', 04:23:31 INFO - '7'], 04:23:31 INFO - 'tests': ['tsvgm']}}, 04:23:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:23:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:23:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:23:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'tests': ['damp', 'tps']}, 04:23:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['damp', 'tps']}, 04:23:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:23:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:31 INFO - 'other': {'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'other_l64': {'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:23:31 INFO - 'ts_paint', 04:23:31 INFO - 'tpaint', 04:23:31 INFO - 'sessionrestore', 04:23:31 INFO - 'sessionrestore_no_auto_restore']}, 04:23:31 INFO - 'svgr': {'tests': ['tsvgx', 04:23:31 INFO - 'tsvgr_opacity', 04:23:31 INFO - 'tart', 04:23:31 INFO - 'tscrollx', 04:23:31 INFO - 'cart']}, 04:23:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['tsvgx', 04:23:31 INFO - 'tsvgr_opacity', 04:23:31 INFO - 'tart', 04:23:31 INFO - 'tscrollx', 04:23:31 INFO - 'cart']}, 04:23:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'tests': ['tp5o']}, 04:23:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'talos_options': ['--e10s'], 04:23:31 INFO - 'tests': ['tp5o']}, 04:23:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'talos_options': ['--xperf_path', 04:23:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:31 INFO - 'tests': ['tp5n']}, 04:23:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:31 INFO - 'talos_options': ['--e10s', 04:23:31 INFO - '--xperf_path', 04:23:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:31 INFO - 'tests': ['tp5n']}}, 04:23:31 INFO - 'talos.zip': {'path': '', 04:23:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:31 INFO - Running post-action listener: _resource_record_post_action 04:23:31 INFO - ##### 04:23:31 INFO - ##### Running create-virtualenv step. 04:23:31 INFO - ##### 04:23:31 INFO - Running pre-action listener: _resource_record_pre_action 04:23:31 INFO - Running main action method: create_virtualenv 04:23:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:31 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 04:23:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:31 INFO - Using real prefix '/usr' 04:23:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:33 INFO - Installing pip.................done. 04:23:34 INFO - Return code: 0 04:23:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:23:34 INFO - Using env: {'DISPLAY': ':0', 04:23:34 INFO - 'HOME': '/home/cltbld', 04:23:34 INFO - 'LANG': 'en_US.UTF-8', 04:23:34 INFO - 'LANGUAGE': 'en_US:en', 04:23:34 INFO - 'LOGNAME': 'cltbld', 04:23:34 INFO - 'MAIL': '/var/mail/cltbld', 04:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:34 INFO - 'MOZ_NO_REMOTE': '1', 04:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:34 INFO - 'NO_EM_RESTART': '1', 04:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:34 INFO - 'PWD': '/builds/slave/test', 04:23:34 INFO - 'SHELL': '/bin/bash', 04:23:34 INFO - 'SHLVL': '1', 04:23:34 INFO - 'TERM': 'linux', 04:23:34 INFO - 'TMOUT': '86400', 04:23:34 INFO - 'USER': 'cltbld', 04:23:34 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:34 INFO - '_': '/tools/buildbot/bin/python'} 04:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:34 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 04:23:34 INFO - Cleaning up... 04:23:34 INFO - Return code: 0 04:23:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:23:34 INFO - Using env: {'DISPLAY': ':0', 04:23:34 INFO - 'HOME': '/home/cltbld', 04:23:34 INFO - 'LANG': 'en_US.UTF-8', 04:23:34 INFO - 'LANGUAGE': 'en_US:en', 04:23:34 INFO - 'LOGNAME': 'cltbld', 04:23:34 INFO - 'MAIL': '/var/mail/cltbld', 04:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:34 INFO - 'MOZ_NO_REMOTE': '1', 04:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:34 INFO - 'NO_EM_RESTART': '1', 04:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:34 INFO - 'PWD': '/builds/slave/test', 04:23:34 INFO - 'SHELL': '/bin/bash', 04:23:34 INFO - 'SHLVL': '1', 04:23:34 INFO - 'TERM': 'linux', 04:23:34 INFO - 'TMOUT': '86400', 04:23:34 INFO - 'USER': 'cltbld', 04:23:34 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:34 INFO - '_': '/tools/buildbot/bin/python'} 04:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:34 INFO - Downloading/unpacking psutil>=0.7.1 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:36 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:23:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:36 INFO - Installing collected packages: psutil 04:23:36 INFO - Running setup.py install for psutil 04:23:36 INFO - building 'psutil._psutil_linux' extension 04:23:36 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 04:23:36 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 04:23:36 INFO - building 'psutil._psutil_posix' extension 04:23:36 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 04:23:36 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 04:23:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:36 INFO - Successfully installed psutil 04:23:36 INFO - Cleaning up... 04:23:36 INFO - Return code: 0 04:23:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', '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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:23: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 mozsystemmonitor==0.0.0 04:23:36 INFO - Using env: {'DISPLAY': ':0', 04:23:36 INFO - 'HOME': '/home/cltbld', 04:23:36 INFO - 'LANG': 'en_US.UTF-8', 04:23:36 INFO - 'LANGUAGE': 'en_US:en', 04:23:36 INFO - 'LOGNAME': 'cltbld', 04:23:36 INFO - 'MAIL': '/var/mail/cltbld', 04:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:36 INFO - 'MOZ_NO_REMOTE': '1', 04:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:36 INFO - 'NO_EM_RESTART': '1', 04:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:36 INFO - 'PWD': '/builds/slave/test', 04:23:36 INFO - 'SHELL': '/bin/bash', 04:23:36 INFO - 'SHLVL': '1', 04:23:36 INFO - 'TERM': 'linux', 04:23:36 INFO - 'TMOUT': '86400', 04:23:36 INFO - 'USER': 'cltbld', 04:23:36 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:36 INFO - '_': '/tools/buildbot/bin/python'} 04:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:23:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:23:38 INFO - Installing collected packages: mozsystemmonitor 04:23:38 INFO - Running setup.py install for mozsystemmonitor 04:23:38 INFO - Successfully installed mozsystemmonitor 04:23:38 INFO - Cleaning up... 04:23:38 INFO - Return code: 0 04:23:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:38 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:38 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 04:23:38 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 04:23:38 INFO - Using env: {'DISPLAY': ':0', 04:23:38 INFO - 'HOME': '/home/cltbld', 04:23:38 INFO - 'LANG': 'en_US.UTF-8', 04:23:38 INFO - 'LANGUAGE': 'en_US:en', 04:23:38 INFO - 'LOGNAME': 'cltbld', 04:23:38 INFO - 'MAIL': '/var/mail/cltbld', 04:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:38 INFO - 'MOZ_NO_REMOTE': '1', 04:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:38 INFO - 'NO_EM_RESTART': '1', 04:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:38 INFO - 'PWD': '/builds/slave/test', 04:23:38 INFO - 'SHELL': '/bin/bash', 04:23:38 INFO - 'SHLVL': '1', 04:23:38 INFO - 'TERM': 'linux', 04:23:38 INFO - 'TMOUT': '86400', 04:23:38 INFO - 'USER': 'cltbld', 04:23:38 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:38 INFO - '_': '/tools/buildbot/bin/python'} 04:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:40 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 04:23:40 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 04:23:40 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 04:23:40 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 04:23:40 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 04:23:40 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 04:23:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:41 INFO - Downloading docopt-0.6.1.tar.gz 04:23:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:41 INFO - Running setup.py install for blobuploader 04:23:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:41 INFO - Running setup.py install for requests 04:23:41 INFO - Running setup.py install for docopt 04:23:41 INFO - Successfully installed blobuploader requests docopt 04:23:41 INFO - Cleaning up... 04:23:42 INFO - Return code: 0 04:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:42 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')]} 04:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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')]} 04:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:42 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:42 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 04:23:42 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 04:23:42 INFO - Using env: {'DISPLAY': ':0', 04:23:42 INFO - 'HOME': '/home/cltbld', 04:23:42 INFO - 'LANG': 'en_US.UTF-8', 04:23:42 INFO - 'LANGUAGE': 'en_US:en', 04:23:42 INFO - 'LOGNAME': 'cltbld', 04:23:42 INFO - 'MAIL': '/var/mail/cltbld', 04:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:42 INFO - 'MOZ_NO_REMOTE': '1', 04:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:42 INFO - 'NO_EM_RESTART': '1', 04:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:42 INFO - 'PWD': '/builds/slave/test', 04:23:42 INFO - 'SHELL': '/bin/bash', 04:23:42 INFO - 'SHLVL': '1', 04:23:42 INFO - 'TERM': 'linux', 04:23:42 INFO - 'TMOUT': '86400', 04:23:42 INFO - 'USER': 'cltbld', 04:23:42 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:42 INFO - '_': '/tools/buildbot/bin/python'} 04:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:42 INFO - Running setup.py (path:/tmp/pip-kieLme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:42 INFO - Running setup.py (path:/tmp/pip-75urWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:42 INFO - Running setup.py (path:/tmp/pip-kedW5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:42 INFO - Running setup.py (path:/tmp/pip-jeulLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:42 INFO - Running setup.py (path:/tmp/pip-XlgM_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:42 INFO - Running setup.py (path:/tmp/pip-8Ngb5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:42 INFO - Running setup.py (path:/tmp/pip-hSu32q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:42 INFO - Running setup.py (path:/tmp/pip-fEdVhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:42 INFO - Running setup.py (path:/tmp/pip-yEbClD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:42 INFO - Running setup.py (path:/tmp/pip-lhOE9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:42 INFO - Running setup.py (path:/tmp/pip-bLzR1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:43 INFO - Running setup.py (path:/tmp/pip-nNIycX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:43 INFO - Running setup.py (path:/tmp/pip-fvAAlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:43 INFO - Running setup.py (path:/tmp/pip-BiibHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:43 INFO - Running setup.py (path:/tmp/pip-w4Y9L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:43 INFO - Running setup.py (path:/tmp/pip-VJLkhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:43 INFO - Running setup.py (path:/tmp/pip-HaODv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:43 INFO - Running setup.py install for manifestparser 04:23:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for mozcrash 04:23:43 INFO - Running setup.py install for mozdebug 04:23:43 INFO - Running setup.py install for mozdevice 04:23:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for mozfile 04:23:43 INFO - Running setup.py install for mozhttpd 04:23:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozinfo 04:23:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozInstall 04:23:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozleak 04:23:44 INFO - Running setup.py install for mozlog 04:23:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for moznetwork 04:23:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozprocess 04:23:44 INFO - Running setup.py install for mozprofile 04:23:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozrunner 04:23:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:44 INFO - Running setup.py install for mozscreenshot 04:23:45 INFO - Running setup.py install for moztest 04:23:45 INFO - Running setup.py install for mozversion 04:23:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:45 INFO - Cleaning up... 04:23:45 INFO - Return code: 0 04:23:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:45 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')]} 04:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:45 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')]} 04:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:45 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:45 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 04:23:45 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 04:23:45 INFO - Using env: {'DISPLAY': ':0', 04:23:45 INFO - 'HOME': '/home/cltbld', 04:23:45 INFO - 'LANG': 'en_US.UTF-8', 04:23:45 INFO - 'LANGUAGE': 'en_US:en', 04:23:45 INFO - 'LOGNAME': 'cltbld', 04:23:45 INFO - 'MAIL': '/var/mail/cltbld', 04:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:45 INFO - 'MOZ_NO_REMOTE': '1', 04:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:45 INFO - 'NO_EM_RESTART': '1', 04:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:45 INFO - 'PWD': '/builds/slave/test', 04:23:45 INFO - 'SHELL': '/bin/bash', 04:23:45 INFO - 'SHLVL': '1', 04:23:45 INFO - 'TERM': 'linux', 04:23:45 INFO - 'TMOUT': '86400', 04:23:45 INFO - 'USER': 'cltbld', 04:23:45 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:45 INFO - '_': '/tools/buildbot/bin/python'} 04:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:45 INFO - Running setup.py (path:/tmp/pip-TbNUlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:45 INFO - Running setup.py (path:/tmp/pip-MjS2pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:45 INFO - Running setup.py (path:/tmp/pip-rFEt9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:45 INFO - Running setup.py (path:/tmp/pip-VXB4O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:45 INFO - Running setup.py (path:/tmp/pip-XKiok7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:45 INFO - Running setup.py (path:/tmp/pip-QB9O9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:45 INFO - Running setup.py (path:/tmp/pip-ekDWJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:45 INFO - Running setup.py (path:/tmp/pip-bgD5e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:46 INFO - Running setup.py (path:/tmp/pip-3x1hrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:46 INFO - Running setup.py (path:/tmp/pip-hlW1j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:46 INFO - Running setup.py (path:/tmp/pip-KE4RjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:46 INFO - Running setup.py (path:/tmp/pip-lWAG0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:46 INFO - Running setup.py (path:/tmp/pip-yZCb9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:46 INFO - Running setup.py (path:/tmp/pip-gQE59Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:46 INFO - Running setup.py (path:/tmp/pip-7QWJp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:46 INFO - Running setup.py (path:/tmp/pip-mmTIdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:46 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)) 04:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:46 INFO - Running setup.py (path:/tmp/pip-qw5uV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:46 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)) 04:23:46 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)) 04:23:46 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)) 04:23:46 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)) 04:23:46 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)) 04:23:46 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)) 04:23:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:48 INFO - Downloading blessings-1.5.1.tar.gz 04:23:48 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 04:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:48 INFO - Installing collected packages: blessings 04:23:48 INFO - Running setup.py install for blessings 04:23:48 INFO - Successfully installed blessings 04:23:48 INFO - Cleaning up... 04:23:48 INFO - Return code: 0 04:23:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:48 INFO - Reading from file tmpfile_stdout 04:23:48 INFO - Current package versions: 04:23:48 INFO - argparse == 1.2.1 04:23:48 INFO - blessings == 1.5.1 04:23:48 INFO - blobuploader == 1.2.4 04:23:48 INFO - docopt == 0.6.1 04:23:48 INFO - manifestparser == 1.1 04:23:48 INFO - mozInstall == 1.12 04:23:48 INFO - mozcrash == 0.16 04:23:48 INFO - mozdebug == 0.1 04:23:48 INFO - mozdevice == 0.47 04:23:48 INFO - mozfile == 1.2 04:23:48 INFO - mozhttpd == 0.7 04:23:48 INFO - mozinfo == 0.9 04:23:48 INFO - mozleak == 0.1 04:23:48 INFO - mozlog == 3.1 04:23:48 INFO - moznetwork == 0.27 04:23:48 INFO - mozprocess == 0.22 04:23:48 INFO - mozprofile == 0.27 04:23:48 INFO - mozrunner == 6.11 04:23:48 INFO - mozscreenshot == 0.1 04:23:48 INFO - mozsystemmonitor == 0.0 04:23:48 INFO - moztest == 0.7 04:23:48 INFO - mozversion == 1.4 04:23:48 INFO - psutil == 3.1.1 04:23:48 INFO - requests == 1.2.3 04:23:48 INFO - wsgiref == 0.1.2 04:23:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:48 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')]} 04:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:48 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')]} 04:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:48 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:48 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 04:23:48 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 04:23:48 INFO - Using env: {'DISPLAY': ':0', 04:23:48 INFO - 'HOME': '/home/cltbld', 04:23:48 INFO - 'LANG': 'en_US.UTF-8', 04:23:48 INFO - 'LANGUAGE': 'en_US:en', 04:23:48 INFO - 'LOGNAME': 'cltbld', 04:23:48 INFO - 'MAIL': '/var/mail/cltbld', 04:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:48 INFO - 'MOZ_NO_REMOTE': '1', 04:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:48 INFO - 'NO_EM_RESTART': '1', 04:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:48 INFO - 'PWD': '/builds/slave/test', 04:23:48 INFO - 'SHELL': '/bin/bash', 04:23:48 INFO - 'SHLVL': '1', 04:23:48 INFO - 'TERM': 'linux', 04:23:48 INFO - 'TMOUT': '86400', 04:23:48 INFO - 'USER': 'cltbld', 04:23:48 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:48 INFO - '_': '/tools/buildbot/bin/python'} 04:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 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)) 04:23:49 INFO - Cleaning up... 04:23:49 INFO - Return code: 0 04:23:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:49 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:49 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 04:23:49 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 04:23:49 INFO - Using env: {'DISPLAY': ':0', 04:23:49 INFO - 'HOME': '/home/cltbld', 04:23:49 INFO - 'LANG': 'en_US.UTF-8', 04:23:49 INFO - 'LANGUAGE': 'en_US:en', 04:23:49 INFO - 'LOGNAME': 'cltbld', 04:23:49 INFO - 'MAIL': '/var/mail/cltbld', 04:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:49 INFO - 'MOZ_NO_REMOTE': '1', 04:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:49 INFO - 'NO_EM_RESTART': '1', 04:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:49 INFO - 'PWD': '/builds/slave/test', 04:23:49 INFO - 'SHELL': '/bin/bash', 04:23:49 INFO - 'SHLVL': '1', 04:23:49 INFO - 'TERM': 'linux', 04:23:49 INFO - 'TMOUT': '86400', 04:23:49 INFO - 'USER': 'cltbld', 04:23:49 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:49 INFO - '_': '/tools/buildbot/bin/python'} 04:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:49 INFO - Downloading/unpacking jsonschema 04:23:49 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 04:23:49 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 04:23:49 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 04:23:49 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 04:23:49 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 04:23:49 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 04:23:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:50 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 04:23:50 INFO - Downloading/unpacking functools32 (from jsonschema) 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:51 INFO - warning: no files found matching '*.txt' 04:23:51 INFO - no previously-included directories found matching 'build' 04:23:51 INFO - no previously-included directories found matching 'dist' 04:23:51 INFO - no previously-included directories found matching '.git*' 04:23:51 INFO - Installing collected packages: jsonschema, functools32 04:23:51 INFO - Running setup.py install for functools32 04:23:51 INFO - warning: no files found matching '*.txt' 04:23:51 INFO - no previously-included directories found matching 'build' 04:23:51 INFO - no previously-included directories found matching 'dist' 04:23:51 INFO - no previously-included directories found matching '.git*' 04:23:51 INFO - Successfully installed jsonschema functools32 04:23:51 INFO - Cleaning up... 04:23:51 INFO - Return code: 0 04:23:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:51 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')]} 04:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:51 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')]} 04:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:51 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 0x7f6a2c966f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1baf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', '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 04:23:51 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 04:23:51 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 04:23:51 INFO - Using env: {'DISPLAY': ':0', 04:23:51 INFO - 'HOME': '/home/cltbld', 04:23:51 INFO - 'LANG': 'en_US.UTF-8', 04:23:51 INFO - 'LANGUAGE': 'en_US:en', 04:23:51 INFO - 'LOGNAME': 'cltbld', 04:23:51 INFO - 'MAIL': '/var/mail/cltbld', 04:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:51 INFO - 'MOZ_NO_REMOTE': '1', 04:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:51 INFO - 'NO_EM_RESTART': '1', 04:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:51 INFO - 'PWD': '/builds/slave/test', 04:23:51 INFO - 'SHELL': '/bin/bash', 04:23:51 INFO - 'SHLVL': '1', 04:23:51 INFO - 'TERM': 'linux', 04:23:51 INFO - 'TMOUT': '86400', 04:23:51 INFO - 'USER': 'cltbld', 04:23:51 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:51 INFO - '_': '/tools/buildbot/bin/python'} 04:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:51 INFO - Downloading/unpacking flake8 04:23:51 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 04:23:51 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 04:23:51 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 04:23:51 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 04:23:51 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 04:23:51 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 04:23:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:53 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 04:23:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:53 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 04:23:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 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 04:23:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:53 INFO - no previously-included directories found matching 'docs/_build' 04:23:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:53 INFO - Running setup.py install for pep8 04:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:54 INFO - no previously-included directories found matching 'docs/_build' 04:23:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:54 INFO - Cleaning up... 04:23:54 INFO - Return code: 0 04:23:54 INFO - Running post-action listener: _resource_record_post_action 04:23:54 INFO - Running post-action listener: _start_resource_monitoring 04:23:54 INFO - Starting resource monitoring. 04:23:54 INFO - ##### 04:23:54 INFO - ##### Running install step. 04:23:54 INFO - ##### 04:23:54 INFO - Running pre-action listener: _resource_record_pre_action 04:23:54 INFO - Running main action method: install 04:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:54 INFO - Reading from file tmpfile_stdout 04:23:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:54 INFO - Reading from file tmpfile_stdout 04:23:54 INFO - Output received: 04:23:54 INFO - Usage: mozinstall [options] installer 04:23:54 INFO - Options: 04:23:54 INFO - -h, --help show this help message and exit 04:23:54 INFO - -d DEST, --destination=DEST 04:23:54 INFO - Directory to install application into. [default: 04:23:54 INFO - "/builds/slave/test"] 04:23:54 INFO - --app=APP Application being installed. [default: firefox] 04:23:54 INFO - mkdir: /builds/slave/test/build/application 04:23:54 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'] 04:23:54 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 04:24:09 INFO - Reading from file tmpfile_stdout 04:24:09 INFO - Output received: 04:24:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:09 INFO - Running post-action listener: _resource_record_post_action 04:24:09 INFO - ##### 04:24:09 INFO - ##### Running run-tests step. 04:24:09 INFO - ##### 04:24:09 INFO - Running pre-action listener: _resource_record_pre_action 04:24:09 INFO - Running main action method: run_tests 04:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:09 INFO - Python 2.7.3 04:24:09 INFO - Return code: 0 04:24:09 INFO - grabbing minidump binary from tooltool 04:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:09 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 0x1d0c0b0>, '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 0x1d0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:09 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 04:24:09 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 04:24:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:09 INFO - Return code: 0 04:24:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:10 INFO - Return code: 0 04:24:10 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/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test/build 04:24:10 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/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 04:24:10 INFO - Using env: {'DISPLAY': ':0', 04:24:10 INFO - 'HOME': '/home/cltbld', 04:24:10 INFO - 'LANG': 'en_US.UTF-8', 04:24:10 INFO - 'LANGUAGE': 'en_US:en', 04:24:10 INFO - 'LOGNAME': 'cltbld', 04:24:10 INFO - 'MAIL': '/var/mail/cltbld', 04:24:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:10 INFO - 'MOZ_NO_REMOTE': '1', 04:24:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:10 INFO - 'NO_EM_RESTART': '1', 04:24:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:10 INFO - 'PWD': '/builds/slave/test', 04:24:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:10 INFO - 'SHELL': '/bin/bash', 04:24:10 INFO - 'SHLVL': '1', 04:24:10 INFO - 'TERM': 'linux', 04:24:10 INFO - 'TMOUT': '86400', 04:24:10 INFO - 'USER': 'cltbld', 04:24:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231', 04:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:10 INFO - '_': '/tools/buildbot/bin/python'} 04:24:10 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/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 04:24:11 INFO - mozversion INFO | application_buildid: 20151221024234 04:24:11 INFO - mozversion INFO | application_changeset: ad9a8dfbf99ed97c0e79094cedd8561d1ef79207 04:24:11 INFO - mozversion INFO | application_display_name: Nightly 04:24:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:11 INFO - mozversion INFO | application_name: Firefox 04:24:11 INFO - mozversion INFO | application_remotingname: firefox 04:24:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:24:11 INFO - mozversion INFO | application_vendor: Mozilla 04:24:11 INFO - mozversion INFO | application_version: 46.0a1 04:24:11 INFO - mozversion INFO | platform_buildid: 20151221024234 04:24:11 INFO - mozversion INFO | platform_changeset: ad9a8dfbf99ed97c0e79094cedd8561d1ef79207 04:24:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:24:11 INFO - mozversion INFO | platform_version: 46.0a1 04:24:11 INFO - 2015-12-21 04:24:11,147 DEBUG : using testdate: 1450700651 04:24:11 INFO - 2015-12-21 04:24:11,147 DEBUG : actual date: 1450700651 04:24:11 INFO - 2015-12-21 04:24:11,156 INFO : starting webserver on 'localhost:41995' 04:24:11 INFO - 2015-12-21 04:24:11,157 INFO : Starting test suite talos-linux64-ix-035 04:24:11 INFO - 2015-12-21 04:24:11,157 INFO : Starting test dromaeo_css 04:24:11 INFO - 2015-12-21 04:24:11,157 DEBUG : operating with platform_type : linux_ 04:24:11 INFO - 2015-12-21 04:24:11,158 INFO : Initialising browser for dromaeo_css test... 04:24:11 INFO - 2015-12-21 04:24:11,167 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkSyHS/profile http://localhost:41995/getInfo.html 04:24:15 INFO - 2015-12-21 04:24:15,362 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:24:15 INFO - 2015-12-21 04:24:15,362 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:24:15 INFO - 2015-12-21 04:24:15,363 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:24:15 INFO - 2015-12-21 04:24:15,363 DEBUG : BROWSER_OUTPUT: __metrics 04:24:15 INFO - 2015-12-21 04:24:15,504 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] 04:24:15 INFO - 2015-12-21 04:24:15,572 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] 04:24:16 INFO - 2015-12-21 04:24:16,687 INFO : Browser initialized. 04:24:16 INFO - 2015-12-21 04:24:16,688 INFO : Running cycle 1/1 for dromaeo_css test... 04:24:16 INFO - 2015-12-21 04:24:16,688 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkSyHS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:24:28 INFO - 2015-12-21 04:24:28,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 149929984 04:24:28 INFO - 2015-12-21 04:24:28,583 DEBUG : BROWSER_OUTPUT: 04:25:19 INFO - 2015-12-21 04:25:19,815 DEBUG : BROWSER_OUTPUT: 1450700719814 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] 04:27:31 INFO - 2015-12-21 04:27:31,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41995/tests/dromaeo/cssquery-ext.html) 04:27:33 INFO - 2015-12-21 04:27:33,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 255410176 04:27:33 INFO - 2015-12-21 04:27:33,023 DEBUG : BROWSER_OUTPUT: 04:30:35 INFO - 2015-12-21 04:30:35,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-ext.html (next: http://localhost:41995/tests/dromaeo/cssquery-jquery.html) 04:30:36 INFO - 2015-12-21 04:30:36,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 235450368 04:30:36 INFO - 2015-12-21 04:30:36,122 DEBUG : BROWSER_OUTPUT: 04:33:38 INFO - 2015-12-21 04:33:38,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41995/tests/dromaeo/cssquery-mootools.html) 04:33:38 INFO - 2015-12-21 04:33:38,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 223805440 04:33:38 INFO - 2015-12-21 04:33:38,770 DEBUG : BROWSER_OUTPUT: 04:36:40 INFO - 2015-12-21 04:36:40,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41995/tests/dromaeo/cssquery-prototype.html) 04:36:41 INFO - 2015-12-21 04:36:41,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 212148224 04:36:41 INFO - 2015-12-21 04:36:41,259 DEBUG : BROWSER_OUTPUT: 04:39:44 INFO - 2015-12-21 04:39:44,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41995/tests/dromaeo/cssquery-yui.html) 04:39:44 INFO - 2015-12-21 04:39:44,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 218050560 04:39:44 INFO - 2015-12-21 04:39:44,655 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/dromaeo/cssquery-yui.html (next: http://localhost:41995/tests/dromaeo/cssquery-dojo.html) 04:42:47 INFO - 2015-12-21 04:42:47,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 259375104 04:42:47 INFO - 2015-12-21 04:42:47,649 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,649 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:42:47 INFO - 2015-12-21 04:42:47,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:42:47 INFO - 2015-12-21 04:42:47,649 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:42:47 INFO - 2015-12-21 04:42:47,650 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:42:47 INFO - 2015-12-21 04:42:47,650 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.1874318961122;2714.117911678705;2716.606092116642;2723.387237871479;2731.4400547887685;4429.800658970346;4550.79521421536;4730.881727956803;4733.668643194974;4739.4075740532435;4549.6132828709515;4627.282771170466;4682.531746825324;4689.132510485562;4694.577488026077;4291.3777502262155;4333.674974376934;4360.825566977325;4446.444194475691;4472.664550158751;4110.835566577348;4393.802278897441;4411.448568928884;4466.910661786762;4499.527549607294;4227.598378154071;4257.6806739494505;4286.292761694317;4307.698461107724;4322.7190232634775;4352.955290730202;4353.651707863363;4355.194289056535;4370.2352088384405;4391.824327026947;4095.1400205956784;4165.812538435777;4326.307790753496;4331.913361732779;4383.868483945486;4551.271796512575;4577.244754615484;4672.0889426561835;4679.344891715163;4688.320193571913;5018.949810501885;5050.4697006814495;5050.772715227824;5051.797928082872;5105.923411148836;5072.0870243356185;5090.77091530882;5091.439941606421;5093.770780314895;5093.770780314895;4462.085272519158;4549.0447006128425;4579.816807327703;4603.746793926299;4712.340272361872;5197.688138711689;5243.554297884646;5249.317588713519;5253;5253.527182553588;5002.199648056294;5018.447970723218;5023.522765337287;5029.974850125726;5065.062963351792;4799.496052914464;4886.926696099561;4892.094962431962;4894.730789806595;4953.18272485036;5054.82308119214;5066.189409694432;5069.822556210589;5071.290019397287;5071.290019397287;5042.4957504250015;5047.747612619354;5050.898982020339;5051.898962020739;5085.771140298695;4014.3175660137845;4129.359949207817;4132.5454200037975;4214.199302132585;4290.2063118322585;3652.981735091361;3679.3745063339297;3712.6287371263197;3725.2921944830396;3745.5130832991535;4346.695731298779;4348.2825333819565;4352.129574085196;4359.258925982591;4392.231359512072;4869.586085182799;5009.323741294878;5011;5041.974790126026;5088.185890257541;4348.478182618106;4433.268510695763;4439.778011099432;4460.598546130864;4475.462944446687;4494.056248187851;4495.25828238337;4496.865094047183;4501.617362524156;4538.2738761797955;4580.992181720017;4688.578027977498;4689.648276379354;4786.760661966958;4793.376861008047;4980.153373926513;5067.46791586878;5086.084504789025;5086.949130508796;5123;4797.616190704665;4818.831340903052;4822.42130944289;4822.8794280143275;4866.683665561727;4682.016776476978;4776.5701086902345;4778.904421911612;5020.623453240948;5089.465606111453;4954.5540901319055;5002.899942001212;5022.995400919904;5040.395152581714;5074.137396642506;4914.975425122851;4971.229459433794;4974.527419895104;4974.726390048582;5027.044861476454;4638.907221855611;4752.120857641347;4912.6561140719805;4948.975255123702;5013.273075404119;4698.107359601665;4698.694584851974;4739.905201896012;4748.62011039123;4817.181079216612;4949.876253093701;4994.275830004556;5002.874928126826;5007.549320561167;5043.87390315245;4623.930641040454;4735.455422626304;4883.511648835088;4895.4370247420575;4944.629152813625 04:42:47 INFO - 2015-12-21 04:42:47,650 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.3036669346664;559.56074481532;564.9293838270216;575.7466714645556;579.9971000145001;24492.265232043046;31904.680953190462;32115.35769284616;32118.67881321186;32198.839005804995;39157.41263881044;39557.802210988906;39807;39984;40096;6949.826254343657;7022.297770222988;7792.96103519483;7945.880811787828;7954.602269886512;9989.200863930904;10244.948775256113;10246.7438314042;10248;10254.794904101913;9891.406515609051;9938.15525680318;9954.65158719445;9995.2003839693;9999.850002249972;7165.355118039375;7313.853722925512;7325.304096110861;9797.265205109645;9962.701118966443;9619.90380096197;9767.072128147815;9772.853407198898;9782.706518804376;9787.657431989917;36842.8157859209;37382.813085934395;37408.81295593532;37475.812620936995;37521.624783752086;2907.563865420204;2962.1853990152663;2985.134311049793;2995.3709720958623;3486.3201675673254;28075.719242807718;28195.577066343816;28291.292717682223;28445.146645600664;28969.275768105756;3363.983180084084;3419.4357930941364;3443;3464.1685995361186;3492.4761285807076;235755;237943.81028094923;239664;239696;240191;51076.48923510792;51619;51755.223671644955;51759;51787.74106129445;49675;50143.74928125409;60595;61553.38446615476;61658.38341616616;13487.190768553919;13517.391717372742;13616.523421680193;13617.591472255848;13647.86352136466;10630.255882088335;10778.568857245778;10779;10787.137029037658;10789.622363217406;18540.497032900654;18671.906640466983;18731.25074997012;18732.25070997145;18751.624967500575;7021.648917554102;7191.548056932597;7381.66782494789;7392.075990501187;7455.888161677579;865.6407590849727;910.153557191818;910.6949172027445;920.3879420185501;994.6071301835734;25037.374065648506;25094.37264068413;25312.367190820376;25333.87333063323;25410.745892541207;962.4995002598749;963.8457846744487;964.8600952861796;980.612658000086;998.8801343838641;13450.394732237073;13484.12353197039;13569.1858488491;13624;13670.52153174634;265844;269551;270296;270677;271153;44465;44851;45007.54992450034;45011.774941125084;45057;1186.0511590727556;1195.343822814872;1210.84864391951;1211.0553768060927;1219.536576101076;24691.382715432257;25416.491670166863;25888.223353299432;25956.480870382107;26049.348766280993;39521.60478395294;39798.801005994785;39837;39927.80036099801;39942.60057399505;249136;249528;250981;251542;252005;23904.40238994039;24401.755982439947;25893.482130357665;29185.227403396642;30634.234144145685;35651.82174089113;36320;36551.817240913624;36602.45096323504;36700.26599468049;30292.84853575718;31213.219669507536;31388.52917206198;31695.683043169272;31770.364592707556;24364;28502.42995140044;31226.531602025534;31549.211269718442;31831.84084079565;31125.844370778002;31574.684253158095;31614.36771264608;31633;31686.366272674877;26100.477990439704;27980.30049248785;28058.85970570134;28135.296617584725;28274.293142670776;21480.462988425414;21959.560808784056;22006.229781957554;22030.779692202872;22034 04:42:47 INFO - 2015-12-21 04:42:47,650 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.38166338965794;322.32633795367684;330.4877439968049;333.5680294019245;337.3489165909793;13117.672058198526;13568.864311356883;14943.775843362344;15367;15708.685826283481;14711.92644036781;14834.48079317224;14891.404343826262;14970.476033338835;15302;4869.220924652048;4871.732054736988;4992.051510213066;4994.850154495371;5008.69947803133;3742.251549690059;3798.6771124454453;5019.924701129486;5092.898142037157;5538;5725.57058220633;5754.367019627837;5756.8272951811305;5777.797777077803;5784.508316793057;5592.832215033555;5682.715864206773;5704.714764261812;5722.341930677983;5722.427757224286;4946.678465899705;4951.282064100721;4953.2074868020945;4968.354113965198;4994.87512812179;17854.910725446418;19777.40667779969;20321.79678203214;20355.287564935305;20499.18003279882;1808.4032269351214;1837.5681714797013;1862.1154951397978;1902.2771346888233;1930.0253372047166;12695.365231738377;12732.681682957907;12803.295818729966;12808.295543745091;13167.670808229776;1742.1811748478194;1775.5028591994262;1782.064416181502;1800.3158799656178;1810.8279713427335;53675;56416.435835641525;56452.717736411054;56872.71563642197;57155.71422142904;9395.295352848563;9512.524373781283;9567.091126342986;9580.281478889112;9625.181859542017;12121.515139394325;12211.633650990485;12226.694332641755;12237.816432753516;12241.877581224251;7163.283671632795;7341.706331746777;7371.778846634609;7407.592582407911;7441.739539116105;7186.245444228385;7188.281171882874;7221.53060051095;7224.67488962998;7229.674664640103;5673.914891276634;5772.105323674753;5785.392533783976;5820.534357251409;5840.182374467578;1471.2717204983387;1515.9545213643607;1520.597041783928;1527.7708343748304;1636.5744906324203;357.6048466444593;358.03866618130405;387.6317498376554;393.7539038101187;911.9954400228089;9504.762380940394;9777.951110244545;9892.243086918696;9955.402675839472;9987.750306242402;353.64458718987254;356.33187772925766;377.0084677298687;388.854179682619;393.12137372971387;4922.4339200992345;5115.923261151086;5176.301199338116;5208.374995000624;5251.8161864335325;479151;485211;487169;493099;499686;71304.64347678333;71638.64180679168;72318;73183.2681673187;74496.25503744894;418.5793277755836;422.7210041372679;423.68647201070985;424.3846422687116;424.9341352090431;8794.42836215644;8966.237869781142;9161.725148245563;9185.265178785814;9277.118673725985;30153.849230753705;30874.53688194634;31165.376692466478;34397.65602343944;34397.82801085978;41883;41931.58068419277;42032.369514456695;42313.365299521145;44356.33465497955;8516.190961858614;8660.220580147818;8751.168638979287;8761.080086591071;8847.911520884967;15379.923100384874;15520.767188491956;15664.451744188898;15791.36834526606;15979.360825567312;12955.611331660066;13239.073264871367;13620.65948351299;13712;13737.725245495234;12884.355782210665;13265.46938122503;13278;13331.800022999856;13829.792553111913;13517;13631.318434078456;13901.86098139046;14127.223002734538;14164.220967846868;8441.66233350659;8502.404831661725;8514.74455766328;8534.658613655633;8833.69082082124;9262.212711919563;9326.813463730823;9488.573014214238;13723.656908577366;13894 04:42:47 INFO - 2015-12-21 04:42:47,651 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.923114228717;1606.5341051095184;1683.5370273174876;1683.5370273174883;1710.811810700822;5793.102069179274;7055.576665400074;7204.567725936435;7234.60209688467;7237.348638622523;7221.56670599763;7237.457190710705;7307.26927307269;7316.524425912326;7321.487495875291;2077.5117847305833;2114.8731076135405;2119.5972765174643;2120.978790212101;2122.1617461102855;2145.013293884815;2167.566486702658;2170.1319472211085;2179.8256139508803;2185.606590813653;2082.333653230967;2083.312506872736;2105.1368938735122;2135.9466013349634;2136.797004284598;2084.322595156573;2109.040386624082;2115.079940226007;2115.5451577910744;2116.428564287634;2064.721262629541;2103.779103194158;2106.2312256026594;2109.1457959526415;2109.567538654572;7118.28817118284;7171.426285897168;7208.783736487913;7209.855802883913;7210.53131546453;4334.5882141196535;4388.27593447084;4413.6910416270875;4421.447319085114;4428.911421771547;2818.633577634894;2843.6018957345987;2876.0652787844033;2897.174305322973;2897.5653651952166;942.5428667096453;969.2343048991288;975.0785507695231;1655.4867990922733;1685.9662806743797;9261.907380926239;9268.768280792967;9306.86039709405;9357.485338306391;9363.34456588046;3830.3296923038356;3879.7866117363815;3929.4302326162547;3938.1139243669945;3950.9209815803524;7837.216278372117;7907.644156012993;7913.762587122395;7926.24700653437;7933.801654958672;4364.039911219526;4372.606465418127;4372.737635741865;4373.2565463871215;4374.934375984363;3216.565763621881;3317.800931944091;3847.769133851978;4037.475128233311;4039.5960403959957;3367.9326413471595;3383.780054296463;3397.524346591479;3492.6158122606494;3508.736844736655;1081.1675010242227;1094.6715985204407;1095.775366049958;1100.5872797700863;1105.9391733454738;902.7697937026016;1033.867914633475;1157.7626586549736;1180.6753142885602;1188.1089183112665;6443.420092191632;6714.362135597111;6714.865702685919;6723.63020033893;6741.764038258638;1009.6516701737888;1038.4963292802984;1052.1845569683403;1053.5522402978704;1063.803196408667;5182.97408512955;5241.633085683966;5244.5542128918705;5250.816221432308;5253.054450198924;7964.800879977931;8097.433179677484;8104.149064348277;8178.591070446454;8474.3644226682;8679.045305016443;8695.782605434788;8770.868436973451;8780.253678437277;8790.516521591373;6713.899291510631;6777.3900348967845;6894.413974812097;6908.723651054002;6909.447244220451;6855.520113592001;6904.3095690430555;6923.861522769617;6927.653617319013;6929.133858267716;7644.891490733701;7831.647575858986;7858.44990850635;7884.487508311941;7955.363570914197;7932.563708996061;7968.521888686697;7979.48133371329;7982.08206056311;7992.513241209013;5114.539691427789;5250.829300801098;5962.582619216613;6157;6260.841744277323;6492.935070649233;6840.9315906842285;6864.5881247125335;6894.3795058442975;6927.480438967198;6363.713632886439;6454.451371633464;6547.607143571401;6565.474762018932;6686.465082793267;6324.905126423199;6332.588381755171;6372.808815735535;6454.354564543508;6477.740890364333;6634.701438435185;6689;6690;6694.464442844658;6696.129503164558;5783.334916484658;5958.702064896651;6084.6349219047;6123.326434092335;6124.050772130327;6191.721372538336;6252.437280644764;6254;6254.155688981929;6261.655608941552 04:42:47 INFO - 2015-12-21 04:42:47,654 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.588748090231;295.6481786673858;297.64134218266986;301.6832326057639;301.7751774927679;5168.715720635363;5250.921236181461;5255.553277971372;5321.494458026491;5337.505498460428;5211.687298762067;5268.446813084619;5270.393904700961;5283.128283833163;5293.655912365693;3885.417187421895;4069.1861627674584;4071.8982025449454;4076.714629975903;4081.2857749893797;3956.9604303957026;3978.7612743235354;4069.409935559342;4071.9185616287655;4088.693347998912;4004.899877503057;4022.6781857451333;4028.4964379452567;4032.213718324928;4038.2125485530332;3792.867249646277;3864.14988702485;3916.060145565044;4028.436018957348;4033.2336855997414;3505.1061979195397;3507.473878918157;3510.9467159851943;3517.2262102337445;3522.806245656488;5023.819402440424;5048.192289233742;5052.595792336604;5053.140966035783;5065.214891691794;4607.976960115211;4625.745583992879;4629.930551041737;4630.166570017395;4632.559906808881;5253.894922101575;5493.972530137364;5502.642328248691;5520.227168196456;5520.751566179531;3771.5662698789715;3771.641694039062;3773.1887644156363;3773.811309434545;3775.924481510382;5732.111522713986;5824.213731146283;5826.359100498984;5829.09649004405;5829.650220986712;3925.509311336083;3940.2316548273384;3943.2507823514015;3945.349017412152;3947.4670919426085;3723.832427540767;3846.5961074087377;3986.421968814506;3996.500437445319;4007.318755811519;4415.381846541487;4446.221911165533;4551.840685575989;4597.747123908217;4604.907901842012;5528.44715528444;5529.668219906738;5538.390777014525;5543.057680194376;5549.38956714761;1360.1227208450493;1392.6379141423304;1393.8675825796533;1394.504950742472;1394.5119208277224;921.2445794448622;926.5506229478698;933.9252859771337;947.5877993073035;953.9570719317647;4836.854894353175;4839.830605928775;4842.837718947428;4848.903021939542;4851.2723091535845;5671.489565939085;5672.205891175238;5679.091345384719;5681.147827825859;5686.459786320293;4828.227483602606;4830.468648448667;4841.685290456109;4842.975785121052;4846.321514987904;3007.7593792496546;3059.5563643272044;3099.380123975214;3099.9380012400075;3101.9918526478987;5385.5960802939935;5429.267048948342;5433.402325744165;5433.6196466247775;5449.782008719607;5886.058230683156;5888.293404791452;5893.793717219963;5896.351401345849;5900.114982752536;5405.648632838853;5408.594355423359;5409.26974858397;5413.377461591967;5413.810516631899;5627.7467513961155;5737.110747834093;5809.24479817621;5811.27359080115;5813.418658134153;5668.5465162787705;5680.7443665036;5691.4877661010705;5691.715414229355;5696.686682232517;5444.455554444524;5473.370562385377;5479.945200547943;5485.50630443262;5495.670259784426;3900.3564411871725;3958.8416463342296;3988.4416181734;3998.740081894784;4005.098852758106;5558.499735023867;5695.572832037531;5788.710564471844;5802.984477716467;5803.82588522345;5402.783888644411;5523.337199536081;5531.253280807039;5531.778728850801;5567.832965011056;5559.58303127259;5576.386597474356;5587.608867379245;5590.636608620427;5598.496135347838;5328.706921119376;5446.400895901368;5467.316585426822;5469.671819690831;5476.835694929158;5594.1608758686525;5603.243562119062;5614.69119198448;5620.494155526022;5637.746301416528;5482.945170548243;5484.067708489646;5485.314335708036;5488.204210389391;5490.121580547093 04:42:47 INFO - 2015-12-21 04:42:47,655 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.581123287808;780.1028816860613;784.6233807772269;790.4743345675124;799.73608709126;13901.165930044192;14194.929025354859;14199.29003549821;14214.431422743091;14241.572752817432;13072.084954053196;13161.605151845437;13171.275579843128;13179.868201317984;13191.208527488358;634.8698516804067;638.023823549967;785.1206648553627;798.5049269452948;799.3804801278997;786.7679034684753;793.4485532554877;797.4935915693547;801.6352559585374;802.9156938521459;831.4013909984801;840.844443777903;841.2765022081005;842.0484852117099;842.1241908415241;650.9251436084863;654.0483596367297;654.5418207254941;659.399946049093;842.1241908415241;488.1213815132782;605.0289285696482;612.1582823617526;618.7401291457554;618.8947878860605;11902.34537100459;12018.399080045963;12026.639200823989;12039.63881083569;12039.81940270888;10644.627438039708;11067.948544888222;11568.652940411801;12005.87994120065;12008.579699710555;9536.475493847836;9539.761505962406;9577.521123943845;9618.855717164248;9724.902750972471;3329.766916315859;3349.0790032740947;3373.207296285371;3378.527006219131;3382.3742607617423;38238.42642360339;38358.808205959074;38492.615073849185;39135.80432097821;39423.21153576941;9645.37305075182;9754.561044753003;9822.410655360702;9842.80314393708;9941.671552212309;16598.75101873473;16617.50147495577;16632.417865374653;16677.91661041687;16687.666246675;6570.737170513126;6598.37315455031;6634.303398143125;6649.833754156185;6895.448364130958;3534.452159915217;3616.2044350242904;3632.7820330780237;3681.705463562962;3743.5320584926885;2689.986550067237;2706.8917243310443;2717.904873329424;2719.5648696208514;2733.644626198621;476.8474088291783;479.6618384039244;481.41748484334346;483.95886349660674;486.36529329224993;512.6206607110711;534.4281618668066;558.2798190334504;570.1561688700746;571.6827160925726;7024.964875175694;7140.143182818095;7223.783286501413;7294.781156565312;7304.014915105465;416.3317874810945;431.57274298444315;436.9388285640013;482.9348038014823;568.5025602597727;3274.476083826576;3289.161263877696;3447.9655203447646;3586.3903136466865;3606.74752767309;47698.76150619294;48792.26811597829;49159.26261106086;49359.75320123448;49536.50463495319;40557.133144022315;41708;41815;42279.154416912104;42433.36349954753;38675.226495469935;39190.41214381786;39524.60475395267;39733;40159.59441419595;7140.46446516503;7241;7401.888971665537;7493.737719180021;7595.696172153052;30762.76948922018;31100.066997990096;31102.35631467398;31113.377732444773;31144.688553115084;35490.46764298486;35573;36809.63190368062;39283.803580983054;39751.40372894351;9372.39079459833;9568.76078098053;9660.806783864144;9938.304318697621;10024.298299119284;11127;11160.609378671708;11270.098392128446;11300.547978080785;11326.150538709466;9882.25883058759;10031.598736050477;10392.96070392985;10423.895761042595;10746.570137194738;10096.242781791541;10333.431661258703;10334.328268662513;10364.222683298633;10447.111995480469;10074.44590547527;10345.534450949875;10412.635557755442;10697.572097116028;10738.731531711457;8735.257503112307;8910.242629376575;8930.86603700932;8998.190162885372;9558.617655293989;8007.2393122655585;8653;8683.138881255254;8691;8738.25724813398 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,960 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701767642__endTimestamp 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4645.98 Median:4735.46 stddev:488.81 (10.3%) stddev-sans-first:463.78 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: Values: 2621.2 2714.1 2716.6 2723.4 2731.4 4429.8 4550.8 4730.9 4733.7 4739.4 4549.6 4627.3 4682.5 4689.1 4694.6 4291.4 4333.7 4360.8 4446.4 4472.7 4110.8 4393.8 4411.4 4466.9 4499.5 4227.6 4257.7 4286.3 4307.7 4322.7 4353.0 4353.7 4355.2 4370.2 4391.8 4095.1 4165.8 4326.3 4331.9 4383.9 4551.3 4577.2 4672.1 4679.3 4688.3 5018.9 5050.5 5050.8 5051.8 5105.9 5072.1 5090.8 5091.4 5093.8 5093.8 4462.1 4549.0 4579.8 4603.7 4712.3 5197.7 5243.6 5249.3 5253.0 5253.5 5002.2 5018.4 5023.5 5030.0 5065.1 4799.5 4886.9 4892.1 4894.7 4953.2 5054.8 5066.2 5069.8 5071.3 5071.3 5042.5 5047.7 5050.9 5051.9 5085.8 4014.3 4129.4 4132.5 4214.2 4290.2 3653.0 3679.4 3712.6 3725.3 3745.5 4346.7 4348.3 4352.1 4359.3 4392.2 4869.6 5009.3 5011.0 5042.0 5088.2 4348.5 4433.3 4439.8 4460.6 4475.5 4494.1 4495.3 4496.9 4501.6 4538.3 4581.0 4688.6 4689.6 4786.8 4793.4 4980.2 5067.5 5086.1 5086.9 5123.0 4797.6 4818.8 4822.4 4822.9 4866.7 4682.0 4776.6 4778.9 5020.6 5089.5 4954.6 5002.9 5023.0 5040.4 5074.1 4915.0 4971.2 4974.5 4974.7 5027.0 4638.9 4752.1 4912.7 4949.0 5013.3 4698.1 4698.7 4739.9 4748.6 4817.2 4949.9 4994.3 5002.9 5007.5 5043.9 4623.9 4735.5 4883.5 4895.4 4944.6 04:42:47 INFO - 2015-12-21 04:42:47,656 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,657 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40652.83 Median:31691.02 stddev:65995.81 (208.2%) stddev-sans-first:66112.28 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: Values: 559.3 559.6 564.9 575.7 580.0 24492.3 31904.7 32115.4 32118.7 32198.8 39157.4 39557.8 39807.0 39984.0 40096.0 6949.8 7022.3 7793.0 7945.9 7954.6 9989.2 10244.9 10246.7 10248.0 10254.8 9891.4 9938.2 9954.7 9995.2 9999.9 7165.4 7313.9 7325.3 9797.3 9962.7 9619.9 9767.1 9772.9 9782.7 9787.7 36842.8 37382.8 37408.8 37475.8 37521.6 2907.6 2962.2 2985.1 2995.4 3486.3 28075.7 28195.6 28291.3 28445.1 28969.3 3364.0 3419.4 3443.0 3464.2 3492.5 235755.0 237943.8 239664.0 239696.0 240191.0 51076.5 51619.0 51755.2 51759.0 51787.7 49675.0 50143.7 60595.0 61553.4 61658.4 13487.2 13517.4 13616.5 13617.6 13647.9 10630.3 10778.6 10779.0 10787.1 10789.6 18540.5 18671.9 18731.3 18732.3 18751.6 7021.6 7191.5 7381.7 7392.1 7455.9 865.6 910.2 910.7 920.4 994.6 25037.4 25094.4 25312.4 25333.9 25410.7 962.5 963.8 964.9 980.6 998.9 13450.4 13484.1 13569.2 13624.0 13670.5 265844.0 269551.0 270296.0 270677.0 271153.0 44465.0 44851.0 45007.5 45011.8 45057.0 1186.1 1195.3 1210.8 1211.1 1219.5 24691.4 25416.5 25888.2 25956.5 26049.3 39521.6 39798.8 39837.0 39927.8 39942.6 249136.0 249528.0 250981.0 251542.0 252005.0 23904.4 24401.8 25893.5 29185.2 30634.2 35651.8 36320.0 36551.8 36602.5 36700.3 30292.8 31213.2 31388.5 31695.7 31770.4 24364.0 28502.4 31226.5 31549.2 31831.8 31125.8 31574.7 31614.4 31633.0 31686.4 26100.5 27980.3 28058.9 28135.3 28274.3 21480.5 21959.6 22006.2 22030.8 22034.0 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26054.73 Median:424.66 stddev:79920.31 (18819.9%) stddev-sans-first:80121.14 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: Values: 320.4 322.3 330.5 333.6 337.3 13117.7 13568.9 14943.8 15367.0 15708.7 14711.9 14834.5 14891.4 14970.5 15302.0 4869.2 4871.7 4992.1 4994.9 5008.7 3742.3 3798.7 5019.9 5092.9 5538.0 5725.6 5754.4 5756.8 5777.8 5784.5 5592.8 5682.7 5704.7 5722.3 5722.4 4946.7 4951.3 4953.2 4968.4 4994.9 17854.9 19777.4 20321.8 20355.3 20499.2 1808.4 1837.6 1862.1 1902.3 1930.0 12695.4 12732.7 12803.3 12808.3 13167.7 1742.2 1775.5 1782.1 1800.3 1810.8 53675.0 56416.4 56452.7 56872.7 57155.7 9395.3 9512.5 9567.1 9580.3 9625.2 12121.5 12211.6 12226.7 12237.8 12241.9 7163.3 7341.7 7371.8 7407.6 7441.7 7186.2 7188.3 7221.5 7224.7 7229.7 5673.9 5772.1 5785.4 5820.5 5840.2 1471.3 1516.0 1520.6 1527.8 1636.6 357.6 358.0 387.6 393.8 912.0 9504.8 9778.0 9892.2 9955.4 9987.8 353.6 356.3 377.0 388.9 393.1 4922.4 5115.9 5176.3 5208.4 5251.8 479151.0 485211.0 487169.0 493099.0 499686.0 71304.6 71638.6 72318.0 73183.3 74496.3 418.6 422.7 423.7 424.4 424.9 8794.4 8966.2 9161.7 9185.3 9277.1 30153.8 30874.5 31165.4 34397.7 34397.8 41883.0 41931.6 42032.4 42313.4 44356.3 8516.2 8660.2 8751.2 8761.1 8847.9 15379.9 15520.8 15664.5 15791.4 15979.4 12955.6 13239.1 13620.7 13712.0 13737.7 12884.4 13265.5 13278.0 13331.8 13829.8 13517.0 13631.3 13901.9 14127.2 14164.2 8441.7 8502.4 8514.7 8534.7 8833.7 9262.2 9326.8 9488.6 13723.7 13894.0 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5019.73 Median:6174.36 stddev:2532.87 (41.0%) stddev-sans-first:2525.35 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: Values: 1397.9 1606.5 1683.5 1683.5 1710.8 5793.1 7055.6 7204.6 7234.6 7237.3 7221.6 7237.5 7307.3 7316.5 7321.5 2077.5 2114.9 2119.6 2121.0 2122.2 2145.0 2167.6 2170.1 2179.8 2185.6 2082.3 2083.3 2105.1 2135.9 2136.8 2084.3 2109.0 2115.1 2115.5 2116.4 2064.7 2103.8 2106.2 2109.1 2109.6 7118.3 7171.4 7208.8 7209.9 7210.5 4334.6 4388.3 4413.7 4421.4 4428.9 2818.6 2843.6 2876.1 2897.2 2897.6 942.5 969.2 975.1 1655.5 1686.0 9261.9 9268.8 9306.9 9357.5 9363.3 3830.3 3879.8 3929.4 3938.1 3950.9 7837.2 7907.6 7913.8 7926.2 7933.8 4364.0 4372.6 4372.7 4373.3 4374.9 3216.6 3317.8 3847.8 4037.5 4039.6 3367.9 3383.8 3397.5 3492.6 3508.7 1081.2 1094.7 1095.8 1100.6 1105.9 902.8 1033.9 1157.8 1180.7 1188.1 6443.4 6714.4 6714.9 6723.6 6741.8 1009.7 1038.5 1052.2 1053.6 1063.8 5183.0 5241.6 5244.6 5250.8 5253.1 7964.8 8097.4 8104.1 8178.6 8474.4 8679.0 8695.8 8770.9 8780.3 8790.5 6713.9 6777.4 6894.4 6908.7 6909.4 6855.5 6904.3 6923.9 6927.7 6929.1 7644.9 7831.6 7858.4 7884.5 7955.4 7932.6 7968.5 7979.5 7982.1 7992.5 5114.5 5250.8 5962.6 6157.0 6260.8 6492.9 6840.9 6864.6 6894.4 6927.5 6363.7 6454.5 6547.6 6565.5 6686.5 6324.9 6332.6 6372.8 6454.4 6477.7 6634.7 6689.0 6690.0 6694.5 6696.1 5783.3 5958.7 6084.6 6123.3 6124.1 6191.7 6252.4 6254.0 6254.2 6261.7 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,658 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4575.88 Median:5269.42 stddev:1363.72 (25.9%) stddev-sans-first:1329.02 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: Values: 287.6 295.6 297.6 301.7 301.8 5168.7 5250.9 5255.6 5321.5 5337.5 5211.7 5268.4 5270.4 5283.1 5293.7 3885.4 4069.2 4071.9 4076.7 4081.3 3957.0 3978.8 4069.4 4071.9 4088.7 4004.9 4022.7 4028.5 4032.2 4038.2 3792.9 3864.1 3916.1 4028.4 4033.2 3505.1 3507.5 3510.9 3517.2 3522.8 5023.8 5048.2 5052.6 5053.1 5065.2 4608.0 4625.7 4629.9 4630.2 4632.6 5253.9 5494.0 5502.6 5520.2 5520.8 3771.6 3771.6 3773.2 3773.8 3775.9 5732.1 5824.2 5826.4 5829.1 5829.7 3925.5 3940.2 3943.3 3945.3 3947.5 3723.8 3846.6 3986.4 3996.5 4007.3 4415.4 4446.2 4551.8 4597.7 4604.9 5528.4 5529.7 5538.4 5543.1 5549.4 1360.1 1392.6 1393.9 1394.5 1394.5 921.2 926.6 933.9 947.6 954.0 4836.9 4839.8 4842.8 4848.9 4851.3 5671.5 5672.2 5679.1 5681.1 5686.5 4828.2 4830.5 4841.7 4843.0 4846.3 3007.8 3059.6 3099.4 3099.9 3102.0 5385.6 5429.3 5433.4 5433.6 5449.8 5886.1 5888.3 5893.8 5896.4 5900.1 5405.6 5408.6 5409.3 5413.4 5413.8 5627.7 5737.1 5809.2 5811.3 5813.4 5668.5 5680.7 5691.5 5691.7 5696.7 5444.5 5473.4 5479.9 5485.5 5495.7 3900.4 3958.8 3988.4 3998.7 4005.1 5558.5 5695.6 5788.7 5803.0 5803.8 5402.8 5523.3 5531.3 5531.8 5567.8 5559.6 5576.4 5587.6 5590.6 5598.5 5328.7 5446.4 5467.3 5469.7 5476.8 5594.2 5603.2 5614.7 5620.5 5637.7 5482.9 5484.1 5485.3 5488.2 5490.1 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12056.14 Median:21432.47 stddev:13303.58 (62.1%) stddev-sans-first:13313.90 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: Values: 768.6 780.1 784.6 790.5 799.7 13901.2 14194.9 14199.3 14214.4 14241.6 13072.1 13161.6 13171.3 13179.9 13191.2 634.9 638.0 785.1 798.5 799.4 786.8 793.4 797.5 801.6 802.9 831.4 840.8 841.3 842.0 842.1 650.9 654.0 654.5 659.4 842.1 488.1 605.0 612.2 618.7 618.9 11902.3 12018.4 12026.6 12039.6 12039.8 10644.6 11067.9 11568.7 12005.9 12008.6 9536.5 9539.8 9577.5 9618.9 9724.9 3329.8 3349.1 3373.2 3378.5 3382.4 38238.4 38358.8 38492.6 39135.8 39423.2 9645.4 9754.6 9822.4 9842.8 9941.7 16598.8 16617.5 16632.4 16677.9 16687.7 6570.7 6598.4 6634.3 6649.8 6895.4 3534.5 3616.2 3632.8 3681.7 3743.5 2690.0 2706.9 2717.9 2719.6 2733.6 476.8 479.7 481.4 484.0 486.4 512.6 534.4 558.3 570.2 571.7 7025.0 7140.1 7223.8 7294.8 7304.0 416.3 431.6 436.9 482.9 568.5 3274.5 3289.2 3448.0 3586.4 3606.7 47698.8 48792.3 49159.3 49359.8 49536.5 40557.1 41708.0 41815.0 42279.2 42433.4 38675.2 39190.4 39524.6 39733.0 40159.6 7140.5 7241.0 7401.9 7493.7 7595.7 30762.8 31100.1 31102.4 31113.4 31144.7 35490.5 35573.0 36809.6 39283.8 39751.4 9372.4 9568.8 9660.8 9938.3 10024.3 11127.0 11160.6 11270.1 11300.5 11326.2 9882.3 10031.6 10393.0 10423.9 10746.6 10096.2 10333.4 10334.3 10364.2 10447.1 10074.4 10345.5 10412.6 10697.6 10738.7 8735.3 8910.2 8930.9 8998.2 9558.6 8007.2 8653.0 8683.1 8691.0 8738.3 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:42:47 INFO - 2015-12-21 04:42:47,660 DEBUG : BROWSER_OUTPUT: 04:42:48 INFO - 2015-12-21 04:42:48,423 INFO : Browser exited with error code: 0 04:42:48 INFO - 2015-12-21 04:42:48,444 INFO : Completed test dromaeo_css (00:18:37) 04:42:48 INFO - 2015-12-21 04:42:48,444 INFO : Starting test kraken 04:42:48 INFO - 2015-12-21 04:42:48,444 DEBUG : operating with platform_type : linux_ 04:42:48 INFO - 2015-12-21 04:42:48,444 INFO : Initialising browser for kraken test... 04:42:48 INFO - 2015-12-21 04:42:48,450 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iA8E8/profile http://localhost:41995/getInfo.html 04:42:52 INFO - 2015-12-21 04:42:52,389 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:42:52 INFO - 2015-12-21 04:42:52,390 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:42:52 INFO - 2015-12-21 04:42:52,390 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:42:52 INFO - 2015-12-21 04:42:52,390 DEBUG : BROWSER_OUTPUT: __metrics 04:42:52 INFO - 2015-12-21 04:42:52,486 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] 04:42:52 INFO - 2015-12-21 04:42:52,554 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] 04:42:53 INFO - 2015-12-21 04:42:53,719 INFO : Browser initialized. 04:42:53 INFO - 2015-12-21 04:42:53,720 INFO : Running cycle 1/1 for kraken test... 04:42:53 INFO - 2015-12-21 04:42:53,720 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3iA8E8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:43:05 INFO - 2015-12-21 04:43:05,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 150110208 04:43:05 INFO - 2015-12-21 04:43:05,755 DEBUG : BROWSER_OUTPUT: 04:43:08 INFO - 2015-12-21 04:43:08,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41995/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:08 INFO - 2015-12-21 04:43:08,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 183414784 04:43:08 INFO - 2015-12-21 04:43:08,916 DEBUG : BROWSER_OUTPUT: 04:43:11 INFO - 2015-12-21 04:43:11,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41995/tests/kraken/driver.html?testName=audio-dft) 04:43:12 INFO - 2015-12-21 04:43:12,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 176050176 04:43:12 INFO - 2015-12-21 04:43:12,247 DEBUG : BROWSER_OUTPUT: 04:43:15 INFO - 2015-12-21 04:43:15,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41995/tests/kraken/driver.html?testName=audio-fft) 04:43:15 INFO - 2015-12-21 04:43:15,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 162709504 04:43:15 INFO - 2015-12-21 04:43:15,813 DEBUG : BROWSER_OUTPUT: 04:43:17 INFO - 2015-12-21 04:43:17,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41995/tests/kraken/driver.html?testName=audio-oscillator) 04:43:18 INFO - 2015-12-21 04:43:18,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 163049472 04:43:18 INFO - 2015-12-21 04:43:18,423 DEBUG : BROWSER_OUTPUT: 04:43:20 INFO - 2015-12-21 04:43:20,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:21 INFO - 2015-12-21 04:43:21,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 166518784 04:43:21 INFO - 2015-12-21 04:43:21,230 DEBUG : BROWSER_OUTPUT: 04:43:24 INFO - 2015-12-21 04:43:24,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41995/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:24 INFO - 2015-12-21 04:43:24,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 166219776 04:43:24 INFO - 2015-12-21 04:43:24,837 DEBUG : BROWSER_OUTPUT: 04:43:28 INFO - 2015-12-21 04:43:28,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41995/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:28 INFO - 2015-12-21 04:43:28,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 166256640 04:43:28 INFO - 2015-12-21 04:43:28,790 DEBUG : BROWSER_OUTPUT: 04:43:31 INFO - 2015-12-21 04:43:31,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41995/tests/kraken/driver.html?testName=json-parse-financial) 04:43:32 INFO - 2015-12-21 04:43:32,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 167530496 04:43:32 INFO - 2015-12-21 04:43:32,195 DEBUG : BROWSER_OUTPUT: 04:43:33 INFO - 2015-12-21 04:43:33,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:34 INFO - 2015-12-21 04:43:34,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 174870528 04:43:34 INFO - 2015-12-21 04:43:34,563 DEBUG : BROWSER_OUTPUT: 04:43:36 INFO - 2015-12-21 04:43:36,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:37 INFO - 2015-12-21 04:43:37,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 173867008 04:43:37 INFO - 2015-12-21 04:43:37,033 DEBUG : BROWSER_OUTPUT: 04:43:39 INFO - 2015-12-21 04:43:39,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:39 INFO - 2015-12-21 04:43:39,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 183443456 04:43:39 INFO - 2015-12-21 04:43:39,739 DEBUG : BROWSER_OUTPUT: 04:43:42 INFO - 2015-12-21 04:43:42,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:42 INFO - 2015-12-21 04:43:42,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 189505536 04:43:42 INFO - 2015-12-21 04:43:42,820 DEBUG : BROWSER_OUTPUT: 04:43:45 INFO - 2015-12-21 04:43:45,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:45 INFO - 2015-12-21 04:43:45,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 188436480 04:43:45 INFO - 2015-12-21 04:43:45,980 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41995/tests/kraken/driver.html?testName=ai-astar) 04:43:47 INFO - 2015-12-21 04:43:47,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 247291904 04:43:47 INFO - 2015-12-21 04:43:47,964 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,967 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;112;112;112;101;111;112;104 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;141;155;170;130;152;156;141;172;134 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;160;163;161;163;163;162;163 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;79;77;96;76;72;72;96;92;72 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;95;95;95;132;95;96;127 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;110;109 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;145;146;146;146;146;146 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;95;96;95;96 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;71;72;72;72;81;69;69 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;69;68;70;68;69;74 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;85;84;83;93;84;83;84;84 04:43:47 INFO - 2015-12-21 04:43:47,968 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;127;117;120;122;128;122;121;123;130 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;151;150;151;146;135;149;148;157;137 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;71;70;71;70;70;72;71;69 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,969 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701827966__endTimestamp 04:43:47 INFO - 2015-12-21 04:43:47,969 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.09 (3.7%) stddev-sans-first:4.30 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 112.0 112.0 112.0 101.0 111.0 112.0 104.0 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:155.50 stddev:14.13 (9.1%) stddev-sans-first:14.86 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: Values: 156.0 141.0 155.0 170.0 130.0 152.0 156.0 141.0 172.0 134.0 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.23 (0.8%) stddev-sans-first:1.30 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 160.0 163.0 161.0 163.0 163.0 162.0 163.0 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:78.00 stddev:10.11 (13.0%) stddev-sans-first:10.36 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: Values: 73.0 79.0 77.0 96.0 76.0 72.0 72.0 96.0 92.0 72.0 04:43:47 INFO - 2015-12-21 04:43:47,985 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.30 (18.2%) stddev-sans-first:17.91 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 95.0 95.0 95.0 132.0 95.0 96.0 127.0 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.50 stddev:3.38 (4.7%) stddev-sans-first:3.57 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 72.0 72.0 72.0 81.0 69.0 69.0 04:43:47 INFO - 2015-12-21 04:43:47,986 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.85 (2.7%) stddev-sans-first:1.96 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 69.0 68.0 70.0 68.0 69.0 74.0 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.06 (3.6%) stddev-sans-first:3.08 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 85.0 84.0 83.0 93.0 84.0 83.0 84.0 84.0 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:122.50 stddev:4.18 (3.4%) stddev-sans-first:4.18 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: Values: 119.0 127.0 117.0 120.0 122.0 128.0 122.0 121.0 123.0 130.0 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:149.50 stddev:7.47 (5.0%) stddev-sans-first:6.99 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: Values: 136.0 151.0 150.0 151.0 146.0 135.0 149.0 148.0 157.0 137.0 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 70.0 71.0 70.0 70.0 72.0 71.0 69.0 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:43:47 INFO - 2015-12-21 04:43:47,987 DEBUG : BROWSER_OUTPUT: 04:43:48 INFO - 2015-12-21 04:43:48,871 INFO : Browser exited with error code: 0 04:43:48 INFO - 2015-12-21 04:43:48,926 INFO : Completed test kraken (00:01:00) 04:43:48 INFO - 2015-12-21 04:43:48,926 INFO : Starting test v8_7 04:43:48 INFO - 2015-12-21 04:43:48,926 DEBUG : operating with platform_type : linux_ 04:43:48 INFO - 2015-12-21 04:43:48,926 INFO : Initialising browser for v8_7 test... 04:43:48 INFO - 2015-12-21 04:43:48,932 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrFDWd/profile http://localhost:41995/getInfo.html 04:43:52 INFO - 2015-12-21 04:43:52,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:43:52 INFO - 2015-12-21 04:43:52,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:43:52 INFO - 2015-12-21 04:43:52,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:43:52 INFO - 2015-12-21 04:43:52,756 DEBUG : BROWSER_OUTPUT: __metrics 04:43:52 INFO - 2015-12-21 04:43:52,954 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] 04:43:53 INFO - 2015-12-21 04:43:53,030 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] 04:43:54 INFO - 2015-12-21 04:43:54,101 INFO : Browser initialized. 04:43:54 INFO - 2015-12-21 04:43:54,101 INFO : Running cycle 1/1 for v8_7 test... 04:43:54 INFO - 2015-12-21 04:43:54,102 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrFDWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:44:06 INFO - 2015-12-21 04:44:06,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 149512192 04:44:06 INFO - 2015-12-21 04:44:06,077 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41995/tests/v8_7/run.html (next: http://localhost:41995/tests/v8_7/run.html) 04:44:27 INFO - 2015-12-21 04:44:27,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 442834944 04:44:27 INFO - 2015-12-21 04:44:27,829 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |0;Richards;165.8649859014762 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.53236336504384 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 04:44:27 INFO - 2015-12-21 04:44:27,830 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1982.1782178217823 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: |8;Splay;610.6032906764168 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701867823__endTimestamp 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: Values: 165.9 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,831 DEBUG : BROWSER_OUTPUT: Values: 186.5 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: Values: 278.0 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: Values: 5186.5 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1982.18 Median:1982.18 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,832 DEBUG : BROWSER_OUTPUT: Values: 1982.2 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: Values: 784.3 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: Values: 12168.7 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,833 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: Values: 27108.1 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.60 Median:610.60 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: Values: 610.6 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:44:27 INFO - 2015-12-21 04:44:27,834 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:44:27 INFO - 2015-12-21 04:44:27,835 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:44:27 INFO - 2015-12-21 04:44:27,835 DEBUG : BROWSER_OUTPUT: 04:44:28 INFO - 2015-12-21 04:44:28,743 INFO : Browser exited with error code: 0 04:44:28 INFO - 2015-12-21 04:44:28,757 INFO : Completed test v8_7 (00:00:39) 04:44:29 INFO - 2015-12-21 04:44:29,253 INFO : Completed test suite (00:20:18) 04:44:29 INFO - 2015-12-21 04:44:29,254 DEBUG : Working with test: dromaeo_css 04:44:29 INFO - 2015-12-21 04:44:29,254 DEBUG : Generating results file: dromaeo_css 04:44:29 INFO - 2015-12-21 04:44:29,255 DEBUG : Working with test: kraken 04:44:29 INFO - 2015-12-21 04:44:29,255 DEBUG : Generating results file: kraken 04:44:29 INFO - 2015-12-21 04:44:29,255 INFO : javascript benchmark 04:44:29 INFO - 2015-12-21 04:44:29,256 DEBUG : Working with test: v8_7 04:44:29 INFO - 2015-12-21 04:44:29,256 DEBUG : Generating results file: v8_7 04:44:29 INFO - 2015-12-21 04:44:29,256 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:29 INFO - 2015-12-21 04:44:29,308 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 04:44:29 INFO - 2015-12-21 04:44:29,308 DEBUG : process_Request line: dromaeo_css 6203.35 graph.html#tests=[[72,203,35]] 04:44:29 INFO - 2015-12-21 04:44:29,308 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:29 INFO - 2015-12-21 04:44:29,337 DEBUG : process_Request line: kraken 1523.60 graph.html#tests=[[232,203,35]] 04:44:29 INFO - 2015-12-21 04:44:29,337 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:44:29 INFO - 2015-12-21 04:44:29,366 DEBUG : process_Request line: v8_7 19791.50 graph.html#tests=[[230,203,35]] 04:44:29 INFO - 2015-12-21 04:44:29,367 INFO : javascript benchmark 04:44:29 INFO - 2015-12-21 04:44:29,371 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2621.1874318961122, 2714.117911678705, 2716.606092116642, 2723.387237871479, 2731.4400547887685, 4429.800658970346, 4550.79521421536, 4730.881727956803, 4733.668643194974, 4739.4075740532435, 4549.6132828709515, 4627.282771170466, 4682.531746825324, 4689.132510485562, 4694.577488026077, 4291.3777502262155, 4333.674974376934, 4360.825566977325, 4446.444194475691, 4472.664550158751, 4110.835566577348, 4393.802278897441, 4411.448568928884, 4466.910661786762, 4499.527549607294, 4227.598378154071, 4257.6806739494505, 4286.292761694317, 4307.698461107724, 4322.7190232634775, 4352.955290730202, 4353.651707863363, 4355.194289056535, 4370.2352088384405, 4391.824327026947, 4095.1400205956784, 4165.812538435777, 4326.307790753496, 4331.913361732779, 4383.868483945486, 4551.271796512575, 4577.244754615484, 4672.0889426561835, 4679.344891715163, 4688.320193571913, 5018.949810501885, 5050.4697006814495, 5050.772715227824, 5051.797928082872, 5105.923411148836, 5072.0870243356185, 5090.77091530882, 5091.439941606421, 5093.770780314895, 5093.770780314895, 4462.085272519158, 4549.0447006128425, 4579.816807327703, 4603.746793926299, 4712.340272361872, 5197.688138711689, 5243.554297884646, 5249.317588713519, 5253.0, 5253.527182553588, 5002.199648056294, 5018.447970723218, 5023.522765337287, 5029.974850125726, 5065.062963351792, 4799.496052914464, 4886.926696099561, 4892.094962431962, 4894.730789806595, 4953.18272485036, 5054.82308119214, 5066.189409694432, 5069.822556210589, 5071.290019397287, 5071.290019397287, 5042.4957504250015, 5047.747612619354, 5050.898982020339, 5051.898962020739, 5085.771140298695, 4014.3175660137845, 4129.359949207817, 4132.5454200037975, 4214.199302132585, 4290.2063118322585, 3652.981735091361, 3679.3745063339297, 3712.6287371263197, 3725.2921944830396, 3745.5130832991535, 4346.695731298779, 4348.2825333819565, 4352.129574085196, 4359.258925982591, 4392.231359512072, 4869.586085182799, 5009.323741294878, 5011.0, 5041.974790126026, 5088.185890257541, 4348.478182618106, 4433.268510695763, 4439.778011099432, 4460.598546130864, 4475.462944446687, 4494.056248187851, 4495.25828238337, 4496.865094047183, 4501.617362524156, 4538.2738761797955, 4580.992181720017, 4688.578027977498, 4689.648276379354, 4786.760661966958, 4793.376861008047, 4980.153373926513, 5067.46791586878, 5086.084504789025, 5086.949130508796, 5123.0, 4797.616190704665, 4818.831340903052, 4822.42130944289, 4822.8794280143275, 4866.683665561727, 4682.016776476978, 4776.5701086902345, 4778.904421911612, 5020.623453240948, 5089.465606111453, 4954.5540901319055, 5002.899942001212, 5022.995400919904, 5040.395152581714, 5074.137396642506, 4914.975425122851, 4971.229459433794, 4974.527419895104, 4974.726390048582, 5027.044861476454, 4638.907221855611, 4752.120857641347, 4912.6561140719805, 4948.975255123702, 5013.273075404119, 4698.107359601665, 4698.694584851974, 4739.905201896012, 4748.62011039123, 4817.181079216612, 4949.876253093701, 4994.275830004556, 5002.874928126826, 5007.549320561167, 5043.87390315245, 4623.930641040454, 4735.455422626304, 4883.511648835088, 4895.4370247420575, 4944.629152813625], "unit": "score", "name": "dojo.html", "value": 4615.724158323637}, {"lowerIsBetter": false, "replicates": [559.3036669346664, 559.56074481532, 564.9293838270216, 575.7466714645556, 579.9971000145001, 24492.265232043046, 31904.680953190462, 32115.35769284616, 32118.67881321186, 32198.839005804995, 39157.41263881044, 39557.802210988906, 39807.0, 39984.0, 40096.0, 6949.826254343657, 7022.297770222988, 7792.96103519483, 7945.880811787828, 7954.602269886512, 9989.200863930904, 10244.948775256113, 10246.7438314042, 10248.0, 10254.794904101913, 9891.406515609051, 9938.15525680318, 9954.65158719445, 9995.2003839693, 9999.850002249972, 7165.355118039375, 7313.853722925512, 7325.304096110861, 9797.265205109645, 9962.701118966443, 9619.90380096197, 9767.072128147815, 9772.853407198898, 9782.706518804376, 9787.657431989917, 36842.8157859209, 37382.813085934395, 37408.81295593532, 37475.812620936995, 37521.624783752086, 2907.563865420204, 2962.1853990152663, 2985.134311049793, 2995.3709720958623, 3486.3201675673254, 28075.719242807718, 28195.577066343816, 28291.292717682223, 28445.146645600664, 28969.275768105756, 3363.983180084084, 3419.4357930941364, 3443.0, 3464.1685995361186, 3492.4761285807076, 235755.0, 237943.81028094923, 239664.0, 239696.0, 240191.0, 51076.48923510792, 51619.0, 51755.223671644955, 51759.0, 51787.74106129445, 49675.0, 50143.74928125409, 60595.0, 61553.38446615476, 61658.38341616616, 13487.190768553919, 13517.391717372742, 13616.523421680193, 13617.591472255848, 13647.86352136466, 10630.255882088335, 10778.568857245778, 10779.0, 10787.137029037658, 10789.622363217406, 18540.497032900654, 18671.906640466983, 18731.25074997012, 18732.25070997145, 18751.624967500575, 7021.648917554102, 7191.548056932597, 7381.66782494789, 7392.075990501187, 7455.888161677579, 865.6407590849727, 910.153557191818, 910.6949172027445, 920.3879420185501, 994.6071301835734, 25037.374065648506, 25094.37264068413, 25312.367190820376, 25333.87333063323, 25410.745892541207, 962.4995002598749, 963.8457846744487, 964.8600952861796, 980.612658000086, 998.8801343838641, 13450.394732237073, 13484.12353197039, 13569.1858488491, 13624.0, 13670.52153174634, 265844.0, 269551.0, 270296.0, 270677.0, 271153.0, 44465.0, 44851.0, 45007.54992450034, 45011.774941125084, 45057.0, 1186.0511590727556, 1195.343822814872, 1210.84864391951, 1211.0553768060927, 1219.536576101076, 24691.382715432257, 25416.491670166863, 25888.223353299432, 25956.480870382107, 26049.348766280993, 39521.60478395294, 39798.801005994785, 39837.0, 39927.80036099801, 39942.60057399505, 249136.0, 249528.0, 250981.0, 251542.0, 252005.0, 23904.40238994039, 24401.755982439947, 25893.482130357665, 29185.227403396642, 30634.234144145685, 35651.82174089113, 36320.0, 36551.817240913624, 36602.45096323504, 36700.26599468049, 30292.84853575718, 31213.219669507536, 31388.52917206198, 31695.683043169272, 31770.364592707556, 24364.0, 28502.42995140044, 31226.531602025534, 31549.211269718442, 31831.84084079565, 31125.844370778002, 31574.684253158095, 31614.36771264608, 31633.0, 31686.366272674877, 26100.477990439704, 27980.30049248785, 28058.85970570134, 28135.296617584725, 28274.293142670776, 21480.462988425414, 21959.560808784056, 22006.229781957554, 22030.779692202872, 22034.0], "unit": "score", "name": "ext.html", "value": 16805.87136599878}, {"lowerIsBetter": false, "replicates": [320.38166338965794, 322.32633795367684, 330.4877439968049, 333.5680294019245, 337.3489165909793, 13117.672058198526, 13568.864311356883, 14943.775843362344, 15367.0, 15708.685826283481, 14711.92644036781, 14834.48079317224, 14891.404343826262, 14970.476033338835, 15302.0, 4869.220924652048, 4871.732054736988, 4992.051510213066, 4994.850154495371, 5008.69947803133, 3742.251549690059, 3798.6771124454453, 5019.924701129486, 5092.898142037157, 5538.0, 5725.57058220633, 5754.367019627837, 5756.8272951811305, 5777.797777077803, 5784.508316793057, 5592.832215033555, 5682.715864206773, 5704.714764261812, 5722.341930677983, 5722.427757224286, 4946.678465899705, 4951.282064100721, 4953.2074868020945, 4968.354113965198, 4994.87512812179, 17854.910725446418, 19777.40667779969, 20321.79678203214, 20355.287564935305, 20499.18003279882, 1808.4032269351214, 1837.5681714797013, 1862.1154951397978, 1902.2771346888233, 1930.0253372047166, 12695.365231738377, 12732.681682957907, 12803.295818729966, 12808.295543745091, 13167.670808229776, 1742.1811748478194, 1775.5028591994262, 1782.064416181502, 1800.3158799656178, 1810.8279713427335, 53675.0, 56416.435835641525, 56452.717736411054, 56872.71563642197, 57155.71422142904, 9395.295352848563, 9512.524373781283, 9567.091126342986, 9580.281478889112, 9625.181859542017, 12121.515139394325, 12211.633650990485, 12226.694332641755, 12237.816432753516, 12241.877581224251, 7163.283671632795, 7341.706331746777, 7371.778846634609, 7407.592582407911, 7441.739539116105, 7186.245444228385, 7188.281171882874, 7221.53060051095, 7224.67488962998, 7229.674664640103, 5673.914891276634, 5772.105323674753, 5785.392533783976, 5820.534357251409, 5840.182374467578, 1471.2717204983387, 1515.9545213643607, 1520.597041783928, 1527.7708343748304, 1636.5744906324203, 357.6048466444593, 358.03866618130405, 387.6317498376554, 393.7539038101187, 911.9954400228089, 9504.762380940394, 9777.951110244545, 9892.243086918696, 9955.402675839472, 9987.750306242402, 353.64458718987254, 356.33187772925766, 377.0084677298687, 388.854179682619, 393.12137372971387, 4922.4339200992345, 5115.923261151086, 5176.301199338116, 5208.374995000624, 5251.8161864335325, 479151.0, 485211.0, 487169.0, 493099.0, 499686.0, 71304.64347678333, 71638.64180679168, 72318.0, 73183.2681673187, 74496.25503744894, 418.5793277755836, 422.7210041372679, 423.68647201070985, 424.3846422687116, 424.9341352090431, 8794.42836215644, 8966.237869781142, 9161.725148245563, 9185.265178785814, 9277.118673725985, 30153.849230753705, 30874.53688194634, 31165.376692466478, 34397.65602343944, 34397.82801085978, 41883.0, 41931.58068419277, 42032.369514456695, 42313.365299521145, 44356.33465497955, 8516.190961858614, 8660.220580147818, 8751.168638979287, 8761.080086591071, 8847.911520884967, 15379.923100384874, 15520.767188491956, 15664.451744188898, 15791.36834526606, 15979.360825567312, 12955.611331660066, 13239.073264871367, 13620.65948351299, 13712.0, 13737.725245495234, 12884.355782210665, 13265.46938122503, 13278.0, 13331.800022999856, 13829.792553111913, 13517.0, 13631.318434078456, 13901.86098139046, 14127.223002734538, 14164.220967846868, 8441.66233350659, 8502.404831661725, 8514.74455766328, 8534.658613655633, 8833.69082082124, 9262.212711919563, 9326.813463730823, 9488.573014214238, 13723.656908577366, 13894.0], "unit": "score", "name": "jquery.html", "value": 7538.392601278687}, {"lowerIsBetter": false, "replicates": [1397.923114228717, 1606.5341051095184, 1683.5370273174876, 1683.5370273174883, 1710.811810700822, 5793.102069179274, 7055.576665400074, 7204.567725936435, 7234.60209688467, 7237.348638622523, 7221.56670599763, 7237.457190710705, 7307.26927307269, 7316.524425912326, 7321.487495875291, 2077.5117847305833, 2114.8731076135405, 2119.5972765174643, 2120.978790212101, 2122.1617461102855, 2145.013293884815, 2167.566486702658, 2170.1319472211085, 2179.8256139508803, 2185.606590813653, 2082.333653230967, 2083.312506872736, 2105.1368938735122, 2135.9466013349634, 2136.797004284598, 2084.322595156573, 2109.040386624082, 2115.079940226007, 2115.5451577910744, 2116.428564287634, 2064.721262629541, 2103.779103194158, 2106.2312256026594, 2109.1457959526415, 2109.567538654572, 7118.28817118284, 7171.426285897168, 7208.783736487913, 7209.855802883913, 7210.53131546453, 4334.5882141196535, 4388.27593447084, 4413.6910416270875, 4421.447319085114, 4428.911421771547, 2818.633577634894, 2843.6018957345987, 2876.0652787844033, 2897.174305322973, 2897.5653651952166, 942.5428667096453, 969.2343048991288, 975.0785507695231, 1655.4867990922733, 1685.9662806743797, 9261.907380926239, 9268.768280792967, 9306.86039709405, 9357.485338306391, 9363.34456588046, 3830.3296923038356, 3879.7866117363815, 3929.4302326162547, 3938.1139243669945, 3950.9209815803524, 7837.216278372117, 7907.644156012993, 7913.762587122395, 7926.24700653437, 7933.801654958672, 4364.039911219526, 4372.606465418127, 4372.737635741865, 4373.2565463871215, 4374.934375984363, 3216.565763621881, 3317.800931944091, 3847.769133851978, 4037.475128233311, 4039.5960403959957, 3367.9326413471595, 3383.780054296463, 3397.524346591479, 3492.6158122606494, 3508.736844736655, 1081.1675010242227, 1094.6715985204407, 1095.775366049958, 1100.5872797700863, 1105.9391733454738, 902.7697937026016, 1033.867914633475, 1157.7626586549736, 1180.6753142885602, 1188.1089183112665, 6443.420092191632, 6714.362135597111, 6714.865702685919, 6723.63020033893, 6741.764038258638, 1009.6516701737888, 1038.4963292802984, 1052.1845569683403, 1053.5522402978704, 1063.803196408667, 5182.97408512955, 5241.633085683966, 5244.5542128918705, 5250.816221432308, 5253.054450198924, 7964.800879977931, 8097.433179677484, 8104.149064348277, 8178.591070446454, 8474.3644226682, 8679.045305016443, 8695.782605434788, 8770.868436973451, 8780.253678437277, 8790.516521591373, 6713.899291510631, 6777.3900348967845, 6894.413974812097, 6908.723651054002, 6909.447244220451, 6855.520113592001, 6904.3095690430555, 6923.861522769617, 6927.653617319013, 6929.133858267716, 7644.891490733701, 7831.647575858986, 7858.44990850635, 7884.487508311941, 7955.363570914197, 7932.563708996061, 7968.521888686697, 7979.48133371329, 7982.08206056311, 7992.513241209013, 5114.539691427789, 5250.829300801098, 5962.582619216613, 6157.0, 6260.841744277323, 6492.935070649233, 6840.9315906842285, 6864.5881247125335, 6894.3795058442975, 6927.480438967198, 6363.713632886439, 6454.451371633464, 6547.607143571401, 6565.474762018932, 6686.465082793267, 6324.905126423199, 6332.588381755171, 6372.808815735535, 6454.354564543508, 6477.740890364333, 6634.701438435185, 6689.0, 6690.0, 6694.464442844658, 6696.129503164558, 5783.334916484658, 5958.702064896651, 6084.6349219047, 6123.326434092335, 6124.050772130327, 6191.721372538336, 6252.437280644764, 6254.0, 6254.155688981929, 6261.655608941552], "unit": "score", "name": "mootools.html", "value": 4182.267233839132}, {"lowerIsBetter": false, "replicates": [287.588748090231, 295.6481786673858, 297.64134218266986, 301.6832326057639, 301.7751774927679, 5168.715720635363, 5250.921236181461, 5255.553277971372, 5321.494458026491, 5337.505498460428, 5211.687298762067, 5268.446813084619, 5270.393904700961, 5283.128283833163, 5293.655912365693, 3885.417187421895, 4069.1861627674584, 4071.8982025449454, 4076.714629975903, 4081.2857749893797, 3956.9604303957026, 3978.7612743235354, 4069.409935559342, 4071.9185616287655, 4088.693347998912, 4004.899877503057, 4022.6781857451333, 4028.4964379452567, 4032.213718324928, 4038.2125485530332, 3792.867249646277, 3864.14988702485, 3916.060145565044, 4028.436018957348, 4033.2336855997414, 3505.1061979195397, 3507.473878918157, 3510.9467159851943, 3517.2262102337445, 3522.806245656488, 5023.819402440424, 5048.192289233742, 5052.595792336604, 5053.140966035783, 5065.214891691794, 4607.976960115211, 4625.745583992879, 4629.930551041737, 4630.166570017395, 4632.559906808881, 5253.894922101575, 5493.972530137364, 5502.642328248691, 5520.227168196456, 5520.751566179531, 3771.5662698789715, 3771.641694039062, 3773.1887644156363, 3773.811309434545, 3775.924481510382, 5732.111522713986, 5824.213731146283, 5826.359100498984, 5829.09649004405, 5829.650220986712, 3925.509311336083, 3940.2316548273384, 3943.2507823514015, 3945.349017412152, 3947.4670919426085, 3723.832427540767, 3846.5961074087377, 3986.421968814506, 3996.500437445319, 4007.318755811519, 4415.381846541487, 4446.221911165533, 4551.840685575989, 4597.747123908217, 4604.907901842012, 5528.44715528444, 5529.668219906738, 5538.390777014525, 5543.057680194376, 5549.38956714761, 1360.1227208450493, 1392.6379141423304, 1393.8675825796533, 1394.504950742472, 1394.5119208277224, 921.2445794448622, 926.5506229478698, 933.9252859771337, 947.5877993073035, 953.9570719317647, 4836.854894353175, 4839.830605928775, 4842.837718947428, 4848.903021939542, 4851.2723091535845, 5671.489565939085, 5672.205891175238, 5679.091345384719, 5681.147827825859, 5686.459786320293, 4828.227483602606, 4830.468648448667, 4841.685290456109, 4842.975785121052, 4846.321514987904, 3007.7593792496546, 3059.5563643272044, 3099.380123975214, 3099.9380012400075, 3101.9918526478987, 5385.5960802939935, 5429.267048948342, 5433.402325744165, 5433.6196466247775, 5449.782008719607, 5886.058230683156, 5888.293404791452, 5893.793717219963, 5896.351401345849, 5900.114982752536, 5405.648632838853, 5408.594355423359, 5409.26974858397, 5413.377461591967, 5413.810516631899, 5627.7467513961155, 5737.110747834093, 5809.24479817621, 5811.27359080115, 5813.418658134153, 5668.5465162787705, 5680.7443665036, 5691.4877661010705, 5691.715414229355, 5696.686682232517, 5444.455554444524, 5473.370562385377, 5479.945200547943, 5485.50630443262, 5495.670259784426, 3900.3564411871725, 3958.8416463342296, 3988.4416181734, 3998.740081894784, 4005.098852758106, 5558.499735023867, 5695.572832037531, 5788.710564471844, 5802.984477716467, 5803.82588522345, 5402.783888644411, 5523.337199536081, 5531.253280807039, 5531.778728850801, 5567.832965011056, 5559.58303127259, 5576.386597474356, 5587.608867379245, 5590.636608620427, 5598.496135347838, 5328.706921119376, 5446.400895901368, 5467.316585426822, 5469.671819690831, 5476.835694929158, 5594.1608758686525, 5603.243562119062, 5614.69119198448, 5620.494155526022, 5637.746301416528, 5482.945170548243, 5484.067708489646, 5485.314335708036, 5488.204210389391, 5490.121580547093], "unit": "score", "name": "prototype.html", "value": 4134.758104653096}, {"lowerIsBetter": false, "replicates": [768.581123287808, 780.1028816860613, 784.6233807772269, 790.4743345675124, 799.73608709126, 13901.165930044192, 14194.929025354859, 14199.29003549821, 14214.431422743091, 14241.572752817432, 13072.084954053196, 13161.605151845437, 13171.275579843128, 13179.868201317984, 13191.208527488358, 634.8698516804067, 638.023823549967, 785.1206648553627, 798.5049269452948, 799.3804801278997, 786.7679034684753, 793.4485532554877, 797.4935915693547, 801.6352559585374, 802.9156938521459, 831.4013909984801, 840.844443777903, 841.2765022081005, 842.0484852117099, 842.1241908415241, 650.9251436084863, 654.0483596367297, 654.5418207254941, 659.399946049093, 842.1241908415241, 488.1213815132782, 605.0289285696482, 612.1582823617526, 618.7401291457554, 618.8947878860605, 11902.34537100459, 12018.399080045963, 12026.639200823989, 12039.63881083569, 12039.81940270888, 10644.627438039708, 11067.948544888222, 11568.652940411801, 12005.87994120065, 12008.579699710555, 9536.475493847836, 9539.761505962406, 9577.521123943845, 9618.855717164248, 9724.902750972471, 3329.766916315859, 3349.0790032740947, 3373.207296285371, 3378.527006219131, 3382.3742607617423, 38238.42642360339, 38358.808205959074, 38492.615073849185, 39135.80432097821, 39423.21153576941, 9645.37305075182, 9754.561044753003, 9822.410655360702, 9842.80314393708, 9941.671552212309, 16598.75101873473, 16617.50147495577, 16632.417865374653, 16677.91661041687, 16687.666246675, 6570.737170513126, 6598.37315455031, 6634.303398143125, 6649.833754156185, 6895.448364130958, 3534.452159915217, 3616.2044350242904, 3632.7820330780237, 3681.705463562962, 3743.5320584926885, 2689.986550067237, 2706.8917243310443, 2717.904873329424, 2719.5648696208514, 2733.644626198621, 476.8474088291783, 479.6618384039244, 481.41748484334346, 483.95886349660674, 486.36529329224993, 512.6206607110711, 534.4281618668066, 558.2798190334504, 570.1561688700746, 571.6827160925726, 7024.964875175694, 7140.143182818095, 7223.783286501413, 7294.781156565312, 7304.014915105465, 416.3317874810945, 431.57274298444315, 436.9388285640013, 482.9348038014823, 568.5025602597727, 3274.476083826576, 3289.161263877696, 3447.9655203447646, 3586.3903136466865, 3606.74752767309, 47698.76150619294, 48792.26811597829, 49159.26261106086, 49359.75320123448, 49536.50463495319, 40557.133144022315, 41708.0, 41815.0, 42279.154416912104, 42433.36349954753, 38675.226495469935, 39190.41214381786, 39524.60475395267, 39733.0, 40159.59441419595, 7140.46446516503, 7241.0, 7401.888971665537, 7493.737719180021, 7595.696172153052, 30762.76948922018, 31100.066997990096, 31102.35631467398, 31113.377732444773, 31144.688553115084, 35490.46764298486, 35573.0, 36809.63190368062, 39283.803580983054, 39751.40372894351, 9372.39079459833, 9568.76078098053, 9660.806783864144, 9938.304318697621, 10024.298299119284, 11127.0, 11160.609378671708, 11270.098392128446, 11300.547978080785, 11326.150538709466, 9882.25883058759, 10031.598736050477, 10392.96070392985, 10423.895761042595, 10746.570137194738, 10096.242781791541, 10333.431661258703, 10334.328268662513, 10364.222683298633, 10447.111995480469, 10074.44590547527, 10345.534450949875, 10412.635557755442, 10697.572097116028, 10738.731531711457, 8735.257503112307, 8910.242629376575, 8930.86603700932, 8998.190162885372, 9558.617655293989, 8007.2393122655585, 8653.0, 8683.138881255254, 8691.0, 8738.25724813398], "unit": "score", "name": "yui.html", "value": 5634.714265516557}], "name": "dromaeo_css", "value": 6203.347930669714}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 112.0, 112.0, 101.0, 111.0, 112.0, 104.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [156.0, 141.0, 155.0, 170.0, 130.0, 152.0, 156.0, 141.0, 172.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 160.0, 163.0, 161.0, 163.0, 163.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 77.0, 96.0, 76.0, 72.0, 72.0, 96.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 95.0, 95.0, 95.0, 132.0, 95.0, 96.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 72.0, 72.0, 72.0, 81.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 70.0, 68.0, 69.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 85.0, 84.0, 83.0, 93.0, 84.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 117.0, 120.0, 122.0, 128.0, 122.0, 121.0, 123.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [136.0, 151.0, 150.0, 151.0, 146.0, 135.0, 149.0, 148.0, 157.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 70.0, 71.0, 70.0, 70.0, 72.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1523.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1982.1782178217823], "unit": "score", "name": "RayTrace", "value": 373.32112387612375}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [610.6032906764168], "unit": "score", "name": "Splay", "value": 133.4598113772455}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19791.502109794637}]} 04:44:29 INFO - RETURN: dromaeo_css: 6203.35 04:44:29 INFO - RETURN: kraken: 1523.60 04:44:29 INFO - RETURN: v8_7: 19791.50 04:44:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19791.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1523.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6203.35"}}} 04:44:29 INFO - Return code: 0 04:44:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:44:29 INFO - # TBPL SUCCESS # 04:44:29 INFO - Running post-action listener: _resource_record_post_action 04:44:29 INFO - Running post-run listener: _resource_record_post_run 04:44:30 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544710656; Read time: 8; Write time: 339224 04:44:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 226971648; Read time: 0; Write time: 182056 04:44:30 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316874752; Read time: 8; Write time: 157124 04:44:30 INFO - Running post-run listener: _upload_blobber_files 04:44:30 INFO - Blob upload gear active. 04:44:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:44:30 INFO - Copying logs to upload dir... 04:44:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.255626 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-21 04:44:30.040392) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:44:30.043444) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009979 build_url: 'https://queue.taskcluster.net/v1/task/K7CWWMQXQzualM44bW5FcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:44:30.094145) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:44:30.094466) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450700600.699493-790261231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:44:30.143796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:44:30.144112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:44:30.144391) ========= ========= Total master_lag: 0.21 =========