builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-053 starttime: 1448358933.35 results: success (0) buildid: 20151124012131 builduid: e5f74d643fef453f9a894c006d40420f revision: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.351133) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.351628) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.351933) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006477 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.386109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.389813) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.512189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.518550) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.565653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.565919) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.566260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.570630) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 01:55:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.2M=0s 2015-11-24 01:55:33 (73.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176883 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.813069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.813373) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014722 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:33.874436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 01:55:33.874815) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe --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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 01:55:34,058 truncating revision to first 12 chars 2015-11-24 01:55:34,059 Setting DEBUG logging. 2015-11-24 01:55:34,059 attempt 1/10 2015-11-24 01:55:34,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d1be94ff95a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 01:55:34,789 unpacking tar archive at: fx-team-9d1be94ff95a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.013295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 01:55:34.906577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:34.907041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:34.917318) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:34.917665) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 01:55:34.918136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-24 01:55:34.918458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:55:35 INFO - MultiFileLogger online at 20151124 01:55:35 in /builds/slave/test 01:55:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:55:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:55:35 INFO - {'append_to_log': False, 01:55:35 INFO - 'base_work_dir': '/builds/slave/test', 01:55:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:55:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:55:35 INFO - 'branch': 'Fx-Team-Non-PGO', 01:55:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:55:35 INFO - 'config_files': ('talos/linux_config.py',), 01:55:35 INFO - 'default_actions': ('clobber', 01:55:35 INFO - 'read-buildbot-config', 01:55:35 INFO - 'download-and-extract', 01:55:35 INFO - 'populate-webroot', 01:55:35 INFO - 'create-virtualenv', 01:55:35 INFO - 'install', 01:55:35 INFO - 'run-tests'), 01:55:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:55:35 INFO - 'download_minidump_stackwalk': True, 01:55:35 INFO - 'download_symbols': 'ondemand', 01:55:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:55:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:55:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:55:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:55:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:55:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:55:35 INFO - 'installer_path': 'installer.exe', 01:55:35 INFO - 'log_level': 'info', 01:55:35 INFO - 'log_name': 'talos', 01:55:35 INFO - 'log_to_console': True, 01:55:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:55:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:55:35 INFO - 'opt_config_files': (), 01:55:35 INFO - 'pip_index': False, 01:55:35 INFO - 'sps_profile': False, 01:55:35 INFO - 'sps_profile_interval': 0, 01:55:35 INFO - 'suite': 'dromaeojs', 01:55:35 INFO - 'system_bits': '64', 01:55:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:55:35 INFO - 'title': 'talos-linux64-ix-053', 01:55:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:55:35 INFO - 'use_talos_json': True, 01:55:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:55:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:55:35 INFO - 'work_dir': 'build'} 01:55:35 INFO - ##### 01:55:35 INFO - ##### Running clobber step. 01:55:35 INFO - ##### 01:55:35 INFO - Running pre-action listener: _resource_record_pre_action 01:55:35 INFO - Running main action method: clobber 01:55:35 INFO - rmtree: /builds/slave/test/build 01:55:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:55:35 INFO - Running post-action listener: _resource_record_post_action 01:55:35 INFO - ##### 01:55:35 INFO - ##### Running read-buildbot-config step. 01:55:35 INFO - ##### 01:55:35 INFO - Running pre-action listener: _resource_record_pre_action 01:55:35 INFO - Running main action method: read_buildbot_config 01:55:35 INFO - Using buildbot properties: 01:55:35 INFO - { 01:55:35 INFO - "properties": { 01:55:35 INFO - "buildnumber": 915, 01:55:35 INFO - "product": "firefox", 01:55:35 INFO - "script_repo_revision": "production", 01:55:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:55:35 INFO - "repository": "", 01:55:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:55:35 INFO - "buildid": "20151124012131", 01:55:35 INFO - "slavename": "talos-linux64-ix-053", 01:55:35 INFO - "pgo_build": "False", 01:55:35 INFO - "basedir": "/builds/slave/test", 01:55:35 INFO - "project": "", 01:55:35 INFO - "platform": "ubuntu64_hw", 01:55:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:55:35 INFO - "slavebuilddir": "test", 01:55:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:55:35 INFO - "branch": "fx-team", 01:55:35 INFO - "repo_path": "integration/fx-team", 01:55:35 INFO - "stage_platform": "linux64", 01:55:35 INFO - "builduid": "e5f74d643fef453f9a894c006d40420f", 01:55:35 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 01:55:35 INFO - }, 01:55:35 INFO - "sourcestamp": { 01:55:35 INFO - "repository": "", 01:55:35 INFO - "hasPatch": false, 01:55:35 INFO - "project": "", 01:55:35 INFO - "branch": "fx-team-linux64-talos", 01:55:35 INFO - "changes": [ 01:55:35 INFO - { 01:55:35 INFO - "category": null, 01:55:35 INFO - "files": [ 01:55:35 INFO - { 01:55:35 INFO - "url": null, 01:55:35 INFO - "name": "https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:55:35 INFO - } 01:55:35 INFO - ], 01:55:35 INFO - "repository": "", 01:55:35 INFO - "rev": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe", 01:55:35 INFO - "who": "gijskruitbosch@gmail.com", 01:55:35 INFO - "when": 1448358878, 01:55:35 INFO - "number": 6699516, 01:55:35 INFO - "comments": "Bug 1227116 - fix cmd-click on SVG links as well, r=felipe", 01:55:35 INFO - "project": "", 01:55:35 INFO - "at": "Tue 24 Nov 2015 01:54:38", 01:55:35 INFO - "branch": "fx-team-linux64-talos", 01:55:35 INFO - "revlink": "", 01:55:35 INFO - "properties": [ 01:55:35 INFO - [ 01:55:35 INFO - "buildid", 01:55:35 INFO - "20151124012131", 01:55:35 INFO - "Change" 01:55:35 INFO - ], 01:55:35 INFO - [ 01:55:35 INFO - "builduid", 01:55:35 INFO - "e5f74d643fef453f9a894c006d40420f", 01:55:35 INFO - "Change" 01:55:35 INFO - ], 01:55:35 INFO - [ 01:55:35 INFO - "pgo_build", 01:55:35 INFO - "False", 01:55:35 INFO - "Change" 01:55:35 INFO - ] 01:55:35 INFO - ], 01:55:35 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 01:55:35 INFO - } 01:55:35 INFO - ], 01:55:35 INFO - "revision": "9d1be94ff95a2252405ae5ec6fb4a8d083440dbe" 01:55:35 INFO - } 01:55:35 INFO - } 01:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:55:35 INFO - Running post-action listener: _resource_record_post_action 01:55:35 INFO - ##### 01:55:35 INFO - ##### Running download-and-extract step. 01:55:35 INFO - ##### 01:55:35 INFO - Running pre-action listener: _resource_record_pre_action 01:55:35 INFO - Running main action method: download_and_extract 01:55:35 INFO - mkdir: /builds/slave/test/build/tests 01:55:35 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')]} 01:55:35 INFO - https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/test_packages.json 01:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/test_packages.json 01:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:55:39 INFO - Downloaded 1302 bytes. 01:55:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:55:39 INFO - Using the following test package requirements: 01:55:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:55:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'jsshell-linux-x86_64.zip'], 01:55:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:55:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:55:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:55:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:55:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:55:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:55: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')]} 01:55:39 INFO - https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:41 INFO - Downloaded 21341306 bytes. 01:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:55:42 INFO - Return code: 0 01:55:42 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 01:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:42 INFO - https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:54 INFO - Downloaded 21341306 bytes. 01:55:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:55:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:55:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:55:55 INFO - Return code: 0 01:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:55 INFO - https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:55:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:56 INFO - Downloaded 11130997 bytes. 01:55:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 01:55:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:55:56 INFO - Return code: 0 01:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:56 INFO - https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:55:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:55:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:55:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-gIA05XTTx6HBSVs8cQyAA/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 01:55:58 INFO - Downloaded 56069883 bytes. 01:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:55:58 INFO - mkdir: /builds/slave/test/properties 01:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:58 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:58 INFO - Contents: 01:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:55:58 INFO - Running post-action listener: _resource_record_post_action 01:55:58 INFO - Running post-action listener: set_extra_try_arguments 01:55:58 INFO - ##### 01:55:58 INFO - ##### Running populate-webroot step. 01:55:58 INFO - ##### 01:55:58 INFO - Running pre-action listener: _resource_record_pre_action 01:55:58 INFO - Running main action method: populate_webroot 01:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:55:58 INFO - '../fennec_ids.txt'], 01:55:58 INFO - 'tests': ['tcheck2']}, 01:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:58 INFO - '--tppagecycles', 01:55:58 INFO - '7'], 01:55:58 INFO - 'tests': ['tsvgm']}}, 01:55:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:55:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:55:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:55:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'tests': ['damp', 'tps']}, 01:55:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['damp', 'tps']}, 01:55:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:58 INFO - 'other': {'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'other_l64': {'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'other_nol64': {'tests': ['a11yr', 01:55:58 INFO - 'ts_paint', 01:55:58 INFO - 'tpaint', 01:55:58 INFO - 'sessionrestore', 01:55:58 INFO - 'sessionrestore_no_auto_restore']}, 01:55:58 INFO - 'svgr': {'tests': ['tsvgx', 01:55:58 INFO - 'tsvgr_opacity', 01:55:58 INFO - 'tart', 01:55:58 INFO - 'tscrollx', 01:55:58 INFO - 'cart']}, 01:55:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['tsvgx', 01:55:58 INFO - 'tsvgr_opacity', 01:55:58 INFO - 'tart', 01:55:58 INFO - 'tscrollx', 01:55:58 INFO - 'cart']}, 01:55:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'tests': ['tp5o']}, 01:55:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'talos_options': ['--e10s'], 01:55:58 INFO - 'tests': ['tp5o']}, 01:55:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'talos_options': ['--xperf_path', 01:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:58 INFO - 'tests': ['tp5n']}, 01:55:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:58 INFO - 'talos_options': ['--e10s', 01:55:58 INFO - '--xperf_path', 01:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:58 INFO - 'tests': ['tp5n']}}, 01:55:58 INFO - 'talos.zip': {'path': '', 01:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:58 INFO - Running post-action listener: _resource_record_post_action 01:55:58 INFO - ##### 01:55:58 INFO - ##### Running create-virtualenv step. 01:55:58 INFO - ##### 01:55:58 INFO - Running pre-action listener: _resource_record_pre_action 01:55:58 INFO - Running main action method: create_virtualenv 01:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:58 INFO - Using real prefix '/usr' 01:55:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 01:56:01 INFO - Installing pip.................done. 01:56:01 INFO - Return code: 0 01:56:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:56:01 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')]} 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 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')]} 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:01 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 01:56:01 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 01:56:01 INFO - Using env: {'DISPLAY': ':0', 01:56:01 INFO - 'HOME': '/home/cltbld', 01:56:01 INFO - 'LANG': 'en_US.UTF-8', 01:56:01 INFO - 'LANGUAGE': 'en_US:en', 01:56:01 INFO - 'LOGNAME': 'cltbld', 01:56:01 INFO - 'MAIL': '/var/mail/cltbld', 01:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:01 INFO - 'MOZ_NO_REMOTE': '1', 01:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:01 INFO - 'NO_EM_RESTART': '1', 01:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:01 INFO - 'PWD': '/builds/slave/test', 01:56:01 INFO - 'SHELL': '/bin/bash', 01:56:01 INFO - 'SHLVL': '1', 01:56:01 INFO - 'TERM': 'linux', 01:56:01 INFO - 'TMOUT': '86400', 01:56:01 INFO - 'USER': 'cltbld', 01:56:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:01 INFO - '_': '/tools/buildbot/bin/python'} 01:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:01 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 01:56:01 INFO - Cleaning up... 01:56:01 INFO - Return code: 0 01:56:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:56:01 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')]} 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 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')]} 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:01 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 01:56:01 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 01:56:01 INFO - Using env: {'DISPLAY': ':0', 01:56:01 INFO - 'HOME': '/home/cltbld', 01:56:01 INFO - 'LANG': 'en_US.UTF-8', 01:56:01 INFO - 'LANGUAGE': 'en_US:en', 01:56:01 INFO - 'LOGNAME': 'cltbld', 01:56:01 INFO - 'MAIL': '/var/mail/cltbld', 01:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:01 INFO - 'MOZ_NO_REMOTE': '1', 01:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:01 INFO - 'NO_EM_RESTART': '1', 01:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:01 INFO - 'PWD': '/builds/slave/test', 01:56:01 INFO - 'SHELL': '/bin/bash', 01:56:01 INFO - 'SHLVL': '1', 01:56:01 INFO - 'TERM': 'linux', 01:56:01 INFO - 'TMOUT': '86400', 01:56:01 INFO - 'USER': 'cltbld', 01:56:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:01 INFO - '_': '/tools/buildbot/bin/python'} 01:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:01 INFO - Downloading/unpacking psutil>=0.7.1 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:03 INFO - Installing collected packages: psutil 01:56:03 INFO - Running setup.py install for psutil 01:56:03 INFO - building 'psutil._psutil_linux' extension 01:56:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:56:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:56:03 INFO - building 'psutil._psutil_posix' extension 01:56:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:56:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:03 INFO - Successfully installed psutil 01:56:03 INFO - Cleaning up... 01:56:04 INFO - Return code: 0 01:56:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:56:04 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')]} 01:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:04 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')]} 01:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:04 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:04 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 01:56:04 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 01:56:04 INFO - Using env: {'DISPLAY': ':0', 01:56:04 INFO - 'HOME': '/home/cltbld', 01:56:04 INFO - 'LANG': 'en_US.UTF-8', 01:56:04 INFO - 'LANGUAGE': 'en_US:en', 01:56:04 INFO - 'LOGNAME': 'cltbld', 01:56:04 INFO - 'MAIL': '/var/mail/cltbld', 01:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:04 INFO - 'MOZ_NO_REMOTE': '1', 01:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:04 INFO - 'NO_EM_RESTART': '1', 01:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:04 INFO - 'PWD': '/builds/slave/test', 01:56:04 INFO - 'SHELL': '/bin/bash', 01:56:04 INFO - 'SHLVL': '1', 01:56:04 INFO - 'TERM': 'linux', 01:56:04 INFO - 'TMOUT': '86400', 01:56:04 INFO - 'USER': 'cltbld', 01:56:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:04 INFO - '_': '/tools/buildbot/bin/python'} 01:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:56:04 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 01:56:04 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 01:56:04 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 01:56:04 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 01:56:04 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 01:56:04 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 01:56:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:56:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:56:05 INFO - Installing collected packages: mozsystemmonitor 01:56:05 INFO - Running setup.py install for mozsystemmonitor 01:56:06 INFO - Successfully installed mozsystemmonitor 01:56:06 INFO - Cleaning up... 01:56:06 INFO - Return code: 0 01:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:56: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')]} 01:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56: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')]} 01:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:06 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:06 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 01:56:06 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 01:56:06 INFO - Using env: {'DISPLAY': ':0', 01:56:06 INFO - 'HOME': '/home/cltbld', 01:56:06 INFO - 'LANG': 'en_US.UTF-8', 01:56:06 INFO - 'LANGUAGE': 'en_US:en', 01:56:06 INFO - 'LOGNAME': 'cltbld', 01:56:06 INFO - 'MAIL': '/var/mail/cltbld', 01:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:06 INFO - 'MOZ_NO_REMOTE': '1', 01:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:06 INFO - 'NO_EM_RESTART': '1', 01:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:06 INFO - 'PWD': '/builds/slave/test', 01:56:06 INFO - 'SHELL': '/bin/bash', 01:56:06 INFO - 'SHLVL': '1', 01:56:06 INFO - 'TERM': 'linux', 01:56:06 INFO - 'TMOUT': '86400', 01:56:06 INFO - 'USER': 'cltbld', 01:56:06 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:06 INFO - '_': '/tools/buildbot/bin/python'} 01:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:06 INFO - Downloading/unpacking blobuploader==1.2.4 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:06 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 01:56:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 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 01:56:08 INFO - Downloading docopt-0.6.1.tar.gz 01:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:08 INFO - Running setup.py install for blobuploader 01:56:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:08 INFO - Running setup.py install for requests 01:56:09 INFO - Running setup.py install for docopt 01:56:09 INFO - Successfully installed blobuploader requests docopt 01:56:09 INFO - Cleaning up... 01:56:09 INFO - Return code: 0 01:56:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:09 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:09 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 01:56:09 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 01:56:09 INFO - Using env: {'DISPLAY': ':0', 01:56:09 INFO - 'HOME': '/home/cltbld', 01:56:09 INFO - 'LANG': 'en_US.UTF-8', 01:56:09 INFO - 'LANGUAGE': 'en_US:en', 01:56:09 INFO - 'LOGNAME': 'cltbld', 01:56:09 INFO - 'MAIL': '/var/mail/cltbld', 01:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:09 INFO - 'MOZ_NO_REMOTE': '1', 01:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:09 INFO - 'NO_EM_RESTART': '1', 01:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:09 INFO - 'PWD': '/builds/slave/test', 01:56:09 INFO - 'SHELL': '/bin/bash', 01:56:09 INFO - 'SHLVL': '1', 01:56:09 INFO - 'TERM': 'linux', 01:56:09 INFO - 'TMOUT': '86400', 01:56:09 INFO - 'USER': 'cltbld', 01:56:09 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:09 INFO - '_': '/tools/buildbot/bin/python'} 01:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:09 INFO - Running setup.py (path:/tmp/pip-1KQpKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:09 INFO - Running setup.py (path:/tmp/pip-vvLCZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:09 INFO - Running setup.py (path:/tmp/pip-ibq76q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:09 INFO - Running setup.py (path:/tmp/pip-TMCcOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:09 INFO - Running setup.py (path:/tmp/pip-fP9x6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:09 INFO - Running setup.py (path:/tmp/pip-cvTQzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:09 INFO - Running setup.py (path:/tmp/pip-ZgILq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:09 INFO - Running setup.py (path:/tmp/pip-1IY4ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:10 INFO - Running setup.py (path:/tmp/pip-J31O7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:10 INFO - Running setup.py (path:/tmp/pip-Tw7T8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:10 INFO - Running setup.py (path:/tmp/pip-UndNnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:10 INFO - Running setup.py (path:/tmp/pip-0NfQ6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:10 INFO - Running setup.py (path:/tmp/pip-Gb_3_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:10 INFO - Running setup.py (path:/tmp/pip-LQ2fDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:10 INFO - Running setup.py (path:/tmp/pip-wcpuYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:10 INFO - Running setup.py (path:/tmp/pip-4ObN8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:10 INFO - Running setup.py (path:/tmp/pip-bapCqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:10 INFO - Running setup.py install for manifestparser 01:56:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:10 INFO - Running setup.py install for mozcrash 01:56:10 INFO - Running setup.py install for mozdebug 01:56:11 INFO - Running setup.py install for mozdevice 01:56:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for mozfile 01:56:11 INFO - Running setup.py install for mozhttpd 01:56:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for mozinfo 01:56:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for mozInstall 01:56:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for mozleak 01:56:11 INFO - Running setup.py install for mozlog 01:56:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for moznetwork 01:56:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Running setup.py install for mozprocess 01:56:11 INFO - Running setup.py install for mozprofile 01:56:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:12 INFO - Running setup.py install for mozrunner 01:56:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:12 INFO - Running setup.py install for mozscreenshot 01:56:12 INFO - Running setup.py install for moztest 01:56:12 INFO - Running setup.py install for mozversion 01:56:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:12 INFO - Cleaning up... 01:56:12 INFO - Return code: 0 01:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:56:12 INFO - Using env: {'DISPLAY': ':0', 01:56:12 INFO - 'HOME': '/home/cltbld', 01:56:12 INFO - 'LANG': 'en_US.UTF-8', 01:56:12 INFO - 'LANGUAGE': 'en_US:en', 01:56:12 INFO - 'LOGNAME': 'cltbld', 01:56:12 INFO - 'MAIL': '/var/mail/cltbld', 01:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:12 INFO - 'MOZ_NO_REMOTE': '1', 01:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:12 INFO - 'NO_EM_RESTART': '1', 01:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:12 INFO - 'PWD': '/builds/slave/test', 01:56:12 INFO - 'SHELL': '/bin/bash', 01:56:12 INFO - 'SHLVL': '1', 01:56:12 INFO - 'TERM': 'linux', 01:56:12 INFO - 'TMOUT': '86400', 01:56:12 INFO - 'USER': 'cltbld', 01:56:12 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:12 INFO - '_': '/tools/buildbot/bin/python'} 01:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:12 INFO - Running setup.py (path:/tmp/pip-JTyYoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:12 INFO - Running setup.py (path:/tmp/pip-sBDUGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:12 INFO - Running setup.py (path:/tmp/pip-vQ5jzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:12 INFO - Running setup.py (path:/tmp/pip-JsSZuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:13 INFO - Running setup.py (path:/tmp/pip-F2fUre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:13 INFO - Running setup.py (path:/tmp/pip-OQztSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:13 INFO - Running setup.py (path:/tmp/pip-DgCiMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:13 INFO - Running setup.py (path:/tmp/pip-kEkjjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:13 INFO - Running setup.py (path:/tmp/pip-8Iit7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:13 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)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:13 INFO - Running setup.py (path:/tmp/pip-Mgc4d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:13 INFO - Running setup.py (path:/tmp/pip-KTRghF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:13 INFO - Running setup.py (path:/tmp/pip-gm5WDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:13 INFO - Running setup.py (path:/tmp/pip-3pASVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:13 INFO - Running setup.py (path:/tmp/pip-DhyxXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:13 INFO - Running setup.py (path:/tmp/pip-7QElZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:13 INFO - Running setup.py (path:/tmp/pip-rH8wMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:13 INFO - Running setup.py (path:/tmp/pip-wE_91_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:14 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 01:56:14 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 01:56:14 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 01:56:14 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 01:56:14 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 01:56:14 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 01:56:15 INFO - Downloading blessings-1.5.1.tar.gz 01:56:15 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:15 INFO - Installing collected packages: blessings 01:56:15 INFO - Running setup.py install for blessings 01:56:15 INFO - Successfully installed blessings 01:56:15 INFO - Cleaning up... 01:56:15 INFO - Return code: 0 01:56:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:16 INFO - Reading from file tmpfile_stdout 01:56:16 INFO - Current package versions: 01:56:16 INFO - argparse == 1.2.1 01:56:16 INFO - blessings == 1.5.1 01:56:16 INFO - blobuploader == 1.2.4 01:56:16 INFO - docopt == 0.6.1 01:56:16 INFO - manifestparser == 1.1 01:56:16 INFO - mozInstall == 1.12 01:56:16 INFO - mozcrash == 0.16 01:56:16 INFO - mozdebug == 0.1 01:56:16 INFO - mozdevice == 0.47 01:56:16 INFO - mozfile == 1.2 01:56:16 INFO - mozhttpd == 0.7 01:56:16 INFO - mozinfo == 0.9 01:56:16 INFO - mozleak == 0.1 01:56:16 INFO - mozlog == 3.1 01:56:16 INFO - moznetwork == 0.27 01:56:16 INFO - mozprocess == 0.22 01:56:16 INFO - mozprofile == 0.27 01:56:16 INFO - mozrunner == 6.11 01:56:16 INFO - mozscreenshot == 0.1 01:56:16 INFO - mozsystemmonitor == 0.0 01:56:16 INFO - moztest == 0.7 01:56:16 INFO - mozversion == 1.4 01:56:16 INFO - psutil == 3.1.1 01:56:16 INFO - requests == 1.2.3 01:56:16 INFO - wsgiref == 0.1.2 01:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:16 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 0x7f1969d26c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a4900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, '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': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', '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 01:56:16 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 01:56:16 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 01:56:16 INFO - Using env: {'DISPLAY': ':0', 01:56:16 INFO - 'HOME': '/home/cltbld', 01:56:16 INFO - 'LANG': 'en_US.UTF-8', 01:56:16 INFO - 'LANGUAGE': 'en_US:en', 01:56:16 INFO - 'LOGNAME': 'cltbld', 01:56:16 INFO - 'MAIL': '/var/mail/cltbld', 01:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:16 INFO - 'MOZ_NO_REMOTE': '1', 01:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:16 INFO - 'NO_EM_RESTART': '1', 01:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:16 INFO - 'PWD': '/builds/slave/test', 01:56:16 INFO - 'SHELL': '/bin/bash', 01:56:16 INFO - 'SHLVL': '1', 01:56:16 INFO - 'TERM': 'linux', 01:56:16 INFO - 'TMOUT': '86400', 01:56:16 INFO - 'USER': 'cltbld', 01:56:16 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:16 INFO - '_': '/tools/buildbot/bin/python'} 01:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 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)) 01:56:16 INFO - Cleaning up... 01:56:16 INFO - Return code: 0 01:56:16 INFO - Running post-action listener: _resource_record_post_action 01:56:16 INFO - Running post-action listener: _start_resource_monitoring 01:56:16 INFO - Starting resource monitoring. 01:56:16 INFO - ##### 01:56:16 INFO - ##### Running install step. 01:56:16 INFO - ##### 01:56:16 INFO - Running pre-action listener: _resource_record_pre_action 01:56:16 INFO - Running main action method: install 01:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:16 INFO - Reading from file tmpfile_stdout 01:56:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:56:16 INFO - Reading from file tmpfile_stdout 01:56:16 INFO - Output received: 01:56:16 INFO - Usage: mozinstall [options] installer 01:56:16 INFO - Options: 01:56:16 INFO - -h, --help show this help message and exit 01:56:16 INFO - -d DEST, --destination=DEST 01:56:16 INFO - Directory to install application into. [default: 01:56:16 INFO - "/builds/slave/test"] 01:56:16 INFO - --app=APP Application being installed. [default: firefox] 01:56:16 INFO - mkdir: /builds/slave/test/build/application 01:56:16 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'] 01:56:16 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 01:56:30 INFO - Reading from file tmpfile_stdout 01:56:30 INFO - Output received: 01:56:30 INFO - /builds/slave/test/build/application/firefox/firefox 01:56:30 INFO - Running post-action listener: _resource_record_post_action 01:56:30 INFO - ##### 01:56:30 INFO - ##### Running run-tests step. 01:56:30 INFO - ##### 01:56:30 INFO - Running pre-action listener: _resource_record_pre_action 01:56:30 INFO - Running main action method: run_tests 01:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:30 INFO - Python 2.7.3 01:56:30 INFO - Return code: 0 01:56:30 INFO - grabbing minidump binary from tooltool 01:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:30 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 0x25eab70>, '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 0x263bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x263c250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:30 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 01:56:30 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 01:56:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:30 INFO - Return code: 0 01:56:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:56:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:56:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test/build 01:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 01:56:30 INFO - Using env: {'DISPLAY': ':0', 01:56:30 INFO - 'HOME': '/home/cltbld', 01:56:30 INFO - 'LANG': 'en_US.UTF-8', 01:56:30 INFO - 'LANGUAGE': 'en_US:en', 01:56:30 INFO - 'LOGNAME': 'cltbld', 01:56:30 INFO - 'MAIL': '/var/mail/cltbld', 01:56:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:30 INFO - 'MOZ_NO_REMOTE': '1', 01:56:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:30 INFO - 'NO_EM_RESTART': '1', 01:56:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:30 INFO - 'PWD': '/builds/slave/test', 01:56:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:30 INFO - 'SHELL': '/bin/bash', 01:56:30 INFO - 'SHLVL': '1', 01:56:30 INFO - 'TERM': 'linux', 01:56:30 INFO - 'TMOUT': '86400', 01:56:30 INFO - 'USER': 'cltbld', 01:56:30 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448355895.529698-476290453', 01:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:30 INFO - '_': '/tools/buildbot/bin/python'} 01:56:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 01:56:31 INFO - mozversion INFO | application_buildid: 20151124012131 01:56:31 INFO - mozversion INFO | application_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 01:56:31 INFO - mozversion INFO | application_display_name: Nightly 01:56:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:31 INFO - mozversion INFO | application_name: Firefox 01:56:31 INFO - mozversion INFO | application_remotingname: firefox 01:56:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:56:31 INFO - mozversion INFO | application_vendor: Mozilla 01:56:31 INFO - mozversion INFO | application_version: 45.0a1 01:56:31 INFO - mozversion INFO | platform_buildid: 20151124012131 01:56:31 INFO - mozversion INFO | platform_changeset: 9d1be94ff95a2252405ae5ec6fb4a8d083440dbe 01:56:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:31 INFO - mozversion INFO | platform_version: 45.0a1 01:56:31 INFO - 2015-11-24 01:56:31,105 DEBUG : using testdate: 1448358991 01:56:31 INFO - 2015-11-24 01:56:31,105 DEBUG : actual date: 1448358991 01:56:31 INFO - 2015-11-24 01:56:31,113 INFO : starting webserver on 'localhost:39420' 01:56:31 INFO - 2015-11-24 01:56:31,114 INFO : Starting test suite talos-linux64-ix-053 01:56:31 INFO - 2015-11-24 01:56:31,115 INFO : Starting test dromaeo_css 01:56:31 INFO - 2015-11-24 01:56:31,115 DEBUG : operating with platform_type : linux_ 01:56:31 INFO - 2015-11-24 01:56:31,115 INFO : Initialising browser for dromaeo_css test... 01:56:31 INFO - 2015-11-24 01:56:31,128 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDDdc1/profile http://localhost:39420/getInfo.html 01:56:35 INFO - 2015-11-24 01:56:35,041 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:56:35 INFO - 2015-11-24 01:56:35,041 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:56:35 INFO - 2015-11-24 01:56:35,041 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:56:35 INFO - 2015-11-24 01:56:35,041 DEBUG : BROWSER_OUTPUT: __metrics 01:56:35 INFO - 2015-11-24 01:56:35,138 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:36 INFO - 2015-11-24 01:56:36,397 INFO : Browser initialized. 01:56:36 INFO - 2015-11-24 01:56:36,397 INFO : Running cycle 1/1 for dromaeo_css test... 01:56:36 INFO - 2015-11-24 01:56:36,397 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDDdc1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:56:48 INFO - 2015-11-24 01:56:48,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 01:56:48 INFO - 2015-11-24 01:56:48,348 DEBUG : BROWSER_OUTPUT: 01:57:39 INFO - 2015-11-24 01:57:39,545 DEBUG : BROWSER_OUTPUT: 1448359059542 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] 01:59:51 INFO - 2015-11-24 01:59:51,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39420/tests/dromaeo/cssquery-ext.html) 01:59:52 INFO - 2015-11-24 01:59:52,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 241061888 01:59:52 INFO - 2015-11-24 01:59:52,592 DEBUG : BROWSER_OUTPUT: 02:02:55 INFO - 2015-11-24 02:02:55,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-ext.html (next: http://localhost:39420/tests/dromaeo/cssquery-jquery.html) 02:02:55 INFO - 2015-11-24 02:02:55,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 215617536 02:02:55 INFO - 2015-11-24 02:02:55,705 DEBUG : BROWSER_OUTPUT: 02:05:57 INFO - 2015-11-24 02:05:57,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39420/tests/dromaeo/cssquery-mootools.html) 02:05:58 INFO - 2015-11-24 02:05:58,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 211070976 02:05:58 INFO - 2015-11-24 02:05:58,445 DEBUG : BROWSER_OUTPUT: 02:09:00 INFO - 2015-11-24 02:09:00,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39420/tests/dromaeo/cssquery-prototype.html) 02:09:00 INFO - 2015-11-24 02:09:00,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 202854400 02:09:00 INFO - 2015-11-24 02:09:00,978 DEBUG : BROWSER_OUTPUT: 02:12:03 INFO - 2015-11-24 02:12:03,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39420/tests/dromaeo/cssquery-yui.html) 02:12:04 INFO - 2015-11-24 02:12:04,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 204152832 02:12:04 INFO - 2015-11-24 02:12:04,212 DEBUG : BROWSER_OUTPUT: 02:15:06 INFO - 2015-11-24 02:15:06,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/dromaeo/cssquery-yui.html (next: http://localhost:39420/tests/dromaeo/cssquery-dojo.html) 02:15:07 INFO - 2015-11-24 02:15:07,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 252239872 02:15:07 INFO - 2015-11-24 02:15:07,136 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,139 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:15:07 INFO - 2015-11-24 02:15:07,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:15:07 INFO - 2015-11-24 02:15:07,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:15:07 INFO - 2015-11-24 02:15:07,140 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:15:07 INFO - 2015-11-24 02:15:07,140 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2594.5329840628683;2689.047185261512;2702.4459985702933;2703.7296270372976;2718.8912443502263;4554.954450455494;4574.977125114378;4662.160811054009;4675.462321832986;4696.553827386393;4560.794764235609;4597.1265459562655;4630.606398456135;4643.117807616551;4730.0303437795255;4267.701260911737;4367.541408152138;4370.584794444522;4435.911281774379;4448.310511870665;4380.364847097169;4424.933625995613;4441.644668426534;4446.622037126848;4482.305242687373;4161.0845613964875;4213.894652633678;4259.616634502879;4270.231358355495;4336.154449882274;4305.095929854734;4318.330658747899;4324.524302326741;4324.805383757738;4356.542563030868;4316.892077698051;4340.197063543254;4342.5874541918465;4342.782860856944;4367.235733746614;4380.6057454829215;4471.709338892962;4480.843170489017;4521.276595744698;4643.141018911512;4983.451820299764;4984.177610694231;5007.4992500749995;5011.523905228997;5040.243963405482;5019.52314530119;5023.824166154203;5024.346834911475;5027.271045698353;5027.723475208862;4540.931886021713;4547.749873756975;4654.232051711498;4682.695624784378;4687.390639216914;5095.184770436712;5153.922691159635;5167.948320516822;5169.53474187325;5169.7673604687125;4947.109520286311;4962.6774259673;4965.106280869406;4972.8508144755715;5020.723860187724;4783.976080119647;4870.1233777920315;4885.658003939761;4885.682430641997;4993.575546078551;4904.190808516626;4929.975350123226;4932.383452068491;4940;4988.775505102207;4915.557599816034;4916.926246106311;4917.336159618406;4921.557059864629;4961.883576195327;4050.7569545827346;4080.469538959916;4116.608922152391;4142.647874930604;4166.729147609947;3621.9275614487565;3624.619414961444;3655.2324011957253;3656.2870240302886;3673.3387990162028;4319.092990472036;4323.178596066738;4327.545607711208;4359.38968544404;4361.672874534423;4827.131116399011;4923.926141107886;4942.728149951715;4954.355933728592;4997.125503037027;4243.724157929724;4285.99279169395;4307.655387568987;4322.827086916551;4336.457942757155;4432.711873728197;4467.776611169494;4471.7987690554;4479.126570318822;4513.819447222074;4575.267957126844;4678.766061696833;4794.616430685537;4812.903741925212;4816.470188279286;4901.14230009754;4923.040007198562;4944.629152813482;4975.900481990412;5028.421731500925;4758.976205118952;4760.381150450419;4760.677831731218;4761.976190119027;4800.207965685762;4701.177293973609;4806.663533552618;4931.3096166536;4933.77797999098;4982.8754281143265;4833.782479788348;4885.291632713308;4897.240927656219;4898.510148985073;4943.060818444484;4794.352762377034;4818.301346304696;4821.734804585782;4824.059308434821;4871.95128048715;4656.998745269783;4748;4808.711477311373;4819.566239038503;4865.80536778539;4648.953510464852;4671.906561868812;4738.928916066331;4828.565429111397;4867.440244371943;4846.781894814812;4856.635752318661;4857.101436234167;4863.221884498605;4867.488913664014;4734.17151998392;4766.713997160182;4778.259369797687;4783.186858234039;4818.975905120452 02:15:07 INFO - 2015-11-24 02:15:07,143 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.1049473615902;544.8746788238705;556.5408537956185;560.5459577742026;565.510833129343;27760.3059923502;28332.29169270769;28335.57496637552;28385.14844554664;36467;38819.41770873439;39350.21299574007;39382.803085984604;39390.21219575614;39480;7966.203379662031;8151.307138893201;8161.755147345589;8164.101948785629;8164.1427650096775;7109.644517774116;7305.744298949538;7955.284024437799;10035.849462258071;10209.948950255239;10164.491775411238;10219.080282774548;10293.125084367837;10294;10296.639617613386;6982.720691172347;10031.899681003206;10163.644272450503;10174.949125254401;10176.033276838725;6805.761798337084;10194.286399952007;10469.057784799328;10469.84295235572;10477.109445697124;35797.10507237314;35992.820035899655;36075.458868117;36276.911692649264;36324.27351452956;2610.830296030771;2757.834529928211;3126.656067832537;3259.429599820022;3297.142742886843;27422;27718;27853.721462785517;28158;28229.153125406272;3398.5242066110764;3485.1809824691177;3487.5640544931885;3523.0311664292267;3592.46113083037;226497;227122;227416.99999999834;227880;228298;48678.51321486811;52522;52689.2096618551;52847.47152528426;52869;46341;46490.76754616273;46518.767406162755;46556.9475968122;59941.700291498266;13613.387397567134;13755.074289599464;13778.793318100237;13841.30793460323;13846.10000349974;10465.110465610509;10479.580816767397;10514.421706806199;10515.789684206426;10534.36793792375;17800.3769868054;17815.287388504315;17954.820451795316;17983.73024404635;18017.909910450362;6877.690503927335;7147.678354474061;7154.570725756367;7196.604186769673;7279.927200728031;813.6460639621783;863.628639684929;868.2316150206985;878.7056336127341;886.3839631456076;26060.869695651778;26531.469370612867;26612;26716.732832671813;26837.865810671214;971.4899677669139;994.572333896417;997.2620261006948;1019.2304809868501;1080.3193987787643;12752.234865908074;12792.104552681223;12879.742405151845;12891.935540322238;12901.161424507565;258681;261928;262851;264367;264956;44046.559534404885;44281;44310.55689443064;44339.55660443419;44414.77792611016;1197.2816310213802;1200.6278053803173;1211.8666946635863;1216.7384012437192;1221.865594784573;24339.513209735353;24896.87551562303;25498.235052948443;25612.871935640203;25639;35207.295854083284;35991.82004089963;36049.81975090213;40894.38658420066;41641.79179104085;181729.09135454238;181807;183221;183489;183552;23256;27202.863985679945;27587.310317241427;27596.172114836587;27631.171064868086;24198.395040124138;25197.370065748502;34860.47709284312;35348;35396;29760.553591696575;30065.64704588255;30445.391092178474;30872.69127308698;32113.51829722509;32461.35077298488;32696.34607307793;32723.34553308873;32956.50565241475;33030.834845825615;32735.071791385188;33023.339533208724;33033.66966330306;33089.50365744468;33194;25089.623655645544;26179.73820261773;27434.314142146606;27437;27743.58384624192;23272.3018309451;23560.6465903015;23894.238452932826;24180.51638967246;24203.273901782974 02:15:07 INFO - 2015-11-24 02:15:07,143 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.79744754423575;335.5055164849345;336.40120585358056;337.9273456206915;340.15641209799696;12448.93775531121;12639.684007899807;14299.28503574821;15131.31909064092;15797.289121989525;8675.436096653713;10063.798724025515;10197.643082492114;10299.382037077761;10487.73780655484;4469.553044695537;4593.908121837561;4595.655325850558;4596;4602.240630295997;3077.7383922366625;3120.765942554306;4453.88865278369;4846.345743324641;5118.718470484122;5061.772220250097;5092.261622064799;5113.693178409308;5115.53960143587;5118.9744051279695;4986.252062190682;5075.492450754932;5520.972395138018;5578.553715702775;5584.720763961826;4901.534354236377;4946.604271658259;4949.628777841676;4954.5540901319055;4956;12350.197237179644;16748.916255418768;18562.257509699597;19470;19483.902580487007;1682.9915850420791;1714.1429285357322;1728.6110625109375;1746.2927514356707;1801.0724476894409;8947.32895032875;9059.547022648841;9178.86231706525;9228.538573071319;12091.093168012347;1571.5835303644544;1637.7625244339504;1640.7866977292877;1715.836995485427;1727.6112874603239;47101.5289847104;48347.27479087852;48402.7579862102;49108.263376049385;49383.75308123436;9307.208887244524;9469;9596.66411675588;9630.662926797528;9635.13283804461;12146.75706485883;12155;12155.088368372408;12168.513259469699;12169.634910952685;6687.732490700318;6733.494987875929;6784.287649796799;6848.075509806212;6931.0643063186835;6546.279909209983;6910.550814197061;6981.371676549135;6983.546069505466;6996.230414654384;4118.4440100586635;4126.257273690764;4158.708890377705;4204.1801848639225;4264.189803937304;1635.3213416432286;1670.206651840366;1676.5892356372767;1724.5516165796732;1766.611345503987;385.1372924648767;385.7280617164892;404.8927034335844;746.8244962433823;890.6348397157265;9968.950155249177;10082.848757268646;10121.1903047756;10335.328203666737;10399.48002599867;376.4522619588492;397.2115351028207;399.67226873963654;402.0872619154503;403.38282427885383;8813.383063185516;9074.818503630022;9129.680461183827;9219.492927888896;9308.208802251884;442613;444493;448695;463349;469284;38879.41680874789;38984.41523377151;68014.9797753034;71869.13461922451;71944.20139496554;1046.926715129949;1061.490484567412;1095.27164435651;1123.5898896902736;1125.0718157519916;14368.640783980483;14393.208373539137;14430.494932677306;14583.416663333348;14807.703845922806;29359.412811744074;29845.70154298516;29929.102126936228;30311;30576.388472230876;35748.64251357453;36881;39498.40752388659;40040;40771;8696.521691307038;8725.781855453664;9005.819883602422;9082.45505269686;9094.545272736468;10616.309939853885;12956.481740730265;15437.459688910834;15692;15987.920060399623;12959.287239201934;13045;13193.274369909746;13266.668333291746;13420;13360.86639133635;13379.665508362368;13508.18950862912;13703.177809331472;13805.654858628615;10759.731006724895;13563.389647466085;13994.790078149039;14135.222562759147;14579.198144102176;8679.435836670596;8723.91276087231;8802.691905783267;8832.337574681796;8832.425892316978;13173.341332933507;13189.40647670838;13347.265900375573;13506.797398038841;13551.79672304936 02:15:07 INFO - 2015-11-24 02:15:07,147 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1307.928063956482;1592.3710134496873;1634.8365163483654;1643.318023020446;1653.6692661467703;5981.641101533911;6680.866382672343;6863.965680171605;6868.141482314711;6880.449564034884;6725.562838415512;6892.345227203407;6895.862082758342;6896.75861344853;6907.481938854594;2047.6518991771434;2069.7102405663145;2070.265055905147;2073.564551444191;2075.1595603780493;2016.4857961219868;2019.7980201979758;2025.9696104558443;2049.2008116834445;2049.6925461180795;2035.2164416699604;2063.793620637932;2080.136743251549;2081.458820706612;2081.4588207066195;2015.8488113391481;2037.9592408151755;2040.2960978462406;2043.4891277180704;2044.6932960055963;2037.02222932993;2039.5512987142804;2079.5321052763156;2082.9479263018393;2083.8332933365296;5836.854078648025;6060.909086363708;6876.553024053471;6881.036654868322;6914.723411063552;3989.960100398988;4071.9389209161886;4073.4500842386196;4083.9387409188885;4111.218868414991;2695.7978151638704;2718.103026001415;2753.8898444062415;2755.145904769508;2771.598118272859;907.1654078248027;907.7004588485784;917.7522069041388;918.6095909238547;921.2491819167357;8890.244329232022;8936.910630893737;8974.775630609221;8984.595693193822;8988.415752976036;3834.079820842978;3840.078381188495;3864.574896761354;3913.471681323042;3916.138449541096;7948.523088614702;7950.403719721044;7953.244441778022;7953.801154971056;7963.323117534958;4152.8338866445;4161.167766446722;4167.083241686824;4168;4168.2080404723;3804.2581696569455;3808.6572208501366;3811.294910441577;3812.218495208476;3818.522684664417;3140.9214769630485;3145.150809281481;3169.904902852918;3208.4866421372467;3210.9197270068435;1036.1037702387532;1037.5642230263309;1051.4742628685658;1056.2922841696081;1058.9470526473644;1122.528538014036;1129.48043899807;1160.4313886195703;1161.517970042423;1162.604714397109;6507.609543427315;6522.510811689142;6542.0186971953635;6542.182227221598;6549.705263263165;456.1424521898809;459.23766547530937;464.8884267775777;465.2370113014659;466.1120565323065;4811.831585894477;5062.696238225718;5154.974225128925;5167.586593072545;5168.9224661630105;7483.8877416838795;8192.713255036164;8265.46274492168;8326.250637442537;8329.375296852639;8129.309008734205;8142.918570814334;8184.058833234135;8197.426180167451;8214.342852571779;6243.469305109116;6276.058591211355;6279.4662453691035;6312.873742525216;6336.778212762623;6272.435480806749;6357.841053973688;6362.6818659067785;6368.713407896563;6381.138546296191;7012.824679383056;7238.927610724036;7298.197198308288;7327.194008659149;7344.706211751683;7304.19653838088;7453.813654658677;7581.052368453943;7584.2794934481135;7593.658285377061;6122.418370254819;6129.540284478593;6188.535859810622;6201.224846894138;6201.976673848764;6610.933890661224;6682.599044057372;6682.699278532575;6686.53194276396;6687.230968438692;6315.179026726496;6320.873582528416;6376.3623637635865;6418.29398766126;6483.222013358427;6122.938770612415;6155.876882462236;6166;6195.070739388947;6343.460805831556;6286.779962701284;6376.4580010697755;6379.883520384007;6382.744690212339;6387.968060159669;5868.178455016387;5904.350521442724;5905.970470147622;5908;5919.733611987384;5779.768809247583;5913.881722365614;5918.141869428995;5918.260217472816;6064.423879731418 02:15:07 INFO - 2015-11-24 02:15:07,148 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.90202233263;303.951367781155;304.80492484809724;313.44833093754994;314.7057501236344;5340.359156901172;5381.488758567934;5500.834974950748;5509.669419834812;5534.308211473561;5308.071087559681;5335.413104558495;5378.515933565978;5381.757820898059;5385.35375754909;3970.9675484373984;4023.5976402359825;4171.395147703581;4178.415021896922;4181.393697913801;4123.814428350732;4176.958230417703;4199.7690127043;4212.55768144345;4213.5786421357925;4153;4156.106437116019;4169.187008533338;4170.749755014709;4173.08192197716;3982.0841206522373;4056.655184309337;4080.9591904080876;4130.153318569686;4165;3646.890593282206;3648.890533284006;3662.5971143174497;3666.633336666339;3687.1519550503267;5136.974315128437;5166.664166829181;5169.974150129226;5170.172772356443;5176.948230517684;4757.762111894392;4772.546608072227;4779.283107533863;4779.593734532534;4787.784549695272;5501.648332751955;5591.4688104629995;5608.887822243573;5613.045782216992;5627.746751396197;3992.8602498912687;3996.500437445319;3997;3999.9400008999887;4002.239574480839;5826.329972053226;5923;5924;5933.732982015819;5933.8813223735715;3975.3241948868763;4003.219372222447;4005.459262999516;4008.8997775055273;4010.819513121858;3983.698065018157;4037.051292946155;4069.694772892045;4076.5923407658997;4081.163361510883;4665.370175026396;4666.929996050062;4668.883277918011;4674;4676.719396836201;5610.186522954149;5620.1288800236025;5621.18492818539;5622.85942851432;5622.887542249132;1490.2846633615925;1516.4919751883242;1518.2864053894652;1519.4302136698739;1522.2312732070234;1020.882598501167;1038.5378506564507;1039.1894322428518;1055.145332280855;1067.743741502034;4946.826861059918;4953.306537084811;4958.9504104959215;4959.429665588431;4969.18008528596;5830.329512106162;5836.824895253149;5838.065909454467;5838.795642152504;5846.386129456431;4941.75291235444;4945.307656928033;4954.40547134339;4954.603631709455;4957.132501812241;2932.5747766573727;3002.069358498872;3066.6933306669152;3120.7035331643456;3144.591203143577;5572;5589.552835773128;5592.5246354059545;5602.635828671123;5612.719364031864;6042.335343112254;6049.485793707584;6050.57645964787;6055.455009049207;6063.029915213545;5424.620276580759;5569.443055694479;5571.1086226204425;5579.414161513064;5582.91625625616;5885.676287804212;5894.705264736832;5901.616394934315;5905.91141132892;5910.202122713551;5758.884822303614;5761.798337058351;5764.048931926353;5764.510016648632;5764.538836893123;5581.888362232814;5584.190292407659;5587.245721827664;5594.580406469612;5600.60795744294;3983.940240896447;4017.0961533655864;4019.718619696593;4026.3155263605845;4104.1586474772;5864.882702346014;5871.383504732113;5873.236479257669;5877.911831322619;5878.500327472213;5668.093105103164;5668.178114173505;5668.744906479301;5674.546036317167;5676.574256930664;5430.565554755531;5624.465675760796;5629.493345598752;5662.405447427961;5662.716864156858;5503.807366742145;5526.889462210814;5549.72251387421;5553.72231388437;5558.638688485235;5697.914531281951;5701.030824759718;5701.914471283017;5703;5712.828615141552;5541.307336582927;5565.5825813063375;5566.248556444828;5566.721663916707;5567.276254086943 02:15:07 INFO - 2015-11-24 02:15:07,152 DEBUG : BROWSER_OUTPUT: |5;yui.html;751.984960300794;753.4311594745966;756.4024420707641;771.1941021632393;793.5714714054411;10982.560697572097;12576.81134782979;12748.808767868477;12774.552890648829;12777.744445111115;12378.690532736664;12402.875971240284;12427.875721242784;12436.81344779829;12440.377981100954;598.8832177725324;601.8405122642504;603.604638961481;750.9324160825538;768.3584207186977;742.5507567921384;746.634149266858;756.4440136499668;756.8978187944612;756.9016027916363;767.4359345880773;777.5684495105214;777.9844403111963;778.2489897249153;778.353966208046;621.9440250377465;627.075064280183;629.6757170057401;767.769669099268;775.6587101675273;574.0786038408336;578.3060327606888;579.5045236322925;579.7536047179932;581.7294957844623;11889.405529723479;11999.160058795887;12000.579979700757;12028.819567706492;12061.577844775478;10112.797744045078;10746.140308775279;11022;11131.610393636183;11390.943045284803;8385.916140838575;8976;9010.819783604291;9124.133207345292;9142.634294628207;3107.1300035989734;3107.7979931304394;3164.493681011027;3166.271757495766;3177.094528059492;40517.594824051674;40617.390739139235;40988;41623.58376416258;41682;8647.913520864711;8718.215360617574;8724.563771811385;8746.212840844228;8758.649978765472;14905.105693658199;14943.327550260265;14987.250637468083;15004.699906001819;15028.774568381483;6064;6120.051392034242;6125.846853828601;6155.446009859134;6320.304766475684;3386.695197432243;3507.0706262840367;3525.0834782956617;3538.663826936437;3614.530111085595;2594.9091781787547;2632.197179860161;2635.262126604554;2637.406583518731;2638.1689767723105;443.6007593166176;445.7815670321519;450.58996313355345;452.01686332227274;455;488.6310835319311;498.185466761847;516.4035538952515;566.2977907394801;574.7557288152518;7774.300312971746;7784.610769461504;7855.6464959076975;7861.52830830152;8045.115037345888;449.2699363534257;482.7706839251398;485.29874331590514;525.8185925855573;538.3727956930211;3347.9330413391594;3427.811470369104;3463.8787642432394;3464.9307013860084;3492.4935884296633;50705.23942140871;50789.49210507922;50953.745231273606;51370.22944655833;51676;45309.773451133195;45654;45878;46060.5393946063;46116.3082553762;40829.79585102056;40969.79515102465;41849;42733.78633106814;42740.358894616606;6338.144350512806;6423.229212494531;6427.58220715652;6470.48236141117;7646.350060244941;30321.545176821925;30326;30358.696413036472;30378.240543986576;31772.364552708354;39159;39774.403383949844;40417.79791101025;40614.18771624492;40676.1864762709;8347.540885251126;8643.265322447662;8940.351017471008;9318.254539636948;9373.625054997723;9891.802163956825;10066.094051535398;10077.596896124367;10138.797224055625;10138.847917281395;9759.463229522444;9853.211743060681;9877.703668889944;10395.272330936761;10413.739656508647;9973.202143828621;10054.34646747959;10143.391396516232;10337;10574.788504230026;9260.39807412516;9684.951575242361;9846.852297215404;9947.701568952943;10199.184065274909;8270.917290827256;8384.119667435076;8385.748427547183;8400.453970491899;8527.829443411221;8107.797305067421;8500.914990850013;8501.234888859784;8564.74305770828;8634.352423568384 02:15:07 INFO - 2015-11-24 02:15:07,152 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:15:07 INFO - 2015-11-24 02:15:07,152 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:15:07 INFO - 2015-11-24 02:15:07,152 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,977 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360107137__endTimestamp 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,153 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4597.36 Median:4738.93 stddev:467.61 (9.9%) stddev-sans-first:441.86 02:15:07 INFO - 2015-11-24 02:15:07,154 DEBUG : BROWSER_OUTPUT: Values: 2594.5 2689.0 2702.4 2703.7 2718.9 4555.0 4575.0 4662.2 4675.5 4696.6 4560.8 4597.1 4630.6 4643.1 4730.0 4267.7 4367.5 4370.6 4435.9 4448.3 4380.4 4424.9 4441.6 4446.6 4482.3 4161.1 4213.9 4259.6 4270.2 4336.2 4305.1 4318.3 4324.5 4324.8 4356.5 4316.9 4340.2 4342.6 4342.8 4367.2 4380.6 4471.7 4480.8 4521.3 4643.1 4983.5 4984.2 5007.5 5011.5 5040.2 5019.5 5023.8 5024.3 5027.3 5027.7 4540.9 4547.7 4654.2 4682.7 4687.4 5095.2 5153.9 5167.9 5169.5 5169.8 4947.1 4962.7 4965.1 4972.9 5020.7 4784.0 4870.1 4885.7 4885.7 4993.6 4904.2 4930.0 4932.4 4940.0 4988.8 4915.6 4916.9 4917.3 4921.6 4961.9 4050.8 4080.5 4116.6 4142.6 4166.7 3621.9 3624.6 3655.2 3656.3 3673.3 4319.1 4323.2 4327.5 4359.4 4361.7 4827.1 4923.9 4942.7 4954.4 4997.1 4243.7 4286.0 4307.7 4322.8 4336.5 4432.7 4467.8 4471.8 4479.1 4513.8 4575.3 4678.8 4794.6 4812.9 4816.5 4901.1 4923.0 4944.6 4975.9 5028.4 4759.0 4760.4 4760.7 4762.0 4800.2 4701.2 4806.7 4931.3 4933.8 4982.9 4833.8 4885.3 4897.2 4898.5 4943.1 4794.4 4818.3 4821.7 4824.1 4872.0 4657.0 4748.0 4808.7 4819.6 4865.8 4649.0 4671.9 4738.9 4828.6 4867.4 4846.8 4856.6 4857.1 4863.2 4867.5 4734.2 4766.7 4778.3 4783.2 4819.0 02:15:07 INFO - 2015-11-24 02:15:07,154 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,154 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37889.74 Median:28193.58 stddev:58899.62 (208.9%) stddev-sans-first:58998.10 02:15:07 INFO - 2015-11-24 02:15:07,154 DEBUG : BROWSER_OUTPUT: Values: 544.1 544.9 556.5 560.5 565.5 27760.3 28332.3 28335.6 28385.1 36467.0 38819.4 39350.2 39382.8 39390.2 39480.0 7966.2 8151.3 8161.8 8164.1 8164.1 7109.6 7305.7 7955.3 10035.8 10209.9 10164.5 10219.1 10293.1 10294.0 10296.6 6982.7 10031.9 10163.6 10174.9 10176.0 6805.8 10194.3 10469.1 10469.8 10477.1 35797.1 35992.8 36075.5 36276.9 36324.3 2610.8 2757.8 3126.7 3259.4 3297.1 27422.0 27718.0 27853.7 28158.0 28229.2 3398.5 3485.2 3487.6 3523.0 3592.5 226497.0 227122.0 227417.0 227880.0 228298.0 48678.5 52522.0 52689.2 52847.5 52869.0 46341.0 46490.8 46518.8 46556.9 59941.7 13613.4 13755.1 13778.8 13841.3 13846.1 10465.1 10479.6 10514.4 10515.8 10534.4 17800.4 17815.3 17954.8 17983.7 18017.9 6877.7 7147.7 7154.6 7196.6 7279.9 813.6 863.6 868.2 878.7 886.4 26060.9 26531.5 26612.0 26716.7 26837.9 971.5 994.6 997.3 1019.2 1080.3 12752.2 12792.1 12879.7 12891.9 12901.2 258681.0 261928.0 262851.0 264367.0 264956.0 44046.6 44281.0 44310.6 44339.6 44414.8 1197.3 1200.6 1211.9 1216.7 1221.9 24339.5 24896.9 25498.2 25612.9 25639.0 35207.3 35991.8 36049.8 40894.4 41641.8 181729.1 181807.0 183221.0 183489.0 183552.0 23256.0 27202.9 27587.3 27596.2 27631.2 24198.4 25197.4 34860.5 35348.0 35396.0 29760.6 30065.6 30445.4 30872.7 32113.5 32461.4 32696.3 32723.3 32956.5 33030.8 32735.1 33023.3 33033.7 33089.5 33194.0 25089.6 26179.7 27434.3 27437.0 27743.6 23272.3 23560.6 23894.2 24180.5 24203.3 02:15:07 INFO - 2015-11-24 02:15:07,154 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,156 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24165.25 Median:19632.57 stddev:73977.33 (376.8%) stddev-sans-first:74163.22 02:15:07 INFO - 2015-11-24 02:15:07,156 DEBUG : BROWSER_OUTPUT: Values: 334.8 335.5 336.4 337.9 340.2 12448.9 12639.7 14299.3 15131.3 15797.3 8675.4 10063.8 10197.6 10299.4 10487.7 4469.6 4593.9 4595.7 4596.0 4602.2 3077.7 3120.8 4453.9 4846.3 5118.7 5061.8 5092.3 5113.7 5115.5 5119.0 4986.3 5075.5 5521.0 5578.6 5584.7 4901.5 4946.6 4949.6 4954.6 4956.0 12350.2 16748.9 18562.3 19470.0 19483.9 1683.0 1714.1 1728.6 1746.3 1801.1 8947.3 9059.5 9178.9 9228.5 12091.1 1571.6 1637.8 1640.8 1715.8 1727.6 47101.5 48347.3 48402.8 49108.3 49383.8 9307.2 9469.0 9596.7 9630.7 9635.1 12146.8 12155.0 12155.1 12168.5 12169.6 6687.7 6733.5 6784.3 6848.1 6931.1 6546.3 6910.6 6981.4 6983.5 6996.2 4118.4 4126.3 4158.7 4204.2 4264.2 1635.3 1670.2 1676.6 1724.6 1766.6 385.1 385.7 404.9 746.8 890.6 9969.0 10082.8 10121.2 10335.3 10399.5 376.5 397.2 399.7 402.1 403.4 8813.4 9074.8 9129.7 9219.5 9308.2 442613.0 444493.0 448695.0 463349.0 469284.0 38879.4 38984.4 68015.0 71869.1 71944.2 1046.9 1061.5 1095.3 1123.6 1125.1 14368.6 14393.2 14430.5 14583.4 14807.7 29359.4 29845.7 29929.1 30311.0 30576.4 35748.6 36881.0 39498.4 40040.0 40771.0 8696.5 8725.8 9005.8 9082.5 9094.5 10616.3 12956.5 15437.5 15692.0 15987.9 12959.3 13045.0 13193.3 13266.7 13420.0 13360.9 13379.7 13508.2 13703.2 13805.7 10759.7 13563.4 13994.8 14135.2 14579.2 8679.4 8723.9 8802.7 8832.3 8832.4 13173.3 13189.4 13347.3 13506.8 13551.8 02:15:07 INFO - 2015-11-24 02:15:07,156 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,156 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4807.32 Median:6021.28 stddev:2454.42 (40.8%) stddev-sans-first:2447.21 02:15:07 INFO - 2015-11-24 02:15:07,157 DEBUG : BROWSER_OUTPUT: Values: 1307.9 1592.4 1634.8 1643.3 1653.7 5981.6 6680.9 6864.0 6868.1 6880.4 6725.6 6892.3 6895.9 6896.8 6907.5 2047.7 2069.7 2070.3 2073.6 2075.2 2016.5 2019.8 2026.0 2049.2 2049.7 2035.2 2063.8 2080.1 2081.5 2081.5 2015.8 2038.0 2040.3 2043.5 2044.7 2037.0 2039.6 2079.5 2082.9 2083.8 5836.9 6060.9 6876.6 6881.0 6914.7 3990.0 4071.9 4073.5 4083.9 4111.2 2695.8 2718.1 2753.9 2755.1 2771.6 907.2 907.7 917.8 918.6 921.2 8890.2 8936.9 8974.8 8984.6 8988.4 3834.1 3840.1 3864.6 3913.5 3916.1 7948.5 7950.4 7953.2 7953.8 7963.3 4152.8 4161.2 4167.1 4168.0 4168.2 3804.3 3808.7 3811.3 3812.2 3818.5 3140.9 3145.2 3169.9 3208.5 3210.9 1036.1 1037.6 1051.5 1056.3 1058.9 1122.5 1129.5 1160.4 1161.5 1162.6 6507.6 6522.5 6542.0 6542.2 6549.7 456.1 459.2 464.9 465.2 466.1 4811.8 5062.7 5155.0 5167.6 5168.9 7483.9 8192.7 8265.5 8326.3 8329.4 8129.3 8142.9 8184.1 8197.4 8214.3 6243.5 6276.1 6279.5 6312.9 6336.8 6272.4 6357.8 6362.7 6368.7 6381.1 7012.8 7238.9 7298.2 7327.2 7344.7 7304.2 7453.8 7581.1 7584.3 7593.7 6122.4 6129.5 6188.5 6201.2 6202.0 6610.9 6682.6 6682.7 6686.5 6687.2 6315.2 6320.9 6376.4 6418.3 6483.2 6122.9 6155.9 6166.0 6195.1 6343.5 6286.8 6376.5 6379.9 6382.7 6388.0 5868.2 5904.4 5906.0 5908.0 5919.7 5779.8 5913.9 5918.1 5918.3 6064.4 02:15:07 INFO - 2015-11-24 02:15:07,158 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,158 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4690.92 Median:5321.74 stddev:1376.37 (25.9%) stddev-sans-first:1340.14 02:15:07 INFO - 2015-11-24 02:15:07,159 DEBUG : BROWSER_OUTPUT: Values: 296.9 304.0 304.8 313.4 314.7 5340.4 5381.5 5500.8 5509.7 5534.3 5308.1 5335.4 5378.5 5381.8 5385.4 3971.0 4023.6 4171.4 4178.4 4181.4 4123.8 4177.0 4199.8 4212.6 4213.6 4153.0 4156.1 4169.2 4170.7 4173.1 3982.1 4056.7 4081.0 4130.2 4165.0 3646.9 3648.9 3662.6 3666.6 3687.2 5137.0 5166.7 5170.0 5170.2 5176.9 4757.8 4772.5 4779.3 4779.6 4787.8 5501.6 5591.5 5608.9 5613.0 5627.7 3992.9 3996.5 3997.0 3999.9 4002.2 5826.3 5923.0 5924.0 5933.7 5933.9 3975.3 4003.2 4005.5 4008.9 4010.8 3983.7 4037.1 4069.7 4076.6 4081.2 4665.4 4666.9 4668.9 4674.0 4676.7 5610.2 5620.1 5621.2 5622.9 5622.9 1490.3 1516.5 1518.3 1519.4 1522.2 1020.9 1038.5 1039.2 1055.1 1067.7 4946.8 4953.3 4959.0 4959.4 4969.2 5830.3 5836.8 5838.1 5838.8 5846.4 4941.8 4945.3 4954.4 4954.6 4957.1 2932.6 3002.1 3066.7 3120.7 3144.6 5572.0 5589.6 5592.5 5602.6 5612.7 6042.3 6049.5 6050.6 6055.5 6063.0 5424.6 5569.4 5571.1 5579.4 5582.9 5885.7 5894.7 5901.6 5905.9 5910.2 5758.9 5761.8 5764.0 5764.5 5764.5 5581.9 5584.2 5587.2 5594.6 5600.6 3983.9 4017.1 4019.7 4026.3 4104.2 5864.9 5871.4 5873.2 5877.9 5878.5 5668.1 5668.2 5668.7 5674.5 5676.6 5430.6 5624.5 5629.5 5662.4 5662.7 5503.8 5526.9 5549.7 5553.7 5558.6 5697.9 5701.0 5701.9 5703.0 5712.8 5541.3 5565.6 5566.2 5566.7 5567.3 02:15:07 INFO - 2015-11-24 02:15:07,159 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,159 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12107.52 Median:25601.71 stddev:14165.43 (55.3%) stddev-sans-first:14179.50 02:15:07 INFO - 2015-11-24 02:15:07,161 DEBUG : BROWSER_OUTPUT: Values: 752.0 753.4 756.4 771.2 793.6 10982.6 12576.8 12748.8 12774.6 12777.7 12378.7 12402.9 12427.9 12436.8 12440.4 598.9 601.8 603.6 750.9 768.4 742.6 746.6 756.4 756.9 756.9 767.4 777.6 778.0 778.2 778.4 621.9 627.1 629.7 767.8 775.7 574.1 578.3 579.5 579.8 581.7 11889.4 11999.2 12000.6 12028.8 12061.6 10112.8 10746.1 11022.0 11131.6 11390.9 8385.9 8976.0 9010.8 9124.1 9142.6 3107.1 3107.8 3164.5 3166.3 3177.1 40517.6 40617.4 40988.0 41623.6 41682.0 8647.9 8718.2 8724.6 8746.2 8758.6 14905.1 14943.3 14987.3 15004.7 15028.8 6064.0 6120.1 6125.8 6155.4 6320.3 3386.7 3507.1 3525.1 3538.7 3614.5 2594.9 2632.2 2635.3 2637.4 2638.2 443.6 445.8 450.6 452.0 455.0 488.6 498.2 516.4 566.3 574.8 7774.3 7784.6 7855.6 7861.5 8045.1 449.3 482.8 485.3 525.8 538.4 3347.9 3427.8 3463.9 3464.9 3492.5 50705.2 50789.5 50953.7 51370.2 51676.0 45309.8 45654.0 45878.0 46060.5 46116.3 40829.8 40969.8 41849.0 42733.8 42740.4 6338.1 6423.2 6427.6 6470.5 7646.4 30321.5 30326.0 30358.7 30378.2 31772.4 39159.0 39774.4 40417.8 40614.2 40676.2 8347.5 8643.3 8940.4 9318.3 9373.6 9891.8 10066.1 10077.6 10138.8 10138.8 9759.5 9853.2 9877.7 10395.3 10413.7 9973.2 10054.3 10143.4 10337.0 10574.8 9260.4 9685.0 9846.9 9947.7 10199.2 8270.9 8384.1 8385.7 8400.5 8527.8 8107.8 8500.9 8501.2 8564.7 8634.4 02:15:07 INFO - 2015-11-24 02:15:07,161 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:15:07 INFO - 2015-11-24 02:15:07,161 DEBUG : BROWSER_OUTPUT: 02:15:07 INFO - 2015-11-24 02:15:07,849 INFO : Browser exited with error code: 0 02:15:07 INFO - 2015-11-24 02:15:07,870 INFO : Completed test dromaeo_css (00:18:36) 02:15:07 INFO - 2015-11-24 02:15:07,870 INFO : Starting test kraken 02:15:07 INFO - 2015-11-24 02:15:07,870 DEBUG : operating with platform_type : linux_ 02:15:07 INFO - 2015-11-24 02:15:07,870 INFO : Initialising browser for kraken test... 02:15:07 INFO - 2015-11-24 02:15:07,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprqqSod/profile http://localhost:39420/getInfo.html 02:15:11 INFO - 2015-11-24 02:15:11,561 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:15:11 INFO - 2015-11-24 02:15:11,561 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:15:11 INFO - 2015-11-24 02:15:11,561 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:15:11 INFO - 2015-11-24 02:15:11,561 DEBUG : BROWSER_OUTPUT: __metrics 02:15:11 INFO - 2015-11-24 02:15:11,670 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:12 INFO - 2015-11-24 02:15:12,847 INFO : Browser initialized. 02:15:12 INFO - 2015-11-24 02:15:12,847 INFO : Running cycle 1/1 for kraken test... 02:15:12 INFO - 2015-11-24 02:15:12,848 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprqqSod/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:15:24 INFO - 2015-11-24 02:15:24,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 02:15:24 INFO - 2015-11-24 02:15:24,784 DEBUG : BROWSER_OUTPUT: 02:15:27 INFO - 2015-11-24 02:15:27,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:27 INFO - 2015-11-24 02:15:27,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 179093504 02:15:27 INFO - 2015-11-24 02:15:27,978 DEBUG : BROWSER_OUTPUT: 02:15:30 INFO - 2015-11-24 02:15:30,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-dft) 02:15:31 INFO - 2015-11-24 02:15:31,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 168165376 02:15:31 INFO - 2015-11-24 02:15:31,280 DEBUG : BROWSER_OUTPUT: 02:15:34 INFO - 2015-11-24 02:15:34,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-fft) 02:15:34 INFO - 2015-11-24 02:15:34,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 150917120 02:15:34 INFO - 2015-11-24 02:15:34,838 DEBUG : BROWSER_OUTPUT: 02:15:36 INFO - 2015-11-24 02:15:36,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39420/tests/kraken/driver.html?testName=audio-oscillator) 02:15:37 INFO - 2015-11-24 02:15:37,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 154263552 02:15:37 INFO - 2015-11-24 02:15:37,424 DEBUG : BROWSER_OUTPUT: 02:15:39 INFO - 2015-11-24 02:15:39,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:40 INFO - 2015-11-24 02:15:40,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 155340800 02:15:40 INFO - 2015-11-24 02:15:40,188 DEBUG : BROWSER_OUTPUT: 02:15:43 INFO - 2015-11-24 02:15:43,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:43 INFO - 2015-11-24 02:15:43,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 156983296 02:15:43 INFO - 2015-11-24 02:15:43,735 DEBUG : BROWSER_OUTPUT: 02:15:47 INFO - 2015-11-24 02:15:47,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39420/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:47 INFO - 2015-11-24 02:15:47,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 156712960 02:15:47 INFO - 2015-11-24 02:15:47,758 DEBUG : BROWSER_OUTPUT: 02:15:50 INFO - 2015-11-24 02:15:50,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39420/tests/kraken/driver.html?testName=json-parse-financial) 02:15:51 INFO - 2015-11-24 02:15:51,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 157044736 02:15:51 INFO - 2015-11-24 02:15:51,163 DEBUG : BROWSER_OUTPUT: 02:15:52 INFO - 2015-11-24 02:15:52,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:53 INFO - 2015-11-24 02:15:53,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 168935424 02:15:53 INFO - 2015-11-24 02:15:53,444 DEBUG : BROWSER_OUTPUT: 02:15:55 INFO - 2015-11-24 02:15:55,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:55 INFO - 2015-11-24 02:15:55,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 167370752 02:15:55 INFO - 2015-11-24 02:15:55,900 DEBUG : BROWSER_OUTPUT: 02:15:57 INFO - 2015-11-24 02:15:57,983 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:58 INFO - 2015-11-24 02:15:58,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 176672768 02:15:58 INFO - 2015-11-24 02:15:58,564 DEBUG : BROWSER_OUTPUT: 02:16:01 INFO - 2015-11-24 02:16:01,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:16:01 INFO - 2015-11-24 02:16:01,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 183808000 02:16:01 INFO - 2015-11-24 02:16:01,661 DEBUG : BROWSER_OUTPUT: 02:16:04 INFO - 2015-11-24 02:16:04,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:04 INFO - 2015-11-24 02:16:04,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 181788672 02:16:04 INFO - 2015-11-24 02:16:04,820 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39420/tests/kraken/driver.html?testName=ai-astar) 02:16:06 INFO - 2015-11-24 02:16:06,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 241995776 02:16:06 INFO - 2015-11-24 02:16:06,851 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;107;113;113;114;102;112;112;106 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;129;159;172;133;154;160;131;177;135 02:16:06 INFO - 2015-11-24 02:16:06,855 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;159;160;163;160;162;161;161;162 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;82;93;73;71;73;88;90;71 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;95;95;94;131;94;94;131 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;108;109;109;109;109 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;147;146;147;146;146;146;146;146 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;96 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;71;69;71;71;70;70;70 02:16:06 INFO - 2015-11-24 02:16:06,856 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;68;68;68;71;67;69;68 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;83;86;84;87;86;84;83;82 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;145;118;119;117;122;119;122;127;127 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;144;154;151;150;138;150;145;149;135 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;69;73;67;67;69;70;68 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,963 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360166853__endTimestamp 02:16:06 INFO - 2015-11-24 02:16:06,857 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,860 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:16:06 INFO - 2015-11-24 02:16:06,860 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 107.0 113.0 113.0 114.0 102.0 112.0 112.0 106.0 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:156.50 stddev:17.42 (11.1%) stddev-sans-first:18.46 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: Values: 152.0 129.0 159.0 172.0 133.0 154.0 160.0 131.0 177.0 135.0 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 159.0 160.0 163.0 160.0 162.0 161.0 161.0 162.0 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:77.50 stddev:8.76 (11.3%) stddev-sans-first:8.96 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 82.0 93.0 73.0 71.0 73.0 88.0 90.0 71.0 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:94.50 stddev:17.93 (19.0%) stddev-sans-first:18.60 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 95.0 95.0 94.0 131.0 94.0 94.0 131.0 02:16:06 INFO - 2015-11-24 02:16:06,861 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 108.0 109.0 109.0 109.0 109.0 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.40 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 71.0 69.0 71.0 71.0 70.0 70.0 70.0 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 68.0 68.0 68.0 71.0 67.0 69.0 68.0 02:16:06 INFO - 2015-11-24 02:16:06,862 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.91 (2.3%) stddev-sans-first:1.72 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 83.0 86.0 84.0 87.0 86.0 84.0 83.0 82.0 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:122.50 stddev:8.18 (6.7%) stddev-sans-first:8.67 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: Values: 123.0 145.0 118.0 119.0 117.0 122.0 119.0 122.0 127.0 127.0 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,863 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:149.50 stddev:6.63 (4.4%) stddev-sans-first:6.32 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: Values: 137.0 144.0 154.0 151.0 150.0 138.0 150.0 145.0 149.0 135.0 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.75 (2.5%) stddev-sans-first:1.83 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 69.0 73.0 67.0 67.0 69.0 70.0 68.0 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:16:06 INFO - 2015-11-24 02:16:06,864 DEBUG : BROWSER_OUTPUT: 02:16:07 INFO - 2015-11-24 02:16:07,797 INFO : Browser exited with error code: 0 02:16:07 INFO - 2015-11-24 02:16:07,852 INFO : Completed test kraken (00:00:59) 02:16:07 INFO - 2015-11-24 02:16:07,853 INFO : Starting test v8_7 02:16:07 INFO - 2015-11-24 02:16:07,853 DEBUG : operating with platform_type : linux_ 02:16:07 INFO - 2015-11-24 02:16:07,853 INFO : Initialising browser for v8_7 test... 02:16:07 INFO - 2015-11-24 02:16:07,859 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplhixIh/profile http://localhost:39420/getInfo.html 02:16:11 INFO - 2015-11-24 02:16:11,513 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:16:11 INFO - 2015-11-24 02:16:11,513 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:16:11 INFO - 2015-11-24 02:16:11,513 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:16:11 INFO - 2015-11-24 02:16:11,513 DEBUG : BROWSER_OUTPUT: __metrics 02:16:11 INFO - 2015-11-24 02:16:11,634 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:12 INFO - 2015-11-24 02:16:12,829 INFO : Browser initialized. 02:16:12 INFO - 2015-11-24 02:16:12,830 INFO : Running cycle 1/1 for v8_7 test... 02:16:12 INFO - 2015-11-24 02:16:12,830 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplhixIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:16:24 INFO - 2015-11-24 02:16:24,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 140013568 02:16:24 INFO - 2015-11-24 02:16:24,836 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39420/tests/v8_7/run.html (next: http://localhost:39420/tests/v8_7/run.html) 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 441532416 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: |0;Richards;186.4975755315181 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.9754271453254 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 02:16:46 INFO - 2015-11-24 02:16:46,482 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |6;Boyer;12395.061728395061 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |7;RegExp;26421.052631578947 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |8;Splay;628.75 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:16:46 INFO - 2015-11-24 02:16:46,483 DEBUG : BROWSER_OUTPUT: __startTimestamp1448360206476__endTimestamp 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.50 Median:186.50 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: Values: 186.5 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.98 Median:191.98 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: Values: 192.0 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,484 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 279.0 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 5000.0 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 1998.0 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 798.1 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 12395.1 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,485 DEBUG : BROWSER_OUTPUT: Values: 26421.1 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:628.75 Median:628.75 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: Values: 628.8 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: Values: 4840.6 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:16:46 INFO - 2015-11-24 02:16:46,486 DEBUG : BROWSER_OUTPUT: 02:16:47 INFO - 2015-11-24 02:16:47,377 INFO : Browser exited with error code: 0 02:16:47 INFO - 2015-11-24 02:16:47,394 INFO : Completed test v8_7 (00:00:39) 02:16:47 INFO - 2015-11-24 02:16:47,522 INFO : Completed test suite (00:20:16) 02:16:47 INFO - 2015-11-24 02:16:47,522 DEBUG : Working with test: dromaeo_css 02:16:47 INFO - 2015-11-24 02:16:47,522 DEBUG : Generating results file: dromaeo_css 02:16:47 INFO - 2015-11-24 02:16:47,523 DEBUG : Working with test: kraken 02:16:47 INFO - 2015-11-24 02:16:47,524 DEBUG : Generating results file: kraken 02:16:47 INFO - 2015-11-24 02:16:47,524 INFO : javascript benchmark 02:16:47 INFO - 2015-11-24 02:16:47,524 DEBUG : Working with test: v8_7 02:16:47 INFO - 2015-11-24 02:16:47,524 DEBUG : Generating results file: v8_7 02:16:47 INFO - 2015-11-24 02:16:47,525 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:47 INFO - 2015-11-24 02:16:47,646 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 02:16:47 INFO - 2015-11-24 02:16:47,646 DEBUG : process_Request line: dromaeo_css 6101.71 graph.html#tests=[[72,132,35]] 02:16:47 INFO - 2015-11-24 02:16:47,646 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:47 INFO - 2015-11-24 02:16:47,683 DEBUG : process_Request line: kraken 1516.80 graph.html#tests=[[232,132,35]] 02:16:47 INFO - 2015-11-24 02:16:47,683 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:16:47 INFO - 2015-11-24 02:16:47,711 DEBUG : process_Request line: v8_7 19472.72 graph.html#tests=[[230,132,35]] 02:16:47 INFO - 2015-11-24 02:16:47,712 INFO : javascript benchmark 02:16:47 INFO - 2015-11-24 02:16:47,716 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.5329840628683, 2689.047185261512, 2702.4459985702933, 2703.7296270372976, 2718.8912443502263, 4554.954450455494, 4574.977125114378, 4662.160811054009, 4675.462321832986, 4696.553827386393, 4560.794764235609, 4597.1265459562655, 4630.606398456135, 4643.117807616551, 4730.0303437795255, 4267.701260911737, 4367.541408152138, 4370.584794444522, 4435.911281774379, 4448.310511870665, 4380.364847097169, 4424.933625995613, 4441.644668426534, 4446.622037126848, 4482.305242687373, 4161.0845613964875, 4213.894652633678, 4259.616634502879, 4270.231358355495, 4336.154449882274, 4305.095929854734, 4318.330658747899, 4324.524302326741, 4324.805383757738, 4356.542563030868, 4316.892077698051, 4340.197063543254, 4342.5874541918465, 4342.782860856944, 4367.235733746614, 4380.6057454829215, 4471.709338892962, 4480.843170489017, 4521.276595744698, 4643.141018911512, 4983.451820299764, 4984.177610694231, 5007.4992500749995, 5011.523905228997, 5040.243963405482, 5019.52314530119, 5023.824166154203, 5024.346834911475, 5027.271045698353, 5027.723475208862, 4540.931886021713, 4547.749873756975, 4654.232051711498, 4682.695624784378, 4687.390639216914, 5095.184770436712, 5153.922691159635, 5167.948320516822, 5169.53474187325, 5169.7673604687125, 4947.109520286311, 4962.6774259673, 4965.106280869406, 4972.8508144755715, 5020.723860187724, 4783.976080119647, 4870.1233777920315, 4885.658003939761, 4885.682430641997, 4993.575546078551, 4904.190808516626, 4929.975350123226, 4932.383452068491, 4940.0, 4988.775505102207, 4915.557599816034, 4916.926246106311, 4917.336159618406, 4921.557059864629, 4961.883576195327, 4050.7569545827346, 4080.469538959916, 4116.608922152391, 4142.647874930604, 4166.729147609947, 3621.9275614487565, 3624.619414961444, 3655.2324011957253, 3656.2870240302886, 3673.3387990162028, 4319.092990472036, 4323.178596066738, 4327.545607711208, 4359.38968544404, 4361.672874534423, 4827.131116399011, 4923.926141107886, 4942.728149951715, 4954.355933728592, 4997.125503037027, 4243.724157929724, 4285.99279169395, 4307.655387568987, 4322.827086916551, 4336.457942757155, 4432.711873728197, 4467.776611169494, 4471.7987690554, 4479.126570318822, 4513.819447222074, 4575.267957126844, 4678.766061696833, 4794.616430685537, 4812.903741925212, 4816.470188279286, 4901.14230009754, 4923.040007198562, 4944.629152813482, 4975.900481990412, 5028.421731500925, 4758.976205118952, 4760.381150450419, 4760.677831731218, 4761.976190119027, 4800.207965685762, 4701.177293973609, 4806.663533552618, 4931.3096166536, 4933.77797999098, 4982.8754281143265, 4833.782479788348, 4885.291632713308, 4897.240927656219, 4898.510148985073, 4943.060818444484, 4794.352762377034, 4818.301346304696, 4821.734804585782, 4824.059308434821, 4871.95128048715, 4656.998745269783, 4748.0, 4808.711477311373, 4819.566239038503, 4865.80536778539, 4648.953510464852, 4671.906561868812, 4738.928916066331, 4828.565429111397, 4867.440244371943, 4846.781894814812, 4856.635752318661, 4857.101436234167, 4863.221884498605, 4867.488913664014, 4734.17151998392, 4766.713997160182, 4778.259369797687, 4783.186858234039, 4818.975905120452], "unit": "ms", "name": "dojo.html", "value": 4568.810391194723}, {"lowerIsBetter": false, "replicates": [544.1049473615902, 544.8746788238705, 556.5408537956185, 560.5459577742026, 565.510833129343, 27760.3059923502, 28332.29169270769, 28335.57496637552, 28385.14844554664, 36467.0, 38819.41770873439, 39350.21299574007, 39382.803085984604, 39390.21219575614, 39480.0, 7966.203379662031, 8151.307138893201, 8161.755147345589, 8164.101948785629, 8164.1427650096775, 7109.644517774116, 7305.744298949538, 7955.284024437799, 10035.849462258071, 10209.948950255239, 10164.491775411238, 10219.080282774548, 10293.125084367837, 10294.0, 10296.639617613386, 6982.720691172347, 10031.899681003206, 10163.644272450503, 10174.949125254401, 10176.033276838725, 6805.761798337084, 10194.286399952007, 10469.057784799328, 10469.84295235572, 10477.109445697124, 35797.10507237314, 35992.820035899655, 36075.458868117, 36276.911692649264, 36324.27351452956, 2610.830296030771, 2757.834529928211, 3126.656067832537, 3259.429599820022, 3297.142742886843, 27422.0, 27718.0, 27853.721462785517, 28158.0, 28229.153125406272, 3398.5242066110764, 3485.1809824691177, 3487.5640544931885, 3523.0311664292267, 3592.46113083037, 226497.0, 227122.0, 227416.99999999834, 227880.0, 228298.0, 48678.51321486811, 52522.0, 52689.2096618551, 52847.47152528426, 52869.0, 46341.0, 46490.76754616273, 46518.767406162755, 46556.9475968122, 59941.700291498266, 13613.387397567134, 13755.074289599464, 13778.793318100237, 13841.30793460323, 13846.10000349974, 10465.110465610509, 10479.580816767397, 10514.421706806199, 10515.789684206426, 10534.36793792375, 17800.3769868054, 17815.287388504315, 17954.820451795316, 17983.73024404635, 18017.909910450362, 6877.690503927335, 7147.678354474061, 7154.570725756367, 7196.604186769673, 7279.927200728031, 813.6460639621783, 863.628639684929, 868.2316150206985, 878.7056336127341, 886.3839631456076, 26060.869695651778, 26531.469370612867, 26612.0, 26716.732832671813, 26837.865810671214, 971.4899677669139, 994.572333896417, 997.2620261006948, 1019.2304809868501, 1080.3193987787643, 12752.234865908074, 12792.104552681223, 12879.742405151845, 12891.935540322238, 12901.161424507565, 258681.0, 261928.0, 262851.0, 264367.0, 264956.0, 44046.559534404885, 44281.0, 44310.55689443064, 44339.55660443419, 44414.77792611016, 1197.2816310213802, 1200.6278053803173, 1211.8666946635863, 1216.7384012437192, 1221.865594784573, 24339.513209735353, 24896.87551562303, 25498.235052948443, 25612.871935640203, 25639.0, 35207.295854083284, 35991.82004089963, 36049.81975090213, 40894.38658420066, 41641.79179104085, 181729.09135454238, 181807.0, 183221.0, 183489.0, 183552.0, 23256.0, 27202.863985679945, 27587.310317241427, 27596.172114836587, 27631.171064868086, 24198.395040124138, 25197.370065748502, 34860.47709284312, 35348.0, 35396.0, 29760.553591696575, 30065.64704588255, 30445.391092178474, 30872.69127308698, 32113.51829722509, 32461.35077298488, 32696.34607307793, 32723.34553308873, 32956.50565241475, 33030.834845825615, 32735.071791385188, 33023.339533208724, 33033.66966330306, 33089.50365744468, 33194.0, 25089.623655645544, 26179.73820261773, 27434.314142146606, 27437.0, 27743.58384624192, 23272.3018309451, 23560.6465903015, 23894.238452932826, 24180.51638967246, 24203.273901782974], "unit": "ms", "name": "ext.html", "value": 16461.136866524135}, {"lowerIsBetter": false, "replicates": [334.79744754423575, 335.5055164849345, 336.40120585358056, 337.9273456206915, 340.15641209799696, 12448.93775531121, 12639.684007899807, 14299.28503574821, 15131.31909064092, 15797.289121989525, 8675.436096653713, 10063.798724025515, 10197.643082492114, 10299.382037077761, 10487.73780655484, 4469.553044695537, 4593.908121837561, 4595.655325850558, 4596.0, 4602.240630295997, 3077.7383922366625, 3120.765942554306, 4453.88865278369, 4846.345743324641, 5118.718470484122, 5061.772220250097, 5092.261622064799, 5113.693178409308, 5115.53960143587, 5118.9744051279695, 4986.252062190682, 5075.492450754932, 5520.972395138018, 5578.553715702775, 5584.720763961826, 4901.534354236377, 4946.604271658259, 4949.628777841676, 4954.5540901319055, 4956.0, 12350.197237179644, 16748.916255418768, 18562.257509699597, 19470.0, 19483.902580487007, 1682.9915850420791, 1714.1429285357322, 1728.6110625109375, 1746.2927514356707, 1801.0724476894409, 8947.32895032875, 9059.547022648841, 9178.86231706525, 9228.538573071319, 12091.093168012347, 1571.5835303644544, 1637.7625244339504, 1640.7866977292877, 1715.836995485427, 1727.6112874603239, 47101.5289847104, 48347.27479087852, 48402.7579862102, 49108.263376049385, 49383.75308123436, 9307.208887244524, 9469.0, 9596.66411675588, 9630.662926797528, 9635.13283804461, 12146.75706485883, 12155.0, 12155.088368372408, 12168.513259469699, 12169.634910952685, 6687.732490700318, 6733.494987875929, 6784.287649796799, 6848.075509806212, 6931.0643063186835, 6546.279909209983, 6910.550814197061, 6981.371676549135, 6983.546069505466, 6996.230414654384, 4118.4440100586635, 4126.257273690764, 4158.708890377705, 4204.1801848639225, 4264.189803937304, 1635.3213416432286, 1670.206651840366, 1676.5892356372767, 1724.5516165796732, 1766.611345503987, 385.1372924648767, 385.7280617164892, 404.8927034335844, 746.8244962433823, 890.6348397157265, 9968.950155249177, 10082.848757268646, 10121.1903047756, 10335.328203666737, 10399.48002599867, 376.4522619588492, 397.2115351028207, 399.67226873963654, 402.0872619154503, 403.38282427885383, 8813.383063185516, 9074.818503630022, 9129.680461183827, 9219.492927888896, 9308.208802251884, 442613.0, 444493.0, 448695.0, 463349.0, 469284.0, 38879.41680874789, 38984.41523377151, 68014.9797753034, 71869.13461922451, 71944.20139496554, 1046.926715129949, 1061.490484567412, 1095.27164435651, 1123.5898896902736, 1125.0718157519916, 14368.640783980483, 14393.208373539137, 14430.494932677306, 14583.416663333348, 14807.703845922806, 29359.412811744074, 29845.70154298516, 29929.102126936228, 30311.0, 30576.388472230876, 35748.64251357453, 36881.0, 39498.40752388659, 40040.0, 40771.0, 8696.521691307038, 8725.781855453664, 9005.819883602422, 9082.45505269686, 9094.545272736468, 10616.309939853885, 12956.481740730265, 15437.459688910834, 15692.0, 15987.920060399623, 12959.287239201934, 13045.0, 13193.274369909746, 13266.668333291746, 13420.0, 13360.86639133635, 13379.665508362368, 13508.18950862912, 13703.177809331472, 13805.654858628615, 10759.731006724895, 13563.389647466085, 13994.790078149039, 14135.222562759147, 14579.198144102176, 8679.435836670596, 8723.91276087231, 8802.691905783267, 8832.337574681796, 8832.425892316978, 13173.341332933507, 13189.40647670838, 13347.265900375573, 13506.797398038841, 13551.79672304936], "unit": "ms", "name": "jquery.html", "value": 7538.385332351502}, {"lowerIsBetter": false, "replicates": [1307.928063956482, 1592.3710134496873, 1634.8365163483654, 1643.318023020446, 1653.6692661467703, 5981.641101533911, 6680.866382672343, 6863.965680171605, 6868.141482314711, 6880.449564034884, 6725.562838415512, 6892.345227203407, 6895.862082758342, 6896.75861344853, 6907.481938854594, 2047.6518991771434, 2069.7102405663145, 2070.265055905147, 2073.564551444191, 2075.1595603780493, 2016.4857961219868, 2019.7980201979758, 2025.9696104558443, 2049.2008116834445, 2049.6925461180795, 2035.2164416699604, 2063.793620637932, 2080.136743251549, 2081.458820706612, 2081.4588207066195, 2015.8488113391481, 2037.9592408151755, 2040.2960978462406, 2043.4891277180704, 2044.6932960055963, 2037.02222932993, 2039.5512987142804, 2079.5321052763156, 2082.9479263018393, 2083.8332933365296, 5836.854078648025, 6060.909086363708, 6876.553024053471, 6881.036654868322, 6914.723411063552, 3989.960100398988, 4071.9389209161886, 4073.4500842386196, 4083.9387409188885, 4111.218868414991, 2695.7978151638704, 2718.103026001415, 2753.8898444062415, 2755.145904769508, 2771.598118272859, 907.1654078248027, 907.7004588485784, 917.7522069041388, 918.6095909238547, 921.2491819167357, 8890.244329232022, 8936.910630893737, 8974.775630609221, 8984.595693193822, 8988.415752976036, 3834.079820842978, 3840.078381188495, 3864.574896761354, 3913.471681323042, 3916.138449541096, 7948.523088614702, 7950.403719721044, 7953.244441778022, 7953.801154971056, 7963.323117534958, 4152.8338866445, 4161.167766446722, 4167.083241686824, 4168.0, 4168.2080404723, 3804.2581696569455, 3808.6572208501366, 3811.294910441577, 3812.218495208476, 3818.522684664417, 3140.9214769630485, 3145.150809281481, 3169.904902852918, 3208.4866421372467, 3210.9197270068435, 1036.1037702387532, 1037.5642230263309, 1051.4742628685658, 1056.2922841696081, 1058.9470526473644, 1122.528538014036, 1129.48043899807, 1160.4313886195703, 1161.517970042423, 1162.604714397109, 6507.609543427315, 6522.510811689142, 6542.0186971953635, 6542.182227221598, 6549.705263263165, 456.1424521898809, 459.23766547530937, 464.8884267775777, 465.2370113014659, 466.1120565323065, 4811.831585894477, 5062.696238225718, 5154.974225128925, 5167.586593072545, 5168.9224661630105, 7483.8877416838795, 8192.713255036164, 8265.46274492168, 8326.250637442537, 8329.375296852639, 8129.309008734205, 8142.918570814334, 8184.058833234135, 8197.426180167451, 8214.342852571779, 6243.469305109116, 6276.058591211355, 6279.4662453691035, 6312.873742525216, 6336.778212762623, 6272.435480806749, 6357.841053973688, 6362.6818659067785, 6368.713407896563, 6381.138546296191, 7012.824679383056, 7238.927610724036, 7298.197198308288, 7327.194008659149, 7344.706211751683, 7304.19653838088, 7453.813654658677, 7581.052368453943, 7584.2794934481135, 7593.658285377061, 6122.418370254819, 6129.540284478593, 6188.535859810622, 6201.224846894138, 6201.976673848764, 6610.933890661224, 6682.599044057372, 6682.699278532575, 6686.53194276396, 6687.230968438692, 6315.179026726496, 6320.873582528416, 6376.3623637635865, 6418.29398766126, 6483.222013358427, 6122.938770612415, 6155.876882462236, 6166.0, 6195.070739388947, 6343.460805831556, 6286.779962701284, 6376.4580010697755, 6379.883520384007, 6382.744690212339, 6387.968060159669, 5868.178455016387, 5904.350521442724, 5905.970470147622, 5908.0, 5919.733611987384, 5779.768809247583, 5913.881722365614, 5918.141869428995, 5918.260217472816, 6064.423879731418], "unit": "ms", "name": "mootools.html", "value": 3921.9174418169105}, {"lowerIsBetter": false, "replicates": [296.90202233263, 303.951367781155, 304.80492484809724, 313.44833093754994, 314.7057501236344, 5340.359156901172, 5381.488758567934, 5500.834974950748, 5509.669419834812, 5534.308211473561, 5308.071087559681, 5335.413104558495, 5378.515933565978, 5381.757820898059, 5385.35375754909, 3970.9675484373984, 4023.5976402359825, 4171.395147703581, 4178.415021896922, 4181.393697913801, 4123.814428350732, 4176.958230417703, 4199.7690127043, 4212.55768144345, 4213.5786421357925, 4153.0, 4156.106437116019, 4169.187008533338, 4170.749755014709, 4173.08192197716, 3982.0841206522373, 4056.655184309337, 4080.9591904080876, 4130.153318569686, 4165.0, 3646.890593282206, 3648.890533284006, 3662.5971143174497, 3666.633336666339, 3687.1519550503267, 5136.974315128437, 5166.664166829181, 5169.974150129226, 5170.172772356443, 5176.948230517684, 4757.762111894392, 4772.546608072227, 4779.283107533863, 4779.593734532534, 4787.784549695272, 5501.648332751955, 5591.4688104629995, 5608.887822243573, 5613.045782216992, 5627.746751396197, 3992.8602498912687, 3996.500437445319, 3997.0, 3999.9400008999887, 4002.239574480839, 5826.329972053226, 5923.0, 5924.0, 5933.732982015819, 5933.8813223735715, 3975.3241948868763, 4003.219372222447, 4005.459262999516, 4008.8997775055273, 4010.819513121858, 3983.698065018157, 4037.051292946155, 4069.694772892045, 4076.5923407658997, 4081.163361510883, 4665.370175026396, 4666.929996050062, 4668.883277918011, 4674.0, 4676.719396836201, 5610.186522954149, 5620.1288800236025, 5621.18492818539, 5622.85942851432, 5622.887542249132, 1490.2846633615925, 1516.4919751883242, 1518.2864053894652, 1519.4302136698739, 1522.2312732070234, 1020.882598501167, 1038.5378506564507, 1039.1894322428518, 1055.145332280855, 1067.743741502034, 4946.826861059918, 4953.306537084811, 4958.9504104959215, 4959.429665588431, 4969.18008528596, 5830.329512106162, 5836.824895253149, 5838.065909454467, 5838.795642152504, 5846.386129456431, 4941.75291235444, 4945.307656928033, 4954.40547134339, 4954.603631709455, 4957.132501812241, 2932.5747766573727, 3002.069358498872, 3066.6933306669152, 3120.7035331643456, 3144.591203143577, 5572.0, 5589.552835773128, 5592.5246354059545, 5602.635828671123, 5612.719364031864, 6042.335343112254, 6049.485793707584, 6050.57645964787, 6055.455009049207, 6063.029915213545, 5424.620276580759, 5569.443055694479, 5571.1086226204425, 5579.414161513064, 5582.91625625616, 5885.676287804212, 5894.705264736832, 5901.616394934315, 5905.91141132892, 5910.202122713551, 5758.884822303614, 5761.798337058351, 5764.048931926353, 5764.510016648632, 5764.538836893123, 5581.888362232814, 5584.190292407659, 5587.245721827664, 5594.580406469612, 5600.60795744294, 3983.940240896447, 4017.0961533655864, 4019.718619696593, 4026.3155263605845, 4104.1586474772, 5864.882702346014, 5871.383504732113, 5873.236479257669, 5877.911831322619, 5878.500327472213, 5668.093105103164, 5668.178114173505, 5668.744906479301, 5674.546036317167, 5676.574256930664, 5430.565554755531, 5624.465675760796, 5629.493345598752, 5662.405447427961, 5662.716864156858, 5503.807366742145, 5526.889462210814, 5549.72251387421, 5553.72231388437, 5558.638688485235, 5697.914531281951, 5701.030824759718, 5701.914471283017, 5703.0, 5712.828615141552, 5541.307336582927, 5565.5825813063375, 5566.248556444828, 5566.721663916707, 5567.276254086943], "unit": "ms", "name": "prototype.html", "value": 4254.198904243729}, {"lowerIsBetter": false, "replicates": [751.984960300794, 753.4311594745966, 756.4024420707641, 771.1941021632393, 793.5714714054411, 10982.560697572097, 12576.81134782979, 12748.808767868477, 12774.552890648829, 12777.744445111115, 12378.690532736664, 12402.875971240284, 12427.875721242784, 12436.81344779829, 12440.377981100954, 598.8832177725324, 601.8405122642504, 603.604638961481, 750.9324160825538, 768.3584207186977, 742.5507567921384, 746.634149266858, 756.4440136499668, 756.8978187944612, 756.9016027916363, 767.4359345880773, 777.5684495105214, 777.9844403111963, 778.2489897249153, 778.353966208046, 621.9440250377465, 627.075064280183, 629.6757170057401, 767.769669099268, 775.6587101675273, 574.0786038408336, 578.3060327606888, 579.5045236322925, 579.7536047179932, 581.7294957844623, 11889.405529723479, 11999.160058795887, 12000.579979700757, 12028.819567706492, 12061.577844775478, 10112.797744045078, 10746.140308775279, 11022.0, 11131.610393636183, 11390.943045284803, 8385.916140838575, 8976.0, 9010.819783604291, 9124.133207345292, 9142.634294628207, 3107.1300035989734, 3107.7979931304394, 3164.493681011027, 3166.271757495766, 3177.094528059492, 40517.594824051674, 40617.390739139235, 40988.0, 41623.58376416258, 41682.0, 8647.913520864711, 8718.215360617574, 8724.563771811385, 8746.212840844228, 8758.649978765472, 14905.105693658199, 14943.327550260265, 14987.250637468083, 15004.699906001819, 15028.774568381483, 6064.0, 6120.051392034242, 6125.846853828601, 6155.446009859134, 6320.304766475684, 3386.695197432243, 3507.0706262840367, 3525.0834782956617, 3538.663826936437, 3614.530111085595, 2594.9091781787547, 2632.197179860161, 2635.262126604554, 2637.406583518731, 2638.1689767723105, 443.6007593166176, 445.7815670321519, 450.58996313355345, 452.01686332227274, 455.0, 488.6310835319311, 498.185466761847, 516.4035538952515, 566.2977907394801, 574.7557288152518, 7774.300312971746, 7784.610769461504, 7855.6464959076975, 7861.52830830152, 8045.115037345888, 449.2699363534257, 482.7706839251398, 485.29874331590514, 525.8185925855573, 538.3727956930211, 3347.9330413391594, 3427.811470369104, 3463.8787642432394, 3464.9307013860084, 3492.4935884296633, 50705.23942140871, 50789.49210507922, 50953.745231273606, 51370.22944655833, 51676.0, 45309.773451133195, 45654.0, 45878.0, 46060.5393946063, 46116.3082553762, 40829.79585102056, 40969.79515102465, 41849.0, 42733.78633106814, 42740.358894616606, 6338.144350512806, 6423.229212494531, 6427.58220715652, 6470.48236141117, 7646.350060244941, 30321.545176821925, 30326.0, 30358.696413036472, 30378.240543986576, 31772.364552708354, 39159.0, 39774.403383949844, 40417.79791101025, 40614.18771624492, 40676.1864762709, 8347.540885251126, 8643.265322447662, 8940.351017471008, 9318.254539636948, 9373.625054997723, 9891.802163956825, 10066.094051535398, 10077.596896124367, 10138.797224055625, 10138.847917281395, 9759.463229522444, 9853.211743060681, 9877.703668889944, 10395.272330936761, 10413.739656508647, 9973.202143828621, 10054.34646747959, 10143.391396516232, 10337.0, 10574.788504230026, 9260.39807412516, 9684.951575242361, 9846.852297215404, 9947.701568952943, 10199.184065274909, 8270.917290827256, 8384.119667435076, 8385.748427547183, 8400.453970491899, 8527.829443411221, 8107.797305067421, 8500.914990850013, 8501.234888859784, 8564.74305770828, 8634.352423568384], "unit": "ms", "name": "yui.html", "value": 5455.128692615907}], "name": "dromaeo_css", "value": 6101.704312824118}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 113.0, 113.0, 114.0, 102.0, 112.0, 112.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 129.0, 159.0, 172.0, 133.0, 154.0, 160.0, 131.0, 177.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 160.0, 163.0, 160.0, 162.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 82.0, 93.0, 73.0, 71.0, 73.0, 88.0, 90.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 95.0, 95.0, 94.0, 131.0, 94.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 71.0, 69.0, 71.0, 71.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 70.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 68.0, 68.0, 71.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 86.0, 84.0, 87.0, 86.0, 84.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [123.0, 145.0, 118.0, 119.0, 117.0, 122.0, 119.0, 122.0, 127.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [137.0, 144.0, 154.0, 151.0, 150.0, 138.0, 150.0, 145.0, 149.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 73.0, 67.0, 67.0, 69.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1516.8000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.4975755315181], "unit": "score", "name": "Richards", "value": 189.289324}, {"lowerIsBetter": false, "replicates": [191.9754271453254], "unit": "score", "name": "DeltaBlue", "value": 344.4086619999998}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [628.75], "unit": "score", "name": "Splay", "value": 129.60795228628228}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19472.72136041565}]} 02:16:47 INFO - RETURN: dromaeo_css: 6101.71 02:16:47 INFO - RETURN: kraken: 1516.80 02:16:47 INFO - RETURN: v8_7: 19472.72 02:16:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19472.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1516.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6101.71"}}} 02:16:47 INFO - Return code: 0 02:16:47 INFO - # TBPL SUCCESS # 02:16:47 INFO - Running post-action listener: _resource_record_post_action 02:16:47 INFO - Running post-run listener: _resource_record_post_run 02:16:48 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 502566912; Read time: 80; Write time: 484884 02:16:48 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 152064000; Read time: 0; Write time: 234532 02:16:48 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280121344; Read time: 8; Write time: 146648 02:16:48 INFO - Running post-run listener: _upload_blobber_files 02:16:48 INFO - Blob upload gear active. 02:16:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:16:48 INFO - Copying logs to upload dir... 02:16:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.871225 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-24 02:16:48.795846) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 02:16:48.799812) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010016 build_url: 'https://queue.taskcluster.net/v1/task/-gIA05XTTx6HBSVs8cQyAA/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-24 02:16:48.851416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:16:48.851744) ========= 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=919420d7ee4ef147bef0346300000385-1448355895.529698-476290453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 02:16:48.902385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:16:48.902693) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 02:16:48.903035) ========= ========= Total master_lag: 0.29 =========