builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1447331425.28 results: success (0) buildid: 20151112030147 builduid: 7dbd91abff2d4f3ca5a414504eab4db1 revision: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.277059) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.277437) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.277719) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006538 basedir: '/builds/slave/test' ========= master_lag: 0.56 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.840616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.840903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.871713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.871978) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.923673) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.923938) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.924286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:25.924557) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 04:30:28-- 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% 222M=0s 2015-11-12 04:30:28 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:26.057295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:26.057580) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:26.106648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:26.106954) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 04:30:28,259 truncating revision to first 12 chars 2015-11-12 04:30:28,259 Setting DEBUG logging. 2015-11-12 04:30:28,259 attempt 1/10 2015-11-12 04:30:28,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cc3b1968524?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 04:30:28,961 unpacking tar archive at: mozilla-central-3cc3b1968524/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:27.102579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:27.102915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:27.114422) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:27.114758) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 04:30:27.115212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-12 04:30:27.115500) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:29 INFO - MultiFileLogger online at 20151112 04:30:29 in /builds/slave/test 04:30:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:30:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:29 INFO - {'append_to_log': False, 04:30:29 INFO - 'base_work_dir': '/builds/slave/test', 04:30:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:29 INFO - 'branch': 'Firefox-Non-PGO', 04:30:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:29 INFO - 'config_files': ('talos/linux_config.py',), 04:30:29 INFO - 'default_actions': ('clobber', 04:30:29 INFO - 'read-buildbot-config', 04:30:29 INFO - 'download-and-extract', 04:30:29 INFO - 'populate-webroot', 04:30:29 INFO - 'create-virtualenv', 04:30:29 INFO - 'install', 04:30:29 INFO - 'run-tests'), 04:30:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:29 INFO - 'download_minidump_stackwalk': True, 04:30:29 INFO - 'download_symbols': 'ondemand', 04:30:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:29 INFO - 'installer_path': 'installer.exe', 04:30:29 INFO - 'log_level': 'info', 04:30:29 INFO - 'log_name': 'talos', 04:30:29 INFO - 'log_to_console': True, 04:30:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:29 INFO - 'opt_config_files': (), 04:30:29 INFO - 'pip_index': False, 04:30:29 INFO - 'sps_profile': False, 04:30:29 INFO - 'sps_profile_interval': 0, 04:30:29 INFO - 'suite': 'dromaeojs', 04:30:29 INFO - 'system_bits': '64', 04:30:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:29 INFO - 'title': 'talos-linux64-ix-052', 04:30:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:29 INFO - 'use_talos_json': True, 04:30:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:29 INFO - 'work_dir': 'build'} 04:30:29 INFO - ##### 04:30:29 INFO - ##### Running clobber step. 04:30:29 INFO - ##### 04:30:29 INFO - Running pre-action listener: _resource_record_pre_action 04:30:29 INFO - Running main action method: clobber 04:30:29 INFO - rmtree: /builds/slave/test/build 04:30:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:29 INFO - Running post-action listener: _resource_record_post_action 04:30:29 INFO - ##### 04:30:29 INFO - ##### Running read-buildbot-config step. 04:30:29 INFO - ##### 04:30:29 INFO - Running pre-action listener: _resource_record_pre_action 04:30:29 INFO - Running main action method: read_buildbot_config 04:30:29 INFO - Using buildbot properties: 04:30:29 INFO - { 04:30:29 INFO - "properties": { 04:30:29 INFO - "buildnumber": 209, 04:30:29 INFO - "product": "firefox", 04:30:29 INFO - "script_repo_revision": "production", 04:30:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:29 INFO - "repository": "", 04:30:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:29 INFO - "buildid": "20151112030147", 04:30:29 INFO - "slavename": "talos-linux64-ix-052", 04:30:29 INFO - "pgo_build": "False", 04:30:29 INFO - "basedir": "/builds/slave/test", 04:30:29 INFO - "project": "", 04:30:29 INFO - "platform": "ubuntu64_hw", 04:30:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:30:29 INFO - "slavebuilddir": "test", 04:30:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:29 INFO - "branch": "mozilla-central", 04:30:29 INFO - "repo_path": "mozilla-central", 04:30:29 INFO - "stage_platform": "linux64", 04:30:29 INFO - "builduid": "7dbd91abff2d4f3ca5a414504eab4db1", 04:30:29 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 04:30:29 INFO - }, 04:30:29 INFO - "sourcestamp": { 04:30:29 INFO - "repository": "", 04:30:29 INFO - "hasPatch": false, 04:30:29 INFO - "project": "", 04:30:29 INFO - "branch": "mozilla-central-linux64-talos", 04:30:29 INFO - "changes": [ 04:30:29 INFO - { 04:30:29 INFO - "category": null, 04:30:29 INFO - "files": [ 04:30:29 INFO - { 04:30:29 INFO - "url": null, 04:30:29 INFO - "name": "https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:30:29 INFO - } 04:30:29 INFO - ], 04:30:29 INFO - "repository": "", 04:30:29 INFO - "rev": "3cc3b1968524248450c465c4ea2ee5596ffa65f2", 04:30:29 INFO - "who": "cbook@mozilla.com", 04:30:29 INFO - "when": 1447331385, 04:30:29 INFO - "number": 6653227, 04:30:29 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:30:29 INFO - "project": "", 04:30:29 INFO - "at": "Thu 12 Nov 2015 04:29:45", 04:30:29 INFO - "branch": "mozilla-central-linux64-talos", 04:30:29 INFO - "revlink": "", 04:30:29 INFO - "properties": [ 04:30:29 INFO - [ 04:30:29 INFO - "buildid", 04:30:29 INFO - "20151112030147", 04:30:29 INFO - "Change" 04:30:29 INFO - ], 04:30:29 INFO - [ 04:30:29 INFO - "builduid", 04:30:29 INFO - "7dbd91abff2d4f3ca5a414504eab4db1", 04:30:29 INFO - "Change" 04:30:29 INFO - ], 04:30:29 INFO - [ 04:30:29 INFO - "pgo_build", 04:30:29 INFO - "False", 04:30:29 INFO - "Change" 04:30:29 INFO - ] 04:30:29 INFO - ], 04:30:29 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 04:30:29 INFO - } 04:30:29 INFO - ], 04:30:29 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 04:30:29 INFO - } 04:30:29 INFO - } 04:30:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:30:29 INFO - Running post-action listener: _resource_record_post_action 04:30:29 INFO - ##### 04:30:29 INFO - ##### Running download-and-extract step. 04:30:29 INFO - ##### 04:30:29 INFO - Running pre-action listener: _resource_record_pre_action 04:30:29 INFO - Running main action method: download_and_extract 04:30:29 INFO - mkdir: /builds/slave/test/build/tests 04:30: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:30:29 INFO - https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:30:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/test_packages.json 04:30:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/test_packages.json 04:30:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:30:30 INFO - Downloaded 1302 bytes. 04:30:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:30:30 INFO - Using the following test package requirements: 04:30:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'jsshell-linux-x86_64.zip'], 04:30:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30: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:30:30 INFO - https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:31 INFO - Downloaded 21251723 bytes. 04:30:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:30:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:30:33 INFO - Return code: 0 04:30:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:33 INFO - https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:41 INFO - Downloaded 21251723 bytes. 04:30:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:30:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:30:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:30:42 INFO - Return code: 0 04:30: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:30:42 INFO - https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:30:44 INFO - Downloaded 11131693 bytes. 04:30:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:30:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:30:44 INFO - Return code: 0 04:30:44 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:30:44 INFO - https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:30:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:30:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:30:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:30:46 INFO - Downloaded 55653256 bytes. 04:30:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:30:46 INFO - mkdir: /builds/slave/test/properties 04:30:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:46 INFO - Contents: 04:30:46 INFO - build_url:https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:30:46 INFO - Running post-action listener: _resource_record_post_action 04:30:46 INFO - Running post-action listener: set_extra_try_arguments 04:30:46 INFO - ##### 04:30:46 INFO - ##### Running populate-webroot step. 04:30:46 INFO - ##### 04:30:46 INFO - Running pre-action listener: _resource_record_pre_action 04:30:46 INFO - Running main action method: populate_webroot 04:30:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:30:46 INFO - '../fennec_ids.txt'], 04:30:46 INFO - 'tests': ['tcheck2']}, 04:30:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:46 INFO - '--tppagecycles', 04:30:46 INFO - '7'], 04:30:46 INFO - 'tests': ['tsvgm']}}, 04:30:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:30:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:30:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:30:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'tests': ['damp', 'tps']}, 04:30:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['damp', 'tps']}, 04:30:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:30:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:46 INFO - 'other': {'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'other_l64': {'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:30:46 INFO - 'ts_paint', 04:30:46 INFO - 'tpaint', 04:30:46 INFO - 'sessionrestore', 04:30:46 INFO - 'sessionrestore_no_auto_restore']}, 04:30:46 INFO - 'svgr': {'tests': ['tsvgx', 04:30:46 INFO - 'tsvgr_opacity', 04:30:46 INFO - 'tart', 04:30:46 INFO - 'tscrollx', 04:30:46 INFO - 'cart']}, 04:30:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['tsvgx', 04:30:46 INFO - 'tsvgr_opacity', 04:30:46 INFO - 'tart', 04:30:46 INFO - 'tscrollx', 04:30:46 INFO - 'cart']}, 04:30:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'tests': ['tp5o']}, 04:30:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'talos_options': ['--e10s'], 04:30:46 INFO - 'tests': ['tp5o']}, 04:30:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'talos_options': ['--xperf_path', 04:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:46 INFO - 'tests': ['tp5n']}, 04:30:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:46 INFO - 'talos_options': ['--e10s', 04:30:46 INFO - '--xperf_path', 04:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:46 INFO - 'tests': ['tp5n']}}, 04:30:46 INFO - 'talos.zip': {'path': '', 04:30:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:46 INFO - Running post-action listener: _resource_record_post_action 04:30:46 INFO - ##### 04:30:46 INFO - ##### Running create-virtualenv step. 04:30:46 INFO - ##### 04:30:46 INFO - Running pre-action listener: _resource_record_pre_action 04:30:46 INFO - Running main action method: create_virtualenv 04:30:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:46 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:30:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:46 INFO - Using real prefix '/usr' 04:30:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:48 INFO - Installing pip.................done. 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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', '--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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30:48 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:30:48 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:30:48 INFO - Using env: {'DISPLAY': ':0', 04:30:48 INFO - 'HOME': '/home/cltbld', 04:30:48 INFO - 'LANG': 'en_US.UTF-8', 04:30:48 INFO - 'LANGUAGE': 'en_US:en', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MAIL': '/var/mail/cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SHLVL': '1', 04:30:48 INFO - 'TERM': 'linux', 04:30:48 INFO - 'TMOUT': '86400', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - '_': '/tools/buildbot/bin/python'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 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:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:30: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:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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', '--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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30:48 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:30:48 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:30:48 INFO - Using env: {'DISPLAY': ':0', 04:30:48 INFO - 'HOME': '/home/cltbld', 04:30:48 INFO - 'LANG': 'en_US.UTF-8', 04:30:48 INFO - 'LANGUAGE': 'en_US:en', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MAIL': '/var/mail/cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SHLVL': '1', 04:30:48 INFO - 'TERM': 'linux', 04:30:48 INFO - 'TMOUT': '86400', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - '_': '/tools/buildbot/bin/python'} 04:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:49 INFO - Downloading/unpacking psutil>=0.7.1 04:30: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:30: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:30: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:30: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:30: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:30: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:30:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:30:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:50 INFO - Installing collected packages: psutil 04:30:50 INFO - Running setup.py install for psutil 04:30:50 INFO - building 'psutil._psutil_linux' extension 04:30:50 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:30:51 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:30:51 INFO - building 'psutil._psutil_posix' extension 04:30:51 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:30:51 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:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:51 INFO - Successfully installed psutil 04:30:51 INFO - Cleaning up... 04:30:51 INFO - Return code: 0 04:30:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:30: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:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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', '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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:30: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 mozsystemmonitor==0.0.0 04:30:51 INFO - Using env: {'DISPLAY': ':0', 04:30:51 INFO - 'HOME': '/home/cltbld', 04:30:51 INFO - 'LANG': 'en_US.UTF-8', 04:30:51 INFO - 'LANGUAGE': 'en_US:en', 04:30:51 INFO - 'LOGNAME': 'cltbld', 04:30:51 INFO - 'MAIL': '/var/mail/cltbld', 04:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:51 INFO - 'MOZ_NO_REMOTE': '1', 04:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:51 INFO - 'NO_EM_RESTART': '1', 04:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:51 INFO - 'PWD': '/builds/slave/test', 04:30:51 INFO - 'SHELL': '/bin/bash', 04:30:51 INFO - 'SHLVL': '1', 04:30:51 INFO - 'TERM': 'linux', 04:30:51 INFO - 'TMOUT': '86400', 04:30:51 INFO - 'USER': 'cltbld', 04:30:51 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:51 INFO - '_': '/tools/buildbot/bin/python'} 04:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30: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:30: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:30: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:30: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:30: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:30: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:30:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:53 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:30:53 INFO - Installing collected packages: mozsystemmonitor 04:30:53 INFO - Running setup.py install for mozsystemmonitor 04:30:53 INFO - Successfully installed mozsystemmonitor 04:30:53 INFO - Cleaning up... 04:30:53 INFO - Return code: 0 04:30:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:53 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:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 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:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30:53 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:30:53 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:30:53 INFO - Using env: {'DISPLAY': ':0', 04:30:53 INFO - 'HOME': '/home/cltbld', 04:30:53 INFO - 'LANG': 'en_US.UTF-8', 04:30:53 INFO - 'LANGUAGE': 'en_US:en', 04:30:53 INFO - 'LOGNAME': 'cltbld', 04:30:53 INFO - 'MAIL': '/var/mail/cltbld', 04:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:53 INFO - 'MOZ_NO_REMOTE': '1', 04:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:53 INFO - 'NO_EM_RESTART': '1', 04:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:53 INFO - 'PWD': '/builds/slave/test', 04:30:53 INFO - 'SHELL': '/bin/bash', 04:30:53 INFO - 'SHLVL': '1', 04:30:53 INFO - 'TERM': 'linux', 04:30:53 INFO - 'TMOUT': '86400', 04:30:53 INFO - 'USER': 'cltbld', 04:30:53 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:53 INFO - '_': '/tools/buildbot/bin/python'} 04:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:30: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:30: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:30: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:30: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:30: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:30: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:30:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:55 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:30:56 INFO - Downloading docopt-0.6.1.tar.gz 04:30:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:56 INFO - Running setup.py install for blobuploader 04:30:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:56 INFO - Running setup.py install for requests 04:30:56 INFO - Running setup.py install for docopt 04:30:56 INFO - Successfully installed blobuploader requests docopt 04:30:56 INFO - Cleaning up... 04:30:56 INFO - Return code: 0 04:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30:56 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:30:56 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:30:56 INFO - Using env: {'DISPLAY': ':0', 04:30:56 INFO - 'HOME': '/home/cltbld', 04:30:56 INFO - 'LANG': 'en_US.UTF-8', 04:30:56 INFO - 'LANGUAGE': 'en_US:en', 04:30:56 INFO - 'LOGNAME': 'cltbld', 04:30:56 INFO - 'MAIL': '/var/mail/cltbld', 04:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:56 INFO - 'MOZ_NO_REMOTE': '1', 04:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:56 INFO - 'NO_EM_RESTART': '1', 04:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:56 INFO - 'PWD': '/builds/slave/test', 04:30:56 INFO - 'SHELL': '/bin/bash', 04:30:56 INFO - 'SHLVL': '1', 04:30:56 INFO - 'TERM': 'linux', 04:30:56 INFO - 'TMOUT': '86400', 04:30:56 INFO - 'USER': 'cltbld', 04:30:56 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:56 INFO - '_': '/tools/buildbot/bin/python'} 04:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Running setup.py (path:/tmp/pip-SfTqzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:56 INFO - Running setup.py (path:/tmp/pip-iNLgwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:57 INFO - Running setup.py (path:/tmp/pip-O7EOzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:57 INFO - Running setup.py (path:/tmp/pip-Nh1vct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:57 INFO - Running setup.py (path:/tmp/pip-gDOfWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:57 INFO - Running setup.py (path:/tmp/pip-EOy8gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:57 INFO - Running setup.py (path:/tmp/pip-nKX6T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:57 INFO - Running setup.py (path:/tmp/pip-IzGx86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Running setup.py (path:/tmp/pip-9mfKQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Running setup.py (path:/tmp/pip-UuKDTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Running setup.py (path:/tmp/pip-aT6t8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Running setup.py (path:/tmp/pip-_R6dtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Running setup.py (path:/tmp/pip-CxyRv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Running setup.py (path:/tmp/pip-MmGCEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Running setup.py (path:/tmp/pip-YYFuYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:57 INFO - Running setup.py (path:/tmp/pip-tsJxbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:58 INFO - Running setup.py (path:/tmp/pip-a5tFTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:58 INFO - Running setup.py install for manifestparser 04:30:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozcrash 04:30:58 INFO - Running setup.py install for mozdebug 04:30:58 INFO - Running setup.py install for mozdevice 04:30:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozfile 04:30:58 INFO - Running setup.py install for mozhttpd 04:30:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozinfo 04:30:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozInstall 04:30:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozleak 04:30:59 INFO - Running setup.py install for mozlog 04:30:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for moznetwork 04:30:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozprocess 04:30:59 INFO - Running setup.py install for mozprofile 04:30:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozrunner 04:30:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozscreenshot 04:30:59 INFO - Running setup.py install for moztest 04:30:59 INFO - Running setup.py install for mozversion 04:30:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:59 INFO - Cleaning up... 04:30:59 INFO - Return code: 0 04:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:59 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:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:30:59 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:30:59 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:30:59 INFO - Using env: {'DISPLAY': ':0', 04:30:59 INFO - 'HOME': '/home/cltbld', 04:30:59 INFO - 'LANG': 'en_US.UTF-8', 04:30:59 INFO - 'LANGUAGE': 'en_US:en', 04:30:59 INFO - 'LOGNAME': 'cltbld', 04:30:59 INFO - 'MAIL': '/var/mail/cltbld', 04:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:59 INFO - 'MOZ_NO_REMOTE': '1', 04:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:59 INFO - 'NO_EM_RESTART': '1', 04:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:59 INFO - 'PWD': '/builds/slave/test', 04:30:59 INFO - 'SHELL': '/bin/bash', 04:30:59 INFO - 'SHLVL': '1', 04:30:59 INFO - 'TERM': 'linux', 04:30:59 INFO - 'TMOUT': '86400', 04:30:59 INFO - 'USER': 'cltbld', 04:30:59 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:59 INFO - '_': '/tools/buildbot/bin/python'} 04:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:00 INFO - Running setup.py (path:/tmp/pip-1nd4US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:00 INFO - Running setup.py (path:/tmp/pip-wc5tYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:00 INFO - Running setup.py (path:/tmp/pip-B7Mo7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:00 INFO - Running setup.py (path:/tmp/pip-vqzWko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:00 INFO - Running setup.py (path:/tmp/pip-TZRNnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:00 INFO - Running setup.py (path:/tmp/pip-JpW_jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:00 INFO - Running setup.py (path:/tmp/pip-I1cmYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:00 INFO - Running setup.py (path:/tmp/pip-wlC0VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:00 INFO - Running setup.py (path:/tmp/pip-zHzvtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:00 INFO - Running setup.py (path:/tmp/pip-coqfSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:00 INFO - Running setup.py (path:/tmp/pip-u4MUse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:00 INFO - Running setup.py (path:/tmp/pip-tipx3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:00 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:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:00 INFO - Running setup.py (path:/tmp/pip-VvOwbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:01 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:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:01 INFO - Running setup.py (path:/tmp/pip-mJwu8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:01 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:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:01 INFO - Running setup.py (path:/tmp/pip-Kla9lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:01 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:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:01 INFO - Running setup.py (path:/tmp/pip-sWVUAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:01 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:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:01 INFO - Running setup.py (path:/tmp/pip-mzu4cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:02 INFO - Downloading blessings-1.5.1.tar.gz 04:31:02 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:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:03 INFO - Installing collected packages: blessings 04:31:03 INFO - Running setup.py install for blessings 04:31:03 INFO - Successfully installed blessings 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Current package versions: 04:31:03 INFO - argparse == 1.2.1 04:31:03 INFO - blessings == 1.5.1 04:31:03 INFO - blobuploader == 1.2.4 04:31:03 INFO - docopt == 0.6.1 04:31:03 INFO - manifestparser == 1.1 04:31:03 INFO - mozInstall == 1.12 04:31:03 INFO - mozcrash == 0.16 04:31:03 INFO - mozdebug == 0.1 04:31:03 INFO - mozdevice == 0.47 04:31:03 INFO - mozfile == 1.2 04:31:03 INFO - mozhttpd == 0.7 04:31:03 INFO - mozinfo == 0.9 04:31:03 INFO - mozleak == 0.1 04:31:03 INFO - mozlog == 3.0 04:31:03 INFO - moznetwork == 0.27 04:31:03 INFO - mozprocess == 0.22 04:31:03 INFO - mozprofile == 0.27 04:31:03 INFO - mozrunner == 6.11 04:31:03 INFO - mozscreenshot == 0.1 04:31:03 INFO - mozsystemmonitor == 0.0 04:31:03 INFO - moztest == 0.7 04:31:03 INFO - mozversion == 1.4 04:31:03 INFO - psutil == 3.1.1 04:31:03 INFO - requests == 1.2.3 04:31:03 INFO - wsgiref == 0.1.2 04:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f2e2182dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12729a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, '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': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', '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:31:03 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:31:03 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:31:03 INFO - Using env: {'DISPLAY': ':0', 04:31:03 INFO - 'HOME': '/home/cltbld', 04:31:03 INFO - 'LANG': 'en_US.UTF-8', 04:31:03 INFO - 'LANGUAGE': 'en_US:en', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MAIL': '/var/mail/cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SHLVL': '1', 04:31:03 INFO - 'TERM': 'linux', 04:31:03 INFO - 'TMOUT': '86400', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - '_': '/tools/buildbot/bin/python'} 04:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Running post-action listener: _resource_record_post_action 04:31:03 INFO - Running post-action listener: _start_resource_monitoring 04:31:03 INFO - Starting resource monitoring. 04:31:03 INFO - ##### 04:31:03 INFO - ##### Running install step. 04:31:03 INFO - ##### 04:31:03 INFO - Running pre-action listener: _resource_record_pre_action 04:31:03 INFO - Running main action method: install 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:03 INFO - Reading from file tmpfile_stdout 04:31:03 INFO - Output received: 04:31:03 INFO - Usage: mozinstall [options] installer 04:31:03 INFO - Options: 04:31:03 INFO - -h, --help show this help message and exit 04:31:03 INFO - -d DEST, --destination=DEST 04:31:03 INFO - Directory to install application into. [default: 04:31:03 INFO - "/builds/slave/test"] 04:31:03 INFO - --app=APP Application being installed. [default: firefox] 04:31:03 INFO - mkdir: /builds/slave/test/build/application 04:31:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:31:18 INFO - Reading from file tmpfile_stdout 04:31:18 INFO - Output received: 04:31:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:18 INFO - Running post-action listener: _resource_record_post_action 04:31:18 INFO - ##### 04:31:18 INFO - ##### Running run-tests step. 04:31:18 INFO - ##### 04:31:18 INFO - Running pre-action listener: _resource_record_pre_action 04:31:18 INFO - Running main action method: run_tests 04:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:18 INFO - Python 2.7.3 04:31:18 INFO - Return code: 0 04:31:18 INFO - grabbing minidump binary from tooltool 04:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:18 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 0x1301ac0>, '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 0x13029a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1302e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:18 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:31:18 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:31:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:18 INFO - Return code: 0 04:31:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost'] in /builds/slave/test/build 04:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost 04:31:18 INFO - Using env: {'DISPLAY': ':0', 04:31:18 INFO - 'HOME': '/home/cltbld', 04:31:18 INFO - 'LANG': 'en_US.UTF-8', 04:31:18 INFO - 'LANGUAGE': 'en_US:en', 04:31:18 INFO - 'LOGNAME': 'cltbld', 04:31:18 INFO - 'MAIL': '/var/mail/cltbld', 04:31:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:18 INFO - 'MOZ_NO_REMOTE': '1', 04:31:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:18 INFO - 'NO_EM_RESTART': '1', 04:31:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:18 INFO - 'PWD': '/builds/slave/test', 04:31:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:18 INFO - 'SHELL': '/bin/bash', 04:31:18 INFO - 'SHLVL': '1', 04:31:18 INFO - 'TERM': 'linux', 04:31:18 INFO - 'TMOUT': '86400', 04:31:18 INFO - 'USER': 'cltbld', 04:31:18 INFO - 'XDG_SESSION_COOKIE': '2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566', 04:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:18 INFO - '_': '/tools/buildbot/bin/python'} 04:31:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost'] with output_timeout 3600 04:31:18 INFO - mozversion INFO | application_buildid: 20151112030147 04:31:18 INFO - mozversion INFO | application_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 04:31:18 INFO - mozversion INFO | application_display_name: Nightly 04:31:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:18 INFO - mozversion INFO | application_name: Firefox 04:31:18 INFO - mozversion INFO | application_remotingname: firefox 04:31:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:31:18 INFO - mozversion INFO | application_vendor: Mozilla 04:31:18 INFO - mozversion INFO | application_version: 45.0a1 04:31:18 INFO - mozversion INFO | platform_buildid: 20151112030147 04:31:18 INFO - mozversion INFO | platform_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 04:31:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:31:18 INFO - mozversion INFO | platform_version: 45.0a1 04:31:18 INFO - 2015-11-12 04:31:18,301 DEBUG : using testdate: 1447331478 04:31:18 INFO - 2015-11-12 04:31:18,301 DEBUG : actual date: 1447331478 04:31:18 INFO - 2015-11-12 04:31:18,387 INFO : starting webserver on 'localhost:49722' 04:31:18 INFO - 2015-11-12 04:31:18,388 INFO : Starting test suite talos-linux64-ix-052 04:31:18 INFO - 2015-11-12 04:31:18,388 INFO : Starting test dromaeo_css 04:31:18 INFO - 2015-11-12 04:31:18,388 DEBUG : operating with platform_type : linux_ 04:31:18 INFO - 2015-11-12 04:31:18,389 INFO : Initialising browser for dromaeo_css test... 04:31:18 INFO - 2015-11-12 04:31:18,399 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SwGmh/profile http://localhost:49722/getInfo.html 04:31:23 INFO - 2015-11-12 04:31:23,591 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:31:23 INFO - 2015-11-12 04:31:23,591 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:31:23 INFO - 2015-11-12 04:31:23,591 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:31:23 INFO - 2015-11-12 04:31:23,591 DEBUG : BROWSER_OUTPUT: __metrics 04:31:23 INFO - 2015-11-12 04:31:23,712 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:25 INFO - 2015-11-12 04:31:25,021 INFO : Browser initialized. 04:31:25 INFO - 2015-11-12 04:31:25,021 INFO : Running cycle 1/1 for dromaeo_css test... 04:31:25 INFO - 2015-11-12 04:31:25,022 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1SwGmh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:31:36 INFO - 2015-11-12 04:31:36,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 139390976 04:31:36 INFO - 2015-11-12 04:31:36,999 DEBUG : BROWSER_OUTPUT: 04:32:28 INFO - 2015-11-12 04:32:28,392 DEBUG : BROWSER_OUTPUT: 1447331548389 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:34:40 INFO - 2015-11-12 04:34:40,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49722/tests/dromaeo/cssquery-ext.html) 04:34:41 INFO - 2015-11-12 04:34:41,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 253575168 04:34:41 INFO - 2015-11-12 04:34:41,588 DEBUG : BROWSER_OUTPUT: 04:37:44 INFO - 2015-11-12 04:37:44,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-ext.html (next: http://localhost:49722/tests/dromaeo/cssquery-jquery.html) 04:37:44 INFO - 2015-11-12 04:37:44,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 221044736 04:37:44 INFO - 2015-11-12 04:37:44,686 DEBUG : BROWSER_OUTPUT: 04:40:46 INFO - 2015-11-12 04:40:46,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49722/tests/dromaeo/cssquery-mootools.html) 04:40:47 INFO - 2015-11-12 04:40:47,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 211746816 04:40:47 INFO - 2015-11-12 04:40:47,398 DEBUG : BROWSER_OUTPUT: 04:43:49 INFO - 2015-11-12 04:43:49,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49722/tests/dromaeo/cssquery-prototype.html) 04:43:49 INFO - 2015-11-12 04:43:49,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 200609792 04:43:49 INFO - 2015-11-12 04:43:49,912 DEBUG : BROWSER_OUTPUT: 04:46:52 INFO - 2015-11-12 04:46:52,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49722/tests/dromaeo/cssquery-yui.html) 04:46:53 INFO - 2015-11-12 04:46:53,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 204881920 04:46:53 INFO - 2015-11-12 04:46:53,112 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-yui.html (next: http://localhost:49722/tests/dromaeo/cssquery-dojo.html) 04:49:55 INFO - 2015-11-12 04:49:55,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 229609472 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:49:55 INFO - 2015-11-12 04:49:55,783 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.5405304071787;2704.215777424547;2718.5650295952637;2724.1146627346116;2728.863556822159;4629.722216667003;4750.738709370983;4794.640401969848;4804.663673542854;4805.279208118784;4698.50665680103;4734.218853889112;4762.809487620491;4765.690230135039;4781.18719817631;4377.802998865042;4430.224710675635;4440.86677399677;4541.750203738793;4569.497355290915;4258.276093064171;4473.1501014807245;4505.887352816173;4547.931781023287;4603.930941035887;4267.8079486423185;4326.415933848922;4358.193734159191;4367.650587952956;4379.562043795627;4453.621442177387;4457.130859482402;4485.9102817943785;4492.640588752892;4529.456465224162;4263.4031235627035;4349.956500434987;4444.177827101997;4460.50934397216;4508.549145085498;4601.7699115044115;4678.9940162864805;4697;4702.600278976257;4721.976390118028;5167.328247327823;5189.091908915962;5189.351331083614;5193.091209038404;5249.895002099936;4932.457429682732;5035.924461133086;5044.117279476077;5208.739563021833;5212.713300768456;4700.318453824177;4744.786484608201;4759.286107083896;4767.523247675274;4796.9760151199025;5256.553192978563;5395.4604539545735;5414.945850541523;5417.59368047398;5438.91841622376;4827.686200396963;4937.21004639256;4941.308216849644;5117.309163262987;5149.819756308511;5093.363329583802;5145.434002259748;5185.662931909414;5194.688318700814;5248.160294352885;5115.667481613683;5138.254953031789;5143.61422893277;5145.099607568735;5184.507471790174;4824.541668541553;4989.80040798364;4998.075356059141;5093.439721630618;5109.901371205208;4260.084081922401;4327.7619730914475;4333.479982402132;4353.825846966086;4368.235558777201;3767.3972164453558;3785.091578021255;3793.317202903504;3834.213986132836;3841.0205397623427;4182.853600124042;4305.763183024901;4449.087936972913;4454.354118652842;4463.553644635575;5065.6200784941275;5132.79468821243;5222.477752224823;5224.608154388436;5255.159174532057;4353.10761293934;4358.854482696826;4359.019220675323;4364.061726728705;4391.516933137416;4404.07514421975;4521.977390113094;4522.570355816192;4530.61489773373;4591.770411479412;4685.906281874411;4796.664233503621;4797.040591881568;4805.639577031737;4835.8065677372515;5199.974000129975;5244.921326180034;5247.396549396868;5254.9211761822835;5295.602829787705;4709.199436095803;4813.302071199727;4941.357623508921;4952.504749525018;4961.42943561495;4998.4501704813165;5019.272205530251;5055.570276526537;5066.493350664904;5067.5185857343495;5136.589072874236;5156.639035267495;5157.458466860926;5158.45836187195;5220.7650655721345;4735.147673418817;4860.3681521401995;4977.452480227244;4988.501149884983;5002.499750024968;4881.51184881509;4914.041761856403;4992.575631071254;5007.774650140679;5023.32185155014;4860.635452341018;4865.635077369141;4889;4891.926621100615;4926.482719314564;4854.101991131652;4944.703317800943;5029.1953287473825;5070.949290507047;5099.439061703136;4812.951870481391;4872.098661747446;4913.6069114471475;4916.606671466346;4931.038447502702 04:49:55 INFO - 2015-11-12 04:49:55,784 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.5992485410504;562.2100948167824;565.3978512883779;567.036038734152;585.0931056861863;28187.154385368445;36493.81753091234;37057.444138337945;37178.814105929436;37283.81358093206;41492.58507414925;41958;41983;41999.79000104995;42119.78940105303;6932.306769323052;7031.929680703179;7968.96015519923;8155;8158.143394943534;10283.331583447052;10505.684829455091;10506.737331566696;10518.421486818223;10521.68434946949;10142.847857282146;10249.180065594735;10256.743581410487;10261.692149235498;10267.845982310271;6924.861502769942;7083.291670832927;9801.460919649417;9854.753631159207;10122.848157277647;9899.109080182818;10103.343282686601;10104.89895101047;10107.039831216023;10109.24180686444;37522.24955500875;37957.81021094904;37990.24019519594;38036;38051;2843.8578071096567;2911.8544072796276;3441.6042155152227;3499.1077275294892;3514.91037778287;28783.28041798951;28957.276068098465;29305.267368315748;29378.55932161019;29989.25026874324;3159.178613560468;3179.4912813949886;3181.761367897394;3198.2484116232667;3217.6621454747146;221961;223411;223706;224162;224226;46248.768756156;47198.52801471941;60843.695781521696;62236.68881655653;62303.6884815573;56526.43473565294;56646;56728.43271567314;56840.147397789064;56873.43126568764;12791.168574042658;12923.15999460032;12971;12977.935110324388;12996.675083122998;9455.10176533242;9494.240460763122;9496.240300775922;9574.856377154349;9583.664571739955;19008.809911900706;19178.232870685017;19180.232790688216;19203.423897283104;19284;7277.2722727726805;7521.7743467696055;7562.0925488941675;7633.198514156044;7640.00679911619;836.7991681996399;841.3647695989611;881.316979341003;907.8592818113203;1043.8642976413169;25973.740262597512;26513.86743066272;26759;26786.19641410761;26793.866030670113;894.8702438146432;901.6032945503957;919.4253591505309;979.1970584120952;1025.5333823110466;13693.178409295475;13730;13816.585502434944;14051.78922316166;14109.85890141106;267645;273413;273553;273877;274499;46348.53651463442;46411;46739.766301168274;46746.53253467422;46764.532354676696;1152.8731839497648;1179.1922533064878;1186.4423720851187;1194.8932774785662;1195.2111606339774;25083.87458062698;25609.23172304834;25886.093986710373;26249.212523624323;26438.339041523348;37185.25629487341;37380.626193738804;41818.37272440855;42157.15685686208;42459.78770106253;181325;182691;182878;182943;183091;27668.723312766615;27979.300517487227;28082.85958570194;28087.859560702065;28096.85951570229;31048.22379440532;34566;34581.48127778136;38810.41784373293;39490.21019579535;29462.11613651594;29811;29870;30293.242668932573;30550;30409.23976900595;30645.08064758061;32824;33232;33440.1639959003;32968.67031329656;33257.50113748344;33290.334193316485;33383.49924751179;33394.4990825133;28044.29889252785;29641.703582963895;29718.257043574085;30255.394892101594;30300.24249393783;22621.411897046815;22886.885565572065;22904.198353057564;23056.53886922286;23301.41746456352 04:49:55 INFO - 2015-11-12 04:49:55,784 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.8517852145056;336.9090345606685;337.07304911493395;338.3655645664379;340.7274180655475;12121.393930303471;12469.563565275217;15156.166410847412;15432.768508472367;15688.45090421834;10812.080973117274;11096.500657470413;11099.946509895655;14617.926910365433;15093.849061509381;4123.340265557519;4207.474065741782;4223.197592457439;4229.217594744982;4236.894077648068;3137.5764271823355;3207.7273431758213;4737.3604563384015;4844.87887802806;4853.296272040569;4790.5448982346625;4804.4234691836855;4805.879853003686;4816.807327706888;4824.782884770194;4698.953010469886;4810.855674329776;4831.710097394168;4833.444153922291;4836.903261934777;4142.316517774563;4144.937825932613;4148.875533733993;4149.647279981205;4152.397902304149;13053.151545149534;13086.083974121815;13348.799768003488;13353.332333383292;13355.131916425402;1739.852112570433;1764.8499877510426;1794.237449084134;1818.1091265279917;1843.2995461724593;9301.627934882597;9544.809103817954;9608.951955240249;9643.035696430372;9765.121139097444;1550.0622123615162;1615.3215649427268;1784.1525275494166;1819.699749541324;1861.0601646168734;50661.493385066045;51954.48045519534;52058.21912671313;52973.205401919;54103.18845217325;6615.569987950767;6637.568558043712;6662.533622646465;6694.297098804653;6714.664266786739;7714.5756983366455;7740.032495938008;7747.651355689008;7759.262870027338;7775.300222979959;4900.828471003498;4904.2643603459765;4945.282933974553;4949.925751113737;4962.305277261186;4824.421069471616;4840.249761287007;4905.852824415273;5005.74971251436;5005.949940500548;3101.1471845242286;3142.889998850075;3162.256869635634;3168.2712976015646;3169.667184945594;1039.4906495817147;1085.1102096281131;1085.4247248958065;1127.9830802537967;1136.2614300704608;432.90692501111783;445.4476449202965;446.4352593968632;451.8057235388749;479.2332268370649;10750.247482676294;11126;11143.498542565603;11173.329600224013;11283.153763467608;415.21109891206345;449.43595787286745;455.27838376174134;466.55210997442157;473.47680812702157;5735.541156707453;5856.765729370863;5890.145928840294;5927.4665280125;5960;479996;480513;507881;509657;511994;68504.31495684979;69419.65290173517;70614.64692676504;71674.64162679258;71705.6414717923;495.05938716439056;497.65164384930694;499.6502448286142;500.33705340424086;500.6745615350052;9817.803643927224;9836.163926066365;9869.851952220579;9904.455254960758;9949.303548751517;31864.203394915312;32632.021039368858;33085.503717443775;33149;33325.33349332951;44292.33561496516;44333.11333773371;46486;47293;47442.52557474519;6350.364963503613;6491.4806815455595;6493.805185844432;6495.415412612888;6504.0243963405865;11420.371879546705;11536.192466527262;11810.114241432098;11824.290542567473;11840.70398240051;10254.487275636338;10311.484425778832;10368.429736364573;10410.323328983592;10533.420661863365;10078.647247346307;10215.13171380441;10220.897791022293;10263.281570290306;10543.736406589896;8322.45904016237;8626.09426010285;10285.794284114425;10395.16838652921;10531.94734026325;5691.430856914441;6230.930776241348;6402.551821372459;6463.450606698483;6469.902951455638;9612.423254604746;10170.949145254226;10185.592576296865;10410.323328983592;10469.528871200662 04:49:55 INFO - 2015-11-12 04:49:55,784 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1404.4382247101164;1623.1965177237266;1673.3557580331576;1692.3822804676292;1698.7876515435562;6072.483838873695;6860.108185935827;7019.052427922229;7026.613536255504;7028.051213086238;6848.897266540994;6939.895901561481;6944.6180460074675;6946.96526517368;6957.79126626202;1683.9158042097908;1716.4421562992015;1963.5385684364162;1979.5941831924422;1984.6923726822365;2026.8175864172222;2031.2788959919237;2032.908519116636;2036.389083275019;2036.9083391247354;1967.7540307461568;1990.044778506318;2008.8895110768901;2012.9698054529194;2013.1544751204528;1985.1166231027198;2000.4798752324427;2018.7476565429322;2020.0404807716363;2021.9898900505477;1931.0634342344092;1944.4555524453176;1954.0620502158902;1954.4625228062255;1958.0797025398183;7046.295370462964;7115.3951914087365;7126.857462850714;7135.250798666118;7142.928570714278;4090.079732060263;4176.60322269384;4181.142865712552;4188.078622703;4192.559781222958;2320.477892474197;2618.8428694278405;2701.770349520293;2737.630419893309;2754.5179593571247;811.3306522119216;857.5883575883611;863.0808189278398;876.4872549558515;928.424376886328;9595.904040959571;9600.471974041426;9610.51947402627;9628.374155679858;9654.372465789702;3704.148045949447;3719.1631882826687;3770.6229377062073;3782.130110074698;3945.4279129526058;8264.8347033059;8271.048829384697;8277.95861020691;8296.83406331882;8310.875336869953;4187.5184353799095;4187.916241675211;4204.26425375558;4210.978945105255;4215.747055176699;3799.0882188274613;3824.9426258606145;3825.215830754689;3828.617138286149;3839.347310957144;3356.781809182395;3359.6808303211155;3404.2340473393288;3405.165734395089;3405.3870303345634;1033.106362996018;1039.1167507618616;1041.234692501011;1046.2937517175876;1050.821360368739;1140.3556990300453;1146.2377518949804;1147.363213416545;1154.6882341767675;1194.2774621354129;6343.524235682342;6352.174217351807;6366;6393.488520918316;6413.16628838248;422.82875435448693;422.9555896630871;426.1073051956147;428.54146063712153;435.8496318770019;4878.292647566083;4934.8026078957155;4948.628852836052;4957.256411538298;4967.875803104951;7067.116610423697;7114.39527640146;8431.494110353398;8479.406441549032;8662.480251184948;8078.474899131537;8205.302549283258;8361.665533378597;8371.958140209383;8376.49741015541;6395.520335974914;6657.46740260778;6775.3902148805855;6803.48973826965;6810.182778066664;6712;6772.695228714818;6788.558743681645;6807.591544507345;6823.385895269251;7494.700211991677;7546.622668866645;7606.467547271638;7609.6575654096805;7636.236376362319;7055.753048643272;7281.089863767029;7299.963500182465;7847.921520784719;7853.057633084067;6204.534659900616;6291.087792270004;6301.779437719658;6319.115323854756;6319.399657032574;6649.9354014761675;6708.698108585223;6776.559523630948;6778.8644227116165;6796.796096117125;6311.873762524632;6318.905216421849;6367.044943258548;6428.6785660717715;6465.321141280097;6267.2165979252595;6320.4311611955145;6351;6372.55392122547;6459.677016149268;6283.96858015707;6421.743130274736;6425.261094974137;6430.260520040255;6438.227412710317;5802.361740208658;5817.243758311392;5846.883062338815;5851.941480585139;5872.265966754156;5786.045302525036;5819.4180581943165;5824.097264923944;5873.295204575478;5898.498627616701 04:49:55 INFO - 2015-11-12 04:49:55,784 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.9005383196629;302.4344475830198;306.52488642603964;307.64788753428695;308.5803307501797;5227.581793456524;5229.8169564065265;5243.16109422492;5254.947450525494;5270.525652691262;4952.801887924478;5034.320366750488;5064.873378165538;5140.126178549646;5160.509751573604;3993.660538854186;4001.319775638134;4044.777537235451;4049.5140583130064;4052.9392059119064;3844.480995065658;4046.332355161395;4047.4535937648334;4047.736897101679;4052.8581499647516;3888.2612303662354;3987.3022221111332;4076.7757773322605;4078.8368465261356;4079.653229475498;4044.959550404488;4052.4326594276827;4055.3916912463073;4058.715889887709;4068.349064149722;3562.5724913010604;3566.5006899034156;3567.9108022299392;3569.0542006368332;3591.730620203495;5039.974800125976;5041.143005689041;5042.067217564762;5046;5052.166392545262;4520.073384956109;4610.031893302411;4637.721736695776;4660.976695116537;4675.2052151134385;5494.697791621459;5503.972480137613;5506.91739623906;5511.035568775448;5511.448855114457;3915.804209789499;3916.4321173429694;3916.843326266946;3917.040325120364;3918.9804050979847;5760.567957403212;5761.798337058225;5764.221830052973;5769.942300576982;5777.306723193202;3946.7631942083567;4028.959710402917;4030.052937559671;4031.677465802729;4041.9797901010306;4085.8569950051606;4086.693497987663;4093.85671501496;4098.774567398762;4108.1783643271465;4627.9768601156775;4641.721496710208;4642.46611639659;4642.837500687459;4643.4660014098135;5470.152126420411;5471;5473.0969390050195;5490.149026900836;5504.724763761796;1397.343248673122;1454.2219912346843;1488.3376897280607;1488.4195163886093;1489.352131822639;937.1378331934636;973.5570315506427;978.6232300564334;985.6303886042734;989.8366769482955;4717.2216584263215;4749.24012158053;4754.881127971828;4756.191447453941;4757.785899634525;5537.889242215133;5567.359753628303;5568.9443105568425;5573.968815769014;5591.04952158126;4667;4733.053389322149;4748;4748.548887855717;4750.8337208197545;3100.162956001867;3112.4553203189353;3127.046250893454;3129.2333378322455;3132.8433578321446;5278.5513231375;5294.708791016454;5296.92054619181;5303.178007408857;5303.36359636846;5739.483446489836;5778.711064446761;5783.826485205451;5785.681787501728;5787.536997040227;5143.3827940646615;5371.086915224421;5373.677579345252;5375.4087050425205;5387.515123638969;5687.658740475585;5696.515796157208;5717.857053573527;5725.255716756795;5733.885322293448;5596.916046259228;5597.580181486323;5605.80379686709;5609.80365687199;5613.747381367766;5236.711980840938;5370.650907690988;5373.7850485980125;5383.40782513931;5390.784368625211;3773.0378753417704;3795.544534655859;3798.981005094957;3799.8100094995693;3802.353599888081;5673.574481913791;5697.088465845445;5718.599698021098;5724;5735.283089613798;5494.725263736717;5496.230527726201;5499.4225606310765;5504.339479262514;5506.752196151263;5382.784688612568;5479.0685583451705;5490.231367608458;5498.340199176125;5507.339119305549;5401.783928642811;5402.891942161056;5404.702741349263;5405.891882162414;5407.513323800877;5505.807296744755;5535.086710692852;5547.667139971614;5549.306336707911;5557.888842223052;5254.581263058876;5375.623706340519;5377.27406800077;5378.247045413724;5384.273123128328 04:49:55 INFO - 2015-11-12 04:49:55,787 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.3896814930264;672.2235817630639;754.8075240813591;767.1522967121329;774.9883751743724;11886.465109070092;12078.15452918296;12133.272003679785;12149.149559530837;12152.635420937364;11974.820377694341;12109.818352724717;13114.47542098315;13455.798163027563;13466.192028478297;603.2369053147771;609.881073190728;758.5069704691953;770.5992883700472;771.2364758888716;752.5597525447592;762.12736416803;765.4756491803132;766.4022062791032;767.2251026463284;786.2962648429652;792.18405042806;792.7899106736719;793.654760179321;793.7499687598388;596.7105953612495;605.6547767772349;780.75406247032;784.6665167303873;794.8012996750813;575.5251917168353;578.17032558279;580.5210701171508;580.6806256558918;581.0818906128308;12108.15242932995;12236.510539578407;12253.019758419305;12256.754864902741;12258.75482490354;8827.293816494664;9375.296852736072;9434.150926416656;9518.70596407657;10044.648437304659;8415.957920210421;8518.87221691675;8879.778005549913;8942.597583108776;8954.417962832395;2733.425980544088;2807.7753779697573;2816.4226333601564;2843.5876797864194;2901.883924643033;40282.395764063855;40465.190696186204;40709.389359159635;40728.59271407278;40805;6801.727930882808;6853.691583878737;6868.969654551857;6968.616726080114;6972.686229119702;10602.20483463728;10631.787364252827;10633.415162166155;10677.786444271227;10701.625443109453;5688.971555142198;5723.484886360247;5754.625949313365;5760.913586296209;5897.587168898136;3266.379387916288;3630.6550877666577;3637.436197389356;3671.889843304705;3718.795466249382;2399.4601214726545;2433.415980164748;2437.1348171399254;2439.0853429963763;2439.7194322652767;393.93893946438345;401.2797029332297;404.3005600311419;408.5628377635901;409.37774582634825;550.295621604347;559.4461483131752;573.5497634357009;584.5177728374108;584.5615788158881;7763.301302882767;7845.4900431472915;7948.165442628557;8794.692185773596;8938.642454301886;430.6834476659653;449.32402140017916;490.93863267091615;614.7203022624784;628.6573817269599;3607.332643460968;3831.1954489556947;3890.4942357493346;3984.163325701635;4103.9179216415505;47315.52684473111;47355;47556.7622161887;49046.509534904195;49665;41953.32186712497;42449.57550424518;42495;42782.57217427786;42792.57207427948;43194.784026079666;43196.3520547192;43848.780756096014;43990.56009439928;43997.120057598666;7708.6791173846605;7714.6914123434435;7802.258785415376;7924.286814186751;7977.880331795144;32408.351832962737;32424;33226;33405;33526.82075665074;38542;41159.38260926148;41579.792101039304;41788.582114179684;42027.36958945557;10199.38803671782;10679.223401915402;10817.837732433862;10900.291481053706;11089.889101108885;10904.236703430684;11238.943805280922;11276.32342059479;11800;11843.644690659294;10031.097201251923;10134.391936483835;10306.587736490457;10333.121684656888;10394.272400931863;10395.064444200058;10507.789844203226;10710.143188545053;11007.449627518432;11162.665120046087;8531.445456045338;10004.949975250078;10217.284790064625;10703.143748499946;11052.281601695864;8642.308615310885;8676.132386761527;8832.205101540892;8885.37802353855;9741.318107732392;9093;9140.542972851197;9181.449113053239;9386.577604007973;9469.337146399686 04:49:55 INFO - 2015-11-12 04:49:55,787 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,959 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: __startTimestamp1447332595776__endTimestamp 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4731.41 Median:4813.30 stddev:503.85 (10.5%) stddev-sans-first:477.55 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: Values: 2625.5 2704.2 2718.6 2724.1 2728.9 4629.7 4750.7 4794.6 4804.7 4805.3 4698.5 4734.2 4762.8 4765.7 4781.2 4377.8 4430.2 4440.9 4541.8 4569.5 4258.3 4473.2 4505.9 4547.9 4603.9 4267.8 4326.4 4358.2 4367.7 4379.6 4453.6 4457.1 4485.9 4492.6 4529.5 4263.4 4350.0 4444.2 4460.5 4508.5 4601.8 4679.0 4697.0 4702.6 4722.0 5167.3 5189.1 5189.4 5193.1 5249.9 4932.5 5035.9 5044.1 5208.7 5212.7 4700.3 4744.8 4759.3 4767.5 4797.0 5256.6 5395.5 5414.9 5417.6 5438.9 4827.7 4937.2 4941.3 5117.3 5149.8 5093.4 5145.4 5185.7 5194.7 5248.2 5115.7 5138.3 5143.6 5145.1 5184.5 4824.5 4989.8 4998.1 5093.4 5109.9 4260.1 4327.8 4333.5 4353.8 4368.2 3767.4 3785.1 3793.3 3834.2 3841.0 4182.9 4305.8 4449.1 4454.4 4463.6 5065.6 5132.8 5222.5 5224.6 5255.2 4353.1 4358.9 4359.0 4364.1 4391.5 4404.1 4522.0 4522.6 4530.6 4591.8 4685.9 4796.7 4797.0 4805.6 4835.8 5200.0 5244.9 5247.4 5254.9 5295.6 4709.2 4813.3 4941.4 4952.5 4961.4 4998.5 5019.3 5055.6 5066.5 5067.5 5136.6 5156.6 5157.5 5158.5 5220.8 4735.1 4860.4 4977.5 4988.5 5002.5 4881.5 4914.0 4992.6 5007.8 5023.3 4860.6 4865.6 4889.0 4891.9 4926.5 4854.1 4944.7 5029.2 5070.9 5099.4 4813.0 4872.1 4913.6 4916.6 4931.0 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,788 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39071.00 Median:30597.54 stddev:59646.44 (194.9%) stddev-sans-first:59743.66 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: Values: 556.6 562.2 565.4 567.0 585.1 28187.2 36493.8 37057.4 37178.8 37283.8 41492.6 41958.0 41983.0 41999.8 42119.8 6932.3 7031.9 7969.0 8155.0 8158.1 10283.3 10505.7 10506.7 10518.4 10521.7 10142.8 10249.2 10256.7 10261.7 10267.8 6924.9 7083.3 9801.5 9854.8 10122.8 9899.1 10103.3 10104.9 10107.0 10109.2 37522.2 37957.8 37990.2 38036.0 38051.0 2843.9 2911.9 3441.6 3499.1 3514.9 28783.3 28957.3 29305.3 29378.6 29989.3 3159.2 3179.5 3181.8 3198.2 3217.7 221961.0 223411.0 223706.0 224162.0 224226.0 46248.8 47198.5 60843.7 62236.7 62303.7 56526.4 56646.0 56728.4 56840.1 56873.4 12791.2 12923.2 12971.0 12977.9 12996.7 9455.1 9494.2 9496.2 9574.9 9583.7 19008.8 19178.2 19180.2 19203.4 19284.0 7277.3 7521.8 7562.1 7633.2 7640.0 836.8 841.4 881.3 907.9 1043.9 25973.7 26513.9 26759.0 26786.2 26793.9 894.9 901.6 919.4 979.2 1025.5 13693.2 13730.0 13816.6 14051.8 14109.9 267645.0 273413.0 273553.0 273877.0 274499.0 46348.5 46411.0 46739.8 46746.5 46764.5 1152.9 1179.2 1186.4 1194.9 1195.2 25083.9 25609.2 25886.1 26249.2 26438.3 37185.3 37380.6 41818.4 42157.2 42459.8 181325.0 182691.0 182878.0 182943.0 183091.0 27668.7 27979.3 28082.9 28087.9 28096.9 31048.2 34566.0 34581.5 38810.4 39490.2 29462.1 29811.0 29870.0 30293.2 30550.0 30409.2 30645.1 32824.0 33232.0 33440.2 32968.7 33257.5 33290.3 33383.5 33394.5 28044.3 29641.7 29718.3 30255.4 30300.2 22621.4 22886.9 22904.2 23056.5 23301.4 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24906.27 Median:450.62 stddev:81632.43 (18115.5%) stddev-sans-first:81840.58 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: Values: 336.9 336.9 337.1 338.4 340.7 12121.4 12469.6 15156.2 15432.8 15688.5 10812.1 11096.5 11099.9 14617.9 15093.8 4123.3 4207.5 4223.2 4229.2 4236.9 3137.6 3207.7 4737.4 4844.9 4853.3 4790.5 4804.4 4805.9 4816.8 4824.8 4699.0 4810.9 4831.7 4833.4 4836.9 4142.3 4144.9 4148.9 4149.6 4152.4 13053.2 13086.1 13348.8 13353.3 13355.1 1739.9 1764.8 1794.2 1818.1 1843.3 9301.6 9544.8 9609.0 9643.0 9765.1 1550.1 1615.3 1784.2 1819.7 1861.1 50661.5 51954.5 52058.2 52973.2 54103.2 6615.6 6637.6 6662.5 6694.3 6714.7 7714.6 7740.0 7747.7 7759.3 7775.3 4900.8 4904.3 4945.3 4949.9 4962.3 4824.4 4840.2 4905.9 5005.7 5005.9 3101.1 3142.9 3162.3 3168.3 3169.7 1039.5 1085.1 1085.4 1128.0 1136.3 432.9 445.4 446.4 451.8 479.2 10750.2 11126.0 11143.5 11173.3 11283.2 415.2 449.4 455.3 466.6 473.5 5735.5 5856.8 5890.1 5927.5 5960.0 479996.0 480513.0 507881.0 509657.0 511994.0 68504.3 69419.7 70614.6 71674.6 71705.6 495.1 497.7 499.7 500.3 500.7 9817.8 9836.2 9869.9 9904.5 9949.3 31864.2 32632.0 33085.5 33149.0 33325.3 44292.3 44333.1 46486.0 47293.0 47442.5 6350.4 6491.5 6493.8 6495.4 6504.0 11420.4 11536.2 11810.1 11824.3 11840.7 10254.5 10311.5 10368.4 10410.3 10533.4 10078.6 10215.1 10220.9 10263.3 10543.7 8322.5 8626.1 10285.8 10395.2 10531.9 5691.4 6230.9 6402.6 6463.5 6469.9 9612.4 10170.9 10185.6 10410.3 10469.5 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,790 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4877.64 Median:6138.51 stddev:2556.44 (41.6%) stddev-sans-first:2550.28 04:49:55 INFO - 2015-11-12 04:49:55,791 DEBUG : BROWSER_OUTPUT: Values: 1404.4 1623.2 1673.4 1692.4 1698.8 6072.5 6860.1 7019.1 7026.6 7028.1 6848.9 6939.9 6944.6 6947.0 6957.8 1683.9 1716.4 1963.5 1979.6 1984.7 2026.8 2031.3 2032.9 2036.4 2036.9 1967.8 1990.0 2008.9 2013.0 2013.2 1985.1 2000.5 2018.7 2020.0 2022.0 1931.1 1944.5 1954.1 1954.5 1958.1 7046.3 7115.4 7126.9 7135.3 7142.9 4090.1 4176.6 4181.1 4188.1 4192.6 2320.5 2618.8 2701.8 2737.6 2754.5 811.3 857.6 863.1 876.5 928.4 9595.9 9600.5 9610.5 9628.4 9654.4 3704.1 3719.2 3770.6 3782.1 3945.4 8264.8 8271.0 8278.0 8296.8 8310.9 4187.5 4187.9 4204.3 4211.0 4215.7 3799.1 3824.9 3825.2 3828.6 3839.3 3356.8 3359.7 3404.2 3405.2 3405.4 1033.1 1039.1 1041.2 1046.3 1050.8 1140.4 1146.2 1147.4 1154.7 1194.3 6343.5 6352.2 6366.0 6393.5 6413.2 422.8 423.0 426.1 428.5 435.8 4878.3 4934.8 4948.6 4957.3 4967.9 7067.1 7114.4 8431.5 8479.4 8662.5 8078.5 8205.3 8361.7 8372.0 8376.5 6395.5 6657.5 6775.4 6803.5 6810.2 6712.0 6772.7 6788.6 6807.6 6823.4 7494.7 7546.6 7606.5 7609.7 7636.2 7055.8 7281.1 7300.0 7847.9 7853.1 6204.5 6291.1 6301.8 6319.1 6319.4 6649.9 6708.7 6776.6 6778.9 6796.8 6311.9 6318.9 6367.0 6428.7 6465.3 6267.2 6320.4 6351.0 6372.6 6459.7 6284.0 6421.7 6425.3 6430.3 6438.2 5802.4 5817.2 5846.9 5851.9 5872.3 5786.0 5819.4 5824.1 5873.3 5898.5 04:49:55 INFO - 2015-11-12 04:49:55,791 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,791 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4550.99 Median:5194.05 stddev:1321.82 (25.4%) stddev-sans-first:1286.38 04:49:55 INFO - 2015-11-12 04:49:55,791 DEBUG : BROWSER_OUTPUT: Values: 296.9 302.4 306.5 307.6 308.6 5227.6 5229.8 5243.2 5254.9 5270.5 4952.8 5034.3 5064.9 5140.1 5160.5 3993.7 4001.3 4044.8 4049.5 4052.9 3844.5 4046.3 4047.5 4047.7 4052.9 3888.3 3987.3 4076.8 4078.8 4079.7 4045.0 4052.4 4055.4 4058.7 4068.3 3562.6 3566.5 3567.9 3569.1 3591.7 5040.0 5041.1 5042.1 5046.0 5052.2 4520.1 4610.0 4637.7 4661.0 4675.2 5494.7 5504.0 5506.9 5511.0 5511.4 3915.8 3916.4 3916.8 3917.0 3919.0 5760.6 5761.8 5764.2 5769.9 5777.3 3946.8 4029.0 4030.1 4031.7 4042.0 4085.9 4086.7 4093.9 4098.8 4108.2 4628.0 4641.7 4642.5 4642.8 4643.5 5470.2 5471.0 5473.1 5490.1 5504.7 1397.3 1454.2 1488.3 1488.4 1489.4 937.1 973.6 978.6 985.6 989.8 4717.2 4749.2 4754.9 4756.2 4757.8 5537.9 5567.4 5568.9 5574.0 5591.0 4667.0 4733.1 4748.0 4748.5 4750.8 3100.2 3112.5 3127.0 3129.2 3132.8 5278.6 5294.7 5296.9 5303.2 5303.4 5739.5 5778.7 5783.8 5785.7 5787.5 5143.4 5371.1 5373.7 5375.4 5387.5 5687.7 5696.5 5717.9 5725.3 5733.9 5596.9 5597.6 5605.8 5609.8 5613.7 5236.7 5370.7 5373.8 5383.4 5390.8 3773.0 3795.5 3799.0 3799.8 3802.4 5673.6 5697.1 5718.6 5724.0 5735.3 5494.7 5496.2 5499.4 5504.3 5506.8 5382.8 5479.1 5490.2 5498.3 5507.3 5401.8 5402.9 5404.7 5405.9 5407.5 5505.8 5535.1 5547.7 5549.3 5557.9 5254.6 5375.6 5377.3 5378.2 5384.3 04:49:55 INFO - 2015-11-12 04:49:55,792 DEBUG : BROWSER_OUTPUT: 04:49:55 INFO - 2015-11-12 04:49:55,792 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12044.25 Median:21812.73 stddev:13947.24 (63.9%) stddev-sans-first:13960.18 04:49:55 INFO - 2015-11-12 04:49:55,793 DEBUG : BROWSER_OUTPUT: Values: 663.4 672.2 754.8 767.2 775.0 11886.5 12078.2 12133.3 12149.1 12152.6 11974.8 12109.8 13114.5 13455.8 13466.2 603.2 609.9 758.5 770.6 771.2 752.6 762.1 765.5 766.4 767.2 786.3 792.2 792.8 793.7 793.7 596.7 605.7 780.8 784.7 794.8 575.5 578.2 580.5 580.7 581.1 12108.2 12236.5 12253.0 12256.8 12258.8 8827.3 9375.3 9434.2 9518.7 10044.6 8416.0 8518.9 8879.8 8942.6 8954.4 2733.4 2807.8 2816.4 2843.6 2901.9 40282.4 40465.2 40709.4 40728.6 40805.0 6801.7 6853.7 6869.0 6968.6 6972.7 10602.2 10631.8 10633.4 10677.8 10701.6 5689.0 5723.5 5754.6 5760.9 5897.6 3266.4 3630.7 3637.4 3671.9 3718.8 2399.5 2433.4 2437.1 2439.1 2439.7 393.9 401.3 404.3 408.6 409.4 550.3 559.4 573.5 584.5 584.6 7763.3 7845.5 7948.2 8794.7 8938.6 430.7 449.3 490.9 614.7 628.7 3607.3 3831.2 3890.5 3984.2 4103.9 47315.5 47355.0 47556.8 49046.5 49665.0 41953.3 42449.6 42495.0 42782.6 42792.6 43194.8 43196.4 43848.8 43990.6 43997.1 7708.7 7714.7 7802.3 7924.3 7977.9 32408.4 32424.0 33226.0 33405.0 33526.8 38542.0 41159.4 41579.8 41788.6 42027.4 10199.4 10679.2 10817.8 10900.3 11089.9 10904.2 11238.9 11276.3 11800.0 11843.6 10031.1 10134.4 10306.6 10333.1 10394.3 10395.1 10507.8 10710.1 11007.4 11162.7 8531.4 10004.9 10217.3 10703.1 11052.3 8642.3 8676.1 8832.2 8885.4 9741.3 9093.0 9140.5 9181.4 9386.6 9469.3 04:49:55 INFO - 2015-11-12 04:49:55,793 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:49:55 INFO - 2015-11-12 04:49:55,793 DEBUG : BROWSER_OUTPUT: 04:49:56 INFO - 2015-11-12 04:49:56,467 INFO : Browser exited with error code: 0 04:49:56 INFO - 2015-11-12 04:49:56,488 INFO : Completed test dromaeo_css (00:18:38) 04:49:56 INFO - 2015-11-12 04:49:56,488 INFO : Starting test kraken 04:49:56 INFO - 2015-11-12 04:49:56,488 DEBUG : operating with platform_type : linux_ 04:49:56 INFO - 2015-11-12 04:49:56,489 INFO : Initialising browser for kraken test... 04:49:56 INFO - 2015-11-12 04:49:56,495 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWSypRq/profile http://localhost:49722/getInfo.html 04:50:00 INFO - 2015-11-12 04:50:00,531 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:50:00 INFO - 2015-11-12 04:50:00,531 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:50:00 INFO - 2015-11-12 04:50:00,531 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:50:00 INFO - 2015-11-12 04:50:00,531 DEBUG : BROWSER_OUTPUT: __metrics 04:50:00 INFO - 2015-11-12 04:50:00,653 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:01 INFO - 2015-11-12 04:50:01,864 INFO : Browser initialized. 04:50:01 INFO - 2015-11-12 04:50:01,865 INFO : Running cycle 1/1 for kraken test... 04:50:01 INFO - 2015-11-12 04:50:01,865 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWSypRq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:50:13 INFO - 2015-11-12 04:50:13,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 138989568 04:50:13 INFO - 2015-11-12 04:50:13,807 DEBUG : BROWSER_OUTPUT: 04:50:16 INFO - 2015-11-12 04:50:16,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:16 INFO - 2015-11-12 04:50:16,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 177250304 04:50:16 INFO - 2015-11-12 04:50:16,983 DEBUG : BROWSER_OUTPUT: 04:50:19 INFO - 2015-11-12 04:50:19,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-dft) 04:50:20 INFO - 2015-11-12 04:50:20,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 167886848 04:50:20 INFO - 2015-11-12 04:50:20,266 DEBUG : BROWSER_OUTPUT: 04:50:23 INFO - 2015-11-12 04:50:23,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-fft) 04:50:23 INFO - 2015-11-12 04:50:23,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 151973888 04:50:23 INFO - 2015-11-12 04:50:23,879 DEBUG : BROWSER_OUTPUT: 04:50:25 INFO - 2015-11-12 04:50:25,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-oscillator) 04:50:26 INFO - 2015-11-12 04:50:26,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 154632192 04:50:26 INFO - 2015-11-12 04:50:26,493 DEBUG : BROWSER_OUTPUT: 04:50:28 INFO - 2015-11-12 04:50:28,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:29 INFO - 2015-11-12 04:50:29,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 154910720 04:50:29 INFO - 2015-11-12 04:50:29,267 DEBUG : BROWSER_OUTPUT: 04:50:32 INFO - 2015-11-12 04:50:32,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:32 INFO - 2015-11-12 04:50:32,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 154787840 04:50:32 INFO - 2015-11-12 04:50:32,855 DEBUG : BROWSER_OUTPUT: 04:50:36 INFO - 2015-11-12 04:50:36,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:36 INFO - 2015-11-12 04:50:36,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 155590656 04:50:36 INFO - 2015-11-12 04:50:36,866 DEBUG : BROWSER_OUTPUT: 04:50:39 INFO - 2015-11-12 04:50:39,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49722/tests/kraken/driver.html?testName=json-parse-financial) 04:50:40 INFO - 2015-11-12 04:50:40,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 156266496 04:50:40 INFO - 2015-11-12 04:50:40,297 DEBUG : BROWSER_OUTPUT: 04:50:42 INFO - 2015-11-12 04:50:42,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:42 INFO - 2015-11-12 04:50:42,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 164376576 04:50:42 INFO - 2015-11-12 04:50:42,605 DEBUG : BROWSER_OUTPUT: 04:50:44 INFO - 2015-11-12 04:50:44,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:45 INFO - 2015-11-12 04:50:45,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 164712448 04:50:45 INFO - 2015-11-12 04:50:45,040 DEBUG : BROWSER_OUTPUT: 04:50:47 INFO - 2015-11-12 04:50:47,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:47 INFO - 2015-11-12 04:50:47,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 179621888 04:50:47 INFO - 2015-11-12 04:50:47,754 DEBUG : BROWSER_OUTPUT: 04:50:50 INFO - 2015-11-12 04:50:50,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:50 INFO - 2015-11-12 04:50:50,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 183873536 04:50:50 INFO - 2015-11-12 04:50:50,842 DEBUG : BROWSER_OUTPUT: 04:50:53 INFO - 2015-11-12 04:50:53,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:53 INFO - 2015-11-12 04:50:53,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 182296576 04:50:53 INFO - 2015-11-12 04:50:53,994 DEBUG : BROWSER_OUTPUT: 04:50:55 INFO - 2015-11-12 04:50:55,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49722/tests/kraken/driver.html?testName=ai-astar) 04:50:55 INFO - 2015-11-12 04:50:55,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 240078848 04:50:55 INFO - 2015-11-12 04:50:55,994 DEBUG : BROWSER_OUTPUT: 04:50:55 INFO - 2015-11-12 04:50:55,995 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:50:55 INFO - 2015-11-12 04:50:55,996 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:50:55 INFO - 2015-11-12 04:50:55,996 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:50:55 INFO - 2015-11-12 04:50:55,996 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:50:55 INFO - 2015-11-12 04:50:55,997 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;107;111;111;115;103;111;102;111 04:50:55 INFO - 2015-11-12 04:50:55,997 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;131;159;162;130;154;151;143;174;129 04:50:55 INFO - 2015-11-12 04:50:55,997 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;161;161;161;162;163;160;161 04:50:55 INFO - 2015-11-12 04:50:55,997 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;74;81;92;73;72;71;85;89;72 04:50:55 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;127;91;92;92;128;91;92;128 04:50:55 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;109;110 04:50:55 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;147;146;148;148;147;146 04:50:55 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 04:50:55 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;69;70;69;70;70;79;68;66 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;66;66;66;66;66;66;67 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;83;89;83;85;85;83;85;90 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;130;125;120;126;126;129;120;122;123 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;139;152;145;153;138;140;134;144;134 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;67;69;70;68;68;68;70;68 04:50:56 INFO - 2015-11-12 04:50:55,998 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:50:56 INFO - 2015-11-12 04:50:55,999 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:50:56 INFO - 2015-11-12 04:50:55,999 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,978 04:50:56 INFO - 2015-11-12 04:50:55,999 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:50:56 INFO - 2015-11-12 04:50:55,999 DEBUG : BROWSER_OUTPUT: __startTimestamp1447332655995__endTimestamp 04:50:56 INFO - 2015-11-12 04:50:55,999 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:4.08 (3.7%) stddev-sans-first:4.32 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 107.0 111.0 111.0 115.0 103.0 111.0 102.0 111.0 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:156.50 stddev:15.51 (9.9%) stddev-sans-first:15.96 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: Values: 160.0 131.0 159.0 162.0 130.0 154.0 151.0 143.0 174.0 129.0 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 04:50:56 INFO - 2015-11-12 04:50:56,007 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 161.0 161.0 161.0 162.0 163.0 160.0 161.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.00 Median:77.50 stddev:8.07 (10.4%) stddev-sans-first:8.15 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: Values: 71.0 74.0 81.0 92.0 73.0 72.0 71.0 85.0 89.0 72.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:91.00 stddev:17.51 (19.2%) stddev-sans-first:18.09 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 127.0 91.0 92.0 92.0 128.0 91.0 92.0 128.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 110.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 147.0 146.0 148.0 148.0 147.0 146.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 04:50:56 INFO - 2015-11-12 04:50:56,008 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:3.39 (4.8%) stddev-sans-first:3.59 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 69.0 70.0 69.0 70.0 70.0 79.0 68.0 66.0 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.54 (3.0%) stddev-sans-first:2.59 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 83.0 89.0 83.0 85.0 85.0 83.0 85.0 90.0 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.50 stddev:3.50 (2.8%) stddev-sans-first:3.61 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: Values: 122.0 130.0 125.0 120.0 126.0 126.0 129.0 120.0 122.0 123.0 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:144.50 stddev:7.16 (5.0%) stddev-sans-first:6.99 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: Values: 151.0 139.0 152.0 145.0 153.0 138.0 140.0 134.0 144.0 134.0 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,009 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 04:50:56 INFO - 2015-11-12 04:50:56,010 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 67.0 69.0 70.0 68.0 68.0 68.0 70.0 68.0 04:50:56 INFO - 2015-11-12 04:50:56,010 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:50:56 INFO - 2015-11-12 04:50:56,010 DEBUG : BROWSER_OUTPUT: 04:50:56 INFO - 2015-11-12 04:50:56,915 INFO : Browser exited with error code: 0 04:50:56 INFO - 2015-11-12 04:50:56,966 INFO : Completed test kraken (00:01:00) 04:50:56 INFO - 2015-11-12 04:50:56,966 INFO : Starting test v8_7 04:50:56 INFO - 2015-11-12 04:50:56,966 DEBUG : operating with platform_type : linux_ 04:50:56 INFO - 2015-11-12 04:50:56,966 INFO : Initialising browser for v8_7 test... 04:50:56 INFO - 2015-11-12 04:50:56,972 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7WGcb/profile http://localhost:49722/getInfo.html 04:51:01 INFO - 2015-11-12 04:51:01,083 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:01 INFO - 2015-11-12 04:51:01,083 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:01 INFO - 2015-11-12 04:51:01,083 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:51:01 INFO - 2015-11-12 04:51:01,083 DEBUG : BROWSER_OUTPUT: __metrics 04:51:01 INFO - 2015-11-12 04:51:01,240 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:02 INFO - 2015-11-12 04:51:02,542 INFO : Browser initialized. 04:51:02 INFO - 2015-11-12 04:51:02,542 INFO : Running cycle 1/1 for v8_7 test... 04:51:02 INFO - 2015-11-12 04:51:02,542 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7WGcb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:14 INFO - 2015-11-12 04:51:14,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 141164544 04:51:14 INFO - 2015-11-12 04:51:14,450 DEBUG : BROWSER_OUTPUT: 04:51:35 INFO - 2015-11-12 04:51:35,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/v8_7/run.html (next: http://localhost:49722/tests/v8_7/run.html) 04:51:36 INFO - 2015-11-12 04:51:36,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 440696832 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |0;Richards;171.0863986313088 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.35093761959433 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4857462269424 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 04:51:36 INFO - 2015-11-12 04:51:36,096 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: |5;Earley;801.924619085806 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: |6;Boyer;11620.689655172413 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: |8;Splay;629.6992481203008 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: __startTimestamp1447332696090__endTimestamp 04:51:36 INFO - 2015-11-12 04:51:36,097 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.09 Median:171.09 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: Values: 171.1 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,098 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.35 Median:191.35 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: Values: 191.4 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: Values: 279.5 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: Values: 5020.0 04:51:36 INFO - 2015-11-12 04:51:36,099 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: Values: 1980.2 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: Values: 801.9 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,100 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11620.69 Median:11620.69 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: Values: 11620.7 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: Values: 26710.5 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:629.70 Median:629.70 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,101 DEBUG : BROWSER_OUTPUT: Values: 629.7 04:51:36 INFO - 2015-11-12 04:51:36,102 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,102 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:51:36 INFO - 2015-11-12 04:51:36,102 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:51:36 INFO - 2015-11-12 04:51:36,102 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:36 INFO - 2015-11-12 04:51:36,102 DEBUG : BROWSER_OUTPUT: 04:51:36 INFO - 2015-11-12 04:51:36,987 INFO : Browser exited with error code: 0 04:51:37 INFO - 2015-11-12 04:51:37,002 INFO : Completed test v8_7 (00:00:40) 04:51:37 INFO - 2015-11-12 04:51:37,126 INFO : Completed test suite (00:20:18) 04:51:37 INFO - 2015-11-12 04:51:37,126 DEBUG : Working with test: dromaeo_css 04:51:37 INFO - 2015-11-12 04:51:37,126 DEBUG : Generating results file: dromaeo_css 04:51:37 INFO - 2015-11-12 04:51:37,127 DEBUG : Working with test: kraken 04:51:37 INFO - 2015-11-12 04:51:37,127 DEBUG : Generating results file: kraken 04:51:37 INFO - 2015-11-12 04:51:37,128 INFO : javascript benchmark 04:51:37 INFO - 2015-11-12 04:51:37,128 DEBUG : Working with test: v8_7 04:51:37 INFO - 2015-11-12 04:51:37,128 DEBUG : Generating results file: v8_7 04:51:37 INFO - 2015-11-12 04:51:37,128 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:37 INFO - 2015-11-12 04:51:37,181 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:51:37 INFO - 2015-11-12 04:51:37,181 DEBUG : process_Request line: dromaeo_css 5978.64 graph.html#tests=[[72,94,35]] 04:51:37 INFO - 2015-11-12 04:51:37,181 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:37 INFO - 2015-11-12 04:51:37,286 DEBUG : process_Request line: kraken 1510.50 graph.html#tests=[[232,94,35]] 04:51:37 INFO - 2015-11-12 04:51:37,287 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:37 INFO - 2015-11-12 04:51:37,392 DEBUG : process_Request line: v8_7 19752.05 graph.html#tests=[[230,94,35]] 04:51:37 INFO - 2015-11-12 04:51:37,394 INFO : javascript benchmark 04:51:37 INFO - 2015-11-12 04:51:37,398 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [336.8517852145056, 336.9090345606685, 337.07304911493395, 338.3655645664379, 340.7274180655475, 12121.393930303471, 12469.563565275217, 15156.166410847412, 15432.768508472367, 15688.45090421834, 10812.080973117274, 11096.500657470413, 11099.946509895655, 14617.926910365433, 15093.849061509381, 4123.340265557519, 4207.474065741782, 4223.197592457439, 4229.217594744982, 4236.894077648068, 3137.5764271823355, 3207.7273431758213, 4737.3604563384015, 4844.87887802806, 4853.296272040569, 4790.5448982346625, 4804.4234691836855, 4805.879853003686, 4816.807327706888, 4824.782884770194, 4698.953010469886, 4810.855674329776, 4831.710097394168, 4833.444153922291, 4836.903261934777, 4142.316517774563, 4144.937825932613, 4148.875533733993, 4149.647279981205, 4152.397902304149, 13053.151545149534, 13086.083974121815, 13348.799768003488, 13353.332333383292, 13355.131916425402, 1739.852112570433, 1764.8499877510426, 1794.237449084134, 1818.1091265279917, 1843.2995461724593, 9301.627934882597, 9544.809103817954, 9608.951955240249, 9643.035696430372, 9765.121139097444, 1550.0622123615162, 1615.3215649427268, 1784.1525275494166, 1819.699749541324, 1861.0601646168734, 50661.493385066045, 51954.48045519534, 52058.21912671313, 52973.205401919, 54103.18845217325, 6615.569987950767, 6637.568558043712, 6662.533622646465, 6694.297098804653, 6714.664266786739, 7714.5756983366455, 7740.032495938008, 7747.651355689008, 7759.262870027338, 7775.300222979959, 4900.828471003498, 4904.2643603459765, 4945.282933974553, 4949.925751113737, 4962.305277261186, 4824.421069471616, 4840.249761287007, 4905.852824415273, 5005.74971251436, 5005.949940500548, 3101.1471845242286, 3142.889998850075, 3162.256869635634, 3168.2712976015646, 3169.667184945594, 1039.4906495817147, 1085.1102096281131, 1085.4247248958065, 1127.9830802537967, 1136.2614300704608, 432.90692501111783, 445.4476449202965, 446.4352593968632, 451.8057235388749, 479.2332268370649, 10750.247482676294, 11126.0, 11143.498542565603, 11173.329600224013, 11283.153763467608, 415.21109891206345, 449.43595787286745, 455.27838376174134, 466.55210997442157, 473.47680812702157, 5735.541156707453, 5856.765729370863, 5890.145928840294, 5927.4665280125, 5960.0, 479996.0, 480513.0, 507881.0, 509657.0, 511994.0, 68504.31495684979, 69419.65290173517, 70614.64692676504, 71674.64162679258, 71705.6414717923, 495.05938716439056, 497.65164384930694, 499.6502448286142, 500.33705340424086, 500.6745615350052, 9817.803643927224, 9836.163926066365, 9869.851952220579, 9904.455254960758, 9949.303548751517, 31864.203394915312, 32632.021039368858, 33085.503717443775, 33149.0, 33325.33349332951, 44292.33561496516, 44333.11333773371, 46486.0, 47293.0, 47442.52557474519, 6350.364963503613, 6491.4806815455595, 6493.805185844432, 6495.415412612888, 6504.0243963405865, 11420.371879546705, 11536.192466527262, 11810.114241432098, 11824.290542567473, 11840.70398240051, 10254.487275636338, 10311.484425778832, 10368.429736364573, 10410.323328983592, 10533.420661863365, 10078.647247346307, 10215.13171380441, 10220.897791022293, 10263.281570290306, 10543.736406589896, 8322.45904016237, 8626.09426010285, 10285.794284114425, 10395.16838652921, 10531.94734026325, 5691.430856914441, 6230.930776241348, 6402.551821372459, 6463.450606698483, 6469.902951455638, 9612.423254604746, 10170.949145254226, 10185.592576296865, 10410.323328983592, 10469.528871200662], "dojo.html": [2625.5405304071787, 2704.215777424547, 2718.5650295952637, 2724.1146627346116, 2728.863556822159, 4629.722216667003, 4750.738709370983, 4794.640401969848, 4804.663673542854, 4805.279208118784, 4698.50665680103, 4734.218853889112, 4762.809487620491, 4765.690230135039, 4781.18719817631, 4377.802998865042, 4430.224710675635, 4440.86677399677, 4541.750203738793, 4569.497355290915, 4258.276093064171, 4473.1501014807245, 4505.887352816173, 4547.931781023287, 4603.930941035887, 4267.8079486423185, 4326.415933848922, 4358.193734159191, 4367.650587952956, 4379.562043795627, 4453.621442177387, 4457.130859482402, 4485.9102817943785, 4492.640588752892, 4529.456465224162, 4263.4031235627035, 4349.956500434987, 4444.177827101997, 4460.50934397216, 4508.549145085498, 4601.7699115044115, 4678.9940162864805, 4697.0, 4702.600278976257, 4721.976390118028, 5167.328247327823, 5189.091908915962, 5189.351331083614, 5193.091209038404, 5249.895002099936, 4932.457429682732, 5035.924461133086, 5044.117279476077, 5208.739563021833, 5212.713300768456, 4700.318453824177, 4744.786484608201, 4759.286107083896, 4767.523247675274, 4796.9760151199025, 5256.553192978563, 5395.4604539545735, 5414.945850541523, 5417.59368047398, 5438.91841622376, 4827.686200396963, 4937.21004639256, 4941.308216849644, 5117.309163262987, 5149.819756308511, 5093.363329583802, 5145.434002259748, 5185.662931909414, 5194.688318700814, 5248.160294352885, 5115.667481613683, 5138.254953031789, 5143.61422893277, 5145.099607568735, 5184.507471790174, 4824.541668541553, 4989.80040798364, 4998.075356059141, 5093.439721630618, 5109.901371205208, 4260.084081922401, 4327.7619730914475, 4333.479982402132, 4353.825846966086, 4368.235558777201, 3767.3972164453558, 3785.091578021255, 3793.317202903504, 3834.213986132836, 3841.0205397623427, 4182.853600124042, 4305.763183024901, 4449.087936972913, 4454.354118652842, 4463.553644635575, 5065.6200784941275, 5132.79468821243, 5222.477752224823, 5224.608154388436, 5255.159174532057, 4353.10761293934, 4358.854482696826, 4359.019220675323, 4364.061726728705, 4391.516933137416, 4404.07514421975, 4521.977390113094, 4522.570355816192, 4530.61489773373, 4591.770411479412, 4685.906281874411, 4796.664233503621, 4797.040591881568, 4805.639577031737, 4835.8065677372515, 5199.974000129975, 5244.921326180034, 5247.396549396868, 5254.9211761822835, 5295.602829787705, 4709.199436095803, 4813.302071199727, 4941.357623508921, 4952.504749525018, 4961.42943561495, 4998.4501704813165, 5019.272205530251, 5055.570276526537, 5066.493350664904, 5067.5185857343495, 5136.589072874236, 5156.639035267495, 5157.458466860926, 5158.45836187195, 5220.7650655721345, 4735.147673418817, 4860.3681521401995, 4977.452480227244, 4988.501149884983, 5002.499750024968, 4881.51184881509, 4914.041761856403, 4992.575631071254, 5007.774650140679, 5023.32185155014, 4860.635452341018, 4865.635077369141, 4889.0, 4891.926621100615, 4926.482719314564, 4854.101991131652, 4944.703317800943, 5029.1953287473825, 5070.949290507047, 5099.439061703136, 4812.951870481391, 4872.098661747446, 4913.6069114471475, 4916.606671466346, 4931.038447502702], "mootools.html": [1404.4382247101164, 1623.1965177237266, 1673.3557580331576, 1692.3822804676292, 1698.7876515435562, 6072.483838873695, 6860.108185935827, 7019.052427922229, 7026.613536255504, 7028.051213086238, 6848.897266540994, 6939.895901561481, 6944.6180460074675, 6946.96526517368, 6957.79126626202, 1683.9158042097908, 1716.4421562992015, 1963.5385684364162, 1979.5941831924422, 1984.6923726822365, 2026.8175864172222, 2031.2788959919237, 2032.908519116636, 2036.389083275019, 2036.9083391247354, 1967.7540307461568, 1990.044778506318, 2008.8895110768901, 2012.9698054529194, 2013.1544751204528, 1985.1166231027198, 2000.4798752324427, 2018.7476565429322, 2020.0404807716363, 2021.9898900505477, 1931.0634342344092, 1944.4555524453176, 1954.0620502158902, 1954.4625228062255, 1958.0797025398183, 7046.295370462964, 7115.3951914087365, 7126.857462850714, 7135.250798666118, 7142.928570714278, 4090.079732060263, 4176.60322269384, 4181.142865712552, 4188.078622703, 4192.559781222958, 2320.477892474197, 2618.8428694278405, 2701.770349520293, 2737.630419893309, 2754.5179593571247, 811.3306522119216, 857.5883575883611, 863.0808189278398, 876.4872549558515, 928.424376886328, 9595.904040959571, 9600.471974041426, 9610.51947402627, 9628.374155679858, 9654.372465789702, 3704.148045949447, 3719.1631882826687, 3770.6229377062073, 3782.130110074698, 3945.4279129526058, 8264.8347033059, 8271.048829384697, 8277.95861020691, 8296.83406331882, 8310.875336869953, 4187.5184353799095, 4187.916241675211, 4204.26425375558, 4210.978945105255, 4215.747055176699, 3799.0882188274613, 3824.9426258606145, 3825.215830754689, 3828.617138286149, 3839.347310957144, 3356.781809182395, 3359.6808303211155, 3404.2340473393288, 3405.165734395089, 3405.3870303345634, 1033.106362996018, 1039.1167507618616, 1041.234692501011, 1046.2937517175876, 1050.821360368739, 1140.3556990300453, 1146.2377518949804, 1147.363213416545, 1154.6882341767675, 1194.2774621354129, 6343.524235682342, 6352.174217351807, 6366.0, 6393.488520918316, 6413.16628838248, 422.82875435448693, 422.9555896630871, 426.1073051956147, 428.54146063712153, 435.8496318770019, 4878.292647566083, 4934.8026078957155, 4948.628852836052, 4957.256411538298, 4967.875803104951, 7067.116610423697, 7114.39527640146, 8431.494110353398, 8479.406441549032, 8662.480251184948, 8078.474899131537, 8205.302549283258, 8361.665533378597, 8371.958140209383, 8376.49741015541, 6395.520335974914, 6657.46740260778, 6775.3902148805855, 6803.48973826965, 6810.182778066664, 6712.0, 6772.695228714818, 6788.558743681645, 6807.591544507345, 6823.385895269251, 7494.700211991677, 7546.622668866645, 7606.467547271638, 7609.6575654096805, 7636.236376362319, 7055.753048643272, 7281.089863767029, 7299.963500182465, 7847.921520784719, 7853.057633084067, 6204.534659900616, 6291.087792270004, 6301.779437719658, 6319.115323854756, 6319.399657032574, 6649.9354014761675, 6708.698108585223, 6776.559523630948, 6778.8644227116165, 6796.796096117125, 6311.873762524632, 6318.905216421849, 6367.044943258548, 6428.6785660717715, 6465.321141280097, 6267.2165979252595, 6320.4311611955145, 6351.0, 6372.55392122547, 6459.677016149268, 6283.96858015707, 6421.743130274736, 6425.261094974137, 6430.260520040255, 6438.227412710317, 5802.361740208658, 5817.243758311392, 5846.883062338815, 5851.941480585139, 5872.265966754156, 5786.045302525036, 5819.4180581943165, 5824.097264923944, 5873.295204575478, 5898.498627616701], "ext.html": [556.5992485410504, 562.2100948167824, 565.3978512883779, 567.036038734152, 585.0931056861863, 28187.154385368445, 36493.81753091234, 37057.444138337945, 37178.814105929436, 37283.81358093206, 41492.58507414925, 41958.0, 41983.0, 41999.79000104995, 42119.78940105303, 6932.306769323052, 7031.929680703179, 7968.96015519923, 8155.0, 8158.143394943534, 10283.331583447052, 10505.684829455091, 10506.737331566696, 10518.421486818223, 10521.68434946949, 10142.847857282146, 10249.180065594735, 10256.743581410487, 10261.692149235498, 10267.845982310271, 6924.861502769942, 7083.291670832927, 9801.460919649417, 9854.753631159207, 10122.848157277647, 9899.109080182818, 10103.343282686601, 10104.89895101047, 10107.039831216023, 10109.24180686444, 37522.24955500875, 37957.81021094904, 37990.24019519594, 38036.0, 38051.0, 2843.8578071096567, 2911.8544072796276, 3441.6042155152227, 3499.1077275294892, 3514.91037778287, 28783.28041798951, 28957.276068098465, 29305.267368315748, 29378.55932161019, 29989.25026874324, 3159.178613560468, 3179.4912813949886, 3181.761367897394, 3198.2484116232667, 3217.6621454747146, 221961.0, 223411.0, 223706.0, 224162.0, 224226.0, 46248.768756156, 47198.52801471941, 60843.695781521696, 62236.68881655653, 62303.6884815573, 56526.43473565294, 56646.0, 56728.43271567314, 56840.147397789064, 56873.43126568764, 12791.168574042658, 12923.15999460032, 12971.0, 12977.935110324388, 12996.675083122998, 9455.10176533242, 9494.240460763122, 9496.240300775922, 9574.856377154349, 9583.664571739955, 19008.809911900706, 19178.232870685017, 19180.232790688216, 19203.423897283104, 19284.0, 7277.2722727726805, 7521.7743467696055, 7562.0925488941675, 7633.198514156044, 7640.00679911619, 836.7991681996399, 841.3647695989611, 881.316979341003, 907.8592818113203, 1043.8642976413169, 25973.740262597512, 26513.86743066272, 26759.0, 26786.19641410761, 26793.866030670113, 894.8702438146432, 901.6032945503957, 919.4253591505309, 979.1970584120952, 1025.5333823110466, 13693.178409295475, 13730.0, 13816.585502434944, 14051.78922316166, 14109.85890141106, 267645.0, 273413.0, 273553.0, 273877.0, 274499.0, 46348.53651463442, 46411.0, 46739.766301168274, 46746.53253467422, 46764.532354676696, 1152.8731839497648, 1179.1922533064878, 1186.4423720851187, 1194.8932774785662, 1195.2111606339774, 25083.87458062698, 25609.23172304834, 25886.093986710373, 26249.212523624323, 26438.339041523348, 37185.25629487341, 37380.626193738804, 41818.37272440855, 42157.15685686208, 42459.78770106253, 181325.0, 182691.0, 182878.0, 182943.0, 183091.0, 27668.723312766615, 27979.300517487227, 28082.85958570194, 28087.859560702065, 28096.85951570229, 31048.22379440532, 34566.0, 34581.48127778136, 38810.41784373293, 39490.21019579535, 29462.11613651594, 29811.0, 29870.0, 30293.242668932573, 30550.0, 30409.23976900595, 30645.08064758061, 32824.0, 33232.0, 33440.1639959003, 32968.67031329656, 33257.50113748344, 33290.334193316485, 33383.49924751179, 33394.4990825133, 28044.29889252785, 29641.703582963895, 29718.257043574085, 30255.394892101594, 30300.24249393783, 22621.411897046815, 22886.885565572065, 22904.198353057564, 23056.53886922286, 23301.41746456352], "prototype.html": [296.9005383196629, 302.4344475830198, 306.52488642603964, 307.64788753428695, 308.5803307501797, 5227.581793456524, 5229.8169564065265, 5243.16109422492, 5254.947450525494, 5270.525652691262, 4952.801887924478, 5034.320366750488, 5064.873378165538, 5140.126178549646, 5160.509751573604, 3993.660538854186, 4001.319775638134, 4044.777537235451, 4049.5140583130064, 4052.9392059119064, 3844.480995065658, 4046.332355161395, 4047.4535937648334, 4047.736897101679, 4052.8581499647516, 3888.2612303662354, 3987.3022221111332, 4076.7757773322605, 4078.8368465261356, 4079.653229475498, 4044.959550404488, 4052.4326594276827, 4055.3916912463073, 4058.715889887709, 4068.349064149722, 3562.5724913010604, 3566.5006899034156, 3567.9108022299392, 3569.0542006368332, 3591.730620203495, 5039.974800125976, 5041.143005689041, 5042.067217564762, 5046.0, 5052.166392545262, 4520.073384956109, 4610.031893302411, 4637.721736695776, 4660.976695116537, 4675.2052151134385, 5494.697791621459, 5503.972480137613, 5506.91739623906, 5511.035568775448, 5511.448855114457, 3915.804209789499, 3916.4321173429694, 3916.843326266946, 3917.040325120364, 3918.9804050979847, 5760.567957403212, 5761.798337058225, 5764.221830052973, 5769.942300576982, 5777.306723193202, 3946.7631942083567, 4028.959710402917, 4030.052937559671, 4031.677465802729, 4041.9797901010306, 4085.8569950051606, 4086.693497987663, 4093.85671501496, 4098.774567398762, 4108.1783643271465, 4627.9768601156775, 4641.721496710208, 4642.46611639659, 4642.837500687459, 4643.4660014098135, 5470.152126420411, 5471.0, 5473.0969390050195, 5490.149026900836, 5504.724763761796, 1397.343248673122, 1454.2219912346843, 1488.3376897280607, 1488.4195163886093, 1489.352131822639, 937.1378331934636, 973.5570315506427, 978.6232300564334, 985.6303886042734, 989.8366769482955, 4717.2216584263215, 4749.24012158053, 4754.881127971828, 4756.191447453941, 4757.785899634525, 5537.889242215133, 5567.359753628303, 5568.9443105568425, 5573.968815769014, 5591.04952158126, 4667.0, 4733.053389322149, 4748.0, 4748.548887855717, 4750.8337208197545, 3100.162956001867, 3112.4553203189353, 3127.046250893454, 3129.2333378322455, 3132.8433578321446, 5278.5513231375, 5294.708791016454, 5296.92054619181, 5303.178007408857, 5303.36359636846, 5739.483446489836, 5778.711064446761, 5783.826485205451, 5785.681787501728, 5787.536997040227, 5143.3827940646615, 5371.086915224421, 5373.677579345252, 5375.4087050425205, 5387.515123638969, 5687.658740475585, 5696.515796157208, 5717.857053573527, 5725.255716756795, 5733.885322293448, 5596.916046259228, 5597.580181486323, 5605.80379686709, 5609.80365687199, 5613.747381367766, 5236.711980840938, 5370.650907690988, 5373.7850485980125, 5383.40782513931, 5390.784368625211, 3773.0378753417704, 3795.544534655859, 3798.981005094957, 3799.8100094995693, 3802.353599888081, 5673.574481913791, 5697.088465845445, 5718.599698021098, 5724.0, 5735.283089613798, 5494.725263736717, 5496.230527726201, 5499.4225606310765, 5504.339479262514, 5506.752196151263, 5382.784688612568, 5479.0685583451705, 5490.231367608458, 5498.340199176125, 5507.339119305549, 5401.783928642811, 5402.891942161056, 5404.702741349263, 5405.891882162414, 5407.513323800877, 5505.807296744755, 5535.086710692852, 5547.667139971614, 5549.306336707911, 5557.888842223052, 5254.581263058876, 5375.623706340519, 5377.27406800077, 5378.247045413724, 5384.273123128328], "yui.html": [663.3896814930264, 672.2235817630639, 754.8075240813591, 767.1522967121329, 774.9883751743724, 11886.465109070092, 12078.15452918296, 12133.272003679785, 12149.149559530837, 12152.635420937364, 11974.820377694341, 12109.818352724717, 13114.47542098315, 13455.798163027563, 13466.192028478297, 603.2369053147771, 609.881073190728, 758.5069704691953, 770.5992883700472, 771.2364758888716, 752.5597525447592, 762.12736416803, 765.4756491803132, 766.4022062791032, 767.2251026463284, 786.2962648429652, 792.18405042806, 792.7899106736719, 793.654760179321, 793.7499687598388, 596.7105953612495, 605.6547767772349, 780.75406247032, 784.6665167303873, 794.8012996750813, 575.5251917168353, 578.17032558279, 580.5210701171508, 580.6806256558918, 581.0818906128308, 12108.15242932995, 12236.510539578407, 12253.019758419305, 12256.754864902741, 12258.75482490354, 8827.293816494664, 9375.296852736072, 9434.150926416656, 9518.70596407657, 10044.648437304659, 8415.957920210421, 8518.87221691675, 8879.778005549913, 8942.597583108776, 8954.417962832395, 2733.425980544088, 2807.7753779697573, 2816.4226333601564, 2843.5876797864194, 2901.883924643033, 40282.395764063855, 40465.190696186204, 40709.389359159635, 40728.59271407278, 40805.0, 6801.727930882808, 6853.691583878737, 6868.969654551857, 6968.616726080114, 6972.686229119702, 10602.20483463728, 10631.787364252827, 10633.415162166155, 10677.786444271227, 10701.625443109453, 5688.971555142198, 5723.484886360247, 5754.625949313365, 5760.913586296209, 5897.587168898136, 3266.379387916288, 3630.6550877666577, 3637.436197389356, 3671.889843304705, 3718.795466249382, 2399.4601214726545, 2433.415980164748, 2437.1348171399254, 2439.0853429963763, 2439.7194322652767, 393.93893946438345, 401.2797029332297, 404.3005600311419, 408.5628377635901, 409.37774582634825, 550.295621604347, 559.4461483131752, 573.5497634357009, 584.5177728374108, 584.5615788158881, 7763.301302882767, 7845.4900431472915, 7948.165442628557, 8794.692185773596, 8938.642454301886, 430.6834476659653, 449.32402140017916, 490.93863267091615, 614.7203022624784, 628.6573817269599, 3607.332643460968, 3831.1954489556947, 3890.4942357493346, 3984.163325701635, 4103.9179216415505, 47315.52684473111, 47355.0, 47556.7622161887, 49046.509534904195, 49665.0, 41953.32186712497, 42449.57550424518, 42495.0, 42782.57217427786, 42792.57207427948, 43194.784026079666, 43196.3520547192, 43848.780756096014, 43990.56009439928, 43997.120057598666, 7708.6791173846605, 7714.6914123434435, 7802.258785415376, 7924.286814186751, 7977.880331795144, 32408.351832962737, 32424.0, 33226.0, 33405.0, 33526.82075665074, 38542.0, 41159.38260926148, 41579.792101039304, 41788.582114179684, 42027.36958945557, 10199.38803671782, 10679.223401915402, 10817.837732433862, 10900.291481053706, 11089.889101108885, 10904.236703430684, 11238.943805280922, 11276.32342059479, 11800.0, 11843.644690659294, 10031.097201251923, 10134.391936483835, 10306.587736490457, 10333.121684656888, 10394.272400931863, 10395.064444200058, 10507.789844203226, 10710.143188545053, 11007.449627518432, 11162.665120046087, 8531.445456045338, 10004.949975250078, 10217.284790064625, 10703.143748499946, 11052.281601695864, 8642.308615310885, 8676.132386761527, 8832.205101540892, 8885.37802353855, 9741.318107732392, 9093.0, 9140.542972851197, 9181.449113053239, 9386.577604007973, 9469.337146399686]}, "summary": {"lowerIsBetter": false, "suite": 5978.635499110028, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6467.239953256125, "unit": "ms", "value": 6467.239953256125}, "dojo.html": {"lowerIsBetter": false, "filtered": 4699.525005189, "unit": "ms", "value": 4699.525005189}, "mootools.html": {"lowerIsBetter": false, "filtered": 3933.474974802908, "unit": "ms", "value": 3933.474974802908}, "ext.html": {"lowerIsBetter": false, "filtered": 16929.88822040256, "unit": "ms", "value": 16929.88822040256}, "prototype.html": {"lowerIsBetter": false, "filtered": 4130.598742541081, "unit": "ms", "value": 4130.598742541081}, "yui.html": {"lowerIsBetter": false, "filtered": 5461.998894405135, "unit": "ms", "value": 5461.998894405135}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-052"}, "testrun": {"date": 1447331478, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030147", "branch": "Firefox-Non-PGO", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 163.0, 161.0, 161.0, 161.0, 162.0, 163.0, 160.0, 161.0], "ai-astar": [110.0, 112.0, 107.0, 111.0, 111.0, 115.0, 103.0, 111.0, 102.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "audio-beat-detection": [160.0, 131.0, 159.0, 162.0, 130.0, 154.0, 151.0, 143.0, 174.0, 129.0], "json-stringify-tinderbox": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [151.0, 139.0, 152.0, 145.0, 153.0, 138.0, 140.0, 134.0, 144.0, 134.0], "json-parse-financial": [71.0, 70.0, 69.0, 70.0, 69.0, 70.0, 70.0, 79.0, 68.0, 66.0], "stanford-crypto-sha256-iterative": [68.0, 70.0, 67.0, 69.0, 70.0, 68.0, 68.0, 68.0, 70.0, 68.0], "audio-fft": [71.0, 74.0, 81.0, 92.0, 73.0, 72.0, 71.0, 85.0, 89.0, 72.0], "imaging-darkroom": [148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 147.0, 146.0], "stanford-crypto-ccm": [122.0, 130.0, 125.0, 120.0, 126.0, 126.0, 129.0, 120.0, 122.0, 123.0], "audio-oscillator": [91.0, 91.0, 127.0, 91.0, 92.0, 92.0, 128.0, 91.0, 92.0, 128.0], "stanford-crypto-aes": [83.0, 84.0, 83.0, 89.0, 83.0, 85.0, 85.0, 83.0, 85.0, 90.0], "imaging-desaturate": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1510.4999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.0, "unit": "ms", "value": 78.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.0, "unit": "ms", "value": 143.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.3, "unit": "ms", "value": 149.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 124.3, "unit": "ms", "value": 124.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 70.2, "unit": "ms", "value": 70.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.3, "unit": "ms", "value": 102.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.6, "unit": "ms", "value": 68.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.1, "unit": "ms", "value": 66.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-052"}, "testrun": {"date": 1447331478, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030147", "branch": "Firefox-Non-PGO", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.35093761959433], "Encrypt": [279.4857462269424], "NavierStokes": [4826.923076923077], "Decrypt": [5020.0], "Splay": [629.6992481203008], "Richards": [171.0863986313088], "RegExp": [26710.526315789473], "Earley": [801.924619085806], "Boyer": [11620.689655172413], "RayTrace": [1980.1980198019803]}, "summary": {"lowerIsBetter": false, "suite": 19752.054066514665, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.53266799999994, "unit": "score", "value": 345.53266799999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 952.3956179999999, "unit": "score", "value": 952.3956179999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 129.4125731343283, "unit": "score", "value": 129.4125731343283}, "RegExp": {"lowerIsBetter": false, "filtered": 34.105842364532016, "unit": "score", "value": 34.105842364532016}, "Richards": {"lowerIsBetter": false, "filtered": 206.34019000000004, "unit": "score", "value": 206.34019000000004}, "Earley": {"lowerIsBetter": false, "filtered": 831.079361, "unit": "score", "value": 831.079361}, "Boyer": {"lowerIsBetter": false, "filtered": 57.35141543026708, "unit": "score", "value": 57.35141543026708}, "RayTrace": {"lowerIsBetter": false, "filtered": 373.6944450000001, "unit": "score", "value": 373.6944450000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-052"}, "testrun": {"date": 1447331478, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030147", "branch": "Firefox-Non-PGO", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}] 04:51:37 INFO - RETURN: dromaeo_css: 5978.64 04:51:37 INFO - RETURN: kraken: 1510.50 04:51:37 INFO - RETURN: v8_7: 19752.05 04:51:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19752.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1510.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5978.64"}}} 04:51:37 INFO - Return code: 0 04:51:37 INFO - # TBPL SUCCESS # 04:51:37 INFO - Running post-action listener: _resource_record_post_action 04:51:37 INFO - Running post-run listener: _resource_record_post_run 04:51:38 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 510152704; Read time: 36; Write time: 483932 04:51:38 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 133619712; Read time: 0; Write time: 223820 04:51:38 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357056512; Read time: 24; Write time: 252236 04:51:38 INFO - Running post-run listener: _upload_blobber_files 04:51:38 INFO - Blob upload gear active. 04:51:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:51:38 INFO - Copying logs to upload dir... 04:51:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.374682 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-12 04:51:36.493412) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:51:36.497072) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009603 build_url: 'https://queue.taskcluster.net/v1/task/d0POJyVBQsq43iCKbpfUAw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 04:51:36.549185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:51:36.549509) ========= 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=2c70f4bb59d9561eae6fcf47000001b3-1447330788.647122-691301566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 04:51:36.598988) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 04:51:36.599313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 04:51:36.599619) ========= ========= Total master_lag: 0.76 =========