builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1448331633.6 results: success (0) buildid: 20151123180231 builduid: 2bb2bf33cb334e6e8a902aacffaca018 revision: 0ed0b39c35419af45b20bf9b1df70104be2f7914 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.599565) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.599908) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.600178) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006531 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.628732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.629008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.703354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.703605) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004656 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.753113) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.753386) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.753734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.753992) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 18:20:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-23 18:20:34 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.877711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.877977) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021497 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.929636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:33.929921) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ed0b39c35419af45b20bf9b1df70104be2f7914 --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 0ed0b39c35419af45b20bf9b1df70104be2f7914 --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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 18:20:34,784 truncating revision to first 12 chars 2015-11-23 18:20:34,784 Setting DEBUG logging. 2015-11-23 18:20:34,784 attempt 1/10 2015-11-23 18:20:34,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ed0b39c3541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 18:20:35,099 unpacking tar archive at: fx-team-0ed0b39c3541/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.674951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.675281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.682075) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.682366) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 18:20:34.682828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-23 18:20:34.683102) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:35 INFO - MultiFileLogger online at 20151123 18:20:35 in /builds/slave/test 18:20:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:20:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:35 INFO - {'append_to_log': False, 18:20:35 INFO - 'base_work_dir': '/builds/slave/test', 18:20:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:20:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:35 INFO - 'branch': 'Fx-Team-Non-PGO', 18:20:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:35 INFO - 'config_files': ('talos/linux_config.py',), 18:20:35 INFO - 'default_actions': ('clobber', 18:20:35 INFO - 'read-buildbot-config', 18:20:35 INFO - 'download-and-extract', 18:20:35 INFO - 'populate-webroot', 18:20:35 INFO - 'create-virtualenv', 18:20:35 INFO - 'install', 18:20:35 INFO - 'run-tests'), 18:20:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:35 INFO - 'download_minidump_stackwalk': True, 18:20:35 INFO - 'download_symbols': 'ondemand', 18:20:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:35 INFO - 'installer_path': 'installer.exe', 18:20:35 INFO - 'log_level': 'info', 18:20:35 INFO - 'log_name': 'talos', 18:20:35 INFO - 'log_to_console': True, 18:20:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:35 INFO - 'opt_config_files': (), 18:20:35 INFO - 'pip_index': False, 18:20:35 INFO - 'sps_profile': False, 18:20:35 INFO - 'sps_profile_interval': 0, 18:20:35 INFO - 'suite': 'dromaeojs-e10s', 18:20:35 INFO - 'system_bits': '64', 18:20:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:35 INFO - 'title': 'talos-linux64-ix-025', 18:20:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:35 INFO - 'use_talos_json': True, 18:20:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:35 INFO - 'work_dir': 'build'} 18:20:35 INFO - ##### 18:20:35 INFO - ##### Running clobber step. 18:20:35 INFO - ##### 18:20:35 INFO - Running pre-action listener: _resource_record_pre_action 18:20:35 INFO - Running main action method: clobber 18:20:35 INFO - rmtree: /builds/slave/test/build 18:20:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:36 INFO - Running post-action listener: _resource_record_post_action 18:20:36 INFO - ##### 18:20:36 INFO - ##### Running read-buildbot-config step. 18:20:36 INFO - ##### 18:20:36 INFO - Running pre-action listener: _resource_record_pre_action 18:20:36 INFO - Running main action method: read_buildbot_config 18:20:36 INFO - Using buildbot properties: 18:20:36 INFO - { 18:20:36 INFO - "properties": { 18:20:36 INFO - "buildnumber": 454, 18:20:36 INFO - "product": "firefox", 18:20:36 INFO - "script_repo_revision": "production", 18:20:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:20:36 INFO - "repository": "", 18:20:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:20:36 INFO - "buildid": "20151123180231", 18:20:36 INFO - "slavename": "talos-linux64-ix-025", 18:20:36 INFO - "pgo_build": "False", 18:20:36 INFO - "basedir": "/builds/slave/test", 18:20:36 INFO - "project": "", 18:20:36 INFO - "platform": "ubuntu64_hw", 18:20:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:20:36 INFO - "slavebuilddir": "test", 18:20:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:20:36 INFO - "branch": "fx-team", 18:20:36 INFO - "repo_path": "integration/fx-team", 18:20:36 INFO - "stage_platform": "linux64", 18:20:36 INFO - "builduid": "2bb2bf33cb334e6e8a902aacffaca018", 18:20:36 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:36 INFO - }, 18:20:36 INFO - "sourcestamp": { 18:20:36 INFO - "repository": "", 18:20:36 INFO - "hasPatch": false, 18:20:36 INFO - "project": "", 18:20:36 INFO - "branch": "fx-team-linux64-talos", 18:20:36 INFO - "changes": [ 18:20:36 INFO - { 18:20:36 INFO - "category": null, 18:20:36 INFO - "files": [ 18:20:36 INFO - { 18:20:36 INFO - "url": null, 18:20:36 INFO - "name": "https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:20:36 INFO - } 18:20:36 INFO - ], 18:20:36 INFO - "repository": "", 18:20:36 INFO - "rev": "0ed0b39c35419af45b20bf9b1df70104be2f7914", 18:20:36 INFO - "who": "felipc@gmail.com", 18:20:36 INFO - "when": 1448331580, 18:20:36 INFO - "number": 6698465, 18:20:36 INFO - "comments": "Bug 1226487 - Enable e10s checks for accessibility on Beta. r=mconley", 18:20:36 INFO - "project": "", 18:20:36 INFO - "at": "Mon 23 Nov 2015 18:19:40", 18:20:36 INFO - "branch": "fx-team-linux64-talos", 18:20:36 INFO - "revlink": "", 18:20:36 INFO - "properties": [ 18:20:36 INFO - [ 18:20:36 INFO - "buildid", 18:20:36 INFO - "20151123180231", 18:20:36 INFO - "Change" 18:20:36 INFO - ], 18:20:36 INFO - [ 18:20:36 INFO - "builduid", 18:20:36 INFO - "2bb2bf33cb334e6e8a902aacffaca018", 18:20:36 INFO - "Change" 18:20:36 INFO - ], 18:20:36 INFO - [ 18:20:36 INFO - "pgo_build", 18:20:36 INFO - "False", 18:20:36 INFO - "Change" 18:20:36 INFO - ] 18:20:36 INFO - ], 18:20:36 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:36 INFO - } 18:20:36 INFO - ], 18:20:36 INFO - "revision": "0ed0b39c35419af45b20bf9b1df70104be2f7914" 18:20:36 INFO - } 18:20:36 INFO - } 18:20:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:20:36 INFO - Running post-action listener: _resource_record_post_action 18:20:36 INFO - ##### 18:20:36 INFO - ##### Running download-and-extract step. 18:20:36 INFO - ##### 18:20:36 INFO - Running pre-action listener: _resource_record_pre_action 18:20:36 INFO - Running main action method: download_and_extract 18:20:36 INFO - mkdir: /builds/slave/test/build/tests 18:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:36 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:20:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json 18:20:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json 18:20:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:20:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:20:42 INFO - Downloaded 1302 bytes. 18:20:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:20:42 INFO - Using the following test package requirements: 18:20:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'jsshell-linux-x86_64.zip'], 18:20:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20: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')]} 18:20:42 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:44 INFO - Downloaded 21341655 bytes. 18:20:44 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 18:20:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:44 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 18:20:45 INFO - Return code: 0 18:20:45 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 18:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:45 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:51 INFO - Downloaded 21341655 bytes. 18:20:51 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 18:20:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:20:51 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 18:20:53 INFO - Return code: 0 18:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:53 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:54 INFO - Downloaded 11130997 bytes. 18:20:54 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 18:20:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:54 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 18:20:54 INFO - Return code: 0 18:20:54 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')]} 18:20:54 INFO - https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:20:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4VycUPfhQ-mPRDV5m562IQ/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 18:20:56 INFO - Downloaded 56069436 bytes. 18:20:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:56 INFO - mkdir: /builds/slave/test/properties 18:20:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:56 INFO - Contents: 18:20:56 INFO - build_url:https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:20:56 INFO - Running post-action listener: _resource_record_post_action 18:20:56 INFO - Running post-action listener: set_extra_try_arguments 18:20:56 INFO - ##### 18:20:56 INFO - ##### Running populate-webroot step. 18:20:56 INFO - ##### 18:20:56 INFO - Running pre-action listener: _resource_record_pre_action 18:20:56 INFO - Running main action method: populate_webroot 18:20:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:20:56 INFO - '../fennec_ids.txt'], 18:20:56 INFO - 'tests': ['tcheck2']}, 18:20:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:56 INFO - '--tppagecycles', 18:20:56 INFO - '7'], 18:20:56 INFO - 'tests': ['tsvgm']}}, 18:20:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:20:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:20:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'tests': ['damp', 'tps']}, 18:20:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['damp', 'tps']}, 18:20:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:20:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:56 INFO - 'other': {'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'other_l64': {'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'other_nol64': {'tests': ['a11yr', 18:20:56 INFO - 'ts_paint', 18:20:56 INFO - 'tpaint', 18:20:56 INFO - 'sessionrestore', 18:20:56 INFO - 'sessionrestore_no_auto_restore']}, 18:20:56 INFO - 'svgr': {'tests': ['tsvgx', 18:20:56 INFO - 'tsvgr_opacity', 18:20:56 INFO - 'tart', 18:20:56 INFO - 'tscrollx', 18:20:56 INFO - 'cart']}, 18:20:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['tsvgx', 18:20:56 INFO - 'tsvgr_opacity', 18:20:56 INFO - 'tart', 18:20:56 INFO - 'tscrollx', 18:20:56 INFO - 'cart']}, 18:20:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'tests': ['tp5o']}, 18:20:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'talos_options': ['--e10s'], 18:20:56 INFO - 'tests': ['tp5o']}, 18:20:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'talos_options': ['--xperf_path', 18:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:56 INFO - 'tests': ['tp5n']}, 18:20:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:56 INFO - 'talos_options': ['--e10s', 18:20:56 INFO - '--xperf_path', 18:20:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:56 INFO - 'tests': ['tp5n']}}, 18:20:56 INFO - 'talos.zip': {'path': '', 18:20:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:56 INFO - Running post-action listener: _resource_record_post_action 18:20:56 INFO - ##### 18:20:56 INFO - ##### Running create-virtualenv step. 18:20:56 INFO - ##### 18:20:56 INFO - Running pre-action listener: _resource_record_pre_action 18:20:56 INFO - Running main action method: create_virtualenv 18:20:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:56 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 18:20:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:56 INFO - Using real prefix '/usr' 18:20:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:58 INFO - Installing pip.................done. 18:20:58 INFO - Return code: 0 18:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:58 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')]} 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 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')]} 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:58 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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:20:58 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 18:20:58 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 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:58 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 18:20:58 INFO - Cleaning up... 18:20:59 INFO - Return code: 0 18:20:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:20:59 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 18:20:59 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 18:20:59 INFO - Using env: {'DISPLAY': ':0', 18:20:59 INFO - 'HOME': '/home/cltbld', 18:20:59 INFO - 'LANG': 'en_US.UTF-8', 18:20:59 INFO - 'LANGUAGE': 'en_US:en', 18:20:59 INFO - 'LOGNAME': 'cltbld', 18:20:59 INFO - 'MAIL': '/var/mail/cltbld', 18:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:59 INFO - 'MOZ_NO_REMOTE': '1', 18:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:59 INFO - 'NO_EM_RESTART': '1', 18:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:59 INFO - 'PWD': '/builds/slave/test', 18:20:59 INFO - 'SHELL': '/bin/bash', 18:20:59 INFO - 'SHLVL': '1', 18:20:59 INFO - 'TERM': 'linux', 18:20:59 INFO - 'TMOUT': '86400', 18:20:59 INFO - 'USER': 'cltbld', 18:20:59 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:59 INFO - '_': '/tools/buildbot/bin/python'} 18:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:59 INFO - Downloading/unpacking psutil>=0.7.1 18:20:59 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 18:20:59 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 18:20:59 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 18:20:59 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 18:20:59 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 18:20:59 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 18:21:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:21:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:01 INFO - Installing collected packages: psutil 18:21:01 INFO - Running setup.py install for psutil 18:21:01 INFO - building 'psutil._psutil_linux' extension 18:21:01 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 18:21:01 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 18:21:01 INFO - building 'psutil._psutil_posix' extension 18:21:01 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 18:21:01 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 18:21:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:01 INFO - Successfully installed psutil 18:21:01 INFO - Cleaning up... 18:21:01 INFO - Return code: 0 18:21:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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', '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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:21: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 mozsystemmonitor==0.0.0 18:21:01 INFO - Using env: {'DISPLAY': ':0', 18:21:01 INFO - 'HOME': '/home/cltbld', 18:21:01 INFO - 'LANG': 'en_US.UTF-8', 18:21:01 INFO - 'LANGUAGE': 'en_US:en', 18:21:01 INFO - 'LOGNAME': 'cltbld', 18:21:01 INFO - 'MAIL': '/var/mail/cltbld', 18:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:01 INFO - 'MOZ_NO_REMOTE': '1', 18:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:01 INFO - 'NO_EM_RESTART': '1', 18:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:01 INFO - 'PWD': '/builds/slave/test', 18:21:01 INFO - 'SHELL': '/bin/bash', 18:21:01 INFO - 'SHLVL': '1', 18:21:01 INFO - 'TERM': 'linux', 18:21:01 INFO - 'TMOUT': '86400', 18:21:01 INFO - 'USER': 'cltbld', 18:21:01 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:01 INFO - '_': '/tools/buildbot/bin/python'} 18:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:21:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:21:03 INFO - Installing collected packages: mozsystemmonitor 18:21:03 INFO - Running setup.py install for mozsystemmonitor 18:21:03 INFO - Successfully installed mozsystemmonitor 18:21:03 INFO - Cleaning up... 18:21:03 INFO - Return code: 0 18:21:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:21:03 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 18:21:03 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 18:21:03 INFO - Using env: {'DISPLAY': ':0', 18:21:03 INFO - 'HOME': '/home/cltbld', 18:21:03 INFO - 'LANG': 'en_US.UTF-8', 18:21:03 INFO - 'LANGUAGE': 'en_US:en', 18:21:03 INFO - 'LOGNAME': 'cltbld', 18:21:03 INFO - 'MAIL': '/var/mail/cltbld', 18:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:03 INFO - 'MOZ_NO_REMOTE': '1', 18:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:03 INFO - 'NO_EM_RESTART': '1', 18:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:03 INFO - 'PWD': '/builds/slave/test', 18:21:03 INFO - 'SHELL': '/bin/bash', 18:21:03 INFO - 'SHLVL': '1', 18:21:03 INFO - 'TERM': 'linux', 18:21:03 INFO - 'TMOUT': '86400', 18:21:03 INFO - 'USER': 'cltbld', 18:21:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:03 INFO - '_': '/tools/buildbot/bin/python'} 18:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:21:03 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 18:21:03 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 18:21:03 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 18:21:03 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 18:21:03 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 18:21:03 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 18:21:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:06 INFO - Downloading docopt-0.6.1.tar.gz 18:21:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:06 INFO - Running setup.py install for blobuploader 18:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:06 INFO - Running setup.py install for requests 18:21:06 INFO - Running setup.py install for docopt 18:21:06 INFO - Successfully installed blobuploader requests docopt 18:21:06 INFO - Cleaning up... 18:21:06 INFO - Return code: 0 18:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:06 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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:21:06 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 18:21:06 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 18:21:06 INFO - Using env: {'DISPLAY': ':0', 18:21:06 INFO - 'HOME': '/home/cltbld', 18:21:06 INFO - 'LANG': 'en_US.UTF-8', 18:21:06 INFO - 'LANGUAGE': 'en_US:en', 18:21:06 INFO - 'LOGNAME': 'cltbld', 18:21:06 INFO - 'MAIL': '/var/mail/cltbld', 18:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:06 INFO - 'MOZ_NO_REMOTE': '1', 18:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:06 INFO - 'NO_EM_RESTART': '1', 18:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:06 INFO - 'PWD': '/builds/slave/test', 18:21:06 INFO - 'SHELL': '/bin/bash', 18:21:06 INFO - 'SHLVL': '1', 18:21:06 INFO - 'TERM': 'linux', 18:21:06 INFO - 'TMOUT': '86400', 18:21:06 INFO - 'USER': 'cltbld', 18:21:06 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:06 INFO - '_': '/tools/buildbot/bin/python'} 18:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:07 INFO - Running setup.py (path:/tmp/pip-_ce6Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:07 INFO - Running setup.py (path:/tmp/pip-0SOCWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:07 INFO - Running setup.py (path:/tmp/pip-T_nW8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:07 INFO - Running setup.py (path:/tmp/pip-ZXOif9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:07 INFO - Running setup.py (path:/tmp/pip-w5r719-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:07 INFO - Running setup.py (path:/tmp/pip-01oR2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:07 INFO - Running setup.py (path:/tmp/pip-_m_Zsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:07 INFO - Running setup.py (path:/tmp/pip-iFEP0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:07 INFO - Running setup.py (path:/tmp/pip-UEBQjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:07 INFO - Running setup.py (path:/tmp/pip-wTeLAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:07 INFO - Running setup.py (path:/tmp/pip-etC60Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:07 INFO - Running setup.py (path:/tmp/pip-1Q74YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:07 INFO - Running setup.py (path:/tmp/pip-z4Fwil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:08 INFO - Running setup.py (path:/tmp/pip-r1XhR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:08 INFO - Running setup.py (path:/tmp/pip-S8NHa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:08 INFO - Running setup.py (path:/tmp/pip-Fa6mLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:08 INFO - Running setup.py (path:/tmp/pip-LecPAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:08 INFO - Running setup.py install for manifestparser 18:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:08 INFO - Running setup.py install for mozcrash 18:21:08 INFO - Running setup.py install for mozdebug 18:21:08 INFO - Running setup.py install for mozdevice 18:21:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:08 INFO - Running setup.py install for mozfile 18:21:08 INFO - Running setup.py install for mozhttpd 18:21:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:08 INFO - Running setup.py install for mozinfo 18:21:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozInstall 18:21:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozleak 18:21:09 INFO - Running setup.py install for mozlog 18:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for moznetwork 18:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozprocess 18:21:09 INFO - Running setup.py install for mozprofile 18:21:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozrunner 18:21:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:09 INFO - Running setup.py install for mozscreenshot 18:21:09 INFO - Running setup.py install for moztest 18:21:09 INFO - Running setup.py install for mozversion 18:21:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:10 INFO - Cleaning up... 18:21:10 INFO - Return code: 0 18:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:21:10 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 18:21:10 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 18:21:10 INFO - Using env: {'DISPLAY': ':0', 18:21:10 INFO - 'HOME': '/home/cltbld', 18:21:10 INFO - 'LANG': 'en_US.UTF-8', 18:21:10 INFO - 'LANGUAGE': 'en_US:en', 18:21:10 INFO - 'LOGNAME': 'cltbld', 18:21:10 INFO - 'MAIL': '/var/mail/cltbld', 18:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:10 INFO - 'MOZ_NO_REMOTE': '1', 18:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:10 INFO - 'NO_EM_RESTART': '1', 18:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:10 INFO - 'PWD': '/builds/slave/test', 18:21:10 INFO - 'SHELL': '/bin/bash', 18:21:10 INFO - 'SHLVL': '1', 18:21:10 INFO - 'TERM': 'linux', 18:21:10 INFO - 'TMOUT': '86400', 18:21:10 INFO - 'USER': 'cltbld', 18:21:10 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:10 INFO - '_': '/tools/buildbot/bin/python'} 18:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:10 INFO - Running setup.py (path:/tmp/pip-ZJhyao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:10 INFO - Running setup.py (path:/tmp/pip-Q2zmT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:10 INFO - Running setup.py (path:/tmp/pip-Oqe1eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:10 INFO - Running setup.py (path:/tmp/pip-9cu_Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:10 INFO - Running setup.py (path:/tmp/pip-PDez15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:10 INFO - Running setup.py (path:/tmp/pip-xV5p0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:10 INFO - Running setup.py (path:/tmp/pip-nhfQ7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:10 INFO - Running setup.py (path:/tmp/pip-mNpedi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:10 INFO - Running setup.py (path:/tmp/pip-uRvzxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:10 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)) 18:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:10 INFO - Running setup.py (path:/tmp/pip-JIcO5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:11 INFO - Running setup.py (path:/tmp/pip-NIS2rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:11 INFO - Running setup.py (path:/tmp/pip-olBKs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:11 INFO - Running setup.py (path:/tmp/pip-AuGN1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:11 INFO - Running setup.py (path:/tmp/pip-I6G9oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:11 INFO - Running setup.py (path:/tmp/pip-QnVTIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:11 INFO - Running setup.py (path:/tmp/pip-UrvmLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:11 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)) 18:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:11 INFO - Running setup.py (path:/tmp/pip-ruTwna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:11 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)) 18:21:11 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)) 18:21:11 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)) 18:21:11 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)) 18:21:11 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)) 18:21:11 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)) 18:21:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:11 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 18:21:11 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 18:21:11 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 18:21:11 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 18:21:11 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 18:21:11 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 18:21:13 INFO - Downloading blessings-1.5.1.tar.gz 18:21:13 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 18:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:13 INFO - Installing collected packages: blessings 18:21:13 INFO - Running setup.py install for blessings 18:21:13 INFO - Successfully installed blessings 18:21:13 INFO - Cleaning up... 18:21:13 INFO - Return code: 0 18:21:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:13 INFO - Reading from file tmpfile_stdout 18:21:13 INFO - Current package versions: 18:21:13 INFO - argparse == 1.2.1 18:21:13 INFO - blessings == 1.5.1 18:21:13 INFO - blobuploader == 1.2.4 18:21:13 INFO - docopt == 0.6.1 18:21:13 INFO - manifestparser == 1.1 18:21:13 INFO - mozInstall == 1.12 18:21:13 INFO - mozcrash == 0.16 18:21:13 INFO - mozdebug == 0.1 18:21:13 INFO - mozdevice == 0.47 18:21:13 INFO - mozfile == 1.2 18:21:13 INFO - mozhttpd == 0.7 18:21:13 INFO - mozinfo == 0.9 18:21:13 INFO - mozleak == 0.1 18:21:13 INFO - mozlog == 3.1 18:21:13 INFO - moznetwork == 0.27 18:21:13 INFO - mozprocess == 0.22 18:21:13 INFO - mozprofile == 0.27 18:21:13 INFO - mozrunner == 6.11 18:21:13 INFO - mozscreenshot == 0.1 18:21:13 INFO - mozsystemmonitor == 0.0 18:21:13 INFO - moztest == 0.7 18:21:13 INFO - mozversion == 1.4 18:21:13 INFO - psutil == 3.1.1 18:21:13 INFO - requests == 1.2.3 18:21:13 INFO - wsgiref == 0.1.2 18:21:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff15058dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1450900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, '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': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', '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 18:21:13 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 18:21:13 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 18:21:13 INFO - Using env: {'DISPLAY': ':0', 18:21:13 INFO - 'HOME': '/home/cltbld', 18:21:13 INFO - 'LANG': 'en_US.UTF-8', 18:21:13 INFO - 'LANGUAGE': 'en_US:en', 18:21:13 INFO - 'LOGNAME': 'cltbld', 18:21:13 INFO - 'MAIL': '/var/mail/cltbld', 18:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:13 INFO - 'MOZ_NO_REMOTE': '1', 18:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:13 INFO - 'NO_EM_RESTART': '1', 18:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:13 INFO - 'PWD': '/builds/slave/test', 18:21:13 INFO - 'SHELL': '/bin/bash', 18:21:13 INFO - 'SHLVL': '1', 18:21:13 INFO - 'TERM': 'linux', 18:21:13 INFO - 'TMOUT': '86400', 18:21:13 INFO - 'USER': 'cltbld', 18:21:13 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:13 INFO - '_': '/tools/buildbot/bin/python'} 18:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21:13 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)) 18:21: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:21:13 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)) 18:21:13 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)) 18:21:13 INFO - Cleaning up... 18:21:13 INFO - Return code: 0 18:21:13 INFO - Running post-action listener: _resource_record_post_action 18:21:13 INFO - Running post-action listener: _start_resource_monitoring 18:21:13 INFO - Starting resource monitoring. 18:21:13 INFO - ##### 18:21:13 INFO - ##### Running install step. 18:21:13 INFO - ##### 18:21:13 INFO - Running pre-action listener: _resource_record_pre_action 18:21:13 INFO - Running main action method: install 18:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:14 INFO - Reading from file tmpfile_stdout 18:21:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:14 INFO - Reading from file tmpfile_stdout 18:21:14 INFO - Output received: 18:21:14 INFO - Usage: mozinstall [options] installer 18:21:14 INFO - Options: 18:21:14 INFO - -h, --help show this help message and exit 18:21:14 INFO - -d DEST, --destination=DEST 18:21:14 INFO - Directory to install application into. [default: 18:21:14 INFO - "/builds/slave/test"] 18:21:14 INFO - --app=APP Application being installed. [default: firefox] 18:21:14 INFO - mkdir: /builds/slave/test/build/application 18:21:14 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'] 18:21:14 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 18:21:28 INFO - Reading from file tmpfile_stdout 18:21:28 INFO - Output received: 18:21:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:28 INFO - Running post-action listener: _resource_record_post_action 18:21:28 INFO - ##### 18:21:28 INFO - ##### Running run-tests step. 18:21:28 INFO - ##### 18:21:28 INFO - Running pre-action listener: _resource_record_pre_action 18:21:28 INFO - Running main action method: run_tests 18:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:28 INFO - Python 2.7.3 18:21:28 INFO - Return code: 0 18:21:28 INFO - grabbing minidump binary from tooltool 18:21:28 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')]} 18:21:28 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 0x1496b70>, '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 0x14e7dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e8250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:28 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 18:21:28 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 18:21:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:28 INFO - Return code: 0 18:21:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 18:21:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 18:21:28 INFO - Using env: {'DISPLAY': ':0', 18:21:28 INFO - 'HOME': '/home/cltbld', 18:21:28 INFO - 'LANG': 'en_US.UTF-8', 18:21:28 INFO - 'LANGUAGE': 'en_US:en', 18:21:28 INFO - 'LOGNAME': 'cltbld', 18:21:28 INFO - 'MAIL': '/var/mail/cltbld', 18:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:28 INFO - 'MOZ_NO_REMOTE': '1', 18:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:28 INFO - 'NO_EM_RESTART': '1', 18:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:28 INFO - 'PWD': '/builds/slave/test', 18:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:28 INFO - 'SHELL': '/bin/bash', 18:21:28 INFO - 'SHLVL': '1', 18:21:28 INFO - 'TERM': 'linux', 18:21:28 INFO - 'TMOUT': '86400', 18:21:28 INFO - 'USER': 'cltbld', 18:21:28 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448330484.514104-1216619824', 18:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:28 INFO - '_': '/tools/buildbot/bin/python'} 18:21:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 18:21:29 INFO - mozversion INFO | application_buildid: 20151123180231 18:21:29 INFO - mozversion INFO | application_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 18:21:29 INFO - mozversion INFO | application_display_name: Nightly 18:21:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:29 INFO - mozversion INFO | application_name: Firefox 18:21:29 INFO - mozversion INFO | application_remotingname: firefox 18:21:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:21:29 INFO - mozversion INFO | application_vendor: Mozilla 18:21:29 INFO - mozversion INFO | application_version: 45.0a1 18:21:29 INFO - mozversion INFO | platform_buildid: 20151123180231 18:21:29 INFO - mozversion INFO | platform_changeset: 0ed0b39c35419af45b20bf9b1df70104be2f7914 18:21:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:21:29 INFO - mozversion INFO | platform_version: 45.0a1 18:21:29 INFO - 2015-11-23 18:21:29,058 DEBUG : using testdate: 1448331689 18:21:29 INFO - 2015-11-23 18:21:29,058 DEBUG : actual date: 1448331689 18:21:29 INFO - 2015-11-23 18:21:29,104 INFO : starting webserver on 'localhost:45202' 18:21:29 INFO - 2015-11-23 18:21:29,105 INFO : Starting test suite talos-linux64-ix-025.e 18:21:29 INFO - 2015-11-23 18:21:29,105 INFO : Starting test dromaeo_css 18:21:29 INFO - 2015-11-23 18:21:29,105 DEBUG : operating with platform_type : linux_ 18:21:29 INFO - 2015-11-23 18:21:29,106 INFO : Initialising browser for dromaeo_css test... 18:21:29 INFO - 2015-11-23 18:21:29,115 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJROf7A/profile http://localhost:45202/getInfo.html 18:21:34 INFO - 2015-11-23 18:21:34,359 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:21:34 INFO - 2015-11-23 18:21:34,360 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:21:34 INFO - 2015-11-23 18:21:34,360 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:21:34 INFO - 2015-11-23 18:21:34,360 DEBUG : BROWSER_OUTPUT: __metrics 18:21:35 INFO - 2015-11-23 18:21:35,478 INFO : Browser initialized. 18:21:35 INFO - 2015-11-23 18:21:35,479 INFO : Running cycle 1/1 for dromaeo_css test... 18:21:35 INFO - 2015-11-23 18:21:35,479 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJROf7A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:21:47 INFO - 2015-11-23 18:21:47,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 141840384 18:21:47 INFO - 2015-11-23 18:21:47,391 DEBUG : BROWSER_OUTPUT: 18:22:37 INFO - 2015-11-23 18:22:37,034 DEBUG : BROWSER_OUTPUT: 1448331757033 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] 18:24:48 INFO - 2015-11-23 18:24:48,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45202/tests/dromaeo/cssquery-ext.html) 18:24:49 INFO - 2015-11-23 18:24:49,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 145207296 18:24:49 INFO - 2015-11-23 18:24:49,721 DEBUG : BROWSER_OUTPUT: 18:27:51 INFO - 2015-11-23 18:27:51,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-ext.html (next: http://localhost:45202/tests/dromaeo/cssquery-jquery.html) 18:27:52 INFO - 2015-11-23 18:27:52,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 144027648 18:27:52 INFO - 2015-11-23 18:27:52,355 DEBUG : BROWSER_OUTPUT: 18:30:54 INFO - 2015-11-23 18:30:54,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45202/tests/dromaeo/cssquery-mootools.html) 18:30:54 INFO - 2015-11-23 18:30:54,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 18:30:54 INFO - 2015-11-23 18:30:54,735 DEBUG : BROWSER_OUTPUT: 18:33:56 INFO - 2015-11-23 18:33:56,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45202/tests/dromaeo/cssquery-prototype.html) 18:33:57 INFO - 2015-11-23 18:33:57,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 141193216 18:33:57 INFO - 2015-11-23 18:33:57,048 DEBUG : BROWSER_OUTPUT: 18:36:59 INFO - 2015-11-23 18:36:59,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45202/tests/dromaeo/cssquery-yui.html) 18:37:00 INFO - 2015-11-23 18:37:00,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 141697024 18:37:00 INFO - 2015-11-23 18:37:00,254 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/dromaeo/cssquery-yui.html (next: http://localhost:45202/tests/dromaeo/cssquery-dojo.html) 18:40:02 INFO - 2015-11-23 18:40:02,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 144584704 18:40:02 INFO - 2015-11-23 18:40:02,634 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,634 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:40:02 INFO - 2015-11-23 18:40:02,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:40:02 INFO - 2015-11-23 18:40:02,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:40:02 INFO - 2015-11-23 18:40:02,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:40:02 INFO - 2015-11-23 18:40:02,635 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.2097370788765;2663.467306538693;2696.9056083037085;2699.85150816705;2722.1833449965006;4516.390287311212;4658.045100754346;4681.461631912327;4708.952910470903;4712.410948631421;4553.977230113845;4649.767511624414;4651.837185698501;4725.5510726480925;4766.070616229837;4217.072244106292;4309.698321117523;4324.502682191557;4348.412964249833;4378.452693413324;4165.56261592533;4396.692231543777;4411.4265145531035;4437.4675038995365;4441.267190913495;4270.316749320109;4281.764502952336;4331.805068771912;4353.5428779977965;4365.650747940157;4356.607905288508;4364.170807546588;4369.453818272716;4387.648988080978;4424.225760491901;4166.229247589205;4257.489101307863;4323.697341186118;4327.199468098412;4365.912681746379;4523.434570678665;4600.35595016698;4610.746408947506;4615.076984603093;4670.509596492388;5022.799088036474;5037.823676171316;5048.949510504922;5049.0406822703935;5054.3176671149295;4843.443004054544;4880.145974454456;4953.133201689726;5018.64869459138;5034.043531728959;4664;4678;4686.461056978457;4692.389989301369;4717.410323709536;5135.075686376488;5135.281060651511;5148.639595228298;5163.0190263849745;5166.044281807877;4748.833790817304;4826.155422800995;4858.416989961227;4934.1611925972675;4997.650164488524;5020.347354843847;5035.84892453227;5062.645614807002;5065.468125846806;5068.265101560253;4988.276699878497;4991.425986011583;4993.375828021497;5015.749212539358;5030.2957585938;4735.266033764772;4814.301926220678;4834.709917404967;4894.608431325485;4933.186024305949;4154.833806647761;4186.769727664947;4189.455370801777;4204.915901681949;4212.031232816408;3546.840392182358;3659;3663.084228942764;3676.926461470809;3677.2093999790172;4221.957780422218;4229.703920725519;4292.613664770186;4322.7190232634775;4330.761808100585;4970.105381031449;4979.526944940225;4986.975065124651;4992.775325110379;5128.897422051613;4198.6221240088535;4298.763568003727;4305.182015417061;4322.783860806947;4385;4345.196138714348;4462.330650402466;4469.955300447019;4499.730016199039;4519.344695019269;4782.282657601388;4793.808247670054;4798.23228283473;4806.759662016955;4834.854954351375;4849.369581954324;4904.92642610354;4907.33750943618;5052.59579233653;5053.343065401475;4745.359376484131;4773.498782627774;4779.880502987453;4795.544423279783;4812.205986012269;4970.776315065758;4981.825636102719;4983.875403114806;4997.575206107376;5028.773705183348;4861.368022157097;4973.577245933991;5021.472745361684;5047.722375269395;5121.590272778243;4832.395950506187;4836.492168322276;4846.781894814671;4860.684055536379;4879.853604391874;4850.854474365775;4852.514748525119;4852.611791056636;4862.781174847069;4886.975565122151;4619.2378257587125;4647.674662773574;4674.415698037746;4720.952790472052;4742.5731684148595;4921.384826896638;4925.039617274597;4937.703737775745;4938.283948827472;4963.305137280711;4795.808167673254;4814.807407703793;4827.203511420576;4831.444383895897;4866.537678920497 18:40:02 INFO - 2015-11-23 18:40:02,638 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.1740814889889;568.2413977340251;568.5991376079863;583.5040215816559;596.9702263595296;35805.46291805625;36812.81593592035;37110.443343349834;37127.81436092819;37158.814205929;38723.806380968126;39420.80289598548;39474;39490.60509394905;39551;7892.131865494791;8005.6797728090805;8038.839223215532;8042.798930026737;8053.43625946184;7787.182345853689;7875.763727088197;7918;7952.125266220711;7969.442139050268;7919.287264146225;7993.600319984007;8021.157778433268;8022.598870056474;8027.638756255982;7885.408594355417;7895.881561776578;7924.326432253265;7939.920600794034;7970.920290797105;7862.371010319218;7909.327707144899;7977.162397948248;7994.760157195294;8007.47951383164;37192.07019824499;37633.435498467545;37638;37669;37686.43470347947;2240.092762431218;2402.129203968062;2488.713797913227;2622.8819703113404;3396.2188696599674;26987.86506067477;27126.32184195391;27430.5885411719;27435.45129097427;27451.45097098047;3332.6000879894327;3424.280901010791;3433.725301975836;3466.133466633342;3526.3828829954914;316215;321614;322574;323897;323935;37366.25267494635;37426.81286593604;55002.62493437696;55057.449425506034;55292.723536382866;36195;36316.455253171225;36333.63666363355;36406;36632;13168.341582921008;13255.801162982563;13274.668133296746;13285.66785830362;13289.3355332233;10691.037806597444;10710.839337409789;10760.946195268974;10771.976662217077;10788.730281743019;13124.212547247196;13129.409176587076;13137.34313284332;13140.868591314156;13174.275414852083;5381.327334083239;5389.676619402849;5415.702136382458;5432.619716619799;5446.836594902159;850.974470765878;929.8047410043831;965.7778710896392;1003.0671475527829;1064.095518809006;29763.553546696818;30122.69877301199;30583.8470807649;30819.69180308213;31067.689323106933;904.8597467392565;915.4232833314969;925.153484561632;931.9068093190626;1017.2777328097134;13009.934950325187;13376.39806208723;13454.730905381837;13488.93255533716;13559.728805424034;317735;321622;322773;322957;323914;46259.53740462619;46844.5315546847;46882;46995.76502117536;47150.292745608844;1173.8297946797666;1195.2231049817515;1203.1171217045471;1230.3971054183564;1234.9073819463397;24650.63024054605;25323.74676253214;25351.492970140862;25458.363540911625;25590.36024099338;35843;36372.818135909154;36982.8150859244;36985.81507092447;37019.25961480809;245323.82733208503;245916;246092;246571;248517;29241.415171696874;29390.265243369086;40248;41397.37903931383;42534;39528.40707389449;39854.80072599618;40011.79994100011;40171.598284016785;40308.39537407;33715.83142084274;34247.48628770521;34345.484817728255;34371.312573747884;34781;34259;34306;34328;34352.48471272983;36832;33356.499652504746;34103;34246.828765856015;34361.140971475914;34485.827570861984;28323;30462;31226.37547248997;31237.8438107808;31419.528707068956;24174.395640108436;24257.51484970326;24326.39184020343;24481;24802.25593232206 18:40:02 INFO - 2015-11-23 18:40:02,639 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.30756718458423;331.42332341725404;334.1312587273089;334.36303841182547;337.9273456206915;15000.174990375539;15234;15341.616459588487;15432.151231682266;15963.201839907988;14266.572002839905;14282.071665341771;14318.212498312589;14363.856361436383;14529.273536323195;4549.294859296806;4563.2926896330955;4675.742834144121;4679.461861885893;4688.2733176357715;4597.103564804865;4603.355530225771;4607.378003969471;4609.377734005917;4615.446146462413;3334.9598191613336;4465.754383508905;4691.5073917238715;4692.530746925314;5286.233496143057;5234.502722241362;5243.606729495303;5253.133233016548;5265.631405801595;5265.684058956455;4969.751512424365;5070.442251352349;5085.059264036128;5086.160783470723;5099.184130539096;18169.909150454165;18263.72604410935;18550.072496375262;19116.426507204807;19135.712964305545;1551.1158639575447;1594.8803839711952;1762.6562820250056;1801.1534578747967;1851.3890416162635;8516.318694504425;8595.615151997463;8947.194752472244;8981.550922453851;9299.67451139207;1692.424575644287;1698.1848712617889;1725.1567985777547;1740.608363118301;1747.589316510619;54018.189727154124;54753;55610.72194639041;56073.71963140158;57049.71475142639;9719.61121555144;9735.123838854395;9760.316777825627;9912.504374781232;9926.411774116252;12345.197562158432;12418.75162496745;12434.689132771753;12443.377831108408;12502.687432814253;6938.791836244921;6964.199117101497;6980.476464265099;7000.7549735759;7018.473614478935;6636.469082473391;6778.186617605918;6810.795676129724;6811.693473793691;6819.420349270268;3970.80145992705;4012.53855806586;4137.50349958007;4142.047329114321;4143.56492568282;1716.4249976257843;1767.6287979524186;1774.3612299572144;1778.484239570536;1780.3323753592404;382.9119302560427;392.97445666031615;425.38956597283;795.3756301303565;838.3670328901641;10168.28821982454;10237.539310731036;10340.586376545005;10352.637657681946;10583.735406614896;405.89446743846224;416.84785053455875;417.32393522493754;419.1993292810717;422.6745406037334;5553.50018498329;5604.579656525777;5673.886522269614;5699.00267453194;5748.051571490741;457577;457991;468652;469094;476700;70086.64956675185;71328;74473.6276318615;75153;76458.61770691222;980.6077568972468;1028.876534815827;1042.1246153231323;1050.8791488978713;1052.2108418685987;9677;9833.115019648267;14358.712825743636;14545.41818327255;14651.267436628339;31661.36677266488;31881.6811831888;32074.83962580172;33304.50043249402;33612.831935840164;25128.24615261545;34603.96188114361;37189.81405092957;46797;46892.765536173465;13654.522091726742;13755.587332380044;13840.653983650489;13943.651408714863;13962.4415023402;17099.572510687332;17417;17512.211950462006;17569.209385577426;18312.72530912064;9056.683016094405;14536.982411231535;14676.339564719827;14693.485727999469;15179.392824287346;9023.593938272925;9071.818563628558;9074;9089.636414543344;9274.768130796783;9430.434173949585;9446.811063778548;9505.904940950502;9635.084666956627;9638.710838674851;13639.522616708367;13974.79037814454;14009.719805603627;14058.507952221624;14106.448290688222;14236.786448203078;14264.072835265675;14310.856891430953;14557.708845823236;15059.472918447802 18:40:02 INFO - 2015-11-23 18:40:02,640 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.2070102845482;1564.507180238225;1603.2304493842955;1614.4107400798705;1627.4303993602236;5755.68343741094;5799.420057994198;6537.215534135905;6902.723891044358;6910.412614927731;6584;6714.6306953117555;6715.563488373253;6725.865482690343;6802;1999.3302243748362;2021.5047313408236;2021.5148364392514;2027.9695804562944;2031.2992017753852;1997.660397732389;2016.939491815248;2030.0864610925069;2040.1839264294254;2057.2593866208153;2008.3673642802544;2019.3739940618455;2038.1134206620168;2041.4488088216174;2044.877307361563;2012.3359291433865;2029.8071683190146;2037.4091513461153;2048.07836473586;2052.6818343156833;2056.475598722331;2076.0553947953795;2080.833533317331;2086.123827992247;2089.5925294567414;6826.726930922757;6847.897281540781;6869.793906182823;6874.65626718667;6906.965465172692;4109.527404348479;4148.23257697324;4149.668026557868;4153.646940010103;4164.83340666373;2669.82646128003;2694.7844172466353;2725.591161325797;2730.2082396105307;2778.305423644089;874.0691163910415;885.4288983605603;893.0622846011662;898.1198425542939;911.4121391702315;8810.647574097029;8864.778380540474;8865.556722163867;8870.600822962917;8875.689350872753;3703.370427027412;3725.683316918038;3753.6997040236715;3847;3855.094052897567;7803.804904877424;7839.608019598997;7864.095629002623;7864.882026769603;7885.1326354101;4167.916641667211;4182.435371224907;4189.832406703758;4193.958060419357;4201.096764195651;3585.766925149857;3681.9447708284397;3687.225682606629;3793.3172029034486;3827.5024246847734;3154.558361829346;3159.7156255937075;3163.225009872596;3164.161497203243;3170.3500782340025;982.0523195116747;983.0660872171466;984.601236499219;985.6845809340942;991.509202944547;1072.5120070367964;1091.1543553745753;1119.1047162270152;1128.3850301585655;1132.824412216108;6495.317991610813;6513.120728701565;6523.478121750249;6528.37980391862;6547.083408322838;1073.4471747050275;1080.6595922284455;1094.655183617158;1106.5850306135198;1107.479484642217;5126.641135120506;5180.766865490987;5184.766685499161;5200.271961925334;5203.401608814959;8147.75556733299;8202.917970820215;8224.095349511548;8308.169183081764;8319.584020798935;7993.800154996055;8056.919430805617;8078.151794061539;8079.353651707849;8180.059293181242;6333.714982825784;6354.3963323484195;6411.230652321751;6419.935800642027;6492.772752953719;6045.365236650088;6101.29835068955;6102.511799055976;6125.019996800491;6134.110553969738;7044.577325360495;7270.272972702687;7334.156571994075;7372.447066469929;7464.104307483137;7399.297066778648;7528.058992625922;7563;7580.204078571891;7644.426667999811;4693.929591056205;4759.809607615656;5695.373508913934;5744.368119506935;5776.42235776419;6089.604175728564;6522.902156467562;6538.934610653832;6562.442192413508;6570.375814297825;5956.523478121827;6046.667433291212;6069.514438844793;6194.473469755121;6332.873342533216;6074.179985701874;6097.4817140543555;6139.508839292936;6235.438810507076;6262.1546091278915;6360.745570177141;6386.68066596659;6399.840003999751;6411.134496842867;6446.871062578816;5883.705814709333;5887.646741195542;5890.1164825276555;5898.4101589840675;5910.349861515316;5592.189132575672;5640.097584386478;5684.118961560965;5821.738021788945;5860.970695146497 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: |4;prototype.html;295.88312616516475;311.834727594375;317.16269049708774;321.5305653745532;324.8814182823267;5456.672599644019;5595.944040559593;5599.888002239953;5699.458551437607;5724.427557244274;5589.496945274925;5612.775488980446;5614.157876318554;5619;5625.46558076982;4235.8729238122905;4342.4789025317;4391.604755571998;4396.538363471837;4398.956010439887;4314.180305741915;4347.543507931669;4350.412694286262;4357.869263922072;4367;4308.935365969497;4309.095090031097;4314.899700576364;4320.049589090395;4334.523202447728;4308.267594508925;4313.309870420733;4333.2200203963275;4338.544452832439;4345.760983145926;3667.413213885792;3790.9431358529646;3795.1650636859845;3796.1079146400575;3804.5434547854434;5321.068812957717;5446.183072539111;5448.809291674773;5464.480874316933;5481.561475081984;4912.680675756064;4942.085714142895;4948.183549714293;4951.455339912607;4951.851444456672;5882.294124705063;5885.058390657474;5925.437083477106;5928.584999050068;5938.910916336258;3970.3647416413523;4032.354823228269;4057.2088442753675;4062.817173227182;4085.55058943516;6154.753809847601;6235.314115447297;6235.781747638811;6237.87524249517;6242.625442473421;4034.9798251008556;4038.414429907647;4044.090079732037;4047.008482921703;4052.5339585947404;4088.5298190707854;4089.7750623715983;4091.3862920562156;4093.5906409359422;4100.487439070116;4719.716816990992;4780.091782561302;4782.091402633558;4786.234202527578;4794;5898.2332296802;5899.380565040695;5902.58681892272;5902.6458412495385;5911.349751527328;1492.6865358274667;1507.088211631947;1519.566923426818;1519.9012064216013;1520;1002.7142264454595;1017.9796404072025;1026.810040142576;1038.4236748604596;1040.0431602925328;5120.871978200575;5122.615803814654;5140.897182056338;5144.099782538041;5164.7934082636275;6107.206063211843;6143.56995010345;6145.907811382833;6147.139400483936;6160.44555989963;5106.208537676666;5140.306058682105;5144.305518754995;5144.536991670768;5153.072446959508;3239.6922292382187;3298.86804527821;3316.5522654441825;3349.480830471281;3349.9330013399594;5791.131330300489;5841.211436456109;5869.735861886225;5871.765129394862;5887.705614719247;6380.84047898797;6381.361863813581;6404.23149222087;6417.96791016042;6430.035494675836;5718.714064296852;5847.386024467455;5853.9414605854245;5863.736131874076;5872.647641141545;6182.505399568114;6190.690465476618;6191.535634827496;6234.501239900706;6237.157983672146;6020.819375418744;6058.303295121117;6062.909056364247;6062.939370606414;6064.181335519648;5730.5129064030025;5849.064149736022;5856.385079566584;5857.414258574108;5859.384764599826;4217.177650358273;4259;4271.679624028273;4278.9572104279805;4279.914401712011;6008.24896887889;6152.200213972155;6210.037444196157;6213.968930155501;6220.657863817533;5944.256967879015;5962.6422414653525;5973.462388385066;5985.581009329305;5999.220101386792;5943.58394912352;5958.731857066356;5967.880642387215;5975.073863551156;5980.401959803985;5705.343885453226;5807.912881306699;5813;5827.125931110368;5838.970805146117;5967.940320596738;5972.910406343822;5997.220361352996;6002.549808764447;6018.856417280703;5824.446677565625;5872.119182122545;5877.706114694333;5884.617499862496;5897.9115313271195 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: |5;yui.html;621.1180124223602;669.5948950884715;673.2426020726682;725.6553137259799;746.0227102495729;10538.420386878719;10601.522931468084;10685.198610104244;10698.304610200332;10720.195985301114;10991.571095757541;11312.773744525104;11323.094152467782;11377.488013039412;11400.657980260605;733.6038539188845;735.0407717928101;748.2816496163689;748.981275468115;749.048708140661;743.8475112601903;746.045062320231;748.8801791713327;751.5265382808823;751.7181057103586;779.9961000195019;785.4227143049853;785.9331956783681;786.7285786403681;787.3425689549205;775.5501808950795;776.9456138070337;778.5562229529171;779.7154038775863;779.719301051621;578.9015867302527;581.7149596697587;581.834177259479;583.5477504933668;583.768248994621;10615.150787936947;10812.135029197723;10823.025927666547;10826.891731082667;10844.078253348474;9873.90126098737;10384.480775961172;10480;10514.842277365846;10858.565657373696;9250.86123708145;9372.109649583279;9427.858582121273;9476.147146756755;10117.392956422638;3157.4790159623635;3243.675632436761;3253.2517520970073;3256.96743032569;3275.361304545591;39183.60816391828;39334;39433.61982330605;39512.20975580501;39520.20959580821;8681.826363472695;8843.557822108869;8893.244074253631;8950.14973577509;8953.418027828171;15329.46346877854;15332.15673137988;15342.463013794464;15345.923270383577;15383.538493844979;5758.424157584208;5987.6108052976415;6048.455638992512;6252.374762523711;6334.8416289592205;3455.671711187433;3502.264524449843;3514.314708631792;3554.2003049314217;3604.567451905788;2696.32591852037;2713.4573085383004;2720.7551320381262;2722.414680843628;2723.9591406128925;465.1650287733526;465.85092770313173;466.9463011753692;467.0518846741121;470.0809916613013;423.69070578477266;451.1428286256074;488.44073535801306;516.2978349444752;569.8717788497555;6368.076628888785;6877.793666190022;6933.37599616037;6985.89521157183;7020.648967551602;418.16575931017815;466.43561290838466;507.2771300896282;548.3200830969569;552.7567870137127;2951.631046119235;2969.2576855786056;3078.399712056172;3078.815271083742;3079;48965.75517122463;49217.75391123021;49815.75092124516;49856;53509.73245133749;45897.77051114723;46987.29519057217;47584.5241547587;47663.5233647666;48155.03689926182;42363;43439.78280108579;43528.347074793906;43673;44497.55502444999;7195.496315258091;7399.667014984447;7495.587742674205;7580.166181720117;7612;30222.09333719992;30564.388712226075;30918;31964.360712786078;32399;38963.80518097391;42204;42417;42640.78679606582;43523;9209.815803684023;9376.156145946898;9441.811163776823;9607.423554586747;9621.08599683029;9747.9025209747;9881.357711748713;10162.644307449204;10174.491275436347;10286.331388459726;9605.03949605034;9671.661491847752;9684.85472717924;9699.175570076623;9743.61025558998;9554.187894029086;9760.804783904425;9799.608015679292;9853.261005424478;9913.405195688281;9457.716268511957;9679.854802177832;9688.370255933341;9692.273079518924;9715.70852874415;7982.720604779037;8406.873896891673;8411.957940210259;8490.27832634233;8849.159329863653;7693.6085550858;7853.45025848208;7975.322097621767;8037.557934313669;8162.979627546557 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 18:40:02 INFO - 2015-11-23 18:40:02,641 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:40:02 INFO - 2015-11-23 18:40:02,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332802632__endTimestamp 18:40:02 INFO - 2015-11-23 18:40:02,642 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:40:02 INFO - 2015-11-23 18:40:02,643 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:40:02 INFO - 2015-11-23 18:40:02,643 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,643 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4620.10 Median:4766.07 stddev:478.83 (10.0%) stddev-sans-first:454.25 18:40:02 INFO - 2015-11-23 18:40:02,643 DEBUG : BROWSER_OUTPUT: Values: 2634.2 2663.5 2696.9 2699.9 2722.2 4516.4 4658.0 4681.5 4709.0 4712.4 4554.0 4649.8 4651.8 4725.6 4766.1 4217.1 4309.7 4324.5 4348.4 4378.5 4165.6 4396.7 4411.4 4437.5 4441.3 4270.3 4281.8 4331.8 4353.5 4365.7 4356.6 4364.2 4369.5 4387.6 4424.2 4166.2 4257.5 4323.7 4327.2 4365.9 4523.4 4600.4 4610.7 4615.1 4670.5 5022.8 5037.8 5048.9 5049.0 5054.3 4843.4 4880.1 4953.1 5018.6 5034.0 4664.0 4678.0 4686.5 4692.4 4717.4 5135.1 5135.3 5148.6 5163.0 5166.0 4748.8 4826.2 4858.4 4934.2 4997.7 5020.3 5035.8 5062.6 5065.5 5068.3 4988.3 4991.4 4993.4 5015.7 5030.3 4735.3 4814.3 4834.7 4894.6 4933.2 4154.8 4186.8 4189.5 4204.9 4212.0 3546.8 3659.0 3663.1 3676.9 3677.2 4222.0 4229.7 4292.6 4322.7 4330.8 4970.1 4979.5 4987.0 4992.8 5128.9 4198.6 4298.8 4305.2 4322.8 4385.0 4345.2 4462.3 4470.0 4499.7 4519.3 4782.3 4793.8 4798.2 4806.8 4834.9 4849.4 4904.9 4907.3 5052.6 5053.3 4745.4 4773.5 4779.9 4795.5 4812.2 4970.8 4981.8 4983.9 4997.6 5028.8 4861.4 4973.6 5021.5 5047.7 5121.6 4832.4 4836.5 4846.8 4860.7 4879.9 4850.9 4852.5 4852.6 4862.8 4887.0 4619.2 4647.7 4674.4 4721.0 4742.6 4921.4 4925.0 4937.7 4938.3 4963.3 4795.8 4814.8 4827.2 4831.4 4866.5 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44297.03 Median:18975.98 stddev:78404.19 (413.2%) stddev-sans-first:78555.35 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: Values: 556.2 568.2 568.6 583.5 597.0 35805.5 36812.8 37110.4 37127.8 37158.8 38723.8 39420.8 39474.0 39490.6 39551.0 7892.1 8005.7 8038.8 8042.8 8053.4 7787.2 7875.8 7918.0 7952.1 7969.4 7919.3 7993.6 8021.2 8022.6 8027.6 7885.4 7895.9 7924.3 7939.9 7970.9 7862.4 7909.3 7977.2 7994.8 8007.5 37192.1 37633.4 37638.0 37669.0 37686.4 2240.1 2402.1 2488.7 2622.9 3396.2 26987.9 27126.3 27430.6 27435.5 27451.5 3332.6 3424.3 3433.7 3466.1 3526.4 316215.0 321614.0 322574.0 323897.0 323935.0 37366.3 37426.8 55002.6 55057.4 55292.7 36195.0 36316.5 36333.6 36406.0 36632.0 13168.3 13255.8 13274.7 13285.7 13289.3 10691.0 10710.8 10760.9 10772.0 10788.7 13124.2 13129.4 13137.3 13140.9 13174.3 5381.3 5389.7 5415.7 5432.6 5446.8 851.0 929.8 965.8 1003.1 1064.1 29763.6 30122.7 30583.8 30819.7 31067.7 904.9 915.4 925.2 931.9 1017.3 13009.9 13376.4 13454.7 13488.9 13559.7 317735.0 321622.0 322773.0 322957.0 323914.0 46259.5 46844.5 46882.0 46995.8 47150.3 1173.8 1195.2 1203.1 1230.4 1234.9 24650.6 25323.7 25351.5 25458.4 25590.4 35843.0 36372.8 36982.8 36985.8 37019.3 245323.8 245916.0 246092.0 246571.0 248517.0 29241.4 29390.3 40248.0 41397.4 42534.0 39528.4 39854.8 40011.8 40171.6 40308.4 33715.8 34247.5 34345.5 34371.3 34781.0 34259.0 34306.0 34328.0 34352.5 36832.0 33356.5 34103.0 34246.8 34361.1 34485.8 28323.0 30462.0 31226.4 31237.8 31419.5 24174.4 24257.5 24326.4 24481.0 24802.3 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25424.67 Median:4139.78 stddev:76212.81 (1841.0%) stddev-sans-first:76403.31 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: Values: 331.3 331.4 334.1 334.4 337.9 15000.2 15234.0 15341.6 15432.2 15963.2 14266.6 14282.1 14318.2 14363.9 14529.3 4549.3 4563.3 4675.7 4679.5 4688.3 4597.1 4603.4 4607.4 4609.4 4615.4 3335.0 4465.8 4691.5 4692.5 5286.2 5234.5 5243.6 5253.1 5265.6 5265.7 4969.8 5070.4 5085.1 5086.2 5099.2 18169.9 18263.7 18550.1 19116.4 19135.7 1551.1 1594.9 1762.7 1801.2 1851.4 8516.3 8595.6 8947.2 8981.6 9299.7 1692.4 1698.2 1725.2 1740.6 1747.6 54018.2 54753.0 55610.7 56073.7 57049.7 9719.6 9735.1 9760.3 9912.5 9926.4 12345.2 12418.8 12434.7 12443.4 12502.7 6938.8 6964.2 6980.5 7000.8 7018.5 6636.5 6778.2 6810.8 6811.7 6819.4 3970.8 4012.5 4137.5 4142.0 4143.6 1716.4 1767.6 1774.4 1778.5 1780.3 382.9 393.0 425.4 795.4 838.4 10168.3 10237.5 10340.6 10352.6 10583.7 405.9 416.8 417.3 419.2 422.7 5553.5 5604.6 5673.9 5699.0 5748.1 457577.0 457991.0 468652.0 469094.0 476700.0 70086.6 71328.0 74473.6 75153.0 76458.6 980.6 1028.9 1042.1 1050.9 1052.2 9677.0 9833.1 14358.7 14545.4 14651.3 31661.4 31881.7 32074.8 33304.5 33612.8 25128.2 34604.0 37189.8 46797.0 46892.8 13654.5 13755.6 13840.7 13943.7 13962.4 17099.6 17417.0 17512.2 17569.2 18312.7 9056.7 14537.0 14676.3 14693.5 15179.4 9023.6 9071.8 9074.0 9089.6 9274.8 9430.4 9446.8 9505.9 9635.1 9638.7 13639.5 13974.8 14009.7 14058.5 14106.4 14236.8 14264.1 14310.9 14557.7 15059.5 18:40:02 INFO - 2015-11-23 18:40:02,644 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,645 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4768.72 Median:5904.38 stddev:2407.19 (40.8%) stddev-sans-first:2401.38 18:40:02 INFO - 2015-11-23 18:40:02,646 DEBUG : BROWSER_OUTPUT: Values: 1496.2 1564.5 1603.2 1614.4 1627.4 5755.7 5799.4 6537.2 6902.7 6910.4 6584.0 6714.6 6715.6 6725.9 6802.0 1999.3 2021.5 2021.5 2028.0 2031.3 1997.7 2016.9 2030.1 2040.2 2057.3 2008.4 2019.4 2038.1 2041.4 2044.9 2012.3 2029.8 2037.4 2048.1 2052.7 2056.5 2076.1 2080.8 2086.1 2089.6 6826.7 6847.9 6869.8 6874.7 6907.0 4109.5 4148.2 4149.7 4153.6 4164.8 2669.8 2694.8 2725.6 2730.2 2778.3 874.1 885.4 893.1 898.1 911.4 8810.6 8864.8 8865.6 8870.6 8875.7 3703.4 3725.7 3753.7 3847.0 3855.1 7803.8 7839.6 7864.1 7864.9 7885.1 4167.9 4182.4 4189.8 4194.0 4201.1 3585.8 3681.9 3687.2 3793.3 3827.5 3154.6 3159.7 3163.2 3164.2 3170.4 982.1 983.1 984.6 985.7 991.5 1072.5 1091.2 1119.1 1128.4 1132.8 6495.3 6513.1 6523.5 6528.4 6547.1 1073.4 1080.7 1094.7 1106.6 1107.5 5126.6 5180.8 5184.8 5200.3 5203.4 8147.8 8202.9 8224.1 8308.2 8319.6 7993.8 8056.9 8078.2 8079.4 8180.1 6333.7 6354.4 6411.2 6419.9 6492.8 6045.4 6101.3 6102.5 6125.0 6134.1 7044.6 7270.3 7334.2 7372.4 7464.1 7399.3 7528.1 7563.0 7580.2 7644.4 4693.9 4759.8 5695.4 5744.4 5776.4 6089.6 6522.9 6538.9 6562.4 6570.4 5956.5 6046.7 6069.5 6194.5 6332.9 6074.2 6097.5 6139.5 6235.4 6262.2 6360.7 6386.7 6399.8 6411.1 6446.9 5883.7 5887.6 5890.1 5898.4 5910.3 5592.2 5640.1 5684.1 5821.7 5861.0 18:40:02 INFO - 2015-11-23 18:40:02,646 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,647 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4902.33 Median:5535.53 stddev:1463.49 (26.4%) stddev-sans-first:1426.17 18:40:02 INFO - 2015-11-23 18:40:02,647 DEBUG : BROWSER_OUTPUT: Values: 295.9 311.8 317.2 321.5 324.9 5456.7 5595.9 5599.9 5699.5 5724.4 5589.5 5612.8 5614.2 5619.0 5625.5 4235.9 4342.5 4391.6 4396.5 4399.0 4314.2 4347.5 4350.4 4357.9 4367.0 4308.9 4309.1 4314.9 4320.0 4334.5 4308.3 4313.3 4333.2 4338.5 4345.8 3667.4 3790.9 3795.2 3796.1 3804.5 5321.1 5446.2 5448.8 5464.5 5481.6 4912.7 4942.1 4948.2 4951.5 4951.9 5882.3 5885.1 5925.4 5928.6 5938.9 3970.4 4032.4 4057.2 4062.8 4085.6 6154.8 6235.3 6235.8 6237.9 6242.6 4035.0 4038.4 4044.1 4047.0 4052.5 4088.5 4089.8 4091.4 4093.6 4100.5 4719.7 4780.1 4782.1 4786.2 4794.0 5898.2 5899.4 5902.6 5902.6 5911.3 1492.7 1507.1 1519.6 1519.9 1520.0 1002.7 1018.0 1026.8 1038.4 1040.0 5120.9 5122.6 5140.9 5144.1 5164.8 6107.2 6143.6 6145.9 6147.1 6160.4 5106.2 5140.3 5144.3 5144.5 5153.1 3239.7 3298.9 3316.6 3349.5 3349.9 5791.1 5841.2 5869.7 5871.8 5887.7 6380.8 6381.4 6404.2 6418.0 6430.0 5718.7 5847.4 5853.9 5863.7 5872.6 6182.5 6190.7 6191.5 6234.5 6237.2 6020.8 6058.3 6062.9 6062.9 6064.2 5730.5 5849.1 5856.4 5857.4 5859.4 4217.2 4259.0 4271.7 4279.0 4279.9 6008.2 6152.2 6210.0 6214.0 6220.7 5944.3 5962.6 5973.5 5985.6 5999.2 5943.6 5958.7 5967.9 5975.1 5980.4 5705.3 5807.9 5813.0 5827.1 5839.0 5967.9 5972.9 5997.2 6002.5 6018.9 5824.4 5872.1 5877.7 5884.6 5897.9 18:40:02 INFO - 2015-11-23 18:40:02,647 DEBUG : BROWSER_OUTPUT: 18:40:02 INFO - 2015-11-23 18:40:02,647 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12058.49 Median:550.54 stddev:14349.86 (2606.5%) stddev-sans-first:14364.41 18:40:02 INFO - 2015-11-23 18:40:02,648 DEBUG : BROWSER_OUTPUT: Values: 621.1 669.6 673.2 725.7 746.0 10538.4 10601.5 10685.2 10698.3 10720.2 10991.6 11312.8 11323.1 11377.5 11400.7 733.6 735.0 748.3 749.0 749.0 743.8 746.0 748.9 751.5 751.7 780.0 785.4 785.9 786.7 787.3 775.6 776.9 778.6 779.7 779.7 578.9 581.7 581.8 583.5 583.8 10615.2 10812.1 10823.0 10826.9 10844.1 9873.9 10384.5 10480.0 10514.8 10858.6 9250.9 9372.1 9427.9 9476.1 10117.4 3157.5 3243.7 3253.3 3257.0 3275.4 39183.6 39334.0 39433.6 39512.2 39520.2 8681.8 8843.6 8893.2 8950.1 8953.4 15329.5 15332.2 15342.5 15345.9 15383.5 5758.4 5987.6 6048.5 6252.4 6334.8 3455.7 3502.3 3514.3 3554.2 3604.6 2696.3 2713.5 2720.8 2722.4 2724.0 465.2 465.9 466.9 467.1 470.1 423.7 451.1 488.4 516.3 569.9 6368.1 6877.8 6933.4 6985.9 7020.6 418.2 466.4 507.3 548.3 552.8 2951.6 2969.3 3078.4 3078.8 3079.0 48965.8 49217.8 49815.8 49856.0 53509.7 45897.8 46987.3 47584.5 47663.5 48155.0 42363.0 43439.8 43528.3 43673.0 44497.6 7195.5 7399.7 7495.6 7580.2 7612.0 30222.1 30564.4 30918.0 31964.4 32399.0 38963.8 42204.0 42417.0 42640.8 43523.0 9209.8 9376.2 9441.8 9607.4 9621.1 9747.9 9881.4 10162.6 10174.5 10286.3 9605.0 9671.7 9684.9 9699.2 9743.6 9554.2 9760.8 9799.6 9853.3 9913.4 9457.7 9679.9 9688.4 9692.3 9715.7 7982.7 8406.9 8412.0 8490.3 8849.2 7693.6 7853.5 7975.3 8037.6 8163.0 18:40:02 INFO - 2015-11-23 18:40:02,648 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:40:02 INFO - 2015-11-23 18:40:02,648 DEBUG : BROWSER_OUTPUT: 18:40:03 INFO - 2015-11-23 18:40:03,418 INFO : Browser exited with error code: 0 18:40:03 INFO - 2015-11-23 18:40:03,437 INFO : Completed test dromaeo_css (00:18:34) 18:40:03 INFO - 2015-11-23 18:40:03,437 INFO : Starting test kraken 18:40:03 INFO - 2015-11-23 18:40:03,437 DEBUG : operating with platform_type : linux_ 18:40:03 INFO - 2015-11-23 18:40:03,437 INFO : Initialising browser for kraken test... 18:40:03 INFO - 2015-11-23 18:40:03,444 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7pjIt/profile http://localhost:45202/getInfo.html 18:40:08 INFO - 2015-11-23 18:40:08,229 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:40:08 INFO - 2015-11-23 18:40:08,229 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:40:08 INFO - 2015-11-23 18:40:08,229 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:40:08 INFO - 2015-11-23 18:40:08,229 DEBUG : BROWSER_OUTPUT: __metrics 18:40:09 INFO - 2015-11-23 18:40:09,342 INFO : Browser initialized. 18:40:09 INFO - 2015-11-23 18:40:09,343 INFO : Running cycle 1/1 for kraken test... 18:40:09 INFO - 2015-11-23 18:40:09,343 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7pjIt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:40:21 INFO - 2015-11-23 18:40:21,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 140009472 18:40:21 INFO - 2015-11-23 18:40:21,396 DEBUG : BROWSER_OUTPUT: 18:40:24 INFO - 2015-11-23 18:40:24,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45202/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:24 INFO - 2015-11-23 18:40:24,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 141242368 18:40:24 INFO - 2015-11-23 18:40:24,638 DEBUG : BROWSER_OUTPUT: 18:40:27 INFO - 2015-11-23 18:40:27,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45202/tests/kraken/driver.html?testName=audio-dft) 18:40:27 INFO - 2015-11-23 18:40:27,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 141680640 18:40:27 INFO - 2015-11-23 18:40:27,970 DEBUG : BROWSER_OUTPUT: 18:40:30 INFO - 2015-11-23 18:40:30,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45202/tests/kraken/driver.html?testName=audio-fft) 18:40:31 INFO - 2015-11-23 18:40:31,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 18:40:31 INFO - 2015-11-23 18:40:31,470 DEBUG : BROWSER_OUTPUT: 18:40:33 INFO - 2015-11-23 18:40:33,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45202/tests/kraken/driver.html?testName=audio-oscillator) 18:40:34 INFO - 2015-11-23 18:40:34,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 18:40:34 INFO - 2015-11-23 18:40:34,177 DEBUG : BROWSER_OUTPUT: 18:40:36 INFO - 2015-11-23 18:40:36,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:37 INFO - 2015-11-23 18:40:37,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 138694656 18:40:37 INFO - 2015-11-23 18:40:37,044 DEBUG : BROWSER_OUTPUT: 18:40:40 INFO - 2015-11-23 18:40:40,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45202/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:40 INFO - 2015-11-23 18:40:40,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 18:40:40 INFO - 2015-11-23 18:40:40,667 DEBUG : BROWSER_OUTPUT: 18:40:44 INFO - 2015-11-23 18:40:44,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45202/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:44 INFO - 2015-11-23 18:40:44,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 136953856 18:40:44 INFO - 2015-11-23 18:40:44,730 DEBUG : BROWSER_OUTPUT: 18:40:47 INFO - 2015-11-23 18:40:47,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45202/tests/kraken/driver.html?testName=json-parse-financial) 18:40:48 INFO - 2015-11-23 18:40:48,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 137773056 18:40:48 INFO - 2015-11-23 18:40:48,232 DEBUG : BROWSER_OUTPUT: 18:40:50 INFO - 2015-11-23 18:40:50,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:50 INFO - 2015-11-23 18:40:50,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 18:40:50 INFO - 2015-11-23 18:40:50,596 DEBUG : BROWSER_OUTPUT: 18:40:52 INFO - 2015-11-23 18:40:52,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:53 INFO - 2015-11-23 18:40:53,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 138833920 18:40:53 INFO - 2015-11-23 18:40:53,134 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-23 18:40:55,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:55 INFO - 2015-11-23 18:40:55,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 138887168 18:40:55 INFO - 2015-11-23 18:40:55,926 DEBUG : BROWSER_OUTPUT: 18:40:58 INFO - 2015-11-23 18:40:58,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:59 INFO - 2015-11-23 18:40:59,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 18:40:59 INFO - 2015-11-23 18:40:59,149 DEBUG : BROWSER_OUTPUT: 18:41:01 INFO - 2015-11-23 18:41:01,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:02 INFO - 2015-11-23 18:41:02,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 139198464 18:41:02 INFO - 2015-11-23 18:41:02,367 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45202/tests/kraken/driver.html?testName=ai-astar) 18:41:04 INFO - 2015-11-23 18:41:04,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 18:41:04 INFO - 2015-11-23 18:41:04,393 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,393 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:04 INFO - 2015-11-23 18:41:04,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:04 INFO - 2015-11-23 18:41:04,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:04 INFO - 2015-11-23 18:41:04,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:04 INFO - 2015-11-23 18:41:04,395 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;118;117;118;126;114;114;113;115 18:41:04 INFO - 2015-11-23 18:41:04,395 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;135;161;171;131;157;151;141;166;132 18:41:04 INFO - 2015-11-23 18:41:04,396 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;166;163;162;165;169;170;164;165;163 18:41:04 INFO - 2015-11-23 18:41:04,396 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;72;75;74;137;72;73;72 18:41:04 INFO - 2015-11-23 18:41:04,396 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;95;134;100;95;94;147;94;95;127 18:41:04 INFO - 2015-11-23 18:41:04,396 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;109;112;110;111 18:41:04 INFO - 2015-11-23 18:41:04,397 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;153;149;147;148;148;147;148;149 18:41:04 INFO - 2015-11-23 18:41:04,397 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;98;96;95;97;96;96;97;95 18:41:04 INFO - 2015-11-23 18:41:04,397 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;80;75;74;75;74;74;74;73;73 18:41:04 INFO - 2015-11-23 18:41:04,397 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;68;69;68;68;68;69 18:41:04 INFO - 2015-11-23 18:41:04,397 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;84;91;83;84;82;87;82;84 18:41:04 INFO - 2015-11-23 18:41:04,398 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;138;123;127;139;133;121;130;131;140;122 18:41:04 INFO - 2015-11-23 18:41:04,398 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;152;149;147;149;139;152;147;149;144 18:41:04 INFO - 2015-11-23 18:41:04,398 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;71;71;71;71;70;71;72;70;75 18:41:04 INFO - 2015-11-23 18:41:04,398 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:04 INFO - 2015-11-23 18:41:04,399 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:41:04 INFO - 2015-11-23 18:41:04,399 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,804 18:41:04 INFO - 2015-11-23 18:41:04,399 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:41:04 INFO - 2015-11-23 18:41:04,399 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332864392__endTimestamp 18:41:04 INFO - 2015-11-23 18:41:04,400 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,403 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:04 INFO - 2015-11-23 18:41:04,403 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:41:04 INFO - 2015-11-23 18:41:04,403 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,403 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:4.31 (3.7%) stddev-sans-first:4.51 18:41:04 INFO - 2015-11-23 18:41:04,404 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 118.0 117.0 118.0 126.0 114.0 114.0 113.0 115.0 18:41:04 INFO - 2015-11-23 18:41:04,404 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,404 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:159.00 stddev:14.90 (9.4%) stddev-sans-first:15.23 18:41:04 INFO - 2015-11-23 18:41:04,404 DEBUG : BROWSER_OUTPUT: Values: 162.0 135.0 161.0 171.0 131.0 157.0 151.0 141.0 166.0 132.0 18:41:04 INFO - 2015-11-23 18:41:04,405 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,405 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.57 (1.6%) stddev-sans-first:2.73 18:41:04 INFO - 2015-11-23 18:41:04,405 DEBUG : BROWSER_OUTPUT: Values: 165.0 166.0 163.0 162.0 165.0 169.0 170.0 164.0 165.0 163.0 18:41:04 INFO - 2015-11-23 18:41:04,405 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,405 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.00 Median:72.00 stddev:20.41 (28.4%) stddev-sans-first:21.49 18:41:04 INFO - 2015-11-23 18:41:04,406 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 72.0 75.0 74.0 137.0 72.0 73.0 72.0 18:41:04 INFO - 2015-11-23 18:41:04,406 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,406 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:19.96 (21.2%) stddev-sans-first:20.95 18:41:04 INFO - 2015-11-23 18:41:04,406 DEBUG : BROWSER_OUTPUT: Values: 100.0 95.0 134.0 100.0 95.0 94.0 147.0 94.0 95.0 127.0 18:41:04 INFO - 2015-11-23 18:41:04,406 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,407 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 18:41:04 INFO - 2015-11-23 18:41:04,407 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 112.0 110.0 111.0 18:41:04 INFO - 2015-11-23 18:41:04,407 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,407 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.71 (1.2%) stddev-sans-first:1.80 18:41:04 INFO - 2015-11-23 18:41:04,407 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 153.0 149.0 147.0 148.0 148.0 147.0 148.0 149.0 18:41:04 INFO - 2015-11-23 18:41:04,408 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,408 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 18:41:04 INFO - 2015-11-23 18:41:04,408 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 98.0 96.0 95.0 97.0 96.0 96.0 97.0 95.0 18:41:04 INFO - 2015-11-23 18:41:04,408 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,409 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:74.00 stddev:2.01 (2.7%) stddev-sans-first:2.12 18:41:04 INFO - 2015-11-23 18:41:04,409 DEBUG : BROWSER_OUTPUT: Values: 74.0 80.0 75.0 74.0 75.0 74.0 74.0 74.0 73.0 73.0 18:41:04 INFO - 2015-11-23 18:41:04,409 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,409 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 18:41:04 INFO - 2015-11-23 18:41:04,410 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 69.0 18:41:04 INFO - 2015-11-23 18:41:04,410 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,410 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.98 (3.5%) stddev-sans-first:2.96 18:41:04 INFO - 2015-11-23 18:41:04,410 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 84.0 91.0 83.0 84.0 82.0 87.0 82.0 84.0 18:41:04 INFO - 2015-11-23 18:41:04,410 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,411 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:132.00 stddev:7.12 (5.4%) stddev-sans-first:7.00 18:41:04 INFO - 2015-11-23 18:41:04,411 DEBUG : BROWSER_OUTPUT: Values: 138.0 123.0 127.0 139.0 133.0 121.0 130.0 131.0 140.0 122.0 18:41:04 INFO - 2015-11-23 18:41:04,411 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,411 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:149.00 stddev:5.08 (3.4%) stddev-sans-first:4.07 18:41:04 INFO - 2015-11-23 18:41:04,412 DEBUG : BROWSER_OUTPUT: Values: 137.0 152.0 149.0 147.0 149.0 139.0 152.0 147.0 149.0 144.0 18:41:04 INFO - 2015-11-23 18:41:04,412 DEBUG : BROWSER_OUTPUT: 18:41:04 INFO - 2015-11-23 18:41:04,412 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:1.65 (2.3%) stddev-sans-first:1.50 18:41:04 INFO - 2015-11-23 18:41:04,412 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 71.0 71.0 71.0 70.0 71.0 72.0 70.0 75.0 18:41:04 INFO - 2015-11-23 18:41:04,413 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:04 INFO - 2015-11-23 18:41:04,413 DEBUG : BROWSER_OUTPUT: 18:41:05 INFO - 2015-11-23 18:41:05,342 INFO : Browser exited with error code: 0 18:41:05 INFO - 2015-11-23 18:41:05,399 INFO : Completed test kraken (00:01:01) 18:41:05 INFO - 2015-11-23 18:41:05,399 INFO : Starting test v8_7 18:41:05 INFO - 2015-11-23 18:41:05,399 DEBUG : operating with platform_type : linux_ 18:41:05 INFO - 2015-11-23 18:41:05,399 INFO : Initialising browser for v8_7 test... 18:41:05 INFO - 2015-11-23 18:41:05,405 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5rHZm9/profile http://localhost:45202/getInfo.html 18:41:10 INFO - 2015-11-23 18:41:10,206 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:41:10 INFO - 2015-11-23 18:41:10,206 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:41:10 INFO - 2015-11-23 18:41:10,206 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:41:10 INFO - 2015-11-23 18:41:10,206 DEBUG : BROWSER_OUTPUT: __metrics 18:41:11 INFO - 2015-11-23 18:41:11,345 INFO : Browser initialized. 18:41:11 INFO - 2015-11-23 18:41:11,345 INFO : Running cycle 1/1 for v8_7 test... 18:41:11 INFO - 2015-11-23 18:41:11,345 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5rHZm9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:41:23 INFO - 2015-11-23 18:41:23,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 141791232 18:41:23 INFO - 2015-11-23 18:41:23,323 DEBUG : BROWSER_OUTPUT: 18:41:44 INFO - 2015-11-23 18:41:44,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45202/tests/v8_7/run.html (next: http://localhost:45202/tests/v8_7/run.html) 18:41:45 INFO - 2015-11-23 18:41:45,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 138915840 18:41:45 INFO - 2015-11-23 18:41:45,004 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:45 INFO - 2015-11-23 18:41:45,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: |0;Richards;184.5699520118125 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.29495718363464 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 18:41:45 INFO - 2015-11-23 18:41:45,006 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 18:41:45 INFO - 2015-11-23 18:41:45,007 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 18:41:45 INFO - 2015-11-23 18:41:45,007 DEBUG : BROWSER_OUTPUT: |5;Earley;701.7543859649123 18:41:45 INFO - 2015-11-23 18:41:45,007 DEBUG : BROWSER_OUTPUT: |6;Boyer;12518.518518518518 18:41:45 INFO - 2015-11-23 18:41:45,007 DEBUG : BROWSER_OUTPUT: |7;RegExp;25600 18:41:45 INFO - 2015-11-23 18:41:45,007 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1363088057901 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: __startTimestamp1448332905004__endTimestamp 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:184.57 Median:184.57 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: Values: 184.6 18:41:45 INFO - 2015-11-23 18:41:45,008 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.29 Median:190.29 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: Values: 190.3 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: Values: 278.2 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: Values: 5050.5 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,009 DEBUG : BROWSER_OUTPUT: Values: 1063.8 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:701.75 Median:701.75 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: Values: 701.8 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12518.52 Median:12518.52 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: Values: 12518.5 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25600.00 Median:25600.00 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: Values: 25600.0 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: Values: 603.1 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:41:45 INFO - 2015-11-23 18:41:45,010 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:45 INFO - 2015-11-23 18:41:45,011 DEBUG : BROWSER_OUTPUT: 18:41:45 INFO - 2015-11-23 18:41:45,950 INFO : Browser exited with error code: 0 18:41:45 INFO - 2015-11-23 18:41:45,962 INFO : Completed test v8_7 (00:00:40) 18:41:46 INFO - 2015-11-23 18:41:46,008 INFO : Completed test suite (00:20:16) 18:41:46 INFO - 2015-11-23 18:41:46,008 DEBUG : Working with test: dromaeo_css 18:41:46 INFO - 2015-11-23 18:41:46,008 DEBUG : Generating results file: dromaeo_css 18:41:46 INFO - 2015-11-23 18:41:46,009 DEBUG : Working with test: kraken 18:41:46 INFO - 2015-11-23 18:41:46,009 DEBUG : Generating results file: kraken 18:41:46 INFO - 2015-11-23 18:41:46,010 INFO : javascript benchmark 18:41:46 INFO - 2015-11-23 18:41:46,010 DEBUG : Working with test: v8_7 18:41:46 INFO - 2015-11-23 18:41:46,010 DEBUG : Generating results file: v8_7 18:41:46 INFO - 2015-11-23 18:41:46,010 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:46 INFO - 2015-11-23 18:41:46,078 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:41:46 INFO - 2015-11-23 18:41:46,078 DEBUG : process_Request line: dromaeo_css 6188.67 graph.html#tests=[[72,132,43]] 18:41:46 INFO - 2015-11-23 18:41:46,079 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:46 INFO - 2015-11-23 18:41:46,118 DEBUG : process_Request line: kraken 1549.00 graph.html#tests=[[232,132,43]] 18:41:46 INFO - 2015-11-23 18:41:46,119 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:41:46 INFO - 2015-11-23 18:41:46,152 DEBUG : process_Request line: v8_7 21170.33 graph.html#tests=[[230,132,43]] 18:41:46 INFO - 2015-11-23 18:41:46,153 INFO : javascript benchmark 18:41:46 INFO - 2015-11-23 18:41:46,157 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.2097370788765, 2663.467306538693, 2696.9056083037085, 2699.85150816705, 2722.1833449965006, 4516.390287311212, 4658.045100754346, 4681.461631912327, 4708.952910470903, 4712.410948631421, 4553.977230113845, 4649.767511624414, 4651.837185698501, 4725.5510726480925, 4766.070616229837, 4217.072244106292, 4309.698321117523, 4324.502682191557, 4348.412964249833, 4378.452693413324, 4165.56261592533, 4396.692231543777, 4411.4265145531035, 4437.4675038995365, 4441.267190913495, 4270.316749320109, 4281.764502952336, 4331.805068771912, 4353.5428779977965, 4365.650747940157, 4356.607905288508, 4364.170807546588, 4369.453818272716, 4387.648988080978, 4424.225760491901, 4166.229247589205, 4257.489101307863, 4323.697341186118, 4327.199468098412, 4365.912681746379, 4523.434570678665, 4600.35595016698, 4610.746408947506, 4615.076984603093, 4670.509596492388, 5022.799088036474, 5037.823676171316, 5048.949510504922, 5049.0406822703935, 5054.3176671149295, 4843.443004054544, 4880.145974454456, 4953.133201689726, 5018.64869459138, 5034.043531728959, 4664.0, 4678.0, 4686.461056978457, 4692.389989301369, 4717.410323709536, 5135.075686376488, 5135.281060651511, 5148.639595228298, 5163.0190263849745, 5166.044281807877, 4748.833790817304, 4826.155422800995, 4858.416989961227, 4934.1611925972675, 4997.650164488524, 5020.347354843847, 5035.84892453227, 5062.645614807002, 5065.468125846806, 5068.265101560253, 4988.276699878497, 4991.425986011583, 4993.375828021497, 5015.749212539358, 5030.2957585938, 4735.266033764772, 4814.301926220678, 4834.709917404967, 4894.608431325485, 4933.186024305949, 4154.833806647761, 4186.769727664947, 4189.455370801777, 4204.915901681949, 4212.031232816408, 3546.840392182358, 3659.0, 3663.084228942764, 3676.926461470809, 3677.2093999790172, 4221.957780422218, 4229.703920725519, 4292.613664770186, 4322.7190232634775, 4330.761808100585, 4970.105381031449, 4979.526944940225, 4986.975065124651, 4992.775325110379, 5128.897422051613, 4198.6221240088535, 4298.763568003727, 4305.182015417061, 4322.783860806947, 4385.0, 4345.196138714348, 4462.330650402466, 4469.955300447019, 4499.730016199039, 4519.344695019269, 4782.282657601388, 4793.808247670054, 4798.23228283473, 4806.759662016955, 4834.854954351375, 4849.369581954324, 4904.92642610354, 4907.33750943618, 5052.59579233653, 5053.343065401475, 4745.359376484131, 4773.498782627774, 4779.880502987453, 4795.544423279783, 4812.205986012269, 4970.776315065758, 4981.825636102719, 4983.875403114806, 4997.575206107376, 5028.773705183348, 4861.368022157097, 4973.577245933991, 5021.472745361684, 5047.722375269395, 5121.590272778243, 4832.395950506187, 4836.492168322276, 4846.781894814671, 4860.684055536379, 4879.853604391874, 4850.854474365775, 4852.514748525119, 4852.611791056636, 4862.781174847069, 4886.975565122151, 4619.2378257587125, 4647.674662773574, 4674.415698037746, 4720.952790472052, 4742.5731684148595, 4921.384826896638, 4925.039617274597, 4937.703737775745, 4938.283948827472, 4963.305137280711, 4795.808167673254, 4814.807407703793, 4827.203511420576, 4831.444383895897, 4866.537678920497], "unit": "ms", "name": "dojo.html", "value": 4590.398700655236}, {"lowerIsBetter": false, "replicates": [556.1740814889889, 568.2413977340251, 568.5991376079863, 583.5040215816559, 596.9702263595296, 35805.46291805625, 36812.81593592035, 37110.443343349834, 37127.81436092819, 37158.814205929, 38723.806380968126, 39420.80289598548, 39474.0, 39490.60509394905, 39551.0, 7892.131865494791, 8005.6797728090805, 8038.839223215532, 8042.798930026737, 8053.43625946184, 7787.182345853689, 7875.763727088197, 7918.0, 7952.125266220711, 7969.442139050268, 7919.287264146225, 7993.600319984007, 8021.157778433268, 8022.598870056474, 8027.638756255982, 7885.408594355417, 7895.881561776578, 7924.326432253265, 7939.920600794034, 7970.920290797105, 7862.371010319218, 7909.327707144899, 7977.162397948248, 7994.760157195294, 8007.47951383164, 37192.07019824499, 37633.435498467545, 37638.0, 37669.0, 37686.43470347947, 2240.092762431218, 2402.129203968062, 2488.713797913227, 2622.8819703113404, 3396.2188696599674, 26987.86506067477, 27126.32184195391, 27430.5885411719, 27435.45129097427, 27451.45097098047, 3332.6000879894327, 3424.280901010791, 3433.725301975836, 3466.133466633342, 3526.3828829954914, 316215.0, 321614.0, 322574.0, 323897.0, 323935.0, 37366.25267494635, 37426.81286593604, 55002.62493437696, 55057.449425506034, 55292.723536382866, 36195.0, 36316.455253171225, 36333.63666363355, 36406.0, 36632.0, 13168.341582921008, 13255.801162982563, 13274.668133296746, 13285.66785830362, 13289.3355332233, 10691.037806597444, 10710.839337409789, 10760.946195268974, 10771.976662217077, 10788.730281743019, 13124.212547247196, 13129.409176587076, 13137.34313284332, 13140.868591314156, 13174.275414852083, 5381.327334083239, 5389.676619402849, 5415.702136382458, 5432.619716619799, 5446.836594902159, 850.974470765878, 929.8047410043831, 965.7778710896392, 1003.0671475527829, 1064.095518809006, 29763.553546696818, 30122.69877301199, 30583.8470807649, 30819.69180308213, 31067.689323106933, 904.8597467392565, 915.4232833314969, 925.153484561632, 931.9068093190626, 1017.2777328097134, 13009.934950325187, 13376.39806208723, 13454.730905381837, 13488.93255533716, 13559.728805424034, 317735.0, 321622.0, 322773.0, 322957.0, 323914.0, 46259.53740462619, 46844.5315546847, 46882.0, 46995.76502117536, 47150.292745608844, 1173.8297946797666, 1195.2231049817515, 1203.1171217045471, 1230.3971054183564, 1234.9073819463397, 24650.63024054605, 25323.74676253214, 25351.492970140862, 25458.363540911625, 25590.36024099338, 35843.0, 36372.818135909154, 36982.8150859244, 36985.81507092447, 37019.25961480809, 245323.82733208503, 245916.0, 246092.0, 246571.0, 248517.0, 29241.415171696874, 29390.265243369086, 40248.0, 41397.37903931383, 42534.0, 39528.40707389449, 39854.80072599618, 40011.79994100011, 40171.598284016785, 40308.39537407, 33715.83142084274, 34247.48628770521, 34345.484817728255, 34371.312573747884, 34781.0, 34259.0, 34306.0, 34328.0, 34352.48471272983, 36832.0, 33356.499652504746, 34103.0, 34246.828765856015, 34361.140971475914, 34485.827570861984, 28323.0, 30462.0, 31226.37547248997, 31237.8438107808, 31419.528707068956, 24174.395640108436, 24257.51484970326, 24326.39184020343, 24481.0, 24802.25593232206], "unit": "ms", "name": "ext.html", "value": 16659.111221362116}, {"lowerIsBetter": false, "replicates": [331.30756718458423, 331.42332341725404, 334.1312587273089, 334.36303841182547, 337.9273456206915, 15000.174990375539, 15234.0, 15341.616459588487, 15432.151231682266, 15963.201839907988, 14266.572002839905, 14282.071665341771, 14318.212498312589, 14363.856361436383, 14529.273536323195, 4549.294859296806, 4563.2926896330955, 4675.742834144121, 4679.461861885893, 4688.2733176357715, 4597.103564804865, 4603.355530225771, 4607.378003969471, 4609.377734005917, 4615.446146462413, 3334.9598191613336, 4465.754383508905, 4691.5073917238715, 4692.530746925314, 5286.233496143057, 5234.502722241362, 5243.606729495303, 5253.133233016548, 5265.631405801595, 5265.684058956455, 4969.751512424365, 5070.442251352349, 5085.059264036128, 5086.160783470723, 5099.184130539096, 18169.909150454165, 18263.72604410935, 18550.072496375262, 19116.426507204807, 19135.712964305545, 1551.1158639575447, 1594.8803839711952, 1762.6562820250056, 1801.1534578747967, 1851.3890416162635, 8516.318694504425, 8595.615151997463, 8947.194752472244, 8981.550922453851, 9299.67451139207, 1692.424575644287, 1698.1848712617889, 1725.1567985777547, 1740.608363118301, 1747.589316510619, 54018.189727154124, 54753.0, 55610.72194639041, 56073.71963140158, 57049.71475142639, 9719.61121555144, 9735.123838854395, 9760.316777825627, 9912.504374781232, 9926.411774116252, 12345.197562158432, 12418.75162496745, 12434.689132771753, 12443.377831108408, 12502.687432814253, 6938.791836244921, 6964.199117101497, 6980.476464265099, 7000.7549735759, 7018.473614478935, 6636.469082473391, 6778.186617605918, 6810.795676129724, 6811.693473793691, 6819.420349270268, 3970.80145992705, 4012.53855806586, 4137.50349958007, 4142.047329114321, 4143.56492568282, 1716.4249976257843, 1767.6287979524186, 1774.3612299572144, 1778.484239570536, 1780.3323753592404, 382.9119302560427, 392.97445666031615, 425.38956597283, 795.3756301303565, 838.3670328901641, 10168.28821982454, 10237.539310731036, 10340.586376545005, 10352.637657681946, 10583.735406614896, 405.89446743846224, 416.84785053455875, 417.32393522493754, 419.1993292810717, 422.6745406037334, 5553.50018498329, 5604.579656525777, 5673.886522269614, 5699.00267453194, 5748.051571490741, 457577.0, 457991.0, 468652.0, 469094.0, 476700.0, 70086.64956675185, 71328.0, 74473.6276318615, 75153.0, 76458.61770691222, 980.6077568972468, 1028.876534815827, 1042.1246153231323, 1050.8791488978713, 1052.2108418685987, 9677.0, 9833.115019648267, 14358.712825743636, 14545.41818327255, 14651.267436628339, 31661.36677266488, 31881.6811831888, 32074.83962580172, 33304.50043249402, 33612.831935840164, 25128.24615261545, 34603.96188114361, 37189.81405092957, 46797.0, 46892.765536173465, 13654.522091726742, 13755.587332380044, 13840.653983650489, 13943.651408714863, 13962.4415023402, 17099.572510687332, 17417.0, 17512.211950462006, 17569.209385577426, 18312.72530912064, 9056.683016094405, 14536.982411231535, 14676.339564719827, 14693.485727999469, 15179.392824287346, 9023.593938272925, 9071.818563628558, 9074.0, 9089.636414543344, 9274.768130796783, 9430.434173949585, 9446.811063778548, 9505.904940950502, 9635.084666956627, 9638.710838674851, 13639.522616708367, 13974.79037814454, 14009.719805603627, 14058.507952221624, 14106.448290688222, 14236.786448203078, 14264.072835265675, 14310.856891430953, 14557.708845823236, 15059.472918447802], "unit": "ms", "name": "jquery.html", "value": 7729.875359527943}, {"lowerIsBetter": false, "replicates": [1496.2070102845482, 1564.507180238225, 1603.2304493842955, 1614.4107400798705, 1627.4303993602236, 5755.68343741094, 5799.420057994198, 6537.215534135905, 6902.723891044358, 6910.412614927731, 6584.0, 6714.6306953117555, 6715.563488373253, 6725.865482690343, 6802.0, 1999.3302243748362, 2021.5047313408236, 2021.5148364392514, 2027.9695804562944, 2031.2992017753852, 1997.660397732389, 2016.939491815248, 2030.0864610925069, 2040.1839264294254, 2057.2593866208153, 2008.3673642802544, 2019.3739940618455, 2038.1134206620168, 2041.4488088216174, 2044.877307361563, 2012.3359291433865, 2029.8071683190146, 2037.4091513461153, 2048.07836473586, 2052.6818343156833, 2056.475598722331, 2076.0553947953795, 2080.833533317331, 2086.123827992247, 2089.5925294567414, 6826.726930922757, 6847.897281540781, 6869.793906182823, 6874.65626718667, 6906.965465172692, 4109.527404348479, 4148.23257697324, 4149.668026557868, 4153.646940010103, 4164.83340666373, 2669.82646128003, 2694.7844172466353, 2725.591161325797, 2730.2082396105307, 2778.305423644089, 874.0691163910415, 885.4288983605603, 893.0622846011662, 898.1198425542939, 911.4121391702315, 8810.647574097029, 8864.778380540474, 8865.556722163867, 8870.600822962917, 8875.689350872753, 3703.370427027412, 3725.683316918038, 3753.6997040236715, 3847.0, 3855.094052897567, 7803.804904877424, 7839.608019598997, 7864.095629002623, 7864.882026769603, 7885.1326354101, 4167.916641667211, 4182.435371224907, 4189.832406703758, 4193.958060419357, 4201.096764195651, 3585.766925149857, 3681.9447708284397, 3687.225682606629, 3793.3172029034486, 3827.5024246847734, 3154.558361829346, 3159.7156255937075, 3163.225009872596, 3164.161497203243, 3170.3500782340025, 982.0523195116747, 983.0660872171466, 984.601236499219, 985.6845809340942, 991.509202944547, 1072.5120070367964, 1091.1543553745753, 1119.1047162270152, 1128.3850301585655, 1132.824412216108, 6495.317991610813, 6513.120728701565, 6523.478121750249, 6528.37980391862, 6547.083408322838, 1073.4471747050275, 1080.6595922284455, 1094.655183617158, 1106.5850306135198, 1107.479484642217, 5126.641135120506, 5180.766865490987, 5184.766685499161, 5200.271961925334, 5203.401608814959, 8147.75556733299, 8202.917970820215, 8224.095349511548, 8308.169183081764, 8319.584020798935, 7993.800154996055, 8056.919430805617, 8078.151794061539, 8079.353651707849, 8180.059293181242, 6333.714982825784, 6354.3963323484195, 6411.230652321751, 6419.935800642027, 6492.772752953719, 6045.365236650088, 6101.29835068955, 6102.511799055976, 6125.019996800491, 6134.110553969738, 7044.577325360495, 7270.272972702687, 7334.156571994075, 7372.447066469929, 7464.104307483137, 7399.297066778648, 7528.058992625922, 7563.0, 7580.204078571891, 7644.426667999811, 4693.929591056205, 4759.809607615656, 5695.373508913934, 5744.368119506935, 5776.42235776419, 6089.604175728564, 6522.902156467562, 6538.934610653832, 6562.442192413508, 6570.375814297825, 5956.523478121827, 6046.667433291212, 6069.514438844793, 6194.473469755121, 6332.873342533216, 6074.179985701874, 6097.4817140543555, 6139.508839292936, 6235.438810507076, 6262.1546091278915, 6360.745570177141, 6386.68066596659, 6399.840003999751, 6411.134496842867, 6446.871062578816, 5883.705814709333, 5887.646741195542, 5890.1164825276555, 5898.4101589840675, 5910.349861515316, 5592.189132575672, 5640.097584386478, 5684.118961560965, 5821.738021788945, 5860.970695146497], "unit": "ms", "name": "mootools.html", "value": 3965.2247399500884}, {"lowerIsBetter": false, "replicates": [295.88312616516475, 311.834727594375, 317.16269049708774, 321.5305653745532, 324.8814182823267, 5456.672599644019, 5595.944040559593, 5599.888002239953, 5699.458551437607, 5724.427557244274, 5589.496945274925, 5612.775488980446, 5614.157876318554, 5619.0, 5625.46558076982, 4235.8729238122905, 4342.4789025317, 4391.604755571998, 4396.538363471837, 4398.956010439887, 4314.180305741915, 4347.543507931669, 4350.412694286262, 4357.869263922072, 4367.0, 4308.935365969497, 4309.095090031097, 4314.899700576364, 4320.049589090395, 4334.523202447728, 4308.267594508925, 4313.309870420733, 4333.2200203963275, 4338.544452832439, 4345.760983145926, 3667.413213885792, 3790.9431358529646, 3795.1650636859845, 3796.1079146400575, 3804.5434547854434, 5321.068812957717, 5446.183072539111, 5448.809291674773, 5464.480874316933, 5481.561475081984, 4912.680675756064, 4942.085714142895, 4948.183549714293, 4951.455339912607, 4951.851444456672, 5882.294124705063, 5885.058390657474, 5925.437083477106, 5928.584999050068, 5938.910916336258, 3970.3647416413523, 4032.354823228269, 4057.2088442753675, 4062.817173227182, 4085.55058943516, 6154.753809847601, 6235.314115447297, 6235.781747638811, 6237.87524249517, 6242.625442473421, 4034.9798251008556, 4038.414429907647, 4044.090079732037, 4047.008482921703, 4052.5339585947404, 4088.5298190707854, 4089.7750623715983, 4091.3862920562156, 4093.5906409359422, 4100.487439070116, 4719.716816990992, 4780.091782561302, 4782.091402633558, 4786.234202527578, 4794.0, 5898.2332296802, 5899.380565040695, 5902.58681892272, 5902.6458412495385, 5911.349751527328, 1492.6865358274667, 1507.088211631947, 1519.566923426818, 1519.9012064216013, 1520.0, 1002.7142264454595, 1017.9796404072025, 1026.810040142576, 1038.4236748604596, 1040.0431602925328, 5120.871978200575, 5122.615803814654, 5140.897182056338, 5144.099782538041, 5164.7934082636275, 6107.206063211843, 6143.56995010345, 6145.907811382833, 6147.139400483936, 6160.44555989963, 5106.208537676666, 5140.306058682105, 5144.305518754995, 5144.536991670768, 5153.072446959508, 3239.6922292382187, 3298.86804527821, 3316.5522654441825, 3349.480830471281, 3349.9330013399594, 5791.131330300489, 5841.211436456109, 5869.735861886225, 5871.765129394862, 5887.705614719247, 6380.84047898797, 6381.361863813581, 6404.23149222087, 6417.96791016042, 6430.035494675836, 5718.714064296852, 5847.386024467455, 5853.9414605854245, 5863.736131874076, 5872.647641141545, 6182.505399568114, 6190.690465476618, 6191.535634827496, 6234.501239900706, 6237.157983672146, 6020.819375418744, 6058.303295121117, 6062.909056364247, 6062.939370606414, 6064.181335519648, 5730.5129064030025, 5849.064149736022, 5856.385079566584, 5857.414258574108, 5859.384764599826, 4217.177650358273, 4259.0, 4271.679624028273, 4278.9572104279805, 4279.914401712011, 6008.24896887889, 6152.200213972155, 6210.037444196157, 6213.968930155501, 6220.657863817533, 5944.256967879015, 5962.6422414653525, 5973.462388385066, 5985.581009329305, 5999.220101386792, 5943.58394912352, 5958.731857066356, 5967.880642387215, 5975.073863551156, 5980.401959803985, 5705.343885453226, 5807.912881306699, 5813.0, 5827.125931110368, 5838.970805146117, 5967.940320596738, 5972.910406343822, 5997.220361352996, 6002.549808764447, 6018.856417280703, 5824.446677565625, 5872.119182122545, 5877.706114694333, 5884.617499862496, 5897.9115313271195], "unit": "ms", "name": "prototype.html", "value": 4430.569990144901}, {"lowerIsBetter": false, "replicates": [621.1180124223602, 669.5948950884715, 673.2426020726682, 725.6553137259799, 746.0227102495729, 10538.420386878719, 10601.522931468084, 10685.198610104244, 10698.304610200332, 10720.195985301114, 10991.571095757541, 11312.773744525104, 11323.094152467782, 11377.488013039412, 11400.657980260605, 733.6038539188845, 735.0407717928101, 748.2816496163689, 748.981275468115, 749.048708140661, 743.8475112601903, 746.045062320231, 748.8801791713327, 751.5265382808823, 751.7181057103586, 779.9961000195019, 785.4227143049853, 785.9331956783681, 786.7285786403681, 787.3425689549205, 775.5501808950795, 776.9456138070337, 778.5562229529171, 779.7154038775863, 779.719301051621, 578.9015867302527, 581.7149596697587, 581.834177259479, 583.5477504933668, 583.768248994621, 10615.150787936947, 10812.135029197723, 10823.025927666547, 10826.891731082667, 10844.078253348474, 9873.90126098737, 10384.480775961172, 10480.0, 10514.842277365846, 10858.565657373696, 9250.86123708145, 9372.109649583279, 9427.858582121273, 9476.147146756755, 10117.392956422638, 3157.4790159623635, 3243.675632436761, 3253.2517520970073, 3256.96743032569, 3275.361304545591, 39183.60816391828, 39334.0, 39433.61982330605, 39512.20975580501, 39520.20959580821, 8681.826363472695, 8843.557822108869, 8893.244074253631, 8950.14973577509, 8953.418027828171, 15329.46346877854, 15332.15673137988, 15342.463013794464, 15345.923270383577, 15383.538493844979, 5758.424157584208, 5987.6108052976415, 6048.455638992512, 6252.374762523711, 6334.8416289592205, 3455.671711187433, 3502.264524449843, 3514.314708631792, 3554.2003049314217, 3604.567451905788, 2696.32591852037, 2713.4573085383004, 2720.7551320381262, 2722.414680843628, 2723.9591406128925, 465.1650287733526, 465.85092770313173, 466.9463011753692, 467.0518846741121, 470.0809916613013, 423.69070578477266, 451.1428286256074, 488.44073535801306, 516.2978349444752, 569.8717788497555, 6368.076628888785, 6877.793666190022, 6933.37599616037, 6985.89521157183, 7020.648967551602, 418.16575931017815, 466.43561290838466, 507.2771300896282, 548.3200830969569, 552.7567870137127, 2951.631046119235, 2969.2576855786056, 3078.399712056172, 3078.815271083742, 3079.0, 48965.75517122463, 49217.75391123021, 49815.75092124516, 49856.0, 53509.73245133749, 45897.77051114723, 46987.29519057217, 47584.5241547587, 47663.5233647666, 48155.03689926182, 42363.0, 43439.78280108579, 43528.347074793906, 43673.0, 44497.55502444999, 7195.496315258091, 7399.667014984447, 7495.587742674205, 7580.166181720117, 7612.0, 30222.09333719992, 30564.388712226075, 30918.0, 31964.360712786078, 32399.0, 38963.80518097391, 42204.0, 42417.0, 42640.78679606582, 43523.0, 9209.815803684023, 9376.156145946898, 9441.811163776823, 9607.423554586747, 9621.08599683029, 9747.9025209747, 9881.357711748713, 10162.644307449204, 10174.491275436347, 10286.331388459726, 9605.03949605034, 9671.661491847752, 9684.85472717924, 9699.175570076623, 9743.61025558998, 9554.187894029086, 9760.804783904425, 9799.608015679292, 9853.261005424478, 9913.405195688281, 9457.716268511957, 9679.854802177832, 9688.370255933341, 9692.273079518924, 9715.70852874415, 7982.720604779037, 8406.873896891673, 8411.957940210259, 8490.27832634233, 8849.159329863653, 7693.6085550858, 7853.45025848208, 7975.322097621767, 8037.557934313669, 8162.979627546557], "unit": "ms", "name": "yui.html", "value": 5409.2661599364055}], "name": "dromaeo_css", "value": 6188.6703927336675}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 118.0, 117.0, 118.0, 126.0, 114.0, 114.0, 113.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [162.0, 135.0, 161.0, 171.0, 131.0, 157.0, 151.0, 141.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [165.0, 166.0, 163.0, 162.0, 165.0, 169.0, 170.0, 164.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 72.0, 75.0, 74.0, 137.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [100.0, 95.0, 134.0, 100.0, 95.0, 94.0, 147.0, 94.0, 95.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 112.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 153.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [74.0, 80.0, 75.0, 74.0, 75.0, 74.0, 74.0, 74.0, 73.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 84.0, 91.0, 83.0, 84.0, 82.0, 87.0, 82.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [138.0, 123.0, 127.0, 139.0, 133.0, 121.0, 130.0, 131.0, 140.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.4}, {"lowerIsBetter": true, "replicates": [137.0, 152.0, 149.0, 147.0, 149.0, 139.0, 152.0, 147.0, 149.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 71.0, 71.0, 71.0, 70.0, 71.0, 72.0, 70.0, 75.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1549.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [184.5699520118125], "unit": "score", "name": "Richards", "value": 191.26623600000002}, {"lowerIsBetter": false, "replicates": [190.29495718363464], "unit": "score", "name": "DeltaBlue", "value": 347.4500900000001}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [701.7543859649123], "unit": "score", "name": "Earley", "value": 949.7097749999995}, {"lowerIsBetter": false, "replicates": [12518.518518518518], "unit": "score", "name": "Boyer", "value": 53.238168639053214}, {"lowerIsBetter": false, "replicates": [25600.0], "unit": "score", "name": "RegExp", "value": 35.58535156250002}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21170.331122760184}]} 18:41:46 INFO - RETURN: dromaeo_css: 6188.67 18:41:46 INFO - RETURN: kraken: 1549.00 18:41:46 INFO - RETURN: v8_7: 21170.33 18:41:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21170.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1549.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6188.67"}}} 18:41:46 INFO - Return code: 0 18:41:46 INFO - # TBPL SUCCESS # 18:41:46 INFO - Running post-action listener: _resource_record_post_action 18:41:46 INFO - Running post-run listener: _resource_record_post_run 18:41:47 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513245184; Read time: 52; Write time: 709256 18:41:47 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 219729920; Read time: 0; Write time: 425356 18:41:47 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276029440; Read time: 52; Write time: 261324 18:41:47 INFO - Running post-run listener: _upload_blobber_files 18:41:47 INFO - Blob upload gear active. 18:41:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:41:47 INFO - Copying logs to upload dir... 18:41:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.879329 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-23 18:41:46.571359) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:46.575043) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010048 build_url: 'https://queue.taskcluster.net/v1/task/4VycUPfhQ-mPRDV5m562IQ/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-23 18:41:46.628268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:46.628818) ========= 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=3cd289541638898829117e0a000001bd-1448330484.514104-1216619824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 18:41:46.680460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:41:46.680922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 18:41:46.681365) ========= ========= Total master_lag: 0.22 =========