builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1448064958.11 results: success (0) buildid: 20151120144231 builduid: af836f2fccd7444f90812414ca7cf634 revision: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.109807) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.110256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.110546) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006470 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.128373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.128645) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.136101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.136364) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004219 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.183253) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.183526) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.183872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.184145) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 16:15:58-- 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% 76.8M=0s 2015-11-20 16:15:58 (76.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.315647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.315943) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.365281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.365589) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --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 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f --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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 16:15:58,555 truncating revision to first 12 chars 2015-11-20 16:15:58,555 Setting DEBUG logging. 2015-11-20 16:15:58,555 attempt 1/10 2015-11-20 16:15:58,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f5afaf4e6b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:15:58,794 unpacking tar archive at: mozilla-central-3f5afaf4e6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.886881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.887329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.895919) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.896213) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:15:58.896636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 16:15:58.896933) ========= /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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:15:59 INFO - MultiFileLogger online at 20151120 16:15:59 in /builds/slave/test 16:15:59 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 16:15:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:59 INFO - {'append_to_log': False, 16:15:59 INFO - 'base_work_dir': '/builds/slave/test', 16:15:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:15:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:59 INFO - 'branch': 'Firefox-Non-PGO', 16:15:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:59 INFO - 'config_files': ('talos/linux_config.py',), 16:15:59 INFO - 'default_actions': ('clobber', 16:15:59 INFO - 'read-buildbot-config', 16:15:59 INFO - 'download-and-extract', 16:15:59 INFO - 'populate-webroot', 16:15:59 INFO - 'create-virtualenv', 16:15:59 INFO - 'install', 16:15:59 INFO - 'run-tests'), 16:15:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:59 INFO - 'download_minidump_stackwalk': True, 16:15:59 INFO - 'download_symbols': 'ondemand', 16:15:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:59 INFO - 'installer_path': 'installer.exe', 16:15:59 INFO - 'log_level': 'info', 16:15:59 INFO - 'log_name': 'talos', 16:15:59 INFO - 'log_to_console': True, 16:15:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:15:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:15:59 INFO - 'opt_config_files': (), 16:15:59 INFO - 'pip_index': False, 16:15:59 INFO - 'sps_profile': False, 16:15:59 INFO - 'sps_profile_interval': 0, 16:15:59 INFO - 'suite': 'dromaeojs', 16:15:59 INFO - 'system_bits': '64', 16:15:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:59 INFO - 'title': 'talos-linux64-ix-050', 16:15:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:59 INFO - 'use_talos_json': True, 16:15:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:59 INFO - 'work_dir': 'build'} 16:15:59 INFO - ##### 16:15:59 INFO - ##### Running clobber step. 16:15:59 INFO - ##### 16:15:59 INFO - Running pre-action listener: _resource_record_pre_action 16:15:59 INFO - Running main action method: clobber 16:15:59 INFO - rmtree: /builds/slave/test/build 16:15:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:00 INFO - Running post-action listener: _resource_record_post_action 16:16:00 INFO - ##### 16:16:00 INFO - ##### Running read-buildbot-config step. 16:16:00 INFO - ##### 16:16:00 INFO - Running pre-action listener: _resource_record_pre_action 16:16:00 INFO - Running main action method: read_buildbot_config 16:16:00 INFO - Using buildbot properties: 16:16:00 INFO - { 16:16:00 INFO - "properties": { 16:16:00 INFO - "buildnumber": 218, 16:16:00 INFO - "product": "firefox", 16:16:00 INFO - "script_repo_revision": "production", 16:16:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:16:00 INFO - "repository": "", 16:16:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:16:00 INFO - "buildid": "20151120144231", 16:16:00 INFO - "slavename": "talos-linux64-ix-050", 16:16:00 INFO - "pgo_build": "False", 16:16:00 INFO - "basedir": "/builds/slave/test", 16:16:00 INFO - "project": "", 16:16:00 INFO - "platform": "ubuntu64_hw", 16:16:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:16:00 INFO - "slavebuilddir": "test", 16:16:00 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:16:00 INFO - "branch": "mozilla-central", 16:16:00 INFO - "repo_path": "mozilla-central", 16:16:00 INFO - "stage_platform": "linux64", 16:16:00 INFO - "builduid": "af836f2fccd7444f90812414ca7cf634", 16:16:00 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 16:16:00 INFO - }, 16:16:00 INFO - "sourcestamp": { 16:16:00 INFO - "repository": "", 16:16:00 INFO - "hasPatch": false, 16:16:00 INFO - "project": "", 16:16:00 INFO - "branch": "mozilla-central-linux64-talos", 16:16:00 INFO - "changes": [ 16:16:00 INFO - { 16:16:00 INFO - "category": null, 16:16:00 INFO - "files": [ 16:16:00 INFO - { 16:16:00 INFO - "url": null, 16:16:00 INFO - "name": "https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:16:00 INFO - } 16:16:00 INFO - ], 16:16:00 INFO - "repository": "", 16:16:00 INFO - "rev": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f", 16:16:00 INFO - "who": "kwierso@gmail.com", 16:16:00 INFO - "when": 1448064555, 16:16:00 INFO - "number": 6691274, 16:16:00 INFO - "comments": "Merge fx-team to central, a=merge", 16:16:00 INFO - "project": "", 16:16:00 INFO - "at": "Fri 20 Nov 2015 16:09:15", 16:16:00 INFO - "branch": "mozilla-central-linux64-talos", 16:16:00 INFO - "revlink": "", 16:16:00 INFO - "properties": [ 16:16:00 INFO - [ 16:16:00 INFO - "buildid", 16:16:00 INFO - "20151120144231", 16:16:00 INFO - "Change" 16:16:00 INFO - ], 16:16:00 INFO - [ 16:16:00 INFO - "builduid", 16:16:00 INFO - "af836f2fccd7444f90812414ca7cf634", 16:16:00 INFO - "Change" 16:16:00 INFO - ], 16:16:00 INFO - [ 16:16:00 INFO - "pgo_build", 16:16:00 INFO - "False", 16:16:00 INFO - "Change" 16:16:00 INFO - ] 16:16:00 INFO - ], 16:16:00 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 16:16:00 INFO - } 16:16:00 INFO - ], 16:16:00 INFO - "revision": "3f5afaf4e6b72c4b1a20749b4ce7d945add5299f" 16:16:00 INFO - } 16:16:00 INFO - } 16:16:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:16:00 INFO - Running post-action listener: _resource_record_post_action 16:16:00 INFO - ##### 16:16:00 INFO - ##### Running download-and-extract step. 16:16:00 INFO - ##### 16:16:00 INFO - Running pre-action listener: _resource_record_pre_action 16:16:00 INFO - Running main action method: download_and_extract 16:16:00 INFO - mkdir: /builds/slave/test/build/tests 16:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:00 INFO - https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/test_packages.json 16:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/test_packages.json 16:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:16:00 INFO - Downloaded 1302 bytes. 16:16:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:16:00 INFO - Using the following test package requirements: 16:16:00 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:16:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'jsshell-linux-x86_64.zip'], 16:16:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:16:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:16:00 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:16:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:16:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:00 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:16:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:00 INFO - https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:01 INFO - Downloaded 21338531 bytes. 16:16:01 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 16:16:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:01 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 16:16:02 INFO - Return code: 0 16:16:02 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 16:16:02 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')]} 16:16:02 INFO - https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:03 INFO - Downloaded 21338531 bytes. 16:16:03 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 16:16:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:16:03 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 16:16:05 INFO - Return code: 0 16:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:05 INFO - https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:06 INFO - Downloaded 11130997 bytes. 16:16:06 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 16:16:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:06 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 16:16:06 INFO - Return code: 0 16:16:06 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')]} 16:16:06 INFO - https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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 16:16:07 INFO - Downloaded 55904842 bytes. 16:16:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:16:07 INFO - mkdir: /builds/slave/test/properties 16:16:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:07 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:07 INFO - Contents: 16:16:07 INFO - build_url:https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:16:07 INFO - Running post-action listener: _resource_record_post_action 16:16:07 INFO - Running post-action listener: set_extra_try_arguments 16:16:07 INFO - ##### 16:16:07 INFO - ##### Running populate-webroot step. 16:16:07 INFO - ##### 16:16:07 INFO - Running pre-action listener: _resource_record_pre_action 16:16:07 INFO - Running main action method: populate_webroot 16:16:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:16:07 INFO - '../fennec_ids.txt'], 16:16:07 INFO - 'tests': ['tcheck2']}, 16:16:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:07 INFO - '--tppagecycles', 16:16:07 INFO - '7'], 16:16:07 INFO - 'tests': ['tsvgm']}}, 16:16:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:16:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'tests': ['damp', 'tps']}, 16:16:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['damp', 'tps']}, 16:16:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:16:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:07 INFO - 'other': {'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'other_l64': {'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'other_nol64': {'tests': ['a11yr', 16:16:07 INFO - 'ts_paint', 16:16:07 INFO - 'tpaint', 16:16:07 INFO - 'sessionrestore', 16:16:07 INFO - 'sessionrestore_no_auto_restore']}, 16:16:07 INFO - 'svgr': {'tests': ['tsvgx', 16:16:07 INFO - 'tsvgr_opacity', 16:16:07 INFO - 'tart', 16:16:07 INFO - 'tscrollx', 16:16:07 INFO - 'cart']}, 16:16:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['tsvgx', 16:16:07 INFO - 'tsvgr_opacity', 16:16:07 INFO - 'tart', 16:16:07 INFO - 'tscrollx', 16:16:07 INFO - 'cart']}, 16:16:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'tests': ['tp5o']}, 16:16:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'talos_options': ['--e10s'], 16:16:07 INFO - 'tests': ['tp5o']}, 16:16:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'talos_options': ['--xperf_path', 16:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:07 INFO - 'tests': ['tp5n']}, 16:16:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:07 INFO - 'talos_options': ['--e10s', 16:16:07 INFO - '--xperf_path', 16:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:07 INFO - 'tests': ['tp5n']}}, 16:16:07 INFO - 'talos.zip': {'path': '', 16:16:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:07 INFO - Running post-action listener: _resource_record_post_action 16:16:07 INFO - ##### 16:16:07 INFO - ##### Running create-virtualenv step. 16:16:07 INFO - ##### 16:16:07 INFO - Running pre-action listener: _resource_record_pre_action 16:16:07 INFO - Running main action method: create_virtualenv 16:16:07 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:07 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 16:16:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:07 INFO - Using real prefix '/usr' 16:16:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:10 INFO - Installing pip.................done. 16:16:10 INFO - Return code: 0 16:16:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:10 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 16:16:10 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 16:16:10 INFO - Using env: {'DISPLAY': ':0', 16:16:10 INFO - 'HOME': '/home/cltbld', 16:16:10 INFO - 'LANG': 'en_US.UTF-8', 16:16:10 INFO - 'LANGUAGE': 'en_US:en', 16:16:10 INFO - 'LOGNAME': 'cltbld', 16:16:10 INFO - 'MAIL': '/var/mail/cltbld', 16:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:10 INFO - 'MOZ_NO_REMOTE': '1', 16:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:10 INFO - 'NO_EM_RESTART': '1', 16:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:10 INFO - 'PWD': '/builds/slave/test', 16:16:10 INFO - 'SHELL': '/bin/bash', 16:16:10 INFO - 'SHLVL': '1', 16:16:10 INFO - 'TERM': 'linux', 16:16:10 INFO - 'TMOUT': '86400', 16:16:10 INFO - 'USER': 'cltbld', 16:16:10 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:10 INFO - '_': '/tools/buildbot/bin/python'} 16:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:10 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 16:16:10 INFO - Cleaning up... 16:16:10 INFO - Return code: 0 16:16:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:10 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 16:16:10 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 16:16:10 INFO - Using env: {'DISPLAY': ':0', 16:16:10 INFO - 'HOME': '/home/cltbld', 16:16:10 INFO - 'LANG': 'en_US.UTF-8', 16:16:10 INFO - 'LANGUAGE': 'en_US:en', 16:16:10 INFO - 'LOGNAME': 'cltbld', 16:16:10 INFO - 'MAIL': '/var/mail/cltbld', 16:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:10 INFO - 'MOZ_NO_REMOTE': '1', 16:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:10 INFO - 'NO_EM_RESTART': '1', 16:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:10 INFO - 'PWD': '/builds/slave/test', 16:16:10 INFO - 'SHELL': '/bin/bash', 16:16:10 INFO - 'SHLVL': '1', 16:16:10 INFO - 'TERM': 'linux', 16:16:10 INFO - 'TMOUT': '86400', 16:16:10 INFO - 'USER': 'cltbld', 16:16:10 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:10 INFO - '_': '/tools/buildbot/bin/python'} 16:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:10 INFO - Downloading/unpacking psutil>=0.7.1 16:16:10 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 16:16:10 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 16:16:10 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 16:16:10 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 16:16:10 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 16:16:10 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 16:16:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:16:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:12 INFO - Installing collected packages: psutil 16:16:12 INFO - Running setup.py install for psutil 16:16:12 INFO - building 'psutil._psutil_linux' extension 16:16:12 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 16:16:12 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 16:16:12 INFO - building 'psutil._psutil_posix' extension 16:16:12 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 16:16:12 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 16:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:12 INFO - Successfully installed psutil 16:16:12 INFO - Cleaning up... 16:16:13 INFO - Return code: 0 16:16:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:13 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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:13 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 16:16:13 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 16:16:13 INFO - Using env: {'DISPLAY': ':0', 16:16:13 INFO - 'HOME': '/home/cltbld', 16:16:13 INFO - 'LANG': 'en_US.UTF-8', 16:16:13 INFO - 'LANGUAGE': 'en_US:en', 16:16:13 INFO - 'LOGNAME': 'cltbld', 16:16:13 INFO - 'MAIL': '/var/mail/cltbld', 16:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:13 INFO - 'MOZ_NO_REMOTE': '1', 16:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:13 INFO - 'NO_EM_RESTART': '1', 16:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:13 INFO - 'PWD': '/builds/slave/test', 16:16:13 INFO - 'SHELL': '/bin/bash', 16:16:13 INFO - 'SHLVL': '1', 16:16:13 INFO - 'TERM': 'linux', 16:16:13 INFO - 'TMOUT': '86400', 16:16:13 INFO - 'USER': 'cltbld', 16:16:13 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:13 INFO - '_': '/tools/buildbot/bin/python'} 16:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:16:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:16:14 INFO - Installing collected packages: mozsystemmonitor 16:16:14 INFO - Running setup.py install for mozsystemmonitor 16:16:15 INFO - Successfully installed mozsystemmonitor 16:16:15 INFO - Cleaning up... 16:16:15 INFO - Return code: 0 16:16:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:15 INFO - Using env: {'DISPLAY': ':0', 16:16:15 INFO - 'HOME': '/home/cltbld', 16:16:15 INFO - 'LANG': 'en_US.UTF-8', 16:16:15 INFO - 'LANGUAGE': 'en_US:en', 16:16:15 INFO - 'LOGNAME': 'cltbld', 16:16:15 INFO - 'MAIL': '/var/mail/cltbld', 16:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:15 INFO - 'MOZ_NO_REMOTE': '1', 16:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:15 INFO - 'NO_EM_RESTART': '1', 16:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:15 INFO - 'PWD': '/builds/slave/test', 16:16:15 INFO - 'SHELL': '/bin/bash', 16:16:15 INFO - 'SHLVL': '1', 16:16:15 INFO - 'TERM': 'linux', 16:16:15 INFO - 'TMOUT': '86400', 16:16:15 INFO - 'USER': 'cltbld', 16:16:15 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:15 INFO - '_': '/tools/buildbot/bin/python'} 16:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:15 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 16:16:15 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 16:16:15 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 16:16:15 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 16:16:15 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 16:16:15 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 16:16:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - Downloading docopt-0.6.1.tar.gz 16:16:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:17 INFO - Running setup.py install for blobuploader 16:16:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:17 INFO - Running setup.py install for requests 16:16:18 INFO - Running setup.py install for docopt 16:16:18 INFO - Successfully installed blobuploader requests docopt 16:16:18 INFO - Cleaning up... 16:16:18 INFO - Return code: 0 16:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:18 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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:18 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 16:16:18 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 16:16:18 INFO - Using env: {'DISPLAY': ':0', 16:16:18 INFO - 'HOME': '/home/cltbld', 16:16:18 INFO - 'LANG': 'en_US.UTF-8', 16:16:18 INFO - 'LANGUAGE': 'en_US:en', 16:16:18 INFO - 'LOGNAME': 'cltbld', 16:16:18 INFO - 'MAIL': '/var/mail/cltbld', 16:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:18 INFO - 'MOZ_NO_REMOTE': '1', 16:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:18 INFO - 'NO_EM_RESTART': '1', 16:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:18 INFO - 'PWD': '/builds/slave/test', 16:16:18 INFO - 'SHELL': '/bin/bash', 16:16:18 INFO - 'SHLVL': '1', 16:16:18 INFO - 'TERM': 'linux', 16:16:18 INFO - 'TMOUT': '86400', 16:16:18 INFO - 'USER': 'cltbld', 16:16:18 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:18 INFO - '_': '/tools/buildbot/bin/python'} 16:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:18 INFO - Running setup.py (path:/tmp/pip-PumP3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:18 INFO - Running setup.py (path:/tmp/pip-Frw_3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:18 INFO - Running setup.py (path:/tmp/pip-rIpThP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:18 INFO - Running setup.py (path:/tmp/pip-09IPzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:18 INFO - Running setup.py (path:/tmp/pip-Gx_Wkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:18 INFO - Running setup.py (path:/tmp/pip-Kb6Wq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:18 INFO - Running setup.py (path:/tmp/pip-8rULQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:19 INFO - Running setup.py (path:/tmp/pip-a9iRcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:19 INFO - Running setup.py (path:/tmp/pip-NrlGn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:19 INFO - Running setup.py (path:/tmp/pip-VGRjMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:19 INFO - Running setup.py (path:/tmp/pip-VOyOOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:19 INFO - Running setup.py (path:/tmp/pip-6nqJ7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:19 INFO - Running setup.py (path:/tmp/pip-4mkLG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:19 INFO - Running setup.py (path:/tmp/pip-4ktwg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:19 INFO - Running setup.py (path:/tmp/pip-so9TMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:19 INFO - Running setup.py (path:/tmp/pip-oozBTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:19 INFO - Running setup.py (path:/tmp/pip-ZU5fyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:19 INFO - Running setup.py install for manifestparser 16:16:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:19 INFO - Running setup.py install for mozcrash 16:16:19 INFO - Running setup.py install for mozdebug 16:16:20 INFO - Running setup.py install for mozdevice 16:16:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozfile 16:16:20 INFO - Running setup.py install for mozhttpd 16:16:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozinfo 16:16:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozInstall 16:16:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozleak 16:16:20 INFO - Running setup.py install for mozlog 16:16:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for moznetwork 16:16:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:20 INFO - Running setup.py install for mozprocess 16:16:20 INFO - Running setup.py install for mozprofile 16:16:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozrunner 16:16:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Running setup.py install for mozscreenshot 16:16:21 INFO - Running setup.py install for moztest 16:16:21 INFO - Running setup.py install for mozversion 16:16:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:21 INFO - Cleaning up... 16:16:21 INFO - Return code: 0 16:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:21 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 16:16:21 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 16:16:21 INFO - Using env: {'DISPLAY': ':0', 16:16:21 INFO - 'HOME': '/home/cltbld', 16:16:21 INFO - 'LANG': 'en_US.UTF-8', 16:16:21 INFO - 'LANGUAGE': 'en_US:en', 16:16:21 INFO - 'LOGNAME': 'cltbld', 16:16:21 INFO - 'MAIL': '/var/mail/cltbld', 16:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:21 INFO - 'MOZ_NO_REMOTE': '1', 16:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:21 INFO - 'NO_EM_RESTART': '1', 16:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:21 INFO - 'PWD': '/builds/slave/test', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SHLVL': '1', 16:16:21 INFO - 'TERM': 'linux', 16:16:21 INFO - 'TMOUT': '86400', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - '_': '/tools/buildbot/bin/python'} 16:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 INFO - Running setup.py (path:/tmp/pip-45dcdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 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)) 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 INFO - Running setup.py (path:/tmp/pip-d20528-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 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)) 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 INFO - Running setup.py (path:/tmp/pip-GJ9HnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 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)) 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 INFO - Running setup.py (path:/tmp/pip-EbZ3wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 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)) 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:22 INFO - Running setup.py (path:/tmp/pip-f0Iuf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:22 INFO - Running setup.py (path:/tmp/pip-7GSYFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:22 INFO - Running setup.py (path:/tmp/pip-TqxnE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 INFO - Running setup.py (path:/tmp/pip-RLjj6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:22 INFO - Running setup.py (path:/tmp/pip-2OdqPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:22 INFO - Running setup.py (path:/tmp/pip-H_Od1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 INFO - Running setup.py (path:/tmp/pip-sOuGOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 INFO - Running setup.py (path:/tmp/pip-HIbVAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 INFO - Running setup.py (path:/tmp/pip-Urw148-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 INFO - Running setup.py (path:/tmp/pip-GVIUGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 INFO - Running setup.py (path:/tmp/pip-NZ6haT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:22 INFO - Running setup.py (path:/tmp/pip-cVgA6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:22 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)) 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:22 INFO - Running setup.py (path:/tmp/pip-jv2hib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:22 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)) 16:16:22 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)) 16:16:22 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)) 16:16:22 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)) 16:16:22 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)) 16:16:22 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)) 16:16:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:24 INFO - Downloading blessings-1.5.1.tar.gz 16:16:24 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 16:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:24 INFO - Installing collected packages: blessings 16:16:24 INFO - Running setup.py install for blessings 16:16:24 INFO - Successfully installed blessings 16:16:24 INFO - Cleaning up... 16:16:24 INFO - Return code: 0 16:16:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:25 INFO - Reading from file tmpfile_stdout 16:16:25 INFO - Current package versions: 16:16:25 INFO - argparse == 1.2.1 16:16:25 INFO - blessings == 1.5.1 16:16:25 INFO - blobuploader == 1.2.4 16:16:25 INFO - docopt == 0.6.1 16:16:25 INFO - manifestparser == 1.1 16:16:25 INFO - mozInstall == 1.12 16:16:25 INFO - mozcrash == 0.16 16:16:25 INFO - mozdebug == 0.1 16:16:25 INFO - mozdevice == 0.47 16:16:25 INFO - mozfile == 1.2 16:16:25 INFO - mozhttpd == 0.7 16:16:25 INFO - mozinfo == 0.9 16:16:25 INFO - mozleak == 0.1 16:16:25 INFO - mozlog == 3.0 16:16:25 INFO - moznetwork == 0.27 16:16:25 INFO - mozprocess == 0.22 16:16:25 INFO - mozprofile == 0.27 16:16:25 INFO - mozrunner == 6.11 16:16:25 INFO - mozscreenshot == 0.1 16:16:25 INFO - mozsystemmonitor == 0.0 16:16:25 INFO - moztest == 0.7 16:16:25 INFO - mozversion == 1.4 16:16:25 INFO - psutil == 3.1.1 16:16:25 INFO - requests == 1.2.3 16:16:25 INFO - wsgiref == 0.1.2 16:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:25 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')]} 16:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 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')]} 16:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 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 0x7fc48f0ddc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, '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': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', '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 16:16:25 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 16:16:25 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 16:16:25 INFO - Using env: {'DISPLAY': ':0', 16:16:25 INFO - 'HOME': '/home/cltbld', 16:16:25 INFO - 'LANG': 'en_US.UTF-8', 16:16:25 INFO - 'LANGUAGE': 'en_US:en', 16:16:25 INFO - 'LOGNAME': 'cltbld', 16:16:25 INFO - 'MAIL': '/var/mail/cltbld', 16:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:25 INFO - 'MOZ_NO_REMOTE': '1', 16:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:25 INFO - 'NO_EM_RESTART': '1', 16:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:25 INFO - 'PWD': '/builds/slave/test', 16:16:25 INFO - 'SHELL': '/bin/bash', 16:16:25 INFO - 'SHLVL': '1', 16:16:25 INFO - 'TERM': 'linux', 16:16:25 INFO - 'TMOUT': '86400', 16:16:25 INFO - 'USER': 'cltbld', 16:16:25 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:25 INFO - '_': '/tools/buildbot/bin/python'} 16:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 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)) 16:16:25 INFO - Cleaning up... 16:16:25 INFO - Return code: 0 16:16:25 INFO - Running post-action listener: _resource_record_post_action 16:16:25 INFO - Running post-action listener: _start_resource_monitoring 16:16:25 INFO - Starting resource monitoring. 16:16:25 INFO - ##### 16:16:25 INFO - ##### Running install step. 16:16:25 INFO - ##### 16:16:25 INFO - Running pre-action listener: _resource_record_pre_action 16:16:25 INFO - Running main action method: install 16:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:25 INFO - Reading from file tmpfile_stdout 16:16:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:25 INFO - Reading from file tmpfile_stdout 16:16:25 INFO - Output received: 16:16:25 INFO - Usage: mozinstall [options] installer 16:16:25 INFO - Options: 16:16:25 INFO - -h, --help show this help message and exit 16:16:25 INFO - -d DEST, --destination=DEST 16:16:25 INFO - Directory to install application into. [default: 16:16:25 INFO - "/builds/slave/test"] 16:16:25 INFO - --app=APP Application being installed. [default: firefox] 16:16:25 INFO - mkdir: /builds/slave/test/build/application 16:16:25 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'] 16:16:25 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 16:16:39 INFO - Reading from file tmpfile_stdout 16:16:39 INFO - Output received: 16:16:39 INFO - /builds/slave/test/build/application/firefox/firefox 16:16:39 INFO - Running post-action listener: _resource_record_post_action 16:16:39 INFO - ##### 16:16:39 INFO - ##### Running run-tests step. 16:16:39 INFO - ##### 16:16:39 INFO - Running pre-action listener: _resource_record_pre_action 16:16:39 INFO - Running main action method: run_tests 16:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:16:39 INFO - Python 2.7.3 16:16:39 INFO - Return code: 0 16:16:39 INFO - grabbing minidump binary from tooltool 16:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:39 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 0x1b67b70>, '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 0x1bb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:16:39 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 16:16:39 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 16:16:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:16:39 INFO - Return code: 0 16:16:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:16:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:16:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:16:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:16:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:16:39 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/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] in /builds/slave/test/build 16:16:39 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/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost 16:16:39 INFO - Using env: {'DISPLAY': ':0', 16:16:39 INFO - 'HOME': '/home/cltbld', 16:16:39 INFO - 'LANG': 'en_US.UTF-8', 16:16:39 INFO - 'LANGUAGE': 'en_US:en', 16:16:39 INFO - 'LOGNAME': 'cltbld', 16:16:39 INFO - 'MAIL': '/var/mail/cltbld', 16:16:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:16:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:39 INFO - 'MOZ_NO_REMOTE': '1', 16:16:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:39 INFO - 'NO_EM_RESTART': '1', 16:16:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:39 INFO - 'PWD': '/builds/slave/test', 16:16:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:16:39 INFO - 'SHELL': '/bin/bash', 16:16:39 INFO - 'SHLVL': '1', 16:16:39 INFO - 'TERM': 'linux', 16:16:39 INFO - 'TMOUT': '86400', 16:16:39 INFO - 'USER': 'cltbld', 16:16:39 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141', 16:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:39 INFO - '_': '/tools/buildbot/bin/python'} 16:16:39 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/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] with output_timeout 3600 16:16:39 INFO - mozversion INFO | application_buildid: 20151120144231 16:16:39 INFO - mozversion INFO | application_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 16:16:39 INFO - mozversion INFO | application_display_name: Nightly 16:16:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:16:39 INFO - mozversion INFO | application_name: Firefox 16:16:39 INFO - mozversion INFO | application_remotingname: firefox 16:16:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 16:16:39 INFO - mozversion INFO | application_vendor: Mozilla 16:16:39 INFO - mozversion INFO | application_version: 45.0a1 16:16:39 INFO - mozversion INFO | platform_buildid: 20151120144231 16:16:39 INFO - mozversion INFO | platform_changeset: 3f5afaf4e6b72c4b1a20749b4ce7d945add5299f 16:16:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 16:16:39 INFO - mozversion INFO | platform_version: 45.0a1 16:16:39 INFO - 2015-11-20 16:16:39,931 DEBUG : using testdate: 1448064999 16:16:39 INFO - 2015-11-20 16:16:39,931 DEBUG : actual date: 1448064999 16:16:39 INFO - 2015-11-20 16:16:39,940 INFO : starting webserver on 'localhost:57381' 16:16:39 INFO - 2015-11-20 16:16:39,941 INFO : Starting test suite talos-linux64-ix-050 16:16:39 INFO - 2015-11-20 16:16:39,941 INFO : Starting test dromaeo_css 16:16:39 INFO - 2015-11-20 16:16:39,941 DEBUG : operating with platform_type : linux_ 16:16:39 INFO - 2015-11-20 16:16:39,942 INFO : Initialising browser for dromaeo_css test... 16:16:39 INFO - 2015-11-20 16:16:39,955 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDPab7/profile http://localhost:57381/getInfo.html 16:16:43 INFO - 2015-11-20 16:16:43,915 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:16:43 INFO - 2015-11-20 16:16:43,915 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:16:43 INFO - 2015-11-20 16:16:43,915 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:16:43 INFO - 2015-11-20 16:16:43,915 DEBUG : BROWSER_OUTPUT: __metrics 16:16:44 INFO - 2015-11-20 16:16:44,064 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:45 INFO - 2015-11-20 16:16:45,225 INFO : Browser initialized. 16:16:45 INFO - 2015-11-20 16:16:45,225 INFO : Running cycle 1/1 for dromaeo_css test... 16:16:45 INFO - 2015-11-20 16:16:45,225 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRDPab7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:16:57 INFO - 2015-11-20 16:16:57,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 139857920 16:16:57 INFO - 2015-11-20 16:16:57,161 DEBUG : BROWSER_OUTPUT: 16:17:48 INFO - 2015-11-20 16:17:48,457 DEBUG : BROWSER_OUTPUT: 1448065068452 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] 16:20:00 INFO - 2015-11-20 16:20:00,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57381/tests/dromaeo/cssquery-ext.html) 16:20:01 INFO - 2015-11-20 16:20:01,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 239005696 16:20:01 INFO - 2015-11-20 16:20:01,529 DEBUG : BROWSER_OUTPUT: 16:23:03 INFO - 2015-11-20 16:23:03,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-ext.html (next: http://localhost:57381/tests/dromaeo/cssquery-jquery.html) 16:23:04 INFO - 2015-11-20 16:23:04,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 213504000 16:23:04 INFO - 2015-11-20 16:23:04,566 DEBUG : BROWSER_OUTPUT: 16:26:06 INFO - 2015-11-20 16:26:06,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57381/tests/dromaeo/cssquery-mootools.html) 16:26:07 INFO - 2015-11-20 16:26:07,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 224133120 16:26:07 INFO - 2015-11-20 16:26:07,211 DEBUG : BROWSER_OUTPUT: 16:29:09 INFO - 2015-11-20 16:29:09,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57381/tests/dromaeo/cssquery-prototype.html) 16:29:09 INFO - 2015-11-20 16:29:09,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 202838016 16:29:09 INFO - 2015-11-20 16:29:09,780 DEBUG : BROWSER_OUTPUT: 16:32:12 INFO - 2015-11-20 16:32:12,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57381/tests/dromaeo/cssquery-yui.html) 16:32:13 INFO - 2015-11-20 16:32:13,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 203083776 16:32:13 INFO - 2015-11-20 16:32:13,057 DEBUG : BROWSER_OUTPUT: 16:35:15 INFO - 2015-11-20 16:35:15,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/dromaeo/cssquery-yui.html (next: http://localhost:57381/tests/dromaeo/cssquery-dojo.html) 16:35:16 INFO - 2015-11-20 16:35:16,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 218427392 16:35:16 INFO - 2015-11-20 16:35:16,010 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,011 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:35:16 INFO - 2015-11-20 16:35:16,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:35:16 INFO - 2015-11-20 16:35:16,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:35:16 INFO - 2015-11-20 16:35:16,013 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:35:16 INFO - 2015-11-20 16:35:16,014 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2630.2898217481275;2740.7807375409957;2745.3960128771664;2751.834889906606;2771.930701732456;4437.84467543636;4542.750148741826;4676.20504514233;4688.343631891534;4718.551737584929;4579.290210017444;4586.876215327241;4607.216773148564;4656.231721765905;4686.648501362394;4252.617264446199;4269.722468039583;4270.338097594878;4341.717788343748;4348.97825510872;4325;4329.242382583036;4379.189849877767;4387.978060109711;4416.072624748806;4089.079957009649;4179.519355274152;4181.1010632714115;4310.413196922828;4357.4988876279;4329.588689074533;4362.607365337103;4375.47494300686;4380.123975204971;4387.034852332514;4312.568743125694;4319.82720691172;4332.675049371278;4348.782560871975;4360.956390436087;4392.758398288093;4537.455505339381;4538.251188553884;4634.281686338623;4687.367205427257;4944.159492886218;5002.399712034579;5023.196288593844;5025;5068.594512438996;5078.339815823956;5099.949000509984;5100.617453690951;5102.183650615921;5154.639175257734;4434.423524941737;4552.7495987720995;4557.521460246693;4733.290006499018;4748.430188377417;5116.9744151279;5216.165413533817;5223;5246.108161612535;5257.947420525822;4966.354373931365;4982.8754281143265;4984.725840078758;4985.925211121836;5036.79852805891;4795.088933102699;4894.412670479494;4900.901981960341;5066.645334826527;5074.695518268915;4853.4418541867435;4930.383702037246;4931.087748766489;4932.975335123373;4966.404031516241;4920;4921.237208232729;4924.655274130848;4926.729029903318;4959.752012399365;3925.7448265862627;4022.0950286185375;4131.029208136086;4141.97929010353;4186.644135248477;3545.982270088685;3624.329499042633;3658.1037645776955;3677.3932301170544;3712.6844218241213;4296.076343586082;4299;4310.956890431118;4319.200947824663;4338.674599404994;4812.759362031955;4965.155923493015;5005.724685142352;5017.523335283142;5019.623528235397;4243.511996120424;4257.10600773841;4273.636740876998;4353.564643535621;4361.062371590124;4445.444319460067;4478;4479.924818043646;4495.213337665896;4527.932081018787;4815.927761083586;4832.540908613676;4837.637177211794;4838.322634831196;4880.41435027799;4799.328094066764;4921.63087768426;4923.729194894315;4932.53140951609;5076.162433198481;4746.050789842115;4767.952320476889;4775.617950564016;4777.355057067251;4811.08589368033;4963.404391472902;4963.975180124076;4969.279454479152;4976.527229913152;5024.070546948826;4787.0904528139545;4894.877628059327;4919.065377578248;4929.679570827885;5038.042771873333;4853.466118726867;4890.657653964188;4902.142125128017;4903;4940.505949405031;4875.609951203966;4879.316895634685;4882.658213924991;4888.2178851383605;4924.926126108183;4481.417415735934;4623.491415944311;4623.976880115578;4704.835330763407;4828.66199366041;4843.782029808596;4847.757612119451;4848.5636292733825;4851.56335929768;4950.8762280943265;4739.21802902531;4749.738764367993;4751.287306903854;4763.4522029967;4794.616430685606 16:35:16 INFO - 2015-11-20 16:35:16,015 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.312253081396;573.8192469372145;581.8574449259931;584.0917373484232;594.6788734083593;27523.724762752365;36681.26637467252;37073.814630926805;37118.62881371185;37142.44286335707;40063.599364006426;40529.18941621166;40553.59446405535;40615.18769624606;40700.18599628006;7000.474964377667;7138.571685698875;7986.640601172947;8157.469764465291;8160.5103693778265;10196.898031019706;10433.061024507793;10447.477626118702;10451.268411211218;10459.372437653727;10146.695599132037;10290.382577045364;10315;10317.380957142557;10320.948395258014;7201.13586369639;7383.963080184619;10150.13723833475;10209;10227.437490937995;9974.551145198411;10111.64609238673;10112.696619101438;10115.595376184943;10115.898841011644;37135.25729485395;37660.81169594162;37675.811620942;37677.81161094177;37699;2786.2616406652255;2803.327201471632;2808.8455134967567;2815.408764159529;2848.572714092882;28496.430071398663;28601.85699071512;28611.177122940273;28673.85663071692;29378.70621293781;3279.4542193159873;3311.172206948263;3319;3416.8120753358558;3429.8456569454434;222717;223984;225627;226143;226500;46935.765321173174;48098.759506202245;55878.72060639671;56250.718746406004;56254.156187657216;59384.10923836146;60686.69656651777;60931.39068609346;61028.38971610316;61032.69483652642;12582.87417125817;12751.36243187837;12760.553380631633;12774.9361253195;12876.356182190853;8679.47923124602;8697.565121743888;8703.825923481621;8718.910136232971;8735.344849136212;18371.448856534324;19184.232630694616;19339.226430942606;19415.90292048559;19455.3190638327;6873;7217.422606191492;7249.601271930094;7283.635818209068;7326.67029983652;838.7022606974558;864.9524276164872;894.18182363137;944.2776276148752;1028.5011769291887;25724.48551028969;26157.73842261553;26339.209823705318;26571.46857062848;26602.6009609856;962.1965658675085;963.937344072633;1004.4174378860243;1016.065219997604;1031.2832581356035;13675.31623418825;13827;14006.50977215813;14073.577792666236;14077.507287244896;271371;275955;276032;276623;276981;45535.77232113818;45669.543304567196;45697.54302456933;45748.3137752934;45766.542334576894;1180.2800291821982;1194.4386138514883;1196.497471062156;1196.7202479276991;1204.897583705395;24827.627585586593;25535.744642553338;26080.478390432465;26128.34679133037;26266.606000909618;35542;36311.45532816957;40550.59449405468;41571.37642935298;41668.45818105495;212405;213622;213698;213973;214626;23876.283711488682;24393.39016524601;27170.864145679145;27218.047368342013;27578;36454.27091458103;36864.26271474609;37717.81141094387;38405.4239186418;38716.61283387243;29226.853865730536;31551.053468395985;31688.366232674758;32393.190170245933;32964.835175823966;32324;32999.17502062372;33038.33923321568;33823.4926476108;35342.64657353394;32124.518132227568;32523.51214731828;32718.182045449055;32789.67210327866;32953.505697415036;28416.28959275952;28726.569101463912;29617.851910740308;29625.85187074051;29667.40665186641;22640.207592734176;22733;22990;23148.421289467897;23276.6508502376 16:35:16 INFO - 2015-11-20 16:35:16,016 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.569598761579;338.7087105089624;339.4111217038438;340.5011657921145;341.79663100455235;12366.629001129959;12774.42515086821;15168.241587920602;15294.476411392121;16489.670206595874;12357.691057723561;12370.628881133558;12431.067669924747;13506.729865402685;13960.30198490074;4998.625103117262;5007.724575148365;5157.48425157485;5158.27784110223;5162;3510.4909788080713;3619.6561326674055;5766.711664416784;6005.909911351311;6026.0659597762415;5809.244798176232;5946.345901950782;5957.970210148965;5962.195103661015;5981.431763982415;5944.138099975501;5946.583739138262;5948.524118070565;5959.821205363846;5961.5230781537375;5132.666376685504;5181.248718935733;5209.244659524347;5230.92153617696;5230.947690523084;19018.714719279084;19031.333903313454;19042.52393690155;19187.90406047961;19420;1854.9258029678797;1890.7447494588191;1896.1088288504382;1914.2821441959265;2078.646630072891;12583.496660133584;12641.178323408949;12802.231866087972;12889.484420623165;13004.349782510837;1703.3385236074575;1704.9318027278894;1731.2901710298718;1734.5750291178615;1759.7096479080935;52740.73629631865;52860.47139528594;53138.46861531412;53648;54473.1829022565;9225.584848681825;9349.953250233706;9486.335956483117;9500.904990950141;9573.994730553331;12131.878681213251;12151.939240303918;12157.386161975217;12169.756604867853;12171.634850954486;6535.313792051861;6625.105610742585;6634.402903738686;6723.428508576826;6855.348741869514;6188.319284878659;6490;6594.07682924391;6598.37315455031;6608.86782264352;5636.549076073904;5716.5140963017775;5737.713114344266;5747.971260143672;5803.883922321615;1541.4373753579862;1625.1792844613394;1640.5078476457015;1690.7548405481382;1696.8897021693551;414.0291017563808;876.9254613357808;944.4616568555995;959.2134449751277;977.9706608801747;8288.50268983863;9435.858462123073;9870.21038316933;9936.602535898483;10040.849387259197;399.3909288335312;407.76349717163976;408.80377418839123;411.36854927686454;413.9606737360006;5468;5481.451854814487;5640.943590564124;5736.827895163152;5745.482906538432;463339;466789;469586;472859;490258;65987.34012659908;66867.33132668708;67238;67271.66364168246;67933.32066679369;445.93979812724865;446.1456311164084;450.6800171877938;451.3230154767848;451.7876597998935;9609.231261498924;9624.37441566296;9668;9736.561854716412;9737.853932190881;31348.52977205298;31432;31683.99999999908;31927.201819954687;32111.197220069684;39277.41083883801;40738.79630601828;41574.584254157075;41805.79097104617;41954;8898.688545900863;9046;9098.909010909807;9137.817243655223;9146.268298536233;12135.757284854077;15315.77026344628;15494.380224790882;15796.289166987743;16429;13451.058425910483;13519.526816561372;13616.93191534036;13862.168269903837;13996;12651.683707907376;12819.487220511075;12871.356432178542;13436.596902092953;13582.320883955961;10777.245592808742;11122.110231181648;11820.586279480176;13054.934725326313;13349.532766353132;8585.141485851365;8589.184027517376;8609.569521524025;8617.526036068077;8710.738677839676;9086.818263634557;9169.587368568296;9207.079292070739;11002.33985960845;11769.52921883115 16:35:16 INFO - 2015-11-20 16:35:16,017 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1223.2660403757752;1614.1525699008018;1662.9191025833206;1670.38195867529;1702.2765324736984;5757.453041961012;6587.2753997060345;6774.153230846145;6784.864302713949;6795.422389096932;6419.967900160493;6518.739250429977;6527.771527996521;6529.444997175246;6537.738490460376;1736.435658411015;1767.8585713142982;1768.1954710606642;2030.3908827351809;2059.3101311060814;1788.570743021672;2047.467658408817;2080.1471396727343;2085.447356450542;2090.6341390256644;1972.2406873353718;2017.5863947890648;2021.8180363767258;2021.878687278768;2025.0988310201967;2045.3250427358935;2053.743282089739;2061.4331058958755;2061.597988392264;2063.2366024570856;2035.542003049317;2045.3557129504159;2081.1363284237023;2082.854200205986;2088.4778805298674;6766.391024807742;6776.2546119926765;6794.898076528856;6809.080774095483;6816.147981502312;4087.713860029799;4143.937840932388;4151.14901445203;4154.023804405962;4164.7917604119975;2670.8664566771586;2747.7252274772563;2755.2836262571677;2759.1446651538085;2799.818011829245;854.8760429737653;865.3639574912435;866.5840396609663;893.7006102955518;900.6127365232948;9032.458052516804;9040.819183616291;9051.818963620757;9051.864222036675;9062.093790620951;3886.689064874803;3922.1371298314325;3991.4212439196735;3997.920041599152;4001.639852413297;7840.09838868526;7843.4117441191;7863.606819659109;7866.174051724601;7866.72466463671;4208.621224089847;4210.052738133895;4229.281022226229;4250.808713607895;4253.532111467736;3791.8862434127022;3793.5827059023486;3798.9430158547643;3800.3729384651224;3802.1825307559006;2924.5905573219766;3232.337370838972;3284.080457471912;3296.0935742670476;3302.1909632140278;958.8130314588589;971.3103696375653;972.8151651186251;973.6202880876323;1037.486444210121;924.847400178963;926.3654396738256;1002.5638847101534;1114.8517027461728;1170.9238899471507;6437.130987316746;6493.675316234169;6494.090827284184;6496.447801936793;6499.480041596661;1026.8408396698374;1029.4441001858913;1037.8598889150019;1038.2628333883029;1059.5179193466954;5019.824306149268;5097.898042039138;5114.462981386975;5120.462351453044;5124.718140502234;7859.292663660298;7925.0489941207425;8103.513789172668;8129;8176.754697359089;8008.599570021475;8101.392395570356;8110.716124935599;8115.188481151838;8125.4718443301;6023.1567580537885;6347.333529979378;6420.357964203542;6425.9036114457385;6480.611163330215;6284.340144284784;6398.4561312287115;6413.615183089029;6416.358364163546;6447.3552644735155;7257.346838784535;7260.564366138048;7280.9271907280245;7307.426331212248;7382.966384706253;7288.890666640111;7384.556926584422;7473.775786726407;7484.812879678052;7539;6091.269047714125;6156;6183.227096612924;6219.968900155652;6254.6247225166635;6401.29585745577;6429;6465.515086368447;6490.643014634241;6530.151080359523;6139.539534534839;6148.139260503623;6235.875282494416;6241.367317533805;6383.840403989938;5351.170568561879;5540.141278101901;5877.235959325431;5999;6089.421504957022;6216.347283535345;6267.655278959701;6278;6279.372062793684;6283.183186185949;5553.8333849984565;5581.5813813963305;5586.162075688517;5601.355844077983;5614.157876318422;5698.914516282176;5704.201411802268;5712.942870571407;5719.57103217252;5729.223940578434 16:35:16 INFO - 2015-11-20 16:35:16,017 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.45913029589104;318.7784489779604;319.70906475107654;323.20330385599493;324.6850554961686;5203.4796520347945;5391.218273350361;5394.379646340672;5410.648307859996;5443.564514838813;5258.605604579653;5327.121025030875;5328.254044433782;5331.466853314667;5335.493128152829;3921.8823435296986;4033.2538480381077;4073.674106071522;4138.937915931256;4141.585841415849;4114.547399786021;4124.670026397881;4132.462779838616;4148.045949431633;4179.79101044948;4106.3635136553885;4111.629953304202;4123.793810309473;4143.8342466301465;4146.046409325857;3936.4882565266475;4011.5587285398583;4047.413125096874;4109.650679692199;4110.136871257039;3632.418812989909;3642.908927276813;3651.9634803652157;3655.798931058791;3662.5788034376124;5100.234964755279;5109.489051094898;5118.053160165344;5123.257127716461;5132.820351287687;4775.904481910377;4776.5701086902;4796.688215265996;4800.759962001921;4809.470958194595;5412.3505179378335;5595.38450770415;5597.524210442118;5651.9152212716845;5652.971735141339;4029.879103626896;4062.837486500536;4068.7965601719798;4074.185162967389;4075.53131389891;5837.095250236178;5909.379515150933;5916.497097746696;5917.319508256563;5918.7928422505;4183.954011497126;4190.350495673176;4196.454460920122;4198.706090573631;4200.348945913388;4129.648979836687;4217.40956266123;4219;4224.070704445078;4248.065425606362;4759.976200119047;4767.427908650984;4797.328374027639;4798.832040878552;4814.15752243356;5560.77756889728;5562.332520097614;5563.443655634404;5621.971890140523;5624.578156638187;1470.6396932751545;1476.365162979929;1476.402057166849;1477.231839443505;1477.4311889922242;1041.796849614318;1045.3675526306474;1046.7173863056933;1056.2395075545594;1071.5124618298655;4912.287718280829;4928.383952005999;4930.038642464757;4934.18585933317;4934.9013019739405;5837.182794408701;5837.3287071986415;5843.386444423274;5844.649321040752;5851.64890106595;4920.950790492121;4930.1865192243595;4931.3835770528685;4931.605471562267;4931.852044438672;3027.1826606816476;3055.4771210747476;3071.7081877221626;3097.3185899102164;3132.903483780704;5537.889242215133;5542.140968149944;5559.916601250984;5563.666180029211;5573.6098473106495;5997.160397544348;6011;6015.0977353396465;6020.57855950088;6023.879522409527;5425.565954723613;5540.473655002768;5547.55619550435;5553.416891226363;5555.944440555704;5853.239078919713;5859.619124756877;5863.589548731547;5867.823965281048;5876.794312199053;5715.714214289185;5718.199452076796;5728.79949201776;5731.312242530923;5734.7132643368495;5543.750531226186;5550.38945715979;5551.25058117149;5552.916706249329;5559.832435188656;4085.1829634073897;4185.66514678831;4188.748675079505;4190.476190476191;4193.580641935782;5847.239858818326;5856.677882716321;5857.619254748428;5858.7070646468355;5862.091375836752;5588.133839254922;5609.775608975595;5614.07367784311;5614.157876318585;5616.157576363578;5455.509004189484;5606.85982850432;5611.719414029364;5616.887662246814;5643.125315576092;5526.917096243479;5527.778888844562;5529.502344788988;5532.6680399176175;5538.418466061166;5659.122835960433;5671.688057156896;5675.517581005661;5676.091825307931;5681.318241811009;5419.214213939035;5520.089185284383;5520.972395137998;5526.530244929226;5533.418991005887 16:35:16 INFO - 2015-11-20 16:35:16,018 DEBUG : BROWSER_OUTPUT: |5;yui.html;664.3058004385417;717.1322699533564;760.3043215457857;768.8616049111158;793.1711361627096;10460.215483838714;10737.463126843646;10739.301945373545;10744;10745.409002504859;9674.51627418628;11738.237014594046;11794.410279486014;11814.881851181508;11912.702182445442;770.3952397368054;785.3599316557016;787.1538096546207;787.9606019699021;788.203914046814;771.6180490657133;781.1017330070435;781.1875649324724;781.3007358414216;781.8279978404742;812.155358427235;813.6907974969504;819.4673462249526;820.7004443378154;821.4126899267023;809.8866158737782;811.6672164412621;812.9227723366271;813.1502579804119;813.308687615531;600.5585894367637;602.1329285828436;602.2592211579781;603.2097951683265;603.3574243430776;10152.340097893688;10297.279190456671;10299.897001029969;10306.7423314417;10309;9254.722358329262;9367.76580585484;9578.185854202331;9709;9772.41365518064;8682.30541556674;8749.47503149813;9284.675036373694;9606.039396060338;10022.248331375176;3240.1575590346442;3264.7061764441078;3297;3323.6344002159744;3392.7794693344854;34663.30673386544;35954;37712.245755085016;38599.42100868489;38680;9518.428894266366;9534.666286679932;9720.90279097214;9759.853602195974;9814.75463113428;16239.594010149605;16372.672546549002;16372.672546549002;16375;16399;6389.041643753474;6426.35736426363;6581.2102547694585;6650.833729156713;6785.050092986986;3471.271033083081;3498.4927185557954;3527.735419843522;3558.323918455485;3565.6790888820133;2754.807163498576;2772.4039331543413;2777.7361150690654;2778.902738404146;2784.635528590976;488.20422710980876;488.699449838354;492.2517772985043;498.4243199105039;503.68771361755944;446.63822303933915;563.8083051762338;568.3407247592772;580.8722081142142;608.2974164839617;7238.148039977608;7364.889526657104;7407.370373518203;7603.4297427693145;7611.733589324347;455.7561704488083;566.6260268222953;588.2969851028066;602.111884969675;620.7796232337546;3699.445083237482;3720.404735242348;3761.8683346082757;3767.246550689873;3794.298054859805;44816.55183448189;45986;49249.50750492449;49456.25815612769;49643.75178124086;36455.4531682025;36903;43737.56262437398;43968.78015609965;44240.77879610581;37811.432828507044;40499.367541109736;41637.1672566547;41654.58345416507;41964.58035419607;7625.542467451971;8054.516728996279;8526.488410695378;8539.316854651488;8596.441231319945;31984.36031279408;32199.51700724444;32653.18367040843;32795.83602081974;33736.66263337335;36960.44559331666;37561.81219093887;38180.236395271386;41020.1795964085;41077;9601.519924003911;10280.434576098387;10387.324823886423;10588.682339529827;10600.681979540626;11650.941745291218;11781.293122412682;11813.704657383634;11906.52373905034;12312.199707019015;10298.38447901315;10753.731156721145;11003;11312.717182070513;11360.09119270473;10891.183161263096;10976.286541375104;11240.156988225752;11259.042981346678;11294.60468883618;10896.12830973536;11359.54561817551;11372;11385.316880986837;11454;9709.5145242739;9721.659741909;9746.060373560864;9798.77254234912;9971.252156088178;9322.673706420243;9642.132208101024;9713.201851079644;9827.11555959967;9854.605815767289 16:35:16 INFO - 2015-11-20 16:35:16,018 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:35:16 INFO - 2015-11-20 16:35:16,018 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,887 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066116011__endTimestamp 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,019 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4610.13 Median:4751.29 stddev:479.65 (10.1%) stddev-sans-first:455.28 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: Values: 2630.3 2740.8 2745.4 2751.8 2771.9 4437.8 4542.8 4676.2 4688.3 4718.6 4579.3 4586.9 4607.2 4656.2 4686.6 4252.6 4269.7 4270.3 4341.7 4349.0 4325.0 4329.2 4379.2 4388.0 4416.1 4089.1 4179.5 4181.1 4310.4 4357.5 4329.6 4362.6 4375.5 4380.1 4387.0 4312.6 4319.8 4332.7 4348.8 4361.0 4392.8 4537.5 4538.3 4634.3 4687.4 4944.2 5002.4 5023.2 5025.0 5068.6 5078.3 5099.9 5100.6 5102.2 5154.6 4434.4 4552.7 4557.5 4733.3 4748.4 5117.0 5216.2 5223.0 5246.1 5257.9 4966.4 4982.9 4984.7 4985.9 5036.8 4795.1 4894.4 4900.9 5066.6 5074.7 4853.4 4930.4 4931.1 4933.0 4966.4 4920.0 4921.2 4924.7 4926.7 4959.8 3925.7 4022.1 4131.0 4142.0 4186.6 3546.0 3624.3 3658.1 3677.4 3712.7 4296.1 4299.0 4311.0 4319.2 4338.7 4812.8 4965.2 5005.7 5017.5 5019.6 4243.5 4257.1 4273.6 4353.6 4361.1 4445.4 4478.0 4479.9 4495.2 4527.9 4815.9 4832.5 4837.6 4838.3 4880.4 4799.3 4921.6 4923.7 4932.5 5076.2 4746.1 4768.0 4775.6 4777.4 4811.1 4963.4 4964.0 4969.3 4976.5 5024.1 4787.1 4894.9 4919.1 4929.7 5038.0 4853.5 4890.7 4902.1 4903.0 4940.5 4875.6 4879.3 4882.7 4888.2 4924.9 4481.4 4623.5 4624.0 4704.8 4828.7 4843.8 4847.8 4848.6 4851.6 4950.9 4739.2 4749.7 4751.3 4763.5 4794.6 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39964.78 Median:29621.85 stddev:62354.61 (210.5%) stddev-sans-first:62459.34 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: Values: 559.3 573.8 581.9 584.1 594.7 27523.7 36681.3 37073.8 37118.6 37142.4 40063.6 40529.2 40553.6 40615.2 40700.2 7000.5 7138.6 7986.6 8157.5 8160.5 10196.9 10433.1 10447.5 10451.3 10459.4 10146.7 10290.4 10315.0 10317.4 10320.9 7201.1 7384.0 10150.1 10209.0 10227.4 9974.6 10111.6 10112.7 10115.6 10115.9 37135.3 37660.8 37675.8 37677.8 37699.0 2786.3 2803.3 2808.8 2815.4 2848.6 28496.4 28601.9 28611.2 28673.9 29378.7 3279.5 3311.2 3319.0 3416.8 3429.8 222717.0 223984.0 225627.0 226143.0 226500.0 46935.8 48098.8 55878.7 56250.7 56254.2 59384.1 60686.7 60931.4 61028.4 61032.7 12582.9 12751.4 12760.6 12774.9 12876.4 8679.5 8697.6 8703.8 8718.9 8735.3 18371.4 19184.2 19339.2 19415.9 19455.3 6873.0 7217.4 7249.6 7283.6 7326.7 838.7 865.0 894.2 944.3 1028.5 25724.5 26157.7 26339.2 26571.5 26602.6 962.2 963.9 1004.4 1016.1 1031.3 13675.3 13827.0 14006.5 14073.6 14077.5 271371.0 275955.0 276032.0 276623.0 276981.0 45535.8 45669.5 45697.5 45748.3 45766.5 1180.3 1194.4 1196.5 1196.7 1204.9 24827.6 25535.7 26080.5 26128.3 26266.6 35542.0 36311.5 40550.6 41571.4 41668.5 212405.0 213622.0 213698.0 213973.0 214626.0 23876.3 24393.4 27170.9 27218.0 27578.0 36454.3 36864.3 37717.8 38405.4 38716.6 29226.9 31551.1 31688.4 32393.2 32964.8 32324.0 32999.2 33038.3 33823.5 35342.6 32124.5 32523.5 32718.2 32789.7 32953.5 28416.3 28726.6 29617.9 29625.9 29667.4 22640.2 22733.0 22990.0 23148.4 23276.7 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25176.86 Median:231895.39 stddev:77181.17 (33.3%) stddev-sans-first:77375.15 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: Values: 337.6 338.7 339.4 340.5 341.8 12366.6 12774.4 15168.2 15294.5 16489.7 12357.7 12370.6 12431.1 13506.7 13960.3 4998.6 5007.7 5157.5 5158.3 5162.0 3510.5 3619.7 5766.7 6005.9 6026.1 5809.2 5946.3 5958.0 5962.2 5981.4 5944.1 5946.6 5948.5 5959.8 5961.5 5132.7 5181.2 5209.2 5230.9 5230.9 19018.7 19031.3 19042.5 19187.9 19420.0 1854.9 1890.7 1896.1 1914.3 2078.6 12583.5 12641.2 12802.2 12889.5 13004.3 1703.3 1704.9 1731.3 1734.6 1759.7 52740.7 52860.5 53138.5 53648.0 54473.2 9225.6 9350.0 9486.3 9500.9 9574.0 12131.9 12151.9 12157.4 12169.8 12171.6 6535.3 6625.1 6634.4 6723.4 6855.3 6188.3 6490.0 6594.1 6598.4 6608.9 5636.5 5716.5 5737.7 5748.0 5803.9 1541.4 1625.2 1640.5 1690.8 1696.9 414.0 876.9 944.5 959.2 978.0 8288.5 9435.9 9870.2 9936.6 10040.8 399.4 407.8 408.8 411.4 414.0 5468.0 5481.5 5640.9 5736.8 5745.5 463339.0 466789.0 469586.0 472859.0 490258.0 65987.3 66867.3 67238.0 67271.7 67933.3 445.9 446.1 450.7 451.3 451.8 9609.2 9624.4 9668.0 9736.6 9737.9 31348.5 31432.0 31684.0 31927.2 32111.2 39277.4 40738.8 41574.6 41805.8 41954.0 8898.7 9046.0 9098.9 9137.8 9146.3 12135.8 15315.8 15494.4 15796.3 16429.0 13451.1 13519.5 13616.9 13862.2 13996.0 12651.7 12819.5 12871.4 13436.6 13582.3 10777.2 11122.1 11820.6 13054.9 13349.5 8585.1 8589.2 8609.6 8617.5 8710.7 9086.8 9169.6 9207.1 11002.3 11769.5 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,021 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4770.47 Median:6090.35 stddev:2412.27 (39.6%) stddev-sans-first:2404.30 16:35:16 INFO - 2015-11-20 16:35:16,023 DEBUG : BROWSER_OUTPUT: Values: 1223.3 1614.2 1662.9 1670.4 1702.3 5757.5 6587.3 6774.2 6784.9 6795.4 6420.0 6518.7 6527.8 6529.4 6537.7 1736.4 1767.9 1768.2 2030.4 2059.3 1788.6 2047.5 2080.1 2085.4 2090.6 1972.2 2017.6 2021.8 2021.9 2025.1 2045.3 2053.7 2061.4 2061.6 2063.2 2035.5 2045.4 2081.1 2082.9 2088.5 6766.4 6776.3 6794.9 6809.1 6816.1 4087.7 4143.9 4151.1 4154.0 4164.8 2670.9 2747.7 2755.3 2759.1 2799.8 854.9 865.4 866.6 893.7 900.6 9032.5 9040.8 9051.8 9051.9 9062.1 3886.7 3922.1 3991.4 3997.9 4001.6 7840.1 7843.4 7863.6 7866.2 7866.7 4208.6 4210.1 4229.3 4250.8 4253.5 3791.9 3793.6 3798.9 3800.4 3802.2 2924.6 3232.3 3284.1 3296.1 3302.2 958.8 971.3 972.8 973.6 1037.5 924.8 926.4 1002.6 1114.9 1170.9 6437.1 6493.7 6494.1 6496.4 6499.5 1026.8 1029.4 1037.9 1038.3 1059.5 5019.8 5097.9 5114.5 5120.5 5124.7 7859.3 7925.0 8103.5 8129.0 8176.8 8008.6 8101.4 8110.7 8115.2 8125.5 6023.2 6347.3 6420.4 6425.9 6480.6 6284.3 6398.5 6413.6 6416.4 6447.4 7257.3 7260.6 7280.9 7307.4 7383.0 7288.9 7384.6 7473.8 7484.8 7539.0 6091.3 6156.0 6183.2 6220.0 6254.6 6401.3 6429.0 6465.5 6490.6 6530.2 6139.5 6148.1 6235.9 6241.4 6383.8 5351.2 5540.1 5877.2 5999.0 6089.4 6216.3 6267.7 6278.0 6279.4 6283.2 5553.8 5581.6 5586.2 5601.4 5614.2 5698.9 5704.2 5712.9 5719.6 5729.2 16:35:16 INFO - 2015-11-20 16:35:16,023 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,023 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4686.73 Median:5231.04 stddev:1360.50 (26.0%) stddev-sans-first:1324.15 16:35:16 INFO - 2015-11-20 16:35:16,024 DEBUG : BROWSER_OUTPUT: Values: 314.5 318.8 319.7 323.2 324.7 5203.5 5391.2 5394.4 5410.6 5443.6 5258.6 5327.1 5328.3 5331.5 5335.5 3921.9 4033.3 4073.7 4138.9 4141.6 4114.5 4124.7 4132.5 4148.0 4179.8 4106.4 4111.6 4123.8 4143.8 4146.0 3936.5 4011.6 4047.4 4109.7 4110.1 3632.4 3642.9 3652.0 3655.8 3662.6 5100.2 5109.5 5118.1 5123.3 5132.8 4775.9 4776.6 4796.7 4800.8 4809.5 5412.4 5595.4 5597.5 5651.9 5653.0 4029.9 4062.8 4068.8 4074.2 4075.5 5837.1 5909.4 5916.5 5917.3 5918.8 4184.0 4190.4 4196.5 4198.7 4200.3 4129.6 4217.4 4219.0 4224.1 4248.1 4760.0 4767.4 4797.3 4798.8 4814.2 5560.8 5562.3 5563.4 5622.0 5624.6 1470.6 1476.4 1476.4 1477.2 1477.4 1041.8 1045.4 1046.7 1056.2 1071.5 4912.3 4928.4 4930.0 4934.2 4934.9 5837.2 5837.3 5843.4 5844.6 5851.6 4921.0 4930.2 4931.4 4931.6 4931.9 3027.2 3055.5 3071.7 3097.3 3132.9 5537.9 5542.1 5559.9 5563.7 5573.6 5997.2 6011.0 6015.1 6020.6 6023.9 5425.6 5540.5 5547.6 5553.4 5555.9 5853.2 5859.6 5863.6 5867.8 5876.8 5715.7 5718.2 5728.8 5731.3 5734.7 5543.8 5550.4 5551.3 5552.9 5559.8 4085.2 4185.7 4188.7 4190.5 4193.6 5847.2 5856.7 5857.6 5858.7 5862.1 5588.1 5609.8 5614.1 5614.2 5616.2 5455.5 5606.9 5611.7 5616.9 5643.1 5526.9 5527.8 5529.5 5532.7 5538.4 5659.1 5671.7 5675.5 5676.1 5681.3 5419.2 5520.1 5521.0 5526.5 5533.4 16:35:16 INFO - 2015-11-20 16:35:16,024 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,024 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12009.19 Median:22636.15 stddev:13309.02 (58.8%) stddev-sans-first:13319.08 16:35:16 INFO - 2015-11-20 16:35:16,025 DEBUG : BROWSER_OUTPUT: Values: 664.3 717.1 760.3 768.9 793.2 10460.2 10737.5 10739.3 10744.0 10745.4 9674.5 11738.2 11794.4 11814.9 11912.7 770.4 785.4 787.2 788.0 788.2 771.6 781.1 781.2 781.3 781.8 812.2 813.7 819.5 820.7 821.4 809.9 811.7 812.9 813.2 813.3 600.6 602.1 602.3 603.2 603.4 10152.3 10297.3 10299.9 10306.7 10309.0 9254.7 9367.8 9578.2 9709.0 9772.4 8682.3 8749.5 9284.7 9606.0 10022.2 3240.2 3264.7 3297.0 3323.6 3392.8 34663.3 35954.0 37712.2 38599.4 38680.0 9518.4 9534.7 9720.9 9759.9 9814.8 16239.6 16372.7 16372.7 16375.0 16399.0 6389.0 6426.4 6581.2 6650.8 6785.1 3471.3 3498.5 3527.7 3558.3 3565.7 2754.8 2772.4 2777.7 2778.9 2784.6 488.2 488.7 492.3 498.4 503.7 446.6 563.8 568.3 580.9 608.3 7238.1 7364.9 7407.4 7603.4 7611.7 455.8 566.6 588.3 602.1 620.8 3699.4 3720.4 3761.9 3767.2 3794.3 44816.6 45986.0 49249.5 49456.3 49643.8 36455.5 36903.0 43737.6 43968.8 44240.8 37811.4 40499.4 41637.2 41654.6 41964.6 7625.5 8054.5 8526.5 8539.3 8596.4 31984.4 32199.5 32653.2 32795.8 33736.7 36960.4 37561.8 38180.2 41020.2 41077.0 9601.5 10280.4 10387.3 10588.7 10600.7 11650.9 11781.3 11813.7 11906.5 12312.2 10298.4 10753.7 11003.0 11312.7 11360.1 10891.2 10976.3 11240.2 11259.0 11294.6 10896.1 11359.5 11372.0 11385.3 11454.0 9709.5 9721.7 9746.1 9798.8 9971.3 9322.7 9642.1 9713.2 9827.1 9854.6 16:35:16 INFO - 2015-11-20 16:35:16,026 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:35:16 INFO - 2015-11-20 16:35:16,026 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2015-11-20 16:35:16,638 INFO : Browser exited with error code: 0 16:35:16 INFO - 2015-11-20 16:35:16,656 INFO : Completed test dromaeo_css (00:18:36) 16:35:16 INFO - 2015-11-20 16:35:16,656 INFO : Starting test kraken 16:35:16 INFO - 2015-11-20 16:35:16,657 DEBUG : operating with platform_type : linux_ 16:35:16 INFO - 2015-11-20 16:35:16,657 INFO : Initialising browser for kraken test... 16:35:16 INFO - 2015-11-20 16:35:16,663 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaVhwj/profile http://localhost:57381/getInfo.html 16:35:20 INFO - 2015-11-20 16:35:20,440 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:35:20 INFO - 2015-11-20 16:35:20,440 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:35:20 INFO - 2015-11-20 16:35:20,440 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:35:20 INFO - 2015-11-20 16:35:20,440 DEBUG : BROWSER_OUTPUT: __metrics 16:35:20 INFO - 2015-11-20 16:35:20,589 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:35:21 INFO - 2015-11-20 16:35:21,782 INFO : Browser initialized. 16:35:21 INFO - 2015-11-20 16:35:21,782 INFO : Running cycle 1/1 for kraken test... 16:35:21 INFO - 2015-11-20 16:35:21,782 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaVhwj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:35:33 INFO - 2015-11-20 16:35:33,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 142245888 16:35:33 INFO - 2015-11-20 16:35:33,746 DEBUG : BROWSER_OUTPUT: 16:35:36 INFO - 2015-11-20 16:35:36,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:36 INFO - 2015-11-20 16:35:36,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 178659328 16:35:36 INFO - 2015-11-20 16:35:36,920 DEBUG : BROWSER_OUTPUT: 16:35:39 INFO - 2015-11-20 16:35:39,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-dft) 16:35:40 INFO - 2015-11-20 16:35:40,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 167452672 16:35:40 INFO - 2015-11-20 16:35:40,206 DEBUG : BROWSER_OUTPUT: 16:35:43 INFO - 2015-11-20 16:35:43,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-fft) 16:35:43 INFO - 2015-11-20 16:35:43,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 155262976 16:35:43 INFO - 2015-11-20 16:35:43,755 DEBUG : BROWSER_OUTPUT: 16:35:45 INFO - 2015-11-20 16:35:45,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57381/tests/kraken/driver.html?testName=audio-oscillator) 16:35:46 INFO - 2015-11-20 16:35:46,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 154968064 16:35:46 INFO - 2015-11-20 16:35:46,352 DEBUG : BROWSER_OUTPUT: 16:35:48 INFO - 2015-11-20 16:35:48,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:35:49 INFO - 2015-11-20 16:35:49,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 156119040 16:35:49 INFO - 2015-11-20 16:35:49,148 DEBUG : BROWSER_OUTPUT: 16:35:52 INFO - 2015-11-20 16:35:52,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-darkroom) 16:35:52 INFO - 2015-11-20 16:35:52,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 156372992 16:35:52 INFO - 2015-11-20 16:35:52,688 DEBUG : BROWSER_OUTPUT: 16:35:56 INFO - 2015-11-20 16:35:56,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57381/tests/kraken/driver.html?testName=imaging-desaturate) 16:35:56 INFO - 2015-11-20 16:35:56,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 157081600 16:35:56 INFO - 2015-11-20 16:35:56,701 DEBUG : BROWSER_OUTPUT: 16:35:59 INFO - 2015-11-20 16:35:59,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57381/tests/kraken/driver.html?testName=json-parse-financial) 16:36:00 INFO - 2015-11-20 16:36:00,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 156012544 16:36:00 INFO - 2015-11-20 16:36:00,146 DEBUG : BROWSER_OUTPUT: 16:36:01 INFO - 2015-11-20 16:36:01,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:02 INFO - 2015-11-20 16:36:02,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 166825984 16:36:02 INFO - 2015-11-20 16:36:02,436 DEBUG : BROWSER_OUTPUT: 16:36:04 INFO - 2015-11-20 16:36:04,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:04 INFO - 2015-11-20 16:36:04,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 166797312 16:36:04 INFO - 2015-11-20 16:36:04,902 DEBUG : BROWSER_OUTPUT: 16:36:07 INFO - 2015-11-20 16:36:07,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:07 INFO - 2015-11-20 16:36:07,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 174497792 16:36:07 INFO - 2015-11-20 16:36:07,608 DEBUG : BROWSER_OUTPUT: 16:36:10 INFO - 2015-11-20 16:36:10,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:10 INFO - 2015-11-20 16:36:10,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 180510720 16:36:10 INFO - 2015-11-20 16:36:10,685 DEBUG : BROWSER_OUTPUT: 16:36:13 INFO - 2015-11-20 16:36:13,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:13 INFO - 2015-11-20 16:36:13,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 180629504 16:36:13 INFO - 2015-11-20 16:36:13,854 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57381/tests/kraken/driver.html?testName=ai-astar) 16:36:15 INFO - 2015-11-20 16:36:15,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 239874048 16:36:15 INFO - 2015-11-20 16:36:15,865 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,865 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;105;112;113;112;101;112;116;113 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;131;159;170;132;155;150;139;168;130 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;160;161;160;163;161;161;161 16:36:15 INFO - 2015-11-20 16:36:15,866 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;83;93;72;74;73;103;87;73 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;125;91;92;92;129;92;92;123 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;109;109;110;110 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;147;147;146;148 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;96;96;95 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;69;69;69;69;70;85;67;67 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;69;69;69;70;70 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;82;83;82;91;81;82;84;85;102 16:36:15 INFO - 2015-11-20 16:36:15,867 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;115;118;114;119;126;128;126;120;126 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;136;146;153;146;138;146;146;145;133 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;67;68;68;68;68;71;69;69 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:36:15 INFO - 2015-11-20 16:36:15,868 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066175860__endTimestamp 16:36:15 INFO - 2015-11-20 16:36:15,869 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:4.49 (4.0%) stddev-sans-first:4.76 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 105.0 112.0 113.0 112.0 101.0 112.0 116.0 113.0 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:152.50 stddev:14.95 (9.8%) stddev-sans-first:15.84 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: Values: 150.0 131.0 159.0 170.0 132.0 155.0 150.0 139.0 168.0 130.0 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 16:36:15 INFO - 2015-11-20 16:36:15,870 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 160.0 161.0 160.0 163.0 161.0 161.0 161.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:10.73 (14.5%) stddev-sans-first:11.03 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 83.0 93.0 72.0 74.0 73.0 103.0 87.0 73.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.00 Median:92.00 stddev:16.40 (17.8%) stddev-sans-first:16.99 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 125.0 91.0 92.0 92.0 129.0 92.0 92.0 123.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 148.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 16:36:15 INFO - 2015-11-20 16:36:15,871 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.30 Median:69.00 stddev:5.25 (7.6%) stddev-sans-first:5.55 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 70.0 85.0 67.0 67.0 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 70.0 70.0 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.00 stddev:6.45 (7.8%) stddev-sans-first:6.78 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: Values: 83.0 82.0 83.0 82.0 91.0 81.0 82.0 84.0 85.0 102.0 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:123.00 stddev:5.08 (4.1%) stddev-sans-first:5.27 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: Values: 118.0 115.0 118.0 114.0 119.0 126.0 128.0 126.0 120.0 126.0 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:146.00 stddev:6.58 (4.5%) stddev-sans-first:6.26 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: Values: 134.0 136.0 146.0 153.0 146.0 138.0 146.0 146.0 145.0 133.0 16:36:15 INFO - 2015-11-20 16:36:15,872 DEBUG : BROWSER_OUTPUT: 16:36:15 INFO - 2015-11-20 16:36:15,873 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.13 16:36:15 INFO - 2015-11-20 16:36:15,873 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 67.0 68.0 68.0 68.0 68.0 71.0 69.0 69.0 16:36:15 INFO - 2015-11-20 16:36:15,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:36:15 INFO - 2015-11-20 16:36:15,873 DEBUG : BROWSER_OUTPUT: 16:36:16 INFO - 2015-11-20 16:36:16,830 INFO : Browser exited with error code: 0 16:36:16 INFO - 2015-11-20 16:36:16,883 INFO : Completed test kraken (00:01:00) 16:36:16 INFO - 2015-11-20 16:36:16,883 INFO : Starting test v8_7 16:36:16 INFO - 2015-11-20 16:36:16,883 DEBUG : operating with platform_type : linux_ 16:36:16 INFO - 2015-11-20 16:36:16,883 INFO : Initialising browser for v8_7 test... 16:36:16 INFO - 2015-11-20 16:36:16,889 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7m9Erg/profile http://localhost:57381/getInfo.html 16:36:20 INFO - 2015-11-20 16:36:20,611 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:36:20 INFO - 2015-11-20 16:36:20,611 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:36:20 INFO - 2015-11-20 16:36:20,611 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:36:20 INFO - 2015-11-20 16:36:20,611 DEBUG : BROWSER_OUTPUT: __metrics 16:36:20 INFO - 2015-11-20 16:36:20,733 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:21 INFO - 2015-11-20 16:36:21,909 INFO : Browser initialized. 16:36:21 INFO - 2015-11-20 16:36:21,910 INFO : Running cycle 1/1 for v8_7 test... 16:36:21 INFO - 2015-11-20 16:36:21,910 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7m9Erg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:36:33 INFO - 2015-11-20 16:36:33,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 16:36:33 INFO - 2015-11-20 16:36:33,892 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57381/tests/v8_7/run.html (next: http://localhost:57381/tests/v8_7/run.html) 16:36:55 INFO - 2015-11-20 16:36:55,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 444354560 16:36:55 INFO - 2015-11-20 16:36:55,568 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: |0;Richards;163.371998039536 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.12295869356387 16:36:55 INFO - 2015-11-20 16:36:55,569 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.4467120181406 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2042.857142857143 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |5;Earley;778.816199376947 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 16:36:55 INFO - 2015-11-20 16:36:55,570 DEBUG : BROWSER_OUTPUT: |8;Splay;627.0337922403004 16:36:55 INFO - 2015-11-20 16:36:55,571 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:36:55 INFO - 2015-11-20 16:36:55,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:36:55 INFO - 2015-11-20 16:36:55,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066215567__endTimestamp 16:36:55 INFO - 2015-11-20 16:36:55,571 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,572 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:36:55 INFO - 2015-11-20 16:36:55,572 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:36:55 INFO - 2015-11-20 16:36:55,572 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,573 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.37 Median:163.37 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,573 DEBUG : BROWSER_OUTPUT: Values: 163.4 16:36:55 INFO - 2015-11-20 16:36:55,573 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,573 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.12 Median:192.12 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,573 DEBUG : BROWSER_OUTPUT: Values: 192.1 16:36:55 INFO - 2015-11-20 16:36:55,574 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,574 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,574 DEBUG : BROWSER_OUTPUT: Values: 283.4 16:36:55 INFO - 2015-11-20 16:36:55,574 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,575 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,575 DEBUG : BROWSER_OUTPUT: Values: 5076.1 16:36:55 INFO - 2015-11-20 16:36:55,575 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,575 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2042.86 Median:2042.86 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,576 DEBUG : BROWSER_OUTPUT: Values: 2042.9 16:36:55 INFO - 2015-11-20 16:36:55,576 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,576 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,576 DEBUG : BROWSER_OUTPUT: Values: 778.8 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: Values: 12216.9 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,577 DEBUG : BROWSER_OUTPUT: Values: 26736.8 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:627.03 Median:627.03 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: Values: 627.0 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:36:55 INFO - 2015-11-20 16:36:55,578 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,622 INFO : Browser exited with error code: 0 16:36:56 INFO - 2015-11-20 16:36:56,636 INFO : Completed test v8_7 (00:00:39) 16:36:57 INFO - 2015-11-20 16:36:57,073 INFO : Completed test suite (00:20:17) 16:36:57 INFO - 2015-11-20 16:36:57,073 DEBUG : Working with test: dromaeo_css 16:36:57 INFO - 2015-11-20 16:36:57,074 DEBUG : Generating results file: dromaeo_css 16:36:57 INFO - 2015-11-20 16:36:57,075 DEBUG : Working with test: kraken 16:36:57 INFO - 2015-11-20 16:36:57,075 DEBUG : Generating results file: kraken 16:36:57 INFO - 2015-11-20 16:36:57,075 INFO : javascript benchmark 16:36:57 INFO - 2015-11-20 16:36:57,076 DEBUG : Working with test: v8_7 16:36:57 INFO - 2015-11-20 16:36:57,076 DEBUG : Generating results file: v8_7 16:36:57 INFO - 2015-11-20 16:36:57,076 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:36:57 INFO - 2015-11-20 16:36:57,130 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 16:36:57 INFO - 2015-11-20 16:36:57,130 DEBUG : process_Request line: dromaeo_css 6191.09 graph.html#tests=[[72,94,35]] 16:36:57 INFO - 2015-11-20 16:36:57,130 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:36:57 INFO - 2015-11-20 16:36:57,161 DEBUG : process_Request line: kraken 1510.40 graph.html#tests=[[232,94,35]] 16:36:57 INFO - 2015-11-20 16:36:57,161 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:36:57 INFO - 2015-11-20 16:36:57,190 DEBUG : process_Request line: v8_7 19687.34 graph.html#tests=[[230,94,35]] 16:36:57 INFO - 2015-11-20 16:36:57,192 INFO : javascript benchmark 16:36:57 INFO - 2015-11-20 16:36:57,195 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.2898217481275, 2740.7807375409957, 2745.3960128771664, 2751.834889906606, 2771.930701732456, 4437.84467543636, 4542.750148741826, 4676.20504514233, 4688.343631891534, 4718.551737584929, 4579.290210017444, 4586.876215327241, 4607.216773148564, 4656.231721765905, 4686.648501362394, 4252.617264446199, 4269.722468039583, 4270.338097594878, 4341.717788343748, 4348.97825510872, 4325.0, 4329.242382583036, 4379.189849877767, 4387.978060109711, 4416.072624748806, 4089.079957009649, 4179.519355274152, 4181.1010632714115, 4310.413196922828, 4357.4988876279, 4329.588689074533, 4362.607365337103, 4375.47494300686, 4380.123975204971, 4387.034852332514, 4312.568743125694, 4319.82720691172, 4332.675049371278, 4348.782560871975, 4360.956390436087, 4392.758398288093, 4537.455505339381, 4538.251188553884, 4634.281686338623, 4687.367205427257, 4944.159492886218, 5002.399712034579, 5023.196288593844, 5025.0, 5068.594512438996, 5078.339815823956, 5099.949000509984, 5100.617453690951, 5102.183650615921, 5154.639175257734, 4434.423524941737, 4552.7495987720995, 4557.521460246693, 4733.290006499018, 4748.430188377417, 5116.9744151279, 5216.165413533817, 5223.0, 5246.108161612535, 5257.947420525822, 4966.354373931365, 4982.8754281143265, 4984.725840078758, 4985.925211121836, 5036.79852805891, 4795.088933102699, 4894.412670479494, 4900.901981960341, 5066.645334826527, 5074.695518268915, 4853.4418541867435, 4930.383702037246, 4931.087748766489, 4932.975335123373, 4966.404031516241, 4920.0, 4921.237208232729, 4924.655274130848, 4926.729029903318, 4959.752012399365, 3925.7448265862627, 4022.0950286185375, 4131.029208136086, 4141.97929010353, 4186.644135248477, 3545.982270088685, 3624.329499042633, 3658.1037645776955, 3677.3932301170544, 3712.6844218241213, 4296.076343586082, 4299.0, 4310.956890431118, 4319.200947824663, 4338.674599404994, 4812.759362031955, 4965.155923493015, 5005.724685142352, 5017.523335283142, 5019.623528235397, 4243.511996120424, 4257.10600773841, 4273.636740876998, 4353.564643535621, 4361.062371590124, 4445.444319460067, 4478.0, 4479.924818043646, 4495.213337665896, 4527.932081018787, 4815.927761083586, 4832.540908613676, 4837.637177211794, 4838.322634831196, 4880.41435027799, 4799.328094066764, 4921.63087768426, 4923.729194894315, 4932.53140951609, 5076.162433198481, 4746.050789842115, 4767.952320476889, 4775.617950564016, 4777.355057067251, 4811.08589368033, 4963.404391472902, 4963.975180124076, 4969.279454479152, 4976.527229913152, 5024.070546948826, 4787.0904528139545, 4894.877628059327, 4919.065377578248, 4929.679570827885, 5038.042771873333, 4853.466118726867, 4890.657653964188, 4902.142125128017, 4903.0, 4940.505949405031, 4875.609951203966, 4879.316895634685, 4882.658213924991, 4888.2178851383605, 4924.926126108183, 4481.417415735934, 4623.491415944311, 4623.976880115578, 4704.835330763407, 4828.66199366041, 4843.782029808596, 4847.757612119451, 4848.5636292733825, 4851.56335929768, 4950.8762280943265, 4739.21802902531, 4749.738764367993, 4751.287306903854, 4763.4522029967, 4794.616430685606], "unit": "ms", "name": "dojo.html", "value": 4580.8880497387}, {"lowerIsBetter": false, "replicates": [559.312253081396, 573.8192469372145, 581.8574449259931, 584.0917373484232, 594.6788734083593, 27523.724762752365, 36681.26637467252, 37073.814630926805, 37118.62881371185, 37142.44286335707, 40063.599364006426, 40529.18941621166, 40553.59446405535, 40615.18769624606, 40700.18599628006, 7000.474964377667, 7138.571685698875, 7986.640601172947, 8157.469764465291, 8160.5103693778265, 10196.898031019706, 10433.061024507793, 10447.477626118702, 10451.268411211218, 10459.372437653727, 10146.695599132037, 10290.382577045364, 10315.0, 10317.380957142557, 10320.948395258014, 7201.13586369639, 7383.963080184619, 10150.13723833475, 10209.0, 10227.437490937995, 9974.551145198411, 10111.64609238673, 10112.696619101438, 10115.595376184943, 10115.898841011644, 37135.25729485395, 37660.81169594162, 37675.811620942, 37677.81161094177, 37699.0, 2786.2616406652255, 2803.327201471632, 2808.8455134967567, 2815.408764159529, 2848.572714092882, 28496.430071398663, 28601.85699071512, 28611.177122940273, 28673.85663071692, 29378.70621293781, 3279.4542193159873, 3311.172206948263, 3319.0, 3416.8120753358558, 3429.8456569454434, 222717.0, 223984.0, 225627.0, 226143.0, 226500.0, 46935.765321173174, 48098.759506202245, 55878.72060639671, 56250.718746406004, 56254.156187657216, 59384.10923836146, 60686.69656651777, 60931.39068609346, 61028.38971610316, 61032.69483652642, 12582.87417125817, 12751.36243187837, 12760.553380631633, 12774.9361253195, 12876.356182190853, 8679.47923124602, 8697.565121743888, 8703.825923481621, 8718.910136232971, 8735.344849136212, 18371.448856534324, 19184.232630694616, 19339.226430942606, 19415.90292048559, 19455.3190638327, 6873.0, 7217.422606191492, 7249.601271930094, 7283.635818209068, 7326.67029983652, 838.7022606974558, 864.9524276164872, 894.18182363137, 944.2776276148752, 1028.5011769291887, 25724.48551028969, 26157.73842261553, 26339.209823705318, 26571.46857062848, 26602.6009609856, 962.1965658675085, 963.937344072633, 1004.4174378860243, 1016.065219997604, 1031.2832581356035, 13675.31623418825, 13827.0, 14006.50977215813, 14073.577792666236, 14077.507287244896, 271371.0, 275955.0, 276032.0, 276623.0, 276981.0, 45535.77232113818, 45669.543304567196, 45697.54302456933, 45748.3137752934, 45766.542334576894, 1180.2800291821982, 1194.4386138514883, 1196.497471062156, 1196.7202479276991, 1204.897583705395, 24827.627585586593, 25535.744642553338, 26080.478390432465, 26128.34679133037, 26266.606000909618, 35542.0, 36311.45532816957, 40550.59449405468, 41571.37642935298, 41668.45818105495, 212405.0, 213622.0, 213698.0, 213973.0, 214626.0, 23876.283711488682, 24393.39016524601, 27170.864145679145, 27218.047368342013, 27578.0, 36454.27091458103, 36864.26271474609, 37717.81141094387, 38405.4239186418, 38716.61283387243, 29226.853865730536, 31551.053468395985, 31688.366232674758, 32393.190170245933, 32964.835175823966, 32324.0, 32999.17502062372, 33038.33923321568, 33823.4926476108, 35342.64657353394, 32124.518132227568, 32523.51214731828, 32718.182045449055, 32789.67210327866, 32953.505697415036, 28416.28959275952, 28726.569101463912, 29617.851910740308, 29625.85187074051, 29667.40665186641, 22640.207592734176, 22733.0, 22990.0, 23148.421289467897, 23276.6508502376], "unit": "ms", "name": "ext.html", "value": 16926.836386739178}, {"lowerIsBetter": false, "replicates": [337.569598761579, 338.7087105089624, 339.4111217038438, 340.5011657921145, 341.79663100455235, 12366.629001129959, 12774.42515086821, 15168.241587920602, 15294.476411392121, 16489.670206595874, 12357.691057723561, 12370.628881133558, 12431.067669924747, 13506.729865402685, 13960.30198490074, 4998.625103117262, 5007.724575148365, 5157.48425157485, 5158.27784110223, 5162.0, 3510.4909788080713, 3619.6561326674055, 5766.711664416784, 6005.909911351311, 6026.0659597762415, 5809.244798176232, 5946.345901950782, 5957.970210148965, 5962.195103661015, 5981.431763982415, 5944.138099975501, 5946.583739138262, 5948.524118070565, 5959.821205363846, 5961.5230781537375, 5132.666376685504, 5181.248718935733, 5209.244659524347, 5230.92153617696, 5230.947690523084, 19018.714719279084, 19031.333903313454, 19042.52393690155, 19187.90406047961, 19420.0, 1854.9258029678797, 1890.7447494588191, 1896.1088288504382, 1914.2821441959265, 2078.646630072891, 12583.496660133584, 12641.178323408949, 12802.231866087972, 12889.484420623165, 13004.349782510837, 1703.3385236074575, 1704.9318027278894, 1731.2901710298718, 1734.5750291178615, 1759.7096479080935, 52740.73629631865, 52860.47139528594, 53138.46861531412, 53648.0, 54473.1829022565, 9225.584848681825, 9349.953250233706, 9486.335956483117, 9500.904990950141, 9573.994730553331, 12131.878681213251, 12151.939240303918, 12157.386161975217, 12169.756604867853, 12171.634850954486, 6535.313792051861, 6625.105610742585, 6634.402903738686, 6723.428508576826, 6855.348741869514, 6188.319284878659, 6490.0, 6594.07682924391, 6598.37315455031, 6608.86782264352, 5636.549076073904, 5716.5140963017775, 5737.713114344266, 5747.971260143672, 5803.883922321615, 1541.4373753579862, 1625.1792844613394, 1640.5078476457015, 1690.7548405481382, 1696.8897021693551, 414.0291017563808, 876.9254613357808, 944.4616568555995, 959.2134449751277, 977.9706608801747, 8288.50268983863, 9435.858462123073, 9870.21038316933, 9936.602535898483, 10040.849387259197, 399.3909288335312, 407.76349717163976, 408.80377418839123, 411.36854927686454, 413.9606737360006, 5468.0, 5481.451854814487, 5640.943590564124, 5736.827895163152, 5745.482906538432, 463339.0, 466789.0, 469586.0, 472859.0, 490258.0, 65987.34012659908, 66867.33132668708, 67238.0, 67271.66364168246, 67933.32066679369, 445.93979812724865, 446.1456311164084, 450.6800171877938, 451.3230154767848, 451.7876597998935, 9609.231261498924, 9624.37441566296, 9668.0, 9736.561854716412, 9737.853932190881, 31348.52977205298, 31432.0, 31683.99999999908, 31927.201819954687, 32111.197220069684, 39277.41083883801, 40738.79630601828, 41574.584254157075, 41805.79097104617, 41954.0, 8898.688545900863, 9046.0, 9098.909010909807, 9137.817243655223, 9146.268298536233, 12135.757284854077, 15315.77026344628, 15494.380224790882, 15796.289166987743, 16429.0, 13451.058425910483, 13519.526816561372, 13616.93191534036, 13862.168269903837, 13996.0, 12651.683707907376, 12819.487220511075, 12871.356432178542, 13436.596902092953, 13582.320883955961, 10777.245592808742, 11122.110231181648, 11820.586279480176, 13054.934725326313, 13349.532766353132, 8585.141485851365, 8589.184027517376, 8609.569521524025, 8617.526036068077, 8710.738677839676, 9086.818263634557, 9169.587368568296, 9207.079292070739, 11002.33985960845, 11769.52921883115], "unit": "ms", "name": "jquery.html", "value": 7595.133348804383}, {"lowerIsBetter": false, "replicates": [1223.2660403757752, 1614.1525699008018, 1662.9191025833206, 1670.38195867529, 1702.2765324736984, 5757.453041961012, 6587.2753997060345, 6774.153230846145, 6784.864302713949, 6795.422389096932, 6419.967900160493, 6518.739250429977, 6527.771527996521, 6529.444997175246, 6537.738490460376, 1736.435658411015, 1767.8585713142982, 1768.1954710606642, 2030.3908827351809, 2059.3101311060814, 1788.570743021672, 2047.467658408817, 2080.1471396727343, 2085.447356450542, 2090.6341390256644, 1972.2406873353718, 2017.5863947890648, 2021.8180363767258, 2021.878687278768, 2025.0988310201967, 2045.3250427358935, 2053.743282089739, 2061.4331058958755, 2061.597988392264, 2063.2366024570856, 2035.542003049317, 2045.3557129504159, 2081.1363284237023, 2082.854200205986, 2088.4778805298674, 6766.391024807742, 6776.2546119926765, 6794.898076528856, 6809.080774095483, 6816.147981502312, 4087.713860029799, 4143.937840932388, 4151.14901445203, 4154.023804405962, 4164.7917604119975, 2670.8664566771586, 2747.7252274772563, 2755.2836262571677, 2759.1446651538085, 2799.818011829245, 854.8760429737653, 865.3639574912435, 866.5840396609663, 893.7006102955518, 900.6127365232948, 9032.458052516804, 9040.819183616291, 9051.818963620757, 9051.864222036675, 9062.093790620951, 3886.689064874803, 3922.1371298314325, 3991.4212439196735, 3997.920041599152, 4001.639852413297, 7840.09838868526, 7843.4117441191, 7863.606819659109, 7866.174051724601, 7866.72466463671, 4208.621224089847, 4210.052738133895, 4229.281022226229, 4250.808713607895, 4253.532111467736, 3791.8862434127022, 3793.5827059023486, 3798.9430158547643, 3800.3729384651224, 3802.1825307559006, 2924.5905573219766, 3232.337370838972, 3284.080457471912, 3296.0935742670476, 3302.1909632140278, 958.8130314588589, 971.3103696375653, 972.8151651186251, 973.6202880876323, 1037.486444210121, 924.847400178963, 926.3654396738256, 1002.5638847101534, 1114.8517027461728, 1170.9238899471507, 6437.130987316746, 6493.675316234169, 6494.090827284184, 6496.447801936793, 6499.480041596661, 1026.8408396698374, 1029.4441001858913, 1037.8598889150019, 1038.2628333883029, 1059.5179193466954, 5019.824306149268, 5097.898042039138, 5114.462981386975, 5120.462351453044, 5124.718140502234, 7859.292663660298, 7925.0489941207425, 8103.513789172668, 8129.0, 8176.754697359089, 8008.599570021475, 8101.392395570356, 8110.716124935599, 8115.188481151838, 8125.4718443301, 6023.1567580537885, 6347.333529979378, 6420.357964203542, 6425.9036114457385, 6480.611163330215, 6284.340144284784, 6398.4561312287115, 6413.615183089029, 6416.358364163546, 6447.3552644735155, 7257.346838784535, 7260.564366138048, 7280.9271907280245, 7307.426331212248, 7382.966384706253, 7288.890666640111, 7384.556926584422, 7473.775786726407, 7484.812879678052, 7539.0, 6091.269047714125, 6156.0, 6183.227096612924, 6219.968900155652, 6254.6247225166635, 6401.29585745577, 6429.0, 6465.515086368447, 6490.643014634241, 6530.151080359523, 6139.539534534839, 6148.139260503623, 6235.875282494416, 6241.367317533805, 6383.840403989938, 5351.170568561879, 5540.141278101901, 5877.235959325431, 5999.0, 6089.421504957022, 6216.347283535345, 6267.655278959701, 6278.0, 6279.372062793684, 6283.183186185949, 5553.8333849984565, 5581.5813813963305, 5586.162075688517, 5601.355844077983, 5614.157876318422, 5698.914516282176, 5704.201411802268, 5712.942870571407, 5719.57103217252, 5729.223940578434], "unit": "ms", "name": "mootools.html", "value": 3951.21269950659}, {"lowerIsBetter": false, "replicates": [314.45913029589104, 318.7784489779604, 319.70906475107654, 323.20330385599493, 324.6850554961686, 5203.4796520347945, 5391.218273350361, 5394.379646340672, 5410.648307859996, 5443.564514838813, 5258.605604579653, 5327.121025030875, 5328.254044433782, 5331.466853314667, 5335.493128152829, 3921.8823435296986, 4033.2538480381077, 4073.674106071522, 4138.937915931256, 4141.585841415849, 4114.547399786021, 4124.670026397881, 4132.462779838616, 4148.045949431633, 4179.79101044948, 4106.3635136553885, 4111.629953304202, 4123.793810309473, 4143.8342466301465, 4146.046409325857, 3936.4882565266475, 4011.5587285398583, 4047.413125096874, 4109.650679692199, 4110.136871257039, 3632.418812989909, 3642.908927276813, 3651.9634803652157, 3655.798931058791, 3662.5788034376124, 5100.234964755279, 5109.489051094898, 5118.053160165344, 5123.257127716461, 5132.820351287687, 4775.904481910377, 4776.5701086902, 4796.688215265996, 4800.759962001921, 4809.470958194595, 5412.3505179378335, 5595.38450770415, 5597.524210442118, 5651.9152212716845, 5652.971735141339, 4029.879103626896, 4062.837486500536, 4068.7965601719798, 4074.185162967389, 4075.53131389891, 5837.095250236178, 5909.379515150933, 5916.497097746696, 5917.319508256563, 5918.7928422505, 4183.954011497126, 4190.350495673176, 4196.454460920122, 4198.706090573631, 4200.348945913388, 4129.648979836687, 4217.40956266123, 4219.0, 4224.070704445078, 4248.065425606362, 4759.976200119047, 4767.427908650984, 4797.328374027639, 4798.832040878552, 4814.15752243356, 5560.77756889728, 5562.332520097614, 5563.443655634404, 5621.971890140523, 5624.578156638187, 1470.6396932751545, 1476.365162979929, 1476.402057166849, 1477.231839443505, 1477.4311889922242, 1041.796849614318, 1045.3675526306474, 1046.7173863056933, 1056.2395075545594, 1071.5124618298655, 4912.287718280829, 4928.383952005999, 4930.038642464757, 4934.18585933317, 4934.9013019739405, 5837.182794408701, 5837.3287071986415, 5843.386444423274, 5844.649321040752, 5851.64890106595, 4920.950790492121, 4930.1865192243595, 4931.3835770528685, 4931.605471562267, 4931.852044438672, 3027.1826606816476, 3055.4771210747476, 3071.7081877221626, 3097.3185899102164, 3132.903483780704, 5537.889242215133, 5542.140968149944, 5559.916601250984, 5563.666180029211, 5573.6098473106495, 5997.160397544348, 6011.0, 6015.0977353396465, 6020.57855950088, 6023.879522409527, 5425.565954723613, 5540.473655002768, 5547.55619550435, 5553.416891226363, 5555.944440555704, 5853.239078919713, 5859.619124756877, 5863.589548731547, 5867.823965281048, 5876.794312199053, 5715.714214289185, 5718.199452076796, 5728.79949201776, 5731.312242530923, 5734.7132643368495, 5543.750531226186, 5550.38945715979, 5551.25058117149, 5552.916706249329, 5559.832435188656, 4085.1829634073897, 4185.66514678831, 4188.748675079505, 4190.476190476191, 4193.580641935782, 5847.239858818326, 5856.677882716321, 5857.619254748428, 5858.7070646468355, 5862.091375836752, 5588.133839254922, 5609.775608975595, 5614.07367784311, 5614.157876318585, 5616.157576363578, 5455.509004189484, 5606.85982850432, 5611.719414029364, 5616.887662246814, 5643.125315576092, 5526.917096243479, 5527.778888844562, 5529.502344788988, 5532.6680399176175, 5538.418466061166, 5659.122835960433, 5671.688057156896, 5675.517581005661, 5676.091825307931, 5681.318241811009, 5419.214213939035, 5520.089185284383, 5520.972395137998, 5526.530244929226, 5533.418991005887], "unit": "ms", "name": "prototype.html", "value": 4257.894362270551}, {"lowerIsBetter": false, "replicates": [664.3058004385417, 717.1322699533564, 760.3043215457857, 768.8616049111158, 793.1711361627096, 10460.215483838714, 10737.463126843646, 10739.301945373545, 10744.0, 10745.409002504859, 9674.51627418628, 11738.237014594046, 11794.410279486014, 11814.881851181508, 11912.702182445442, 770.3952397368054, 785.3599316557016, 787.1538096546207, 787.9606019699021, 788.203914046814, 771.6180490657133, 781.1017330070435, 781.1875649324724, 781.3007358414216, 781.8279978404742, 812.155358427235, 813.6907974969504, 819.4673462249526, 820.7004443378154, 821.4126899267023, 809.8866158737782, 811.6672164412621, 812.9227723366271, 813.1502579804119, 813.308687615531, 600.5585894367637, 602.1329285828436, 602.2592211579781, 603.2097951683265, 603.3574243430776, 10152.340097893688, 10297.279190456671, 10299.897001029969, 10306.7423314417, 10309.0, 9254.722358329262, 9367.76580585484, 9578.185854202331, 9709.0, 9772.41365518064, 8682.30541556674, 8749.47503149813, 9284.675036373694, 9606.039396060338, 10022.248331375176, 3240.1575590346442, 3264.7061764441078, 3297.0, 3323.6344002159744, 3392.7794693344854, 34663.30673386544, 35954.0, 37712.245755085016, 38599.42100868489, 38680.0, 9518.428894266366, 9534.666286679932, 9720.90279097214, 9759.853602195974, 9814.75463113428, 16239.594010149605, 16372.672546549002, 16372.672546549002, 16375.0, 16399.0, 6389.041643753474, 6426.35736426363, 6581.2102547694585, 6650.833729156713, 6785.050092986986, 3471.271033083081, 3498.4927185557954, 3527.735419843522, 3558.323918455485, 3565.6790888820133, 2754.807163498576, 2772.4039331543413, 2777.7361150690654, 2778.902738404146, 2784.635528590976, 488.20422710980876, 488.699449838354, 492.2517772985043, 498.4243199105039, 503.68771361755944, 446.63822303933915, 563.8083051762338, 568.3407247592772, 580.8722081142142, 608.2974164839617, 7238.148039977608, 7364.889526657104, 7407.370373518203, 7603.4297427693145, 7611.733589324347, 455.7561704488083, 566.6260268222953, 588.2969851028066, 602.111884969675, 620.7796232337546, 3699.445083237482, 3720.404735242348, 3761.8683346082757, 3767.246550689873, 3794.298054859805, 44816.55183448189, 45986.0, 49249.50750492449, 49456.25815612769, 49643.75178124086, 36455.4531682025, 36903.0, 43737.56262437398, 43968.78015609965, 44240.77879610581, 37811.432828507044, 40499.367541109736, 41637.1672566547, 41654.58345416507, 41964.58035419607, 7625.542467451971, 8054.516728996279, 8526.488410695378, 8539.316854651488, 8596.441231319945, 31984.36031279408, 32199.51700724444, 32653.18367040843, 32795.83602081974, 33736.66263337335, 36960.44559331666, 37561.81219093887, 38180.236395271386, 41020.1795964085, 41077.0, 9601.519924003911, 10280.434576098387, 10387.324823886423, 10588.682339529827, 10600.681979540626, 11650.941745291218, 11781.293122412682, 11813.704657383634, 11906.52373905034, 12312.199707019015, 10298.38447901315, 10753.731156721145, 11003.0, 11312.717182070513, 11360.09119270473, 10891.183161263096, 10976.286541375104, 11240.156988225752, 11259.042981346678, 11294.60468883618, 10896.12830973536, 11359.54561817551, 11372.0, 11385.316880986837, 11454.0, 9709.5145242739, 9721.659741909, 9746.060373560864, 9798.77254234912, 9971.252156088178, 9322.673706420243, 9642.132208101024, 9713.201851079644, 9827.11555959967, 9854.605815767289], "unit": "ms", "name": "yui.html", "value": 5682.908072774301}], "name": "dromaeo_css", "value": 6191.088025284334}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 105.0, 112.0, 113.0, 112.0, 101.0, 112.0, 116.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 159.0, 170.0, 132.0, 155.0, 150.0, 139.0, 168.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 163.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 83.0, 93.0, 72.0, 74.0, 73.0, 103.0, 87.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 125.0, 91.0, 92.0, 92.0, 129.0, 92.0, 92.0, 123.0], "unit": "ms", "name": "audio-oscillator", "value": 102.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 85.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 82.0, 91.0, 81.0, 82.0, 84.0, 85.0, 102.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 118.0, 114.0, 119.0, 126.0, 128.0, 126.0, 120.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [134.0, 136.0, 146.0, 153.0, 146.0, 138.0, 146.0, 146.0, 145.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1510.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.371998039536], "unit": "score", "name": "Richards", "value": 216.08354200000005}, {"lowerIsBetter": false, "replicates": [192.12295869356387], "unit": "score", "name": "DeltaBlue", "value": 344.1441900000001}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5076.1421319796955], "unit": "score", "name": "Decrypt", "value": 52.43765699999998}, {"lowerIsBetter": false, "replicates": [2042.857142857143], "unit": "score", "name": "RayTrace", "value": 362.23237762237744}, {"lowerIsBetter": false, "replicates": [778.816199376947], "unit": "score", "name": "Earley", "value": 855.7384919999998}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [627.0337922403004], "unit": "score", "name": "Splay", "value": 129.96269261477048}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19687.344870991663}]} 16:36:57 INFO - RETURN: dromaeo_css: 6191.09 16:36:57 INFO - RETURN: kraken: 1510.40 16:36:57 INFO - RETURN: v8_7: 19687.34 16:36:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19687.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1510.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6191.09"}}} 16:36:57 INFO - Return code: 0 16:36:57 INFO - # TBPL SUCCESS # 16:36:57 INFO - Running post-action listener: _resource_record_post_action 16:36:57 INFO - Running post-run listener: _resource_record_post_run 16:36:58 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520085504; Read time: 12; Write time: 408484 16:36:58 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 230993920; Read time: 0; Write time: 236240 16:36:58 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 289091584; Read time: 0; Write time: 172244 16:36:58 INFO - Running post-run listener: _upload_blobber_files 16:36:58 INFO - Blob upload gear active. 16:36:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:36:58 INFO - Copying logs to upload dir... 16:36:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1259.347119 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-20 16:36:58.247791) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:36:58.251130) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010075 build_url: 'https://queue.taskcluster.net/v1/task/9ldJHtxCRZKJyamt5KEZ1Q/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-20 16:36:58.301863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:36:58.302179) ========= 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=d3f2be9b0713ec03b22325b2000001be-1448064957.552692-1065576141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:36:58.351569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:36:58.351907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:36:58.352196) ========= ========= Total master_lag: 0.20 =========