builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1447450198.42 results: success (0) buildid: 20151113130131 builduid: 1bde9ee8e87e410e9f09772d77074240 revision: 697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.419188) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.419672) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.420017) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006443 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.439507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.439922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.451199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.451535) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004654 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.503699) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.504425) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.505188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.505511) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 13:29:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 3.75M=0.003s 2015-11-13 13:29:58 (3.75 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.631382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.631736) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020127 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:58.683773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 13:29:58.684407) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe --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 697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe --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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 13:29:58,817 truncating revision to first 12 chars 2015-11-13 13:29:58,817 Setting DEBUG logging. 2015-11-13 13:29:58,817 attempt 1/10 2015-11-13 13:29:58,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/697fb66c4494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 13:29:59,614 unpacking tar archive at: fx-team-697fb66c4494/testing/mozharness/ program finished with exit code 0 elapsedTime=1.066256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 13:29:59.764251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:59.764610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:59.774824) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:59.775303) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 13:29:59.775745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-13 13:29:59.776082) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:29:59 INFO - MultiFileLogger online at 20151113 13:29:59 in /builds/slave/test 13:29:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:29:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:29:59 INFO - {'append_to_log': False, 13:29:59 INFO - 'base_work_dir': '/builds/slave/test', 13:29:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:29:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:29:59 INFO - 'branch': 'Fx-Team-Non-PGO', 13:29:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:59 INFO - 'config_files': ('talos/linux_config.py',), 13:29:59 INFO - 'default_actions': ('clobber', 13:29:59 INFO - 'read-buildbot-config', 13:29:59 INFO - 'download-and-extract', 13:29:59 INFO - 'populate-webroot', 13:29:59 INFO - 'create-virtualenv', 13:29:59 INFO - 'install', 13:29:59 INFO - 'run-tests'), 13:29:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:59 INFO - 'download_minidump_stackwalk': True, 13:29:59 INFO - 'download_symbols': 'ondemand', 13:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:30:00 INFO - 'installer_path': 'installer.exe', 13:30:00 INFO - 'log_level': 'info', 13:30:00 INFO - 'log_name': 'talos', 13:30:00 INFO - 'log_to_console': True, 13:30:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:30:00 INFO - 'opt_config_files': (), 13:30:00 INFO - 'pip_index': False, 13:30:00 INFO - 'sps_profile': False, 13:30:00 INFO - 'sps_profile_interval': 0, 13:30:00 INFO - 'suite': 'dromaeojs', 13:30:00 INFO - 'system_bits': '64', 13:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:30:00 INFO - 'title': 'talos-linux64-ix-016', 13:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:30:00 INFO - 'use_talos_json': True, 13:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:30:00 INFO - 'work_dir': 'build'} 13:30:00 INFO - ##### 13:30:00 INFO - ##### Running clobber step. 13:30:00 INFO - ##### 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: clobber 13:30:00 INFO - rmtree: /builds/slave/test/build 13:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:30:00 INFO - Running post-action listener: _resource_record_post_action 13:30:00 INFO - ##### 13:30:00 INFO - ##### Running read-buildbot-config step. 13:30:00 INFO - ##### 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: read_buildbot_config 13:30:00 INFO - Using buildbot properties: 13:30:00 INFO - { 13:30:00 INFO - "properties": { 13:30:00 INFO - "buildnumber": 2060, 13:30:00 INFO - "product": "firefox", 13:30:00 INFO - "script_repo_revision": "production", 13:30:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:30:00 INFO - "repository": "", 13:30:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:30:00 INFO - "buildid": "20151113130131", 13:30:00 INFO - "slavename": "talos-linux64-ix-016", 13:30:00 INFO - "pgo_build": "False", 13:30:00 INFO - "basedir": "/builds/slave/test", 13:30:00 INFO - "project": "", 13:30:00 INFO - "platform": "ubuntu64_hw", 13:30:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:30:00 INFO - "slavebuilddir": "test", 13:30:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:30:00 INFO - "branch": "fx-team", 13:30:00 INFO - "repo_path": "integration/fx-team", 13:30:00 INFO - "stage_platform": "linux64", 13:30:00 INFO - "builduid": "1bde9ee8e87e410e9f09772d77074240", 13:30:00 INFO - "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe" 13:30:00 INFO - }, 13:30:00 INFO - "sourcestamp": { 13:30:00 INFO - "repository": "", 13:30:00 INFO - "hasPatch": false, 13:30:00 INFO - "project": "", 13:30:00 INFO - "branch": "fx-team-linux64-talos", 13:30:00 INFO - "changes": [ 13:30:00 INFO - { 13:30:00 INFO - "category": null, 13:30:00 INFO - "files": [ 13:30:00 INFO - { 13:30:00 INFO - "url": null, 13:30:00 INFO - "name": "https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:30:00 INFO - } 13:30:00 INFO - ], 13:30:00 INFO - "repository": "", 13:30:00 INFO - "rev": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe", 13:30:00 INFO - "who": "jwein@mozilla.com", 13:30:00 INFO - "when": 1447449407, 13:30:00 INFO - "number": 6660394, 13:30:00 INFO - "comments": "Bug 1213421 - Truncate long body and title text in notifications. r=MattN", 13:30:00 INFO - "project": "", 13:30:00 INFO - "at": "Fri 13 Nov 2015 13:16:47", 13:30:00 INFO - "branch": "fx-team-linux64-talos", 13:30:00 INFO - "revlink": "", 13:30:00 INFO - "properties": [ 13:30:00 INFO - [ 13:30:00 INFO - "buildid", 13:30:00 INFO - "20151113130131", 13:30:00 INFO - "Change" 13:30:00 INFO - ], 13:30:00 INFO - [ 13:30:00 INFO - "builduid", 13:30:00 INFO - "1bde9ee8e87e410e9f09772d77074240", 13:30:00 INFO - "Change" 13:30:00 INFO - ], 13:30:00 INFO - [ 13:30:00 INFO - "pgo_build", 13:30:00 INFO - "False", 13:30:00 INFO - "Change" 13:30:00 INFO - ] 13:30:00 INFO - ], 13:30:00 INFO - "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe" 13:30:00 INFO - } 13:30:00 INFO - ], 13:30:00 INFO - "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe" 13:30:00 INFO - } 13:30:00 INFO - } 13:30:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:30:00 INFO - Running post-action listener: _resource_record_post_action 13:30:00 INFO - ##### 13:30:00 INFO - ##### Running download-and-extract step. 13:30:00 INFO - ##### 13:30:00 INFO - Running pre-action listener: _resource_record_pre_action 13:30:00 INFO - Running main action method: download_and_extract 13:30:00 INFO - mkdir: /builds/slave/test/build/tests 13:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:00 INFO - https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:30:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/test_packages.json 13:30:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/test_packages.json 13:30:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:30:01 INFO - Downloaded 1302 bytes. 13:30:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:30:01 INFO - Using the following test package requirements: 13:30:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:30:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:30:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'jsshell-linux-x86_64.zip'], 13:30:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:30:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:30:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:30:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:30:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:30:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:30:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:30:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:30:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:30: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')]} 13:30:01 INFO - https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:02 INFO - Downloaded 21258028 bytes. 13:30:02 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 13:30:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:02 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 13:30:03 INFO - Return code: 0 13:30:03 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 13:30: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')]} 13:30:03 INFO - https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:04 INFO - Downloaded 21258028 bytes. 13:30:04 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 13:30:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:30:04 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 13:30:05 INFO - Return code: 0 13:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:05 INFO - https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:30:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:30:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:30:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:06 INFO - Downloaded 11131693 bytes. 13:30:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 13:30:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:30:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:30:06 INFO - Return code: 0 13:30: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')]} 13:30:06 INFO - https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Az2MuzwLSAaUxJANr0rRFw/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 13:30:07 INFO - Downloaded 55600510 bytes. 13:30:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:30:07 INFO - mkdir: /builds/slave/test/properties 13:30:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:30:07 INFO - Writing to file /builds/slave/test/properties/build_url 13:30:07 INFO - Contents: 13:30:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:30:07 INFO - Running post-action listener: _resource_record_post_action 13:30:07 INFO - Running post-action listener: set_extra_try_arguments 13:30:07 INFO - ##### 13:30:07 INFO - ##### Running populate-webroot step. 13:30:07 INFO - ##### 13:30:07 INFO - Running pre-action listener: _resource_record_pre_action 13:30:07 INFO - Running main action method: populate_webroot 13:30:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:30:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:30:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:30:07 INFO - '../fennec_ids.txt'], 13:30:07 INFO - 'tests': ['tcheck2']}, 13:30:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:30:07 INFO - '--tppagecycles', 13:30:07 INFO - '7'], 13:30:07 INFO - 'tests': ['tsvgm']}}, 13:30:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:30:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:30:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:30:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:30:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:30:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'tests': ['damp', 'tps']}, 13:30:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['damp', 'tps']}, 13:30:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:30:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:30:07 INFO - 'other': {'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'other_l64': {'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'other_nol64': {'tests': ['a11yr', 13:30:07 INFO - 'ts_paint', 13:30:07 INFO - 'tpaint', 13:30:07 INFO - 'sessionrestore', 13:30:07 INFO - 'sessionrestore_no_auto_restore']}, 13:30:07 INFO - 'svgr': {'tests': ['tsvgx', 13:30:07 INFO - 'tsvgr_opacity', 13:30:07 INFO - 'tart', 13:30:07 INFO - 'tscrollx', 13:30:07 INFO - 'cart']}, 13:30:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['tsvgx', 13:30:07 INFO - 'tsvgr_opacity', 13:30:07 INFO - 'tart', 13:30:07 INFO - 'tscrollx', 13:30:07 INFO - 'cart']}, 13:30:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'tests': ['tp5o']}, 13:30:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'talos_options': ['--e10s'], 13:30:07 INFO - 'tests': ['tp5o']}, 13:30:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'talos_options': ['--xperf_path', 13:30:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:07 INFO - 'tests': ['tp5n']}, 13:30:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:30:07 INFO - 'talos_options': ['--e10s', 13:30:07 INFO - '--xperf_path', 13:30:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:30:07 INFO - 'tests': ['tp5n']}}, 13:30:07 INFO - 'talos.zip': {'path': '', 13:30:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:30:07 INFO - Running post-action listener: _resource_record_post_action 13:30:07 INFO - ##### 13:30:07 INFO - ##### Running create-virtualenv step. 13:30:07 INFO - ##### 13:30:07 INFO - Running pre-action listener: _resource_record_pre_action 13:30:07 INFO - Running main action method: create_virtualenv 13:30:07 INFO - Creating virtualenv /builds/slave/test/build/venv 13:30:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:30:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:30:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:30:07 INFO - Using real prefix '/usr' 13:30:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:30:08 INFO - Installing distribute.............................................................................................................................................................................................done. 13:30:10 INFO - Installing pip.................done. 13:30:10 INFO - Return code: 0 13:30:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:30:10 INFO - Using env: {'DISPLAY': ':0', 13:30:10 INFO - 'HOME': '/home/cltbld', 13:30:10 INFO - 'LANG': 'en_US.UTF-8', 13:30:10 INFO - 'LANGUAGE': 'en_US:en', 13:30:10 INFO - 'LOGNAME': 'cltbld', 13:30:10 INFO - 'MAIL': '/var/mail/cltbld', 13:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:10 INFO - 'MOZ_NO_REMOTE': '1', 13:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:10 INFO - 'NO_EM_RESTART': '1', 13:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:10 INFO - 'PWD': '/builds/slave/test', 13:30:10 INFO - 'SHELL': '/bin/bash', 13:30:10 INFO - 'SHLVL': '1', 13:30:10 INFO - 'TERM': 'linux', 13:30:10 INFO - 'TMOUT': '86400', 13:30:10 INFO - 'USER': 'cltbld', 13:30:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:10 INFO - '_': '/tools/buildbot/bin/python'} 13:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:30:10 INFO - Cleaning up... 13:30:10 INFO - Return code: 0 13:30:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:30:10 INFO - Using env: {'DISPLAY': ':0', 13:30:10 INFO - 'HOME': '/home/cltbld', 13:30:10 INFO - 'LANG': 'en_US.UTF-8', 13:30:10 INFO - 'LANGUAGE': 'en_US:en', 13:30:10 INFO - 'LOGNAME': 'cltbld', 13:30:10 INFO - 'MAIL': '/var/mail/cltbld', 13:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:10 INFO - 'MOZ_NO_REMOTE': '1', 13:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:10 INFO - 'NO_EM_RESTART': '1', 13:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:10 INFO - 'PWD': '/builds/slave/test', 13:30:10 INFO - 'SHELL': '/bin/bash', 13:30:10 INFO - 'SHLVL': '1', 13:30:10 INFO - 'TERM': 'linux', 13:30:10 INFO - 'TMOUT': '86400', 13:30:10 INFO - 'USER': 'cltbld', 13:30:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:10 INFO - '_': '/tools/buildbot/bin/python'} 13:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:10 INFO - Downloading/unpacking psutil>=0.7.1 13:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:30:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:30:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:12 INFO - Installing collected packages: psutil 13:30:12 INFO - Running setup.py install for psutil 13:30:12 INFO - building 'psutil._psutil_linux' extension 13:30:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:30:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:30:12 INFO - building 'psutil._psutil_posix' extension 13:30:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:30:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:30:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:30:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:30:12 INFO - Successfully installed psutil 13:30:12 INFO - Cleaning up... 13:30:13 INFO - Return code: 0 13:30:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:30: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')]} 13:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30: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')]} 13:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:30:13 INFO - Using env: {'DISPLAY': ':0', 13:30:13 INFO - 'HOME': '/home/cltbld', 13:30:13 INFO - 'LANG': 'en_US.UTF-8', 13:30:13 INFO - 'LANGUAGE': 'en_US:en', 13:30:13 INFO - 'LOGNAME': 'cltbld', 13:30:13 INFO - 'MAIL': '/var/mail/cltbld', 13:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:13 INFO - 'MOZ_NO_REMOTE': '1', 13:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:13 INFO - 'NO_EM_RESTART': '1', 13:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:13 INFO - 'PWD': '/builds/slave/test', 13:30:13 INFO - 'SHELL': '/bin/bash', 13:30:13 INFO - 'SHLVL': '1', 13:30:13 INFO - 'TERM': 'linux', 13:30:13 INFO - 'TMOUT': '86400', 13:30:13 INFO - 'USER': 'cltbld', 13:30:13 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:13 INFO - '_': '/tools/buildbot/bin/python'} 13:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:30:14 INFO - Installing collected packages: mozsystemmonitor 13:30:14 INFO - Running setup.py install for mozsystemmonitor 13:30:15 INFO - Successfully installed mozsystemmonitor 13:30:15 INFO - Cleaning up... 13:30:15 INFO - Return code: 0 13:30:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:30:15 INFO - Using env: {'DISPLAY': ':0', 13:30:15 INFO - 'HOME': '/home/cltbld', 13:30:15 INFO - 'LANG': 'en_US.UTF-8', 13:30:15 INFO - 'LANGUAGE': 'en_US:en', 13:30:15 INFO - 'LOGNAME': 'cltbld', 13:30:15 INFO - 'MAIL': '/var/mail/cltbld', 13:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:15 INFO - 'MOZ_NO_REMOTE': '1', 13:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:15 INFO - 'NO_EM_RESTART': '1', 13:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:15 INFO - 'PWD': '/builds/slave/test', 13:30:15 INFO - 'SHELL': '/bin/bash', 13:30:15 INFO - 'SHLVL': '1', 13:30:15 INFO - 'TERM': 'linux', 13:30:15 INFO - 'TMOUT': '86400', 13:30:15 INFO - 'USER': 'cltbld', 13:30:15 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:15 INFO - '_': '/tools/buildbot/bin/python'} 13:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:16 INFO - Downloading blobuploader-1.2.4.tar.gz 13:30:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:30:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:30:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:30:17 INFO - Downloading docopt-0.6.1.tar.gz 13:30:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:30:17 INFO - Installing collected packages: blobuploader, requests, docopt 13:30:17 INFO - Running setup.py install for blobuploader 13:30:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:30:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:30:17 INFO - Running setup.py install for requests 13:30:18 INFO - Running setup.py install for docopt 13:30:18 INFO - Successfully installed blobuploader requests docopt 13:30:18 INFO - Cleaning up... 13:30:18 INFO - Return code: 0 13:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:30:18 INFO - Using env: {'DISPLAY': ':0', 13:30:18 INFO - 'HOME': '/home/cltbld', 13:30:18 INFO - 'LANG': 'en_US.UTF-8', 13:30:18 INFO - 'LANGUAGE': 'en_US:en', 13:30:18 INFO - 'LOGNAME': 'cltbld', 13:30:18 INFO - 'MAIL': '/var/mail/cltbld', 13:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:18 INFO - 'MOZ_NO_REMOTE': '1', 13:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:18 INFO - 'NO_EM_RESTART': '1', 13:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:18 INFO - 'PWD': '/builds/slave/test', 13:30:18 INFO - 'SHELL': '/bin/bash', 13:30:18 INFO - 'SHLVL': '1', 13:30:18 INFO - 'TERM': 'linux', 13:30:18 INFO - 'TMOUT': '86400', 13:30:18 INFO - 'USER': 'cltbld', 13:30:18 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:18 INFO - '_': '/tools/buildbot/bin/python'} 13:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:18 INFO - Running setup.py (path:/tmp/pip-xroim6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:18 INFO - Running setup.py (path:/tmp/pip-dL3IZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:18 INFO - Running setup.py (path:/tmp/pip-HDvGmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:18 INFO - Running setup.py (path:/tmp/pip-Kt2Ylb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:18 INFO - Running setup.py (path:/tmp/pip-GBGUNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:18 INFO - Running setup.py (path:/tmp/pip-FxOiW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:18 INFO - Running setup.py (path:/tmp/pip-qRIx2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:18 INFO - Running setup.py (path:/tmp/pip-LmvjEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:19 INFO - Running setup.py (path:/tmp/pip-xmhO2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:19 INFO - Running setup.py (path:/tmp/pip-IrPTpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:19 INFO - Running setup.py (path:/tmp/pip-tJhQ1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:19 INFO - Running setup.py (path:/tmp/pip-YqsZTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:19 INFO - Running setup.py (path:/tmp/pip-iSwMC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:19 INFO - Running setup.py (path:/tmp/pip-Z9gjp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:19 INFO - Running setup.py (path:/tmp/pip-lel10O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:19 INFO - Running setup.py (path:/tmp/pip-QLiQW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:19 INFO - Running setup.py (path:/tmp/pip-VyXA0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:30:19 INFO - Running setup.py install for manifestparser 13:30:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:30:19 INFO - Running setup.py install for mozcrash 13:30:19 INFO - Running setup.py install for mozdebug 13:30:20 INFO - Running setup.py install for mozdevice 13:30:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for mozfile 13:30:20 INFO - Running setup.py install for mozhttpd 13:30:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for mozinfo 13:30:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for mozInstall 13:30:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for mozleak 13:30:20 INFO - Running setup.py install for mozlog 13:30:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for moznetwork 13:30:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:30:20 INFO - Running setup.py install for mozprocess 13:30:20 INFO - Running setup.py install for mozprofile 13:30:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:30:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:30:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:30:21 INFO - Running setup.py install for mozrunner 13:30:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:30:21 INFO - Running setup.py install for mozscreenshot 13:30:21 INFO - Running setup.py install for moztest 13:30:21 INFO - Running setup.py install for mozversion 13:30:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:30:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:30:21 INFO - Cleaning up... 13:30:21 INFO - Return code: 0 13:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:30:21 INFO - Using env: {'DISPLAY': ':0', 13:30:21 INFO - 'HOME': '/home/cltbld', 13:30:21 INFO - 'LANG': 'en_US.UTF-8', 13:30:21 INFO - 'LANGUAGE': 'en_US:en', 13:30:21 INFO - 'LOGNAME': 'cltbld', 13:30:21 INFO - 'MAIL': '/var/mail/cltbld', 13:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:21 INFO - 'MOZ_NO_REMOTE': '1', 13:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:21 INFO - 'NO_EM_RESTART': '1', 13:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:21 INFO - 'PWD': '/builds/slave/test', 13:30:21 INFO - 'SHELL': '/bin/bash', 13:30:21 INFO - 'SHLVL': '1', 13:30:21 INFO - 'TERM': 'linux', 13:30:21 INFO - 'TMOUT': '86400', 13:30:21 INFO - 'USER': 'cltbld', 13:30:21 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:21 INFO - '_': '/tools/buildbot/bin/python'} 13:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:30:21 INFO - Running setup.py (path:/tmp/pip-lDB8Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:30:21 INFO - Running setup.py (path:/tmp/pip-AmMHTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:30:21 INFO - Running setup.py (path:/tmp/pip-mPorzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:30:21 INFO - Running setup.py (path:/tmp/pip-y1mObD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:30:22 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)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:30:22 INFO - Running setup.py (path:/tmp/pip-WHc35t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:30:22 INFO - Running setup.py (path:/tmp/pip-BI0CbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:30:22 INFO - Running setup.py (path:/tmp/pip-XXfmyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:30:22 INFO - Running setup.py (path:/tmp/pip-nW0gPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:30:22 INFO - Running setup.py (path:/tmp/pip-IBdHFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:30:22 INFO - Running setup.py (path:/tmp/pip-B4U0QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:30:22 INFO - Running setup.py (path:/tmp/pip-UKDGXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:30:22 INFO - Running setup.py (path:/tmp/pip-H_nQ3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:30:22 INFO - Running setup.py (path:/tmp/pip-wtlE6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:30:22 INFO - Running setup.py (path:/tmp/pip-IU_86O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:22 INFO - Running setup.py (path:/tmp/pip-ZdIafv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:30:22 INFO - Running setup.py (path:/tmp/pip-xCYDaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:30:22 INFO - Running setup.py (path:/tmp/pip-Cnub5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:30:23 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)) 13:30:23 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)) 13:30:23 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)) 13:30:23 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)) 13:30:23 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)) 13:30:23 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)) 13:30:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:30:23 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 13:30:23 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 13:30:23 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 13:30:23 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 13:30:23 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 13:30:23 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 13:30:24 INFO - Downloading blessings-1.5.1.tar.gz 13:30:24 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:30:24 INFO - Installing collected packages: blessings 13:30:24 INFO - Running setup.py install for blessings 13:30:24 INFO - Successfully installed blessings 13:30:24 INFO - Cleaning up... 13:30:24 INFO - Return code: 0 13:30:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:25 INFO - Reading from file tmpfile_stdout 13:30:25 INFO - Current package versions: 13:30:25 INFO - argparse == 1.2.1 13:30:25 INFO - blessings == 1.5.1 13:30:25 INFO - blobuploader == 1.2.4 13:30:25 INFO - docopt == 0.6.1 13:30:25 INFO - manifestparser == 1.1 13:30:25 INFO - mozInstall == 1.12 13:30:25 INFO - mozcrash == 0.16 13:30:25 INFO - mozdebug == 0.1 13:30:25 INFO - mozdevice == 0.47 13:30:25 INFO - mozfile == 1.2 13:30:25 INFO - mozhttpd == 0.7 13:30:25 INFO - mozinfo == 0.9 13:30:25 INFO - mozleak == 0.1 13:30:25 INFO - mozlog == 3.0 13:30:25 INFO - moznetwork == 0.27 13:30:25 INFO - mozprocess == 0.22 13:30:25 INFO - mozprofile == 0.27 13:30:25 INFO - mozrunner == 6.11 13:30:25 INFO - mozscreenshot == 0.1 13:30:25 INFO - mozsystemmonitor == 0.0 13:30:25 INFO - moztest == 0.7 13:30:25 INFO - mozversion == 1.4 13:30:25 INFO - psutil == 3.1.1 13:30:25 INFO - requests == 1.2.3 13:30:25 INFO - wsgiref == 0.1.2 13:30:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:30:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5939aecc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16579a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, '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': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', '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 13:30:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:30:25 INFO - Using env: {'DISPLAY': ':0', 13:30:25 INFO - 'HOME': '/home/cltbld', 13:30:25 INFO - 'LANG': 'en_US.UTF-8', 13:30:25 INFO - 'LANGUAGE': 'en_US:en', 13:30:25 INFO - 'LOGNAME': 'cltbld', 13:30:25 INFO - 'MAIL': '/var/mail/cltbld', 13:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:25 INFO - 'MOZ_NO_REMOTE': '1', 13:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:25 INFO - 'NO_EM_RESTART': '1', 13:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:25 INFO - 'PWD': '/builds/slave/test', 13:30:25 INFO - 'SHELL': '/bin/bash', 13:30:25 INFO - 'SHLVL': '1', 13:30:25 INFO - 'TERM': 'linux', 13:30:25 INFO - 'TMOUT': '86400', 13:30:25 INFO - 'USER': 'cltbld', 13:30:25 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:25 INFO - '_': '/tools/buildbot/bin/python'} 13:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:30:25 INFO - Cleaning up... 13:30:25 INFO - Return code: 0 13:30:25 INFO - Running post-action listener: _resource_record_post_action 13:30:25 INFO - Running post-action listener: _start_resource_monitoring 13:30:25 INFO - Starting resource monitoring. 13:30:25 INFO - ##### 13:30:25 INFO - ##### Running install step. 13:30:25 INFO - ##### 13:30:25 INFO - Running pre-action listener: _resource_record_pre_action 13:30:25 INFO - Running main action method: install 13:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:25 INFO - Reading from file tmpfile_stdout 13:30:25 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:25 INFO - Reading from file tmpfile_stdout 13:30:25 INFO - Output received: 13:30:25 INFO - Usage: mozinstall [options] installer 13:30:25 INFO - Options: 13:30:25 INFO - -h, --help show this help message and exit 13:30:25 INFO - -d DEST, --destination=DEST 13:30:25 INFO - Directory to install application into. [default: 13:30:25 INFO - "/builds/slave/test"] 13:30:25 INFO - --app=APP Application being installed. [default: firefox] 13:30:25 INFO - mkdir: /builds/slave/test/build/application 13:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:30:39 INFO - Reading from file tmpfile_stdout 13:30:39 INFO - Output received: 13:30:39 INFO - /builds/slave/test/build/application/firefox/firefox 13:30:39 INFO - Running post-action listener: _resource_record_post_action 13:30:39 INFO - ##### 13:30:39 INFO - ##### Running run-tests step. 13:30:39 INFO - ##### 13:30:39 INFO - Running pre-action listener: _resource_record_pre_action 13:30:39 INFO - Running main action method: run_tests 13:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:39 INFO - Python 2.7.3 13:30:39 INFO - Return code: 0 13:30:39 INFO - grabbing minidump binary from tooltool 13:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:39 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6ac0>, '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 0x16e79a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e7e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:30:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:30:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:39 INFO - Return code: 0 13:30:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:30:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:30:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test/build 13:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 13:30:39 INFO - Using env: {'DISPLAY': ':0', 13:30:39 INFO - 'HOME': '/home/cltbld', 13:30:39 INFO - 'LANG': 'en_US.UTF-8', 13:30:39 INFO - 'LANGUAGE': 'en_US:en', 13:30:39 INFO - 'LOGNAME': 'cltbld', 13:30:39 INFO - 'MAIL': '/var/mail/cltbld', 13:30:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:39 INFO - 'MOZ_NO_REMOTE': '1', 13:30:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:39 INFO - 'NO_EM_RESTART': '1', 13:30:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:39 INFO - 'PWD': '/builds/slave/test', 13:30:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:39 INFO - 'SHELL': '/bin/bash', 13:30:39 INFO - 'SHLVL': '1', 13:30:39 INFO - 'TERM': 'linux', 13:30:39 INFO - 'TMOUT': '86400', 13:30:39 INFO - 'USER': 'cltbld', 13:30:39 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597', 13:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:39 INFO - '_': '/tools/buildbot/bin/python'} 13:30:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 13:30:40 INFO - mozversion INFO | application_buildid: 20151113130131 13:30:40 INFO - mozversion INFO | application_changeset: 697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe 13:30:40 INFO - mozversion INFO | application_display_name: Nightly 13:30:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:40 INFO - mozversion INFO | application_name: Firefox 13:30:40 INFO - mozversion INFO | application_remotingname: firefox 13:30:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:30:40 INFO - mozversion INFO | application_vendor: Mozilla 13:30:40 INFO - mozversion INFO | application_version: 45.0a1 13:30:40 INFO - mozversion INFO | platform_buildid: 20151113130131 13:30:40 INFO - mozversion INFO | platform_changeset: 697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe 13:30:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:30:40 INFO - mozversion INFO | platform_version: 45.0a1 13:30:40 INFO - 2015-11-13 13:30:40,057 DEBUG : using testdate: 1447450240 13:30:40 INFO - 2015-11-13 13:30:40,057 DEBUG : actual date: 1447450240 13:30:40 INFO - 2015-11-13 13:30:40,070 INFO : starting webserver on 'localhost:46466' 13:30:40 INFO - 2015-11-13 13:30:40,071 INFO : Starting test suite talos-linux64-ix-016 13:30:40 INFO - 2015-11-13 13:30:40,071 INFO : Starting test dromaeo_css 13:30:40 INFO - 2015-11-13 13:30:40,071 DEBUG : operating with platform_type : linux_ 13:30:40 INFO - 2015-11-13 13:30:40,072 INFO : Initialising browser for dromaeo_css test... 13:30:40 INFO - 2015-11-13 13:30:40,088 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthGSzA/profile http://localhost:46466/getInfo.html 13:30:44 INFO - 2015-11-13 13:30:44,869 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:30:44 INFO - 2015-11-13 13:30:44,869 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:30:44 INFO - 2015-11-13 13:30:44,869 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:30:44 INFO - 2015-11-13 13:30:44,869 DEBUG : BROWSER_OUTPUT: __metrics 13:30:44 INFO - 2015-11-13 13:30:44,970 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:46 INFO - 2015-11-13 13:30:46,157 INFO : Browser initialized. 13:30:46 INFO - 2015-11-13 13:30:46,158 INFO : Running cycle 1/1 for dromaeo_css test... 13:30:46 INFO - 2015-11-13 13:30:46,158 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpthGSzA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:30:58 INFO - 2015-11-13 13:30:58,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 13:30:58 INFO - 2015-11-13 13:30:58,102 DEBUG : BROWSER_OUTPUT: 13:31:49 INFO - 2015-11-13 13:31:49,340 DEBUG : BROWSER_OUTPUT: 1447450309337 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] 13:34:01 INFO - 2015-11-13 13:34:01,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46466/tests/dromaeo/cssquery-ext.html) 13:34:02 INFO - 2015-11-13 13:34:02,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 243154944 13:34:02 INFO - 2015-11-13 13:34:02,242 DEBUG : BROWSER_OUTPUT: 13:37:04 INFO - 2015-11-13 13:37:04,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-ext.html (next: http://localhost:46466/tests/dromaeo/cssquery-jquery.html) 13:37:05 INFO - 2015-11-13 13:37:05,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 212131840 13:37:05 INFO - 2015-11-13 13:37:05,174 DEBUG : BROWSER_OUTPUT: 13:40:07 INFO - 2015-11-13 13:40:07,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46466/tests/dromaeo/cssquery-mootools.html) 13:40:07 INFO - 2015-11-13 13:40:07,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 203825152 13:40:07 INFO - 2015-11-13 13:40:07,779 DEBUG : BROWSER_OUTPUT: 13:43:09 INFO - 2015-11-13 13:43:09,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46466/tests/dromaeo/cssquery-prototype.html) 13:43:10 INFO - 2015-11-13 13:43:10,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 198619136 13:43:10 INFO - 2015-11-13 13:43:10,220 DEBUG : BROWSER_OUTPUT: 13:46:12 INFO - 2015-11-13 13:46:12,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46466/tests/dromaeo/cssquery-yui.html) 13:46:13 INFO - 2015-11-13 13:46:13,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 201015296 13:46:13 INFO - 2015-11-13 13:46:13,379 DEBUG : BROWSER_OUTPUT: 13:49:15 INFO - 2015-11-13 13:49:15,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/dromaeo/cssquery-yui.html (next: http://localhost:46466/tests/dromaeo/cssquery-dojo.html) 13:49:16 INFO - 2015-11-13 13:49:16,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 213078016 13:49:16 INFO - 2015-11-13 13:49:16,018 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,019 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:49:16 INFO - 2015-11-13 13:49:16,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:49:16 INFO - 2015-11-13 13:49:16,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:49:16 INFO - 2015-11-13 13:49:16,020 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:49:16 INFO - 2015-11-13 13:49:16,022 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2661.5741481362984;2737.9726202737966;2747.0248061938023;2750.4774092922357;2757.090160247118;4584.243599806028;4739.620830333573;4796.040791841629;4840.34655321531;4849.781759820808;4736.952630473695;4746.76266186691;4746.952530474694;4805.207140821769;4805.8798530036765;4403.097365040159;4403.515613282529;4418.624416924549;4420.712653677517;4433.113377324532;4265.31754919213;4497.392851964992;4517.503074661801;4551.863444096666;4553.021100463399;4279.229738647043;4391.956080439202;4395.560443955611;4402.009547851708;4420.46954365475;4428.955710442887;4432.445944256968;4447.043885564619;4451.666125040635;4464.084862603191;4191.350340697197;4405.074934263808;4412;4443.755593442359;4460.397846290742;4631.722096674177;4639.930401043987;4704.176769065434;4723.244280915037;4750.667453278272;5152.072626927152;5155.793768249266;5156.04613146569;5178.792848286064;5193.506616871391;4947.282644016597;5056.82301119459;5184;5185.792568297264;5190.091733946582;4552.408186935677;4611.469680986729;4653.976730116327;4686.625069994392;4692.741899195543;5298.70857102863;5316.946830531645;5320.015797077475;5329.54698850602;5364.356277246756;4876.609871210366;4983.526564976321;5102.872428189325;5103.362079740033;5108.361454818148;5056.140456122468;5101.617378696613;5176.818811341585;5206.271122042917;5216.21756736485;5077.035363280965;5137.8715532112;5139.743012849342;5141.845744627667;5142.897142057138;5111.080005599028;5114.820981265638;5120.61595380348;5122.820701275437;5150.227465880148;4113.938290925638;4171.353440216772;4209.326507758744;4210.578942105765;4247.023184667482;3762.1535154589997;3762.8494860205287;3773.4339849022867;3801.6578507933864;3806.314863324573;4486.035502367007;4511.8646440606835;4515.841945531891;4518.525554816762;4542.682012259176;4926.802927882916;5032.446430892599;5035.370578677665;5228.111221092423;5295.602829787781;4387.780610969438;4458.2420988431395;4480.395146655225;4514.909701806011;4520.570545798144;4602.838900638461;4603.194440972817;4606.97696511522;4607.654425918069;4650.255959046536;4726.26742854858;4824.228123500364;4825.95174048255;4945.826896058621;4948.950510494993;5119.820806271762;5207.192885102815;5227.372715274191;5229.13719236337;5260.894782104413;4918.4097908249805;4944.035912996931;4944.8763780905765;4946.1591529439365;4984.302197692398;4855.393075865517;4952.529509696573;4971.676841005323;5126.179811230185;5144.717040562805;5064.797408103635;5138.434772174983;5143.074246635641;5143.871403214949;5154.8969020620125;4991.575716064175;4998.750062496788;5000.074524163171;5019.598432125495;5037.017781532566;4794.95205047959;4903.190973489334;4904.092742842586;4999.150144475375;5008.223725322581;4862.854114376574;4932.334134891744;4954.256861470808;4960.057589058068;4977.402711674622;5003.699778013331;5082.872928176826;5086.0845047891735;5089.236614507853;5127.077126117335;4718.032803275389;4805.5915247204375;4812.8796780080775;4934.975325123495;5001.299818025552 13:49:16 INFO - 2015-11-13 13:49:16,025 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.4806681719184;560.2324815003444;563.6697394149809;569.3054473542279;577.936426993031;28348.716512834864;37055;37763.433548496796;37776.622233777656;37787.81106094466;40089;40556.79721601388;40559.79720101396;40573.59426405742;40587.188256234935;6946.3053694630635;7036.226015138356;7903.683852645887;8064.556449395281;8066.032076150841;10185.33795303303;10446.843297350508;10454.738631534234;10455.73860653486;10462.633807816728;10168.491575421236;10218.029287217703;10262.640807571737;10273.178145748323;10286.897131028707;7190.101237345306;7389.334959853585;10104.696859094201;10234.02776736209;10472.68581942543;9958.70123896277;10046.296759226858;10055.296129270953;10056.597736090547;10095.596176152945;37649.24701505955;38045.23909521794;38105.42841857374;38144.237115257536;38145.61854381448;2767.52859397795;2768.7784977201777;3354.815485148316;3563.7883119739154;3577.767445116059;28273.717262827315;28658.844467552088;28747.55029396465;28839.279018024507;29130;3097.752179825631;3111.766617503696;3136.921576960571;3137.1843320736543;3169.3185965017633;225773;226521;226637.86681066654;226665;227039;50998.74500627473;52578.73710631422;55531;57267.71366143226;57313.71343143341;55770;56080.43919560752;56260.43739562634;56732.71633641805;56842;13442.462301508025;13570.185788852701;13591;13596.66008349799;13605.115667481581;10148.441835699108;10159.542820573091;10185.898141018642;10416.114630256514;10420.531076101593;18819.153138108817;18970.33603823887;19023.714644280346;19029.714554281698;19052;7137.643117844087;7386.409087273005;7459.776206713807;7467.775966721007;7497.587632680146;747.9102507699002;789.4907784478979;1015.3400289811682;1039.4023436524028;1050.8686414198226;26464;26540;26704.465910681676;26762.330941726614;26781.19656410272;881.3610132653903;882.8763973043779;892.7321803459066;896.9237614802685;931.1433481197315;13807.792883106762;13822.447102115802;13947.511837085653;13967.301634918213;14056.22690751998;269899;273643;274706;275034;275110;45453;45704.54295457003;45801.54198458039;45890.311645325346;45904.540954590026;1105.3202280597536;1111.4053981120223;1115.1580556679817;1116.609186784635;1121.7812526557243;24447.144349947666;25153.87423062873;25613.61579576345;25742.485150297263;26368.472630547665;41369.586304137774;41454.792726036176;41469.79265103655;41735.7913210432;41805;213041;218581;331283;341479.6334164919;342964;27363.442752442053;27460.17619471419;27486;27495;27568.310792229553;37638;38111.61888381081;38354.232915342094;38412.23175536418;38542;31028.379432411675;32353.676463235068;32913.506297406035;33086.338273234884;33681;32902.67097328996;32916;32977.175570610925;33114.33771324512;33125.668743313225;32088.197795055312;33087.69859918195;33090;33144.50283245801;33155.50266746049;27561.310967225178;29679.703202967696;29976.550351745176;30071.548926765678;30219.848900755354;21937.890310548344;22273.331800045376;22288.554228915655;23433.531329372978;23443.04429195259 13:49:16 INFO - 2015-11-13 13:49:16,025 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.63211731330165;342.0610424385063;342.0780995217889;342.5752067436378;345.082081662777;12844.935775321133;13089.607311780637;15189.848101518995;15440.459583914566;16528.42150524732;14795.372509023999;14841.480548180816;14846.480373186914;14930.178840163786;15028.323725432354;4728.479867214621;4728.503507131753;4734.455537613184;5119.12974794284;5144.0740666679985;3635.3638113330194;3733.4959780429704;5092.821751238707;5755.625884317506;5933.050711886099;5854.473097421232;5867.76528938842;5871.647701137924;5872.236609240793;5895.056790913433;5669.23465332179;5771.480566749013;5781.797637082724;5788.710564471801;5789.305283366002;5026.396832380138;5033.119204139298;5038.042771873369;5049.722265275408;5053.014662140884;10753.569857205703;11132.220744547885;19253;19861.602767944703;19922.402327930184;1469.8971072024963;1629.9022058676517;1651.9669606607802;1655.7350823868244;1740.730186821032;8124.6750129994725;8206.261436470686;8330.875036874451;8354.624041918129;8452.943382077241;1552.223888055972;1569.5762144220996;1649.4804136696903;1756.2887030752438;1783.7235228539466;50737.74631126858;51133.48866511325;51395.99999999963;51563;51858.7407062966;6216.937830621727;6276.780312689125;6278.560500764994;6293.559450838397;6341.746330146742;7311.853762924712;7337.33963943237;7337.376323012497;7340.853182936311;7342.70629174827;4794.041191761662;4794.832180873653;4801.327814106028;4801.399825021872;4854.635902307341;4825.927611085836;4907.754612269372;4916.606671466274;4938.061768264019;4945.752712364368;2800;2830.3348713052414;2835.277004363874;2862.685104638488;2862.8568571571336;1013.5287091502339;1028.4651980969854;1041.9739506512399;1060.1995493402433;1068.2148620763733;394.28437386144054;398.91024519482886;401.65257052649247;402.937544680575;425.14121474621095;8922.910770892338;9548.809023819624;9705.369151005161;9881.950590247003;10070.395776253448;418.2951726341064;420.6760794188458;426.27533193570434;432.77928256589365;451.4627593164124;5377;5542.0855558832345;5642.689652069093;5671.517920976763;5678.4605462480995;478057;487956;497119;499581;500943;64987.050388488424;69075.65462172657;69245;69747.65126174336;70324;478.5358202543527;486.4916162610081;486.5207770346206;491.3710450623208;491.6411019955524;10089.142422894136;10107.54516046765;10142.594296228068;10166.085052345325;10239.334443261165;32183.51724724084;32588.83705581457;32722.672773271963;33380.499292511115;33390.165245869044;39245.803770980965;39650.42272252294;40785.38821917733;41000.79499602483;41220.79389603033;6157.415045570664;6247.250329960434;6290.9056364155485;6323.4625056868845;6329.7151628175925;11093.50079246452;11104.056155226895;11286.20996530235;11290.096792256763;11381.089512839118;9805.852912206465;10020.498975051363;10091.495425228855;10111.7472063199;10112.646057387956;9504.382215155993;9878.4566848824;9925.602975881173;9971.30200885931;9999.100080992746;8176.7955801105445;8489.490630562186;8714.477131372138;9324.533773311443;9386.06139386056;5936.643801371932;5987.790427335022;5988.640681558946;5996.4902983245165;6008.699565021819;8954.149355811187;8983.056779038106;9000.684976025808;9130.315226358183;9210.677626283048 13:49:16 INFO - 2015-11-13 13:49:16,027 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1193.188631730423;1405.2130806748219;1405.5642750747263;1408.9718205635888;1459.8759105476033;5987.880242395149;6926.584404935707;7083.079199704031;7089.042979197813;7092.326229008236;7148.74979375722;7227.530210536312;7254.202037775841;7262.927370726291;7300.379467745248;1761.665283596119;1785.410814431241;2038.6024725178597;2120.9045592948355;2142.5393540388814;2128.5849259394427;2132.914683412662;2135.1245989144454;2136.423165745248;2141.7429908411013;2030.3705851186105;2065.5972085443345;2076.1384025629345;2076.4497408186844;2078.5011597216635;1722.1561434896935;1756.0429565886623;2022.0496366707623;2060.2274147194803;2069.4102180878376;2099.17082752312;2107.104480595741;2138.615049291127;2140.9036593353335;2143.8070573648447;7317.085364329459;7377.372923301526;7383.556986580768;7399.519031262951;7414.332710056067;4300.419443375167;4392.758398288093;4400.295952647593;4428.911421771547;4432.689711720181;2855.52883774177;2875.7843161762953;2922.3570814420796;2922.605448264478;2962.303858593229;920.2270093121809;924.1405492891676;956.4882787708542;977.0864241933815;986.1075726467558;9862.260330475243;9880.90119098807;9884.110430061257;9885;9900.25748068905;4072.3891416287793;4083.305838007546;4163.958360416417;4212.726172798758;4215.768132752728;8220.753377398687;8230.670773169126;8250.958745206355;8252.669893204205;8275.54484503358;4383.991681913114;4387.188370151533;4392.780360982002;4402.3176407656865;4404.977975110104;3978.7214894957656;3981.22366138606;3981.6217459341315;3984.242993831163;3990.3016972029777;3423.1099914022534;3485.9825700871334;3487.4245749451566;3491.319192757439;3519.542459480251;1059.0627294844119;1067.2422579968309;1090.6182836007492;1099.2250463423268;1101.1741194104422;943.698016634684;1110.4281295133012;1143.9428028598536;1153.682737247247;1153.9307641541534;6704.83237919056;6735;6737.461003119739;6753.594784312957;6809.114815074107;1017.211660962745;1021.4841505039907;1022.8261195596766;1044.984325235122;1063.3460421840512;5366.087765079946;5412;5417.322834645669;5426.321709786277;5426.565874730012;8701.30389568833;8762.86855697165;8931.910680893237;9062.728118156467;9065.68270110543;8846.292296616255;8849.734507964771;8869.467831930106;8933;8944.329175311877;6643.701033453506;6753.729850806011;6797.796066118024;6802.183737951477;6817.761378351734;6367.140436041075;6368.936310637019;6392.808215753535;6394.840128996812;6402.679866006588;7598.278163574451;7612.543247405173;7685.03937007874;7760.650770715444;7821.139674635671;7847.215278472336;8010.599470026359;8091.06952700447;8094.069182044141;8098.190180981855;6035.788747393995;6070.817875463743;6071.514278857592;6074.544409169242;6090.390960903874;6958.582485050913;7154.785356439315;7167.354938055391;7169.713211471482;7217.206107328085;6508.316626754312;6520.967395162994;6606.537542371988;6624.4700423965005;6655.833604159935;5223.608229382736;6387.361263873576;6570.5400621957915;6637.1703537057865;6685.09751183584;6464.256610489854;6490.415862572202;6491.578047426902;6496.675166241764;6499.447546958561;6117.051856962178;6142.846428839136;6178.69106544662;6185.907211391923;6200.782972596118;6134.631922084689;6154.630722156685;6162.784302549389;6222.81331560054;6247.625142491465 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: |4;prototype.html;297.663640086702;302.9803062800918;307.47728860936405;307.6784759925876;308.911960091374;5467.425920278368;5479.4794494523;5525.889482210353;5527.917081243784;5567.832965011046;5417.26866872973;5433.918491222625;5448.37343705474;5449.945500544994;5453.972730136344;3970.463987361698;4187.33002719565;4192.853250136246;4198.559151289117;4201.558836322196;4048.271311163989;4077.1641813428178;4189.581041895816;4200.285951388271;4203.495580530341;4145.108801607654;4151.626353628173;4153.107081977374;4157.127003329289;4158.521769996459;3927.8232479538206;4010.197960407901;4036.636702696742;4158.168366326731;4164.895877603054;3641.635836416364;3653;3660.5607327120915;3661.4324779659196;3662.7619204751604;5232.136697444917;5239.1093514102695;5242.318498595197;5245.921311180336;5253.6322457428;4818.59041981432;4820.301056346845;4822.397200349957;4831.516848315176;4833.32333473314;5571.860703482445;5706.514946229576;5708.457696518824;5721.370649228582;5732.082866741302;3983.3029219886403;3986.6412022918075;3989.8005099744896;3989.900252493711;3991.3214753491975;6019.578629495937;6027.126066720345;6031.939680603182;6032.42691944269;6033.9396606033815;4124.649404800625;4125.422440858282;4134.069834287321;4137.606927341898;4138.089620283533;4065.5324637667045;4068.4100805383646;4081.673466122703;4180.581941805795;4191.497020357516;4687.414073240845;4698.85903422891;4701.623870090384;4705.6470764692785;4711.599514041276;5722.399148089391;5731.168980497888;5737.942620573825;5738.139279108167;5742.598018138774;1454.163855782929;1473.5358362116115;1474.3439169569438;1475.5499572630235;1476.0331982551445;1002.178213864624;1006.959721611142;1011.6964910526813;1021.1065317846884;1031.886492485826;5031.4465408805;5050.621203409685;5054.241863720398;5054.848354549369;5059.848204553869;5962.4633782959745;5975;5976.491998180203;5976.880462390728;5978.940210597838;5042.319286896295;5053.0399224147295;5053.7473126344275;5061.417936937226;5062.519060689228;2999.79001469895;3021.531662592302;3103.7672174586996;3191.0586377018835;3233.1755402372246;5609.971950140223;5650.29371328584;5663.575231857627;5667.829965101054;5673.914891276634;6105.206323178048;6139.815805525842;6148.538859585549;6162.938370616236;6167;5520.254765606592;5611.999999999918;5625.296837895263;5633.521150702154;5638.746256418471;5978.222831031938;5986.700664966821;5990.940090599038;5992.131140984446;6001.129836173817;5821.650700957956;5825.70871456417;5827.6794776286015;5828.854278643068;5833.008388573868;5637.46444087811;5641.351244606923;5643.746031428514;5649.378568357395;5650.378458369494;3880.2821478026653;4027.2146931348107;4027.375756757707;4027.4361589378095;4038.151988082418;5954.821355359346;5969.671668058125;5971.701414929149;5974.044152935509;5978.880422391615;5731.283589551306;5735.483806457439;5737.540996720336;5738.8278351649515;5748.310202775694;5585.659441734036;5676.460736230051;5713.457221563945;5748.655080695172;5772.336181339032;5679.971600141973;5683.374828768915;5694.686792226467;5697.173909783141;5697.202391665087;5825.0388685866355;5825.155352473783;5831.067029275296;5833.504152146946;5843.883122337615;5533.170024496358;5679.204911312337;5679.545636349165;5685.346185188756;5694.772209111755 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.871818713538;722.8951801988709;767.4742801181189;793.9761807145787;794.245466806534;11506.539738410464;11699.590514332;11722.413879306043;11724.941375293121;11761.176717629769;11703.882961170386;11787.057035437167;11803.291802491856;11819.940900295507;11823.467943942522;613.2579578709766;621.925368955726;788.1330536409932;790.4427378698033;805.287320721163;797.3621103117512;799.312591171592;799.3924617290843;800.671724592917;804.7625950344633;640.3052687833683;831.787894087007;839.7690635075342;839.8026463781007;839.9668407858308;634.0330995232262;819.6270696832927;842.5029232752705;843.4770442325736;843.6161546496329;618.9876202475971;621.183144165421;622.2253294648146;622.7695752571532;622.844288927768;11219.663410097628;11256;11319.377434241114;11324.716882077932;11356.148288878367;10883.564657413694;11562.190646654737;11705.3562054087;11762.353070581115;11980.880191198064;9572.425654460685;9580.233581313478;9642.75893102671;9657.613695452173;9858;2762.654668166479;2838.3188034871687;2854.200823769348;2858.6712528059334;2862.885484580635;38495.807520962495;38654;39014;39016.21967560633;39068.60931390678;6548.083268342436;6637.46900247979;6743.494237932175;6780.9150535915005;6817.7954661359245;10125.240606954361;10163.18694504438;10168.33905796121;10186.337888037255;10214.693559193236;5396.83809485716;5505.697186654773;5609.551235901118;5754.971225143848;5775.624584402;3552.5381700378784;3617.1763460828047;3688.7602305850032;3705.2033812729856;3706.3513885070006;2502.4869901670113;2527.2544599343237;2529.709083455389;2533.429978254878;2535.4802265535523;382.54286128076683;385.1430566988428;386.44738024624496;386.65973942930043;386.7389512079335;461.1952143509597;554.0856341340658;598.8353202869246;604.5707547641136;617.6123960078963;7772.417068719868;7776.222377762291;7794.493357931717;7964.641591128413;7974.051896207585;497.2144012460304;607.6536374266626;633.6736580660963;645.5255387290338;651.3031056769212;3549.6627820357025;3576.570811502584;3594.4069228577514;3609.1157666371905;3738.8504459821847;48295.27557086646;48852;48870.26694599584;48909;49222.261666075035;44508;44863.327050094274;44923.10153796906;45573.77213113913;45623.771881141045;40982.79508602438;41568;41717.165656686695;41761.58238417577;41869.371959420634;7178.928210718035;7321.524100933422;7389.630518473948;7444.181140074696;7624.69501219945;32541.34917301688;32995.67004330022;33029.834850825595;33208.1697957553;33279.50080748839;37972.43041354327;40677.389839151845;40745;40864.70920553299;41559.376609351486;6203.131561581292;6204.472619827366;6260.467860231931;6270.655113968775;6325.367463253638;10162.74593135148;10484.737881553023;10501.212409069503;10523.368597884151;10579.682609521727;9547.236221102155;9641.903580964101;9677.612895484102;9680.5643746033;10112.24158188124;9498.905010950079;9618.951905240709;9695.321327507007;9722.319437639297;10101.292909496558;9326.114019168168;9418.387804792941;9429.764255893657;9444.102810233016;9772.9022709772;8580.14198580137;8624.913750862412;8666.393352465268;8703.129687031245;8899;8443.83112337762;8647.913520864711;8667.696630617898;8863.157999989991;8921.598528066123 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: __startTimestamp1447451356018__endTimestamp 13:49:16 INFO - 2015-11-13 13:49:16,028 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:49:16 INFO - 2015-11-13 13:49:16,029 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:49:16 INFO - 2015-11-13 13:49:16,029 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,029 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4738.20 Median:4855.39 stddev:499.51 (10.3%) stddev-sans-first:473.73 13:49:16 INFO - 2015-11-13 13:49:16,030 DEBUG : BROWSER_OUTPUT: Values: 2661.6 2738.0 2747.0 2750.5 2757.1 4584.2 4739.6 4796.0 4840.3 4849.8 4737.0 4746.8 4747.0 4805.2 4805.9 4403.1 4403.5 4418.6 4420.7 4433.1 4265.3 4497.4 4517.5 4551.9 4553.0 4279.2 4392.0 4395.6 4402.0 4420.5 4429.0 4432.4 4447.0 4451.7 4464.1 4191.4 4405.1 4412.0 4443.8 4460.4 4631.7 4639.9 4704.2 4723.2 4750.7 5152.1 5155.8 5156.0 5178.8 5193.5 4947.3 5056.8 5184.0 5185.8 5190.1 4552.4 4611.5 4654.0 4686.6 4692.7 5298.7 5316.9 5320.0 5329.5 5364.4 4876.6 4983.5 5102.9 5103.4 5108.4 5056.1 5101.6 5176.8 5206.3 5216.2 5077.0 5137.9 5139.7 5141.8 5142.9 5111.1 5114.8 5120.6 5122.8 5150.2 4113.9 4171.4 4209.3 4210.6 4247.0 3762.2 3762.8 3773.4 3801.7 3806.3 4486.0 4511.9 4515.8 4518.5 4542.7 4926.8 5032.4 5035.4 5228.1 5295.6 4387.8 4458.2 4480.4 4514.9 4520.6 4602.8 4603.2 4607.0 4607.7 4650.3 4726.3 4824.2 4826.0 4945.8 4949.0 5119.8 5207.2 5227.4 5229.1 5260.9 4918.4 4944.0 4944.9 4946.2 4984.3 4855.4 4952.5 4971.7 5126.2 5144.7 5064.8 5138.4 5143.1 5143.9 5154.9 4991.6 4998.8 5000.1 5019.6 5037.0 4795.0 4903.2 4904.1 4999.2 5008.2 4862.9 4932.3 4954.3 4960.1 4977.4 5003.7 5082.9 5086.1 5089.2 5127.1 4718.0 4805.6 4812.9 4935.0 5001.3 13:49:16 INFO - 2015-11-13 13:49:16,030 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,030 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42246.45 Median:17063.07 stddev:69750.11 (408.8%) stddev-sans-first:69875.52 13:49:16 INFO - 2015-11-13 13:49:16,030 DEBUG : BROWSER_OUTPUT: Values: 552.5 560.2 563.7 569.3 577.9 28348.7 37055.0 37763.4 37776.6 37787.8 40089.0 40556.8 40559.8 40573.6 40587.2 6946.3 7036.2 7903.7 8064.6 8066.0 10185.3 10446.8 10454.7 10455.7 10462.6 10168.5 10218.0 10262.6 10273.2 10286.9 7190.1 7389.3 10104.7 10234.0 10472.7 9958.7 10046.3 10055.3 10056.6 10095.6 37649.2 38045.2 38105.4 38144.2 38145.6 2767.5 2768.8 3354.8 3563.8 3577.8 28273.7 28658.8 28747.6 28839.3 29130.0 3097.8 3111.8 3136.9 3137.2 3169.3 225773.0 226521.0 226637.9 226665.0 227039.0 50998.7 52578.7 55531.0 57267.7 57313.7 55770.0 56080.4 56260.4 56732.7 56842.0 13442.5 13570.2 13591.0 13596.7 13605.1 10148.4 10159.5 10185.9 10416.1 10420.5 18819.2 18970.3 19023.7 19029.7 19052.0 7137.6 7386.4 7459.8 7467.8 7497.6 747.9 789.5 1015.3 1039.4 1050.9 26464.0 26540.0 26704.5 26762.3 26781.2 881.4 882.9 892.7 896.9 931.1 13807.8 13822.4 13947.5 13967.3 14056.2 269899.0 273643.0 274706.0 275034.0 275110.0 45453.0 45704.5 45801.5 45890.3 45904.5 1105.3 1111.4 1115.2 1116.6 1121.8 24447.1 25153.9 25613.6 25742.5 26368.5 41369.6 41454.8 41469.8 41735.8 41805.0 213041.0 218581.0 331283.0 341479.6 342964.0 27363.4 27460.2 27486.0 27495.0 27568.3 37638.0 38111.6 38354.2 38412.2 38542.0 31028.4 32353.7 32913.5 33086.3 33681.0 32902.7 32916.0 32977.2 33114.3 33125.7 32088.2 33087.7 33090.0 33144.5 33155.5 27561.3 29679.7 29976.6 30071.5 30219.8 21937.9 22273.3 22288.6 23433.5 23443.0 13:49:16 INFO - 2015-11-13 13:49:16,031 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,031 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24586.82 Median:246431.88 stddev:80680.07 (32.7%) stddev-sans-first:80885.85 13:49:16 INFO - 2015-11-13 13:49:16,031 DEBUG : BROWSER_OUTPUT: Values: 340.6 342.1 342.1 342.6 345.1 12844.9 13089.6 15189.8 15440.5 16528.4 14795.4 14841.5 14846.5 14930.2 15028.3 4728.5 4728.5 4734.5 5119.1 5144.1 3635.4 3733.5 5092.8 5755.6 5933.1 5854.5 5867.8 5871.6 5872.2 5895.1 5669.2 5771.5 5781.8 5788.7 5789.3 5026.4 5033.1 5038.0 5049.7 5053.0 10753.6 11132.2 19253.0 19861.6 19922.4 1469.9 1629.9 1652.0 1655.7 1740.7 8124.7 8206.3 8330.9 8354.6 8452.9 1552.2 1569.6 1649.5 1756.3 1783.7 50737.7 51133.5 51396.0 51563.0 51858.7 6216.9 6276.8 6278.6 6293.6 6341.7 7311.9 7337.3 7337.4 7340.9 7342.7 4794.0 4794.8 4801.3 4801.4 4854.6 4825.9 4907.8 4916.6 4938.1 4945.8 2800.0 2830.3 2835.3 2862.7 2862.9 1013.5 1028.5 1042.0 1060.2 1068.2 394.3 398.9 401.7 402.9 425.1 8922.9 9548.8 9705.4 9882.0 10070.4 418.3 420.7 426.3 432.8 451.5 5377.0 5542.1 5642.7 5671.5 5678.5 478057.0 487956.0 497119.0 499581.0 500943.0 64987.1 69075.7 69245.0 69747.7 70324.0 478.5 486.5 486.5 491.4 491.6 10089.1 10107.5 10142.6 10166.1 10239.3 32183.5 32588.8 32722.7 33380.5 33390.2 39245.8 39650.4 40785.4 41000.8 41220.8 6157.4 6247.3 6290.9 6323.5 6329.7 11093.5 11104.1 11286.2 11290.1 11381.1 9805.9 10020.5 10091.5 10111.7 10112.6 9504.4 9878.5 9925.6 9971.3 9999.1 8176.8 8489.5 8714.5 9324.5 9386.1 5936.6 5987.8 5988.6 5996.5 6008.7 8954.1 8983.1 9000.7 9130.3 9210.7 13:49:16 INFO - 2015-11-13 13:49:16,031 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,031 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5066.78 Median:6170.74 stddev:2629.27 (42.6%) stddev-sans-first:2620.53 13:49:16 INFO - 2015-11-13 13:49:16,032 DEBUG : BROWSER_OUTPUT: Values: 1193.2 1405.2 1405.6 1409.0 1459.9 5987.9 6926.6 7083.1 7089.0 7092.3 7148.7 7227.5 7254.2 7262.9 7300.4 1761.7 1785.4 2038.6 2120.9 2142.5 2128.6 2132.9 2135.1 2136.4 2141.7 2030.4 2065.6 2076.1 2076.4 2078.5 1722.2 1756.0 2022.0 2060.2 2069.4 2099.2 2107.1 2138.6 2140.9 2143.8 7317.1 7377.4 7383.6 7399.5 7414.3 4300.4 4392.8 4400.3 4428.9 4432.7 2855.5 2875.8 2922.4 2922.6 2962.3 920.2 924.1 956.5 977.1 986.1 9862.3 9880.9 9884.1 9885.0 9900.3 4072.4 4083.3 4164.0 4212.7 4215.8 8220.8 8230.7 8251.0 8252.7 8275.5 4384.0 4387.2 4392.8 4402.3 4405.0 3978.7 3981.2 3981.6 3984.2 3990.3 3423.1 3486.0 3487.4 3491.3 3519.5 1059.1 1067.2 1090.6 1099.2 1101.2 943.7 1110.4 1143.9 1153.7 1153.9 6704.8 6735.0 6737.5 6753.6 6809.1 1017.2 1021.5 1022.8 1045.0 1063.3 5366.1 5412.0 5417.3 5426.3 5426.6 8701.3 8762.9 8931.9 9062.7 9065.7 8846.3 8849.7 8869.5 8933.0 8944.3 6643.7 6753.7 6797.8 6802.2 6817.8 6367.1 6368.9 6392.8 6394.8 6402.7 7598.3 7612.5 7685.0 7760.7 7821.1 7847.2 8010.6 8091.1 8094.1 8098.2 6035.8 6070.8 6071.5 6074.5 6090.4 6958.6 7154.8 7167.4 7169.7 7217.2 6508.3 6521.0 6606.5 6624.5 6655.8 5223.6 6387.4 6570.5 6637.2 6685.1 6464.3 6490.4 6491.6 6496.7 6499.4 6117.1 6142.8 6178.7 6185.9 6200.8 6134.6 6154.6 6162.8 6222.8 6247.6 13:49:16 INFO - 2015-11-13 13:49:16,032 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4750.10 Median:5425.59 stddev:1414.18 (26.1%) stddev-sans-first:1378.09 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: Values: 297.7 303.0 307.5 307.7 308.9 5467.4 5479.5 5525.9 5527.9 5567.8 5417.3 5433.9 5448.4 5449.9 5454.0 3970.5 4187.3 4192.9 4198.6 4201.6 4048.3 4077.2 4189.6 4200.3 4203.5 4145.1 4151.6 4153.1 4157.1 4158.5 3927.8 4010.2 4036.6 4158.2 4164.9 3641.6 3653.0 3660.6 3661.4 3662.8 5232.1 5239.1 5242.3 5245.9 5253.6 4818.6 4820.3 4822.4 4831.5 4833.3 5571.9 5706.5 5708.5 5721.4 5732.1 3983.3 3986.6 3989.8 3989.9 3991.3 6019.6 6027.1 6031.9 6032.4 6033.9 4124.6 4125.4 4134.1 4137.6 4138.1 4065.5 4068.4 4081.7 4180.6 4191.5 4687.4 4698.9 4701.6 4705.6 4711.6 5722.4 5731.2 5737.9 5738.1 5742.6 1454.2 1473.5 1474.3 1475.5 1476.0 1002.2 1007.0 1011.7 1021.1 1031.9 5031.4 5050.6 5054.2 5054.8 5059.8 5962.5 5975.0 5976.5 5976.9 5978.9 5042.3 5053.0 5053.7 5061.4 5062.5 2999.8 3021.5 3103.8 3191.1 3233.2 5610.0 5650.3 5663.6 5667.8 5673.9 6105.2 6139.8 6148.5 6162.9 6167.0 5520.3 5612.0 5625.3 5633.5 5638.7 5978.2 5986.7 5990.9 5992.1 6001.1 5821.7 5825.7 5827.7 5828.9 5833.0 5637.5 5641.4 5643.7 5649.4 5650.4 3880.3 4027.2 4027.4 4027.4 4038.2 5954.8 5969.7 5971.7 5974.0 5978.9 5731.3 5735.5 5737.5 5738.8 5748.3 5585.7 5676.5 5713.5 5748.7 5772.3 5680.0 5683.4 5694.7 5697.2 5697.2 5825.0 5825.2 5831.1 5833.5 5843.9 5533.2 5679.2 5679.5 5685.3 5694.8 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11755.57 Median:3029.89 stddev:13936.71 (460.0%) stddev-sans-first:13951.04 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: Values: 692.9 722.9 767.5 794.0 794.2 11506.5 11699.6 11722.4 11724.9 11761.2 11703.9 11787.1 11803.3 11819.9 11823.5 613.3 621.9 788.1 790.4 805.3 797.4 799.3 799.4 800.7 804.8 640.3 831.8 839.8 839.8 840.0 634.0 819.6 842.5 843.5 843.6 619.0 621.2 622.2 622.8 622.8 11219.7 11256.0 11319.4 11324.7 11356.1 10883.6 11562.2 11705.4 11762.4 11980.9 9572.4 9580.2 9642.8 9657.6 9858.0 2762.7 2838.3 2854.2 2858.7 2862.9 38495.8 38654.0 39014.0 39016.2 39068.6 6548.1 6637.5 6743.5 6780.9 6817.8 10125.2 10163.2 10168.3 10186.3 10214.7 5396.8 5505.7 5609.6 5755.0 5775.6 3552.5 3617.2 3688.8 3705.2 3706.4 2502.5 2527.3 2529.7 2533.4 2535.5 382.5 385.1 386.4 386.7 386.7 461.2 554.1 598.8 604.6 617.6 7772.4 7776.2 7794.5 7964.6 7974.1 497.2 607.7 633.7 645.5 651.3 3549.7 3576.6 3594.4 3609.1 3738.9 48295.3 48852.0 48870.3 48909.0 49222.3 44508.0 44863.3 44923.1 45573.8 45623.8 40982.8 41568.0 41717.2 41761.6 41869.4 7178.9 7321.5 7389.6 7444.2 7624.7 32541.3 32995.7 33029.8 33208.2 33279.5 37972.4 40677.4 40745.0 40864.7 41559.4 6203.1 6204.5 6260.5 6270.7 6325.4 10162.7 10484.7 10501.2 10523.4 10579.7 9547.2 9641.9 9677.6 9680.6 10112.2 9498.9 9619.0 9695.3 9722.3 10101.3 9326.1 9418.4 9429.8 9444.1 9772.9 8580.1 8624.9 8666.4 8703.1 8899.0 8443.8 8647.9 8667.7 8863.2 8921.6 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:49:16 INFO - 2015-11-13 13:49:16,033 DEBUG : BROWSER_OUTPUT: 13:49:16 INFO - 2015-11-13 13:49:16,725 INFO : Browser exited with error code: 0 13:49:16 INFO - 2015-11-13 13:49:16,749 INFO : Completed test dromaeo_css (00:18:36) 13:49:16 INFO - 2015-11-13 13:49:16,749 INFO : Starting test kraken 13:49:16 INFO - 2015-11-13 13:49:16,749 DEBUG : operating with platform_type : linux_ 13:49:16 INFO - 2015-11-13 13:49:16,749 INFO : Initialising browser for kraken test... 13:49:16 INFO - 2015-11-13 13:49:16,755 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YLCaR/profile http://localhost:46466/getInfo.html 13:49:20 INFO - 2015-11-13 13:49:20,606 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:49:20 INFO - 2015-11-13 13:49:20,607 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:49:20 INFO - 2015-11-13 13:49:20,607 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:49:20 INFO - 2015-11-13 13:49:20,607 DEBUG : BROWSER_OUTPUT: __metrics 13:49:20 INFO - 2015-11-13 13:49:20,716 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:21 INFO - 2015-11-13 13:49:21,922 INFO : Browser initialized. 13:49:21 INFO - 2015-11-13 13:49:21,923 INFO : Running cycle 1/1 for kraken test... 13:49:21 INFO - 2015-11-13 13:49:21,923 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3YLCaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:49:33 INFO - 2015-11-13 13:49:33,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 140619776 13:49:33 INFO - 2015-11-13 13:49:33,829 DEBUG : BROWSER_OUTPUT: 13:49:36 INFO - 2015-11-13 13:49:36,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46466/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:36 INFO - 2015-11-13 13:49:36,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 178192384 13:49:36 INFO - 2015-11-13 13:49:36,991 DEBUG : BROWSER_OUTPUT: 13:49:39 INFO - 2015-11-13 13:49:39,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46466/tests/kraken/driver.html?testName=audio-dft) 13:49:40 INFO - 2015-11-13 13:49:40,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 167391232 13:49:40 INFO - 2015-11-13 13:49:40,306 DEBUG : BROWSER_OUTPUT: 13:49:43 INFO - 2015-11-13 13:49:43,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46466/tests/kraken/driver.html?testName=audio-fft) 13:49:43 INFO - 2015-11-13 13:49:43,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 151678976 13:49:43 INFO - 2015-11-13 13:49:43,872 DEBUG : BROWSER_OUTPUT: 13:49:45 INFO - 2015-11-13 13:49:45,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46466/tests/kraken/driver.html?testName=audio-oscillator) 13:49:46 INFO - 2015-11-13 13:49:46,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 153776128 13:49:46 INFO - 2015-11-13 13:49:46,476 DEBUG : BROWSER_OUTPUT: 13:49:48 INFO - 2015-11-13 13:49:48,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:49 INFO - 2015-11-13 13:49:49,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 155537408 13:49:49 INFO - 2015-11-13 13:49:49,235 DEBUG : BROWSER_OUTPUT: 13:49:52 INFO - 2015-11-13 13:49:52,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46466/tests/kraken/driver.html?testName=imaging-darkroom) 13:49:52 INFO - 2015-11-13 13:49:52,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 155144192 13:49:52 INFO - 2015-11-13 13:49:52,823 DEBUG : BROWSER_OUTPUT: 13:49:56 INFO - 2015-11-13 13:49:56,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46466/tests/kraken/driver.html?testName=imaging-desaturate) 13:49:56 INFO - 2015-11-13 13:49:56,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 154943488 13:49:56 INFO - 2015-11-13 13:49:56,904 DEBUG : BROWSER_OUTPUT: 13:49:59 INFO - 2015-11-13 13:49:59,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46466/tests/kraken/driver.html?testName=json-parse-financial) 13:50:00 INFO - 2015-11-13 13:50:00,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 153866240 13:50:00 INFO - 2015-11-13 13:50:00,295 DEBUG : BROWSER_OUTPUT: 13:50:02 INFO - 2015-11-13 13:50:02,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:50:02 INFO - 2015-11-13 13:50:02,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 163901440 13:50:02 INFO - 2015-11-13 13:50:02,618 DEBUG : BROWSER_OUTPUT: 13:50:04 INFO - 2015-11-13 13:50:04,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:50:05 INFO - 2015-11-13 13:50:05,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 162832384 13:50:05 INFO - 2015-11-13 13:50:05,082 DEBUG : BROWSER_OUTPUT: 13:50:07 INFO - 2015-11-13 13:50:07,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:50:07 INFO - 2015-11-13 13:50:07,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 176816128 13:50:07 INFO - 2015-11-13 13:50:07,842 DEBUG : BROWSER_OUTPUT: 13:50:10 INFO - 2015-11-13 13:50:10,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:50:10 INFO - 2015-11-13 13:50:10,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 181522432 13:50:10 INFO - 2015-11-13 13:50:10,942 DEBUG : BROWSER_OUTPUT: 13:50:13 INFO - 2015-11-13 13:50:13,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:50:14 INFO - 2015-11-13 13:50:14,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 181841920 13:50:14 INFO - 2015-11-13 13:50:14,084 DEBUG : BROWSER_OUTPUT: 13:50:15 INFO - 2015-11-13 13:50:15,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46466/tests/kraken/driver.html?testName=ai-astar) 13:50:16 INFO - 2015-11-13 13:50:16,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 238477312 13:50:16 INFO - 2015-11-13 13:50:16,109 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;107;111;113;112;100;112;103;110 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;144;154;173;130;156;152;130;168;134 13:50:16 INFO - 2015-11-13 13:50:16,110 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;160;160;162;161;162;162;161;162 13:50:16 INFO - 2015-11-13 13:50:16,112 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;88;92;73;73;73;114;92;72 13:50:16 INFO - 2015-11-13 13:50:16,112 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;126;91;91;91;133;91;91;134 13:50:16 INFO - 2015-11-13 13:50:16,112 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;110;109;109;110;110 13:50:16 INFO - 2015-11-13 13:50:16,112 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;149;149;149;148;149;149;149;148 13:50:16 INFO - 2015-11-13 13:50:16,112 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;95;96;95;95;95 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;71;71;71;71;71;79;69;68 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;67;68;68;68;68;69;68;68;68 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;92;84;84;90;83;82;93;86;83 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;124;121;126;123;118;127;120;127;124 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;144;145;138;147;145;156;145;134;133 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;71;70;68;68;69;68;67;68 13:50:16 INFO - 2015-11-13 13:50:16,113 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:50:16 INFO - 2015-11-13 13:50:16,114 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:50:16 INFO - 2015-11-13 13:50:16,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,947 13:50:16 INFO - 2015-11-13 13:50:16,114 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:50:16 INFO - 2015-11-13 13:50:16,114 DEBUG : BROWSER_OUTPUT: __startTimestamp1447451416109__endTimestamp 13:50:16 INFO - 2015-11-13 13:50:16,114 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.50 stddev:4.43 (4.0%) stddev-sans-first:4.69 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 107.0 111.0 113.0 112.0 100.0 112.0 103.0 110.0 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.50 Median:154.00 stddev:14.96 (9.7%) stddev-sans-first:15.78 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: Values: 154.0 144.0 154.0 173.0 130.0 156.0 152.0 130.0 168.0 134.0 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,122 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 160.0 160.0 162.0 161.0 162.0 162.0 161.0 162.0 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:73.50 stddev:14.01 (19.1%) stddev-sans-first:14.53 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 88.0 92.0 73.0 73.0 73.0 114.0 92.0 72.0 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.90 Median:91.00 stddev:19.50 (21.4%) stddev-sans-first:20.12 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 126.0 91.0 91.0 91.0 133.0 91.0 91.0 134.0 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 13:50:16 INFO - 2015-11-13 13:50:16,123 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 149.0 149.0 149.0 148.0 149.0 149.0 149.0 148.0 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:71.00 stddev:2.91 (4.1%) stddev-sans-first:3.08 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 71.0 71.0 71.0 79.0 69.0 68.0 13:50:16 INFO - 2015-11-13 13:50:16,124 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,125 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 13:50:16 INFO - 2015-11-13 13:50:16,125 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:88.00 stddev:4.36 (5.0%) stddev-sans-first:4.21 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 84.0 84.0 90.0 83.0 82.0 93.0 86.0 83.0 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.00 stddev:2.99 (2.4%) stddev-sans-first:3.16 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 121.0 126.0 123.0 118.0 127.0 120.0 127.0 124.0 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:145.00 stddev:6.70 (4.6%) stddev-sans-first:7.11 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: Values: 143.0 144.0 145.0 138.0 147.0 145.0 156.0 145.0 134.0 133.0 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 71.0 70.0 68.0 68.0 69.0 68.0 67.0 68.0 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:50:16 INFO - 2015-11-13 13:50:16,126 DEBUG : BROWSER_OUTPUT: 13:50:16 INFO - 2015-11-13 13:50:16,993 INFO : Browser exited with error code: 0 13:50:17 INFO - 2015-11-13 13:50:17,047 INFO : Completed test kraken (00:01:00) 13:50:17 INFO - 2015-11-13 13:50:17,047 INFO : Starting test v8_7 13:50:17 INFO - 2015-11-13 13:50:17,047 DEBUG : operating with platform_type : linux_ 13:50:17 INFO - 2015-11-13 13:50:17,047 INFO : Initialising browser for v8_7 test... 13:50:17 INFO - 2015-11-13 13:50:17,053 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiWYlI/profile http://localhost:46466/getInfo.html 13:50:20 INFO - 2015-11-13 13:50:20,946 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:50:20 INFO - 2015-11-13 13:50:20,946 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:50:20 INFO - 2015-11-13 13:50:20,946 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:50:20 INFO - 2015-11-13 13:50:20,946 DEBUG : BROWSER_OUTPUT: __metrics 13:50:21 INFO - 2015-11-13 13:50:21,063 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:50:22 INFO - 2015-11-13 13:50:22,222 INFO : Browser initialized. 13:50:22 INFO - 2015-11-13 13:50:22,222 INFO : Running cycle 1/1 for v8_7 test... 13:50:22 INFO - 2015-11-13 13:50:22,222 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsiWYlI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:50:34 INFO - 2015-11-13 13:50:34,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 140791808 13:50:34 INFO - 2015-11-13 13:50:34,080 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46466/tests/v8_7/run.html (next: http://localhost:46466/tests/v8_7/run.html) 13:50:55 INFO - 2015-11-13 13:50:55,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 441737216 13:50:55 INFO - 2015-11-13 13:50:55,746 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: |0;Richards;165.28925619834712 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 13:50:55 INFO - 2015-11-13 13:50:55,748 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |5;Earley;801.924619085806 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 13:50:55 INFO - 2015-11-13 13:50:55,749 DEBUG : BROWSER_OUTPUT: |8;Splay;625.3908692933084 13:50:55 INFO - 2015-11-13 13:50:55,750 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 13:50:55 INFO - 2015-11-13 13:50:55,750 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:50:55 INFO - 2015-11-13 13:50:55,750 DEBUG : BROWSER_OUTPUT: __startTimestamp1447451455747__endTimestamp 13:50:55 INFO - 2015-11-13 13:50:55,750 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,750 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:50:55 INFO - 2015-11-13 13:50:55,751 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.29 Median:165.29 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: Values: 165.3 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,752 DEBUG : BROWSER_OUTPUT: Values: 191.4 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: Values: 279.1 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,753 DEBUG : BROWSER_OUTPUT: Values: 5035.2 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: Values: 1992.0 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: Values: 801.9 13:50:55 INFO - 2015-11-13 13:50:55,754 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: Values: 11952.4 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: Values: 25974.4 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:625.39 Median:625.39 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,755 DEBUG : BROWSER_OUTPUT: Values: 625.4 13:50:55 INFO - 2015-11-13 13:50:55,756 DEBUG : BROWSER_OUTPUT: 13:50:55 INFO - 2015-11-13 13:50:55,756 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 13:50:55 INFO - 2015-11-13 13:50:55,756 DEBUG : BROWSER_OUTPUT: Values: 4817.3 13:50:55 INFO - 2015-11-13 13:50:55,756 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:50:55 INFO - 2015-11-13 13:50:55,756 DEBUG : BROWSER_OUTPUT: 13:50:56 INFO - 2015-11-13 13:50:56,629 INFO : Browser exited with error code: 0 13:50:56 INFO - 2015-11-13 13:50:56,646 INFO : Completed test v8_7 (00:00:39) 13:50:56 INFO - 2015-11-13 13:50:56,757 INFO : Completed test suite (00:20:16) 13:50:56 INFO - 2015-11-13 13:50:56,757 DEBUG : Working with test: dromaeo_css 13:50:56 INFO - 2015-11-13 13:50:56,757 DEBUG : Generating results file: dromaeo_css 13:50:56 INFO - 2015-11-13 13:50:56,759 DEBUG : Working with test: kraken 13:50:56 INFO - 2015-11-13 13:50:56,759 DEBUG : Generating results file: kraken 13:50:56 INFO - 2015-11-13 13:50:56,759 INFO : javascript benchmark 13:50:56 INFO - 2015-11-13 13:50:56,759 DEBUG : Working with test: v8_7 13:50:56 INFO - 2015-11-13 13:50:56,759 DEBUG : Generating results file: v8_7 13:50:56 INFO - 2015-11-13 13:50:56,760 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:50:56 INFO - 2015-11-13 13:50:56,818 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 13:50:56 INFO - 2015-11-13 13:50:56,819 DEBUG : process_Request line: dromaeo_css 6066.20 graph.html#tests=[[72,132,35]] 13:50:56 INFO - 2015-11-13 13:50:56,819 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:50:56 INFO - 2015-11-13 13:50:56,852 DEBUG : process_Request line: kraken 1520.10 graph.html#tests=[[232,132,35]] 13:50:56 INFO - 2015-11-13 13:50:56,852 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:50:56 INFO - 2015-11-13 13:50:56,970 DEBUG : process_Request line: v8_7 19821.49 graph.html#tests=[[230,132,35]] 13:50:56 INFO - 2015-11-13 13:50:56,971 INFO : javascript benchmark 13:50:57 INFO - 2015-11-13 13:50:56,975 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [340.63211731330165, 342.0610424385063, 342.0780995217889, 342.5752067436378, 345.082081662777, 12844.935775321133, 13089.607311780637, 15189.848101518995, 15440.459583914566, 16528.42150524732, 14795.372509023999, 14841.480548180816, 14846.480373186914, 14930.178840163786, 15028.323725432354, 4728.479867214621, 4728.503507131753, 4734.455537613184, 5119.12974794284, 5144.0740666679985, 3635.3638113330194, 3733.4959780429704, 5092.821751238707, 5755.625884317506, 5933.050711886099, 5854.473097421232, 5867.76528938842, 5871.647701137924, 5872.236609240793, 5895.056790913433, 5669.23465332179, 5771.480566749013, 5781.797637082724, 5788.710564471801, 5789.305283366002, 5026.396832380138, 5033.119204139298, 5038.042771873369, 5049.722265275408, 5053.014662140884, 10753.569857205703, 11132.220744547885, 19253.0, 19861.602767944703, 19922.402327930184, 1469.8971072024963, 1629.9022058676517, 1651.9669606607802, 1655.7350823868244, 1740.730186821032, 8124.6750129994725, 8206.261436470686, 8330.875036874451, 8354.624041918129, 8452.943382077241, 1552.223888055972, 1569.5762144220996, 1649.4804136696903, 1756.2887030752438, 1783.7235228539466, 50737.74631126858, 51133.48866511325, 51395.99999999963, 51563.0, 51858.7407062966, 6216.937830621727, 6276.780312689125, 6278.560500764994, 6293.559450838397, 6341.746330146742, 7311.853762924712, 7337.33963943237, 7337.376323012497, 7340.853182936311, 7342.70629174827, 4794.041191761662, 4794.832180873653, 4801.327814106028, 4801.399825021872, 4854.635902307341, 4825.927611085836, 4907.754612269372, 4916.606671466274, 4938.061768264019, 4945.752712364368, 2800.0, 2830.3348713052414, 2835.277004363874, 2862.685104638488, 2862.8568571571336, 1013.5287091502339, 1028.4651980969854, 1041.9739506512399, 1060.1995493402433, 1068.2148620763733, 394.28437386144054, 398.91024519482886, 401.65257052649247, 402.937544680575, 425.14121474621095, 8922.910770892338, 9548.809023819624, 9705.369151005161, 9881.950590247003, 10070.395776253448, 418.2951726341064, 420.6760794188458, 426.27533193570434, 432.77928256589365, 451.4627593164124, 5377.0, 5542.0855558832345, 5642.689652069093, 5671.517920976763, 5678.4605462480995, 478057.0, 487956.0, 497119.0, 499581.0, 500943.0, 64987.050388488424, 69075.65462172657, 69245.0, 69747.65126174336, 70324.0, 478.5358202543527, 486.4916162610081, 486.5207770346206, 491.3710450623208, 491.6411019955524, 10089.142422894136, 10107.54516046765, 10142.594296228068, 10166.085052345325, 10239.334443261165, 32183.51724724084, 32588.83705581457, 32722.672773271963, 33380.499292511115, 33390.165245869044, 39245.803770980965, 39650.42272252294, 40785.38821917733, 41000.79499602483, 41220.79389603033, 6157.415045570664, 6247.250329960434, 6290.9056364155485, 6323.4625056868845, 6329.7151628175925, 11093.50079246452, 11104.056155226895, 11286.20996530235, 11290.096792256763, 11381.089512839118, 9805.852912206465, 10020.498975051363, 10091.495425228855, 10111.7472063199, 10112.646057387956, 9504.382215155993, 9878.4566848824, 9925.602975881173, 9971.30200885931, 9999.100080992746, 8176.7955801105445, 8489.490630562186, 8714.477131372138, 9324.533773311443, 9386.06139386056, 5936.643801371932, 5987.790427335022, 5988.640681558946, 5996.4902983245165, 6008.699565021819, 8954.149355811187, 8983.056779038106, 9000.684976025808, 9130.315226358183, 9210.677626283048], "dojo.html": [2661.5741481362984, 2737.9726202737966, 2747.0248061938023, 2750.4774092922357, 2757.090160247118, 4584.243599806028, 4739.620830333573, 4796.040791841629, 4840.34655321531, 4849.781759820808, 4736.952630473695, 4746.76266186691, 4746.952530474694, 4805.207140821769, 4805.8798530036765, 4403.097365040159, 4403.515613282529, 4418.624416924549, 4420.712653677517, 4433.113377324532, 4265.31754919213, 4497.392851964992, 4517.503074661801, 4551.863444096666, 4553.021100463399, 4279.229738647043, 4391.956080439202, 4395.560443955611, 4402.009547851708, 4420.46954365475, 4428.955710442887, 4432.445944256968, 4447.043885564619, 4451.666125040635, 4464.084862603191, 4191.350340697197, 4405.074934263808, 4412.0, 4443.755593442359, 4460.397846290742, 4631.722096674177, 4639.930401043987, 4704.176769065434, 4723.244280915037, 4750.667453278272, 5152.072626927152, 5155.793768249266, 5156.04613146569, 5178.792848286064, 5193.506616871391, 4947.282644016597, 5056.82301119459, 5184.0, 5185.792568297264, 5190.091733946582, 4552.408186935677, 4611.469680986729, 4653.976730116327, 4686.625069994392, 4692.741899195543, 5298.70857102863, 5316.946830531645, 5320.015797077475, 5329.54698850602, 5364.356277246756, 4876.609871210366, 4983.526564976321, 5102.872428189325, 5103.362079740033, 5108.361454818148, 5056.140456122468, 5101.617378696613, 5176.818811341585, 5206.271122042917, 5216.21756736485, 5077.035363280965, 5137.8715532112, 5139.743012849342, 5141.845744627667, 5142.897142057138, 5111.080005599028, 5114.820981265638, 5120.61595380348, 5122.820701275437, 5150.227465880148, 4113.938290925638, 4171.353440216772, 4209.326507758744, 4210.578942105765, 4247.023184667482, 3762.1535154589997, 3762.8494860205287, 3773.4339849022867, 3801.6578507933864, 3806.314863324573, 4486.035502367007, 4511.8646440606835, 4515.841945531891, 4518.525554816762, 4542.682012259176, 4926.802927882916, 5032.446430892599, 5035.370578677665, 5228.111221092423, 5295.602829787781, 4387.780610969438, 4458.2420988431395, 4480.395146655225, 4514.909701806011, 4520.570545798144, 4602.838900638461, 4603.194440972817, 4606.97696511522, 4607.654425918069, 4650.255959046536, 4726.26742854858, 4824.228123500364, 4825.95174048255, 4945.826896058621, 4948.950510494993, 5119.820806271762, 5207.192885102815, 5227.372715274191, 5229.13719236337, 5260.894782104413, 4918.4097908249805, 4944.035912996931, 4944.8763780905765, 4946.1591529439365, 4984.302197692398, 4855.393075865517, 4952.529509696573, 4971.676841005323, 5126.179811230185, 5144.717040562805, 5064.797408103635, 5138.434772174983, 5143.074246635641, 5143.871403214949, 5154.8969020620125, 4991.575716064175, 4998.750062496788, 5000.074524163171, 5019.598432125495, 5037.017781532566, 4794.95205047959, 4903.190973489334, 4904.092742842586, 4999.150144475375, 5008.223725322581, 4862.854114376574, 4932.334134891744, 4954.256861470808, 4960.057589058068, 4977.402711674622, 5003.699778013331, 5082.872928176826, 5086.0845047891735, 5089.236614507853, 5127.077126117335, 4718.032803275389, 4805.5915247204375, 4812.8796780080775, 4934.975325123495, 5001.299818025552], "mootools.html": [1193.188631730423, 1405.2130806748219, 1405.5642750747263, 1408.9718205635888, 1459.8759105476033, 5987.880242395149, 6926.584404935707, 7083.079199704031, 7089.042979197813, 7092.326229008236, 7148.74979375722, 7227.530210536312, 7254.202037775841, 7262.927370726291, 7300.379467745248, 1761.665283596119, 1785.410814431241, 2038.6024725178597, 2120.9045592948355, 2142.5393540388814, 2128.5849259394427, 2132.914683412662, 2135.1245989144454, 2136.423165745248, 2141.7429908411013, 2030.3705851186105, 2065.5972085443345, 2076.1384025629345, 2076.4497408186844, 2078.5011597216635, 1722.1561434896935, 1756.0429565886623, 2022.0496366707623, 2060.2274147194803, 2069.4102180878376, 2099.17082752312, 2107.104480595741, 2138.615049291127, 2140.9036593353335, 2143.8070573648447, 7317.085364329459, 7377.372923301526, 7383.556986580768, 7399.519031262951, 7414.332710056067, 4300.419443375167, 4392.758398288093, 4400.295952647593, 4428.911421771547, 4432.689711720181, 2855.52883774177, 2875.7843161762953, 2922.3570814420796, 2922.605448264478, 2962.303858593229, 920.2270093121809, 924.1405492891676, 956.4882787708542, 977.0864241933815, 986.1075726467558, 9862.260330475243, 9880.90119098807, 9884.110430061257, 9885.0, 9900.25748068905, 4072.3891416287793, 4083.305838007546, 4163.958360416417, 4212.726172798758, 4215.768132752728, 8220.753377398687, 8230.670773169126, 8250.958745206355, 8252.669893204205, 8275.54484503358, 4383.991681913114, 4387.188370151533, 4392.780360982002, 4402.3176407656865, 4404.977975110104, 3978.7214894957656, 3981.22366138606, 3981.6217459341315, 3984.242993831163, 3990.3016972029777, 3423.1099914022534, 3485.9825700871334, 3487.4245749451566, 3491.319192757439, 3519.542459480251, 1059.0627294844119, 1067.2422579968309, 1090.6182836007492, 1099.2250463423268, 1101.1741194104422, 943.698016634684, 1110.4281295133012, 1143.9428028598536, 1153.682737247247, 1153.9307641541534, 6704.83237919056, 6735.0, 6737.461003119739, 6753.594784312957, 6809.114815074107, 1017.211660962745, 1021.4841505039907, 1022.8261195596766, 1044.984325235122, 1063.3460421840512, 5366.087765079946, 5412.0, 5417.322834645669, 5426.321709786277, 5426.565874730012, 8701.30389568833, 8762.86855697165, 8931.910680893237, 9062.728118156467, 9065.68270110543, 8846.292296616255, 8849.734507964771, 8869.467831930106, 8933.0, 8944.329175311877, 6643.701033453506, 6753.729850806011, 6797.796066118024, 6802.183737951477, 6817.761378351734, 6367.140436041075, 6368.936310637019, 6392.808215753535, 6394.840128996812, 6402.679866006588, 7598.278163574451, 7612.543247405173, 7685.03937007874, 7760.650770715444, 7821.139674635671, 7847.215278472336, 8010.599470026359, 8091.06952700447, 8094.069182044141, 8098.190180981855, 6035.788747393995, 6070.817875463743, 6071.514278857592, 6074.544409169242, 6090.390960903874, 6958.582485050913, 7154.785356439315, 7167.354938055391, 7169.713211471482, 7217.206107328085, 6508.316626754312, 6520.967395162994, 6606.537542371988, 6624.4700423965005, 6655.833604159935, 5223.608229382736, 6387.361263873576, 6570.5400621957915, 6637.1703537057865, 6685.09751183584, 6464.256610489854, 6490.415862572202, 6491.578047426902, 6496.675166241764, 6499.447546958561, 6117.051856962178, 6142.846428839136, 6178.69106544662, 6185.907211391923, 6200.782972596118, 6134.631922084689, 6154.630722156685, 6162.784302549389, 6222.81331560054, 6247.625142491465], "ext.html": [552.4806681719184, 560.2324815003444, 563.6697394149809, 569.3054473542279, 577.936426993031, 28348.716512834864, 37055.0, 37763.433548496796, 37776.622233777656, 37787.81106094466, 40089.0, 40556.79721601388, 40559.79720101396, 40573.59426405742, 40587.188256234935, 6946.3053694630635, 7036.226015138356, 7903.683852645887, 8064.556449395281, 8066.032076150841, 10185.33795303303, 10446.843297350508, 10454.738631534234, 10455.73860653486, 10462.633807816728, 10168.491575421236, 10218.029287217703, 10262.640807571737, 10273.178145748323, 10286.897131028707, 7190.101237345306, 7389.334959853585, 10104.696859094201, 10234.02776736209, 10472.68581942543, 9958.70123896277, 10046.296759226858, 10055.296129270953, 10056.597736090547, 10095.596176152945, 37649.24701505955, 38045.23909521794, 38105.42841857374, 38144.237115257536, 38145.61854381448, 2767.52859397795, 2768.7784977201777, 3354.815485148316, 3563.7883119739154, 3577.767445116059, 28273.717262827315, 28658.844467552088, 28747.55029396465, 28839.279018024507, 29130.0, 3097.752179825631, 3111.766617503696, 3136.921576960571, 3137.1843320736543, 3169.3185965017633, 225773.0, 226521.0, 226637.86681066654, 226665.0, 227039.0, 50998.74500627473, 52578.73710631422, 55531.0, 57267.71366143226, 57313.71343143341, 55770.0, 56080.43919560752, 56260.43739562634, 56732.71633641805, 56842.0, 13442.462301508025, 13570.185788852701, 13591.0, 13596.66008349799, 13605.115667481581, 10148.441835699108, 10159.542820573091, 10185.898141018642, 10416.114630256514, 10420.531076101593, 18819.153138108817, 18970.33603823887, 19023.714644280346, 19029.714554281698, 19052.0, 7137.643117844087, 7386.409087273005, 7459.776206713807, 7467.775966721007, 7497.587632680146, 747.9102507699002, 789.4907784478979, 1015.3400289811682, 1039.4023436524028, 1050.8686414198226, 26464.0, 26540.0, 26704.465910681676, 26762.330941726614, 26781.19656410272, 881.3610132653903, 882.8763973043779, 892.7321803459066, 896.9237614802685, 931.1433481197315, 13807.792883106762, 13822.447102115802, 13947.511837085653, 13967.301634918213, 14056.22690751998, 269899.0, 273643.0, 274706.0, 275034.0, 275110.0, 45453.0, 45704.54295457003, 45801.54198458039, 45890.311645325346, 45904.540954590026, 1105.3202280597536, 1111.4053981120223, 1115.1580556679817, 1116.609186784635, 1121.7812526557243, 24447.144349947666, 25153.87423062873, 25613.61579576345, 25742.485150297263, 26368.472630547665, 41369.586304137774, 41454.792726036176, 41469.79265103655, 41735.7913210432, 41805.0, 213041.0, 218581.0, 331283.0, 341479.6334164919, 342964.0, 27363.442752442053, 27460.17619471419, 27486.0, 27495.0, 27568.310792229553, 37638.0, 38111.61888381081, 38354.232915342094, 38412.23175536418, 38542.0, 31028.379432411675, 32353.676463235068, 32913.506297406035, 33086.338273234884, 33681.0, 32902.67097328996, 32916.0, 32977.175570610925, 33114.33771324512, 33125.668743313225, 32088.197795055312, 33087.69859918195, 33090.0, 33144.50283245801, 33155.50266746049, 27561.310967225178, 29679.703202967696, 29976.550351745176, 30071.548926765678, 30219.848900755354, 21937.890310548344, 22273.331800045376, 22288.554228915655, 23433.531329372978, 23443.04429195259], "prototype.html": [297.663640086702, 302.9803062800918, 307.47728860936405, 307.6784759925876, 308.911960091374, 5467.425920278368, 5479.4794494523, 5525.889482210353, 5527.917081243784, 5567.832965011046, 5417.26866872973, 5433.918491222625, 5448.37343705474, 5449.945500544994, 5453.972730136344, 3970.463987361698, 4187.33002719565, 4192.853250136246, 4198.559151289117, 4201.558836322196, 4048.271311163989, 4077.1641813428178, 4189.581041895816, 4200.285951388271, 4203.495580530341, 4145.108801607654, 4151.626353628173, 4153.107081977374, 4157.127003329289, 4158.521769996459, 3927.8232479538206, 4010.197960407901, 4036.636702696742, 4158.168366326731, 4164.895877603054, 3641.635836416364, 3653.0, 3660.5607327120915, 3661.4324779659196, 3662.7619204751604, 5232.136697444917, 5239.1093514102695, 5242.318498595197, 5245.921311180336, 5253.6322457428, 4818.59041981432, 4820.301056346845, 4822.397200349957, 4831.516848315176, 4833.32333473314, 5571.860703482445, 5706.514946229576, 5708.457696518824, 5721.370649228582, 5732.082866741302, 3983.3029219886403, 3986.6412022918075, 3989.8005099744896, 3989.900252493711, 3991.3214753491975, 6019.578629495937, 6027.126066720345, 6031.939680603182, 6032.42691944269, 6033.9396606033815, 4124.649404800625, 4125.422440858282, 4134.069834287321, 4137.606927341898, 4138.089620283533, 4065.5324637667045, 4068.4100805383646, 4081.673466122703, 4180.581941805795, 4191.497020357516, 4687.414073240845, 4698.85903422891, 4701.623870090384, 4705.6470764692785, 4711.599514041276, 5722.399148089391, 5731.168980497888, 5737.942620573825, 5738.139279108167, 5742.598018138774, 1454.163855782929, 1473.5358362116115, 1474.3439169569438, 1475.5499572630235, 1476.0331982551445, 1002.178213864624, 1006.959721611142, 1011.6964910526813, 1021.1065317846884, 1031.886492485826, 5031.4465408805, 5050.621203409685, 5054.241863720398, 5054.848354549369, 5059.848204553869, 5962.4633782959745, 5975.0, 5976.491998180203, 5976.880462390728, 5978.940210597838, 5042.319286896295, 5053.0399224147295, 5053.7473126344275, 5061.417936937226, 5062.519060689228, 2999.79001469895, 3021.531662592302, 3103.7672174586996, 3191.0586377018835, 3233.1755402372246, 5609.971950140223, 5650.29371328584, 5663.575231857627, 5667.829965101054, 5673.914891276634, 6105.206323178048, 6139.815805525842, 6148.538859585549, 6162.938370616236, 6167.0, 5520.254765606592, 5611.999999999918, 5625.296837895263, 5633.521150702154, 5638.746256418471, 5978.222831031938, 5986.700664966821, 5990.940090599038, 5992.131140984446, 6001.129836173817, 5821.650700957956, 5825.70871456417, 5827.6794776286015, 5828.854278643068, 5833.008388573868, 5637.46444087811, 5641.351244606923, 5643.746031428514, 5649.378568357395, 5650.378458369494, 3880.2821478026653, 4027.2146931348107, 4027.375756757707, 4027.4361589378095, 4038.151988082418, 5954.821355359346, 5969.671668058125, 5971.701414929149, 5974.044152935509, 5978.880422391615, 5731.283589551306, 5735.483806457439, 5737.540996720336, 5738.8278351649515, 5748.310202775694, 5585.659441734036, 5676.460736230051, 5713.457221563945, 5748.655080695172, 5772.336181339032, 5679.971600141973, 5683.374828768915, 5694.686792226467, 5697.173909783141, 5697.202391665087, 5825.0388685866355, 5825.155352473783, 5831.067029275296, 5833.504152146946, 5843.883122337615, 5533.170024496358, 5679.204911312337, 5679.545636349165, 5685.346185188756, 5694.772209111755], "yui.html": [692.871818713538, 722.8951801988709, 767.4742801181189, 793.9761807145787, 794.245466806534, 11506.539738410464, 11699.590514332, 11722.413879306043, 11724.941375293121, 11761.176717629769, 11703.882961170386, 11787.057035437167, 11803.291802491856, 11819.940900295507, 11823.467943942522, 613.2579578709766, 621.925368955726, 788.1330536409932, 790.4427378698033, 805.287320721163, 797.3621103117512, 799.312591171592, 799.3924617290843, 800.671724592917, 804.7625950344633, 640.3052687833683, 831.787894087007, 839.7690635075342, 839.8026463781007, 839.9668407858308, 634.0330995232262, 819.6270696832927, 842.5029232752705, 843.4770442325736, 843.6161546496329, 618.9876202475971, 621.183144165421, 622.2253294648146, 622.7695752571532, 622.844288927768, 11219.663410097628, 11256.0, 11319.377434241114, 11324.716882077932, 11356.148288878367, 10883.564657413694, 11562.190646654737, 11705.3562054087, 11762.353070581115, 11980.880191198064, 9572.425654460685, 9580.233581313478, 9642.75893102671, 9657.613695452173, 9858.0, 2762.654668166479, 2838.3188034871687, 2854.200823769348, 2858.6712528059334, 2862.885484580635, 38495.807520962495, 38654.0, 39014.0, 39016.21967560633, 39068.60931390678, 6548.083268342436, 6637.46900247979, 6743.494237932175, 6780.9150535915005, 6817.7954661359245, 10125.240606954361, 10163.18694504438, 10168.33905796121, 10186.337888037255, 10214.693559193236, 5396.83809485716, 5505.697186654773, 5609.551235901118, 5754.971225143848, 5775.624584402, 3552.5381700378784, 3617.1763460828047, 3688.7602305850032, 3705.2033812729856, 3706.3513885070006, 2502.4869901670113, 2527.2544599343237, 2529.709083455389, 2533.429978254878, 2535.4802265535523, 382.54286128076683, 385.1430566988428, 386.44738024624496, 386.65973942930043, 386.7389512079335, 461.1952143509597, 554.0856341340658, 598.8353202869246, 604.5707547641136, 617.6123960078963, 7772.417068719868, 7776.222377762291, 7794.493357931717, 7964.641591128413, 7974.051896207585, 497.2144012460304, 607.6536374266626, 633.6736580660963, 645.5255387290338, 651.3031056769212, 3549.6627820357025, 3576.570811502584, 3594.4069228577514, 3609.1157666371905, 3738.8504459821847, 48295.27557086646, 48852.0, 48870.26694599584, 48909.0, 49222.261666075035, 44508.0, 44863.327050094274, 44923.10153796906, 45573.77213113913, 45623.771881141045, 40982.79508602438, 41568.0, 41717.165656686695, 41761.58238417577, 41869.371959420634, 7178.928210718035, 7321.524100933422, 7389.630518473948, 7444.181140074696, 7624.69501219945, 32541.34917301688, 32995.67004330022, 33029.834850825595, 33208.1697957553, 33279.50080748839, 37972.43041354327, 40677.389839151845, 40745.0, 40864.70920553299, 41559.376609351486, 6203.131561581292, 6204.472619827366, 6260.467860231931, 6270.655113968775, 6325.367463253638, 10162.74593135148, 10484.737881553023, 10501.212409069503, 10523.368597884151, 10579.682609521727, 9547.236221102155, 9641.903580964101, 9677.612895484102, 9680.5643746033, 10112.24158188124, 9498.905010950079, 9618.951905240709, 9695.321327507007, 9722.319437639297, 10101.292909496558, 9326.114019168168, 9418.387804792941, 9429.764255893657, 9444.102810233016, 9772.9022709772, 8580.14198580137, 8624.913750862412, 8666.393352465268, 8703.129687031245, 8899.0, 8443.83112337762, 8647.913520864711, 8667.696630617898, 8863.157999989991, 8921.598528066123]}, "summary": {"lowerIsBetter": false, "suite": 6066.202712080917, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6431.305155017568, "unit": "ms", "value": 6431.305155017568}, "dojo.html": {"lowerIsBetter": false, "filtered": 4706.874079139713, "unit": "ms", "value": 4706.874079139713}, "mootools.html": {"lowerIsBetter": false, "filtered": 4157.431482041895, "unit": "ms", "value": 4157.431482041895}, "ext.html": {"lowerIsBetter": false, "filtered": 17194.652894752875, "unit": "ms", "value": 17194.652894752875}, "prototype.html": {"lowerIsBetter": false, "filtered": 4295.465807262514, "unit": "ms", "value": 4295.465807262514}, "yui.html": {"lowerIsBetter": false, "filtered": 5360.421787260754, "unit": "ms", "value": 5360.421787260754}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447450240, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113130131", "branch": "Fx-Team-Non-PGO", "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 163.0, 160.0, 160.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0], "ai-astar": [110.0, 113.0, 107.0, 111.0, 113.0, 112.0, 100.0, 112.0, 103.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "audio-beat-detection": [154.0, 144.0, 154.0, 173.0, 130.0, 156.0, 152.0, 130.0, 168.0, 134.0], "json-stringify-tinderbox": [69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [143.0, 144.0, 145.0, 138.0, 147.0, 145.0, 156.0, 145.0, 134.0, 133.0], "json-parse-financial": [71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 79.0, 69.0, 68.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 71.0, 70.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0], "audio-fft": [74.0, 72.0, 88.0, 92.0, 73.0, 73.0, 73.0, 114.0, 92.0, 72.0], "imaging-darkroom": [148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0], "stanford-crypto-ccm": [124.0, 124.0, 121.0, 126.0, 123.0, 118.0, 127.0, 120.0, 127.0, 124.0], "audio-oscillator": [90.0, 91.0, 126.0, 91.0, 91.0, 91.0, 133.0, 91.0, 91.0, 134.0], "stanford-crypto-aes": [92.0, 92.0, 84.0, 84.0, 90.0, 83.0, 82.0, 93.0, 86.0, 83.0], "imaging-desaturate": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1520.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.3, "unit": "ms", "value": 82.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 143.0, "unit": "ms", "value": 143.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 149.5, "unit": "ms", "value": 149.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.4, "unit": "ms", "value": 123.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 148.7, "unit": "ms", "value": 148.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.9, "unit": "ms", "value": 102.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.5, "unit": "ms", "value": 161.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.4, "unit": "ms", "value": 68.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.1, "unit": "ms", "value": 68.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.9, "unit": "ms", "value": 86.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447450240, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113130131", "branch": "Fx-Team-Non-PGO", "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.38755980861245], "Encrypt": [279.09572983533354], "NavierStokes": [4817.307692307692], "Decrypt": [5035.175879396985], "Splay": [625.3908692933084], "Richards": [165.28925619834712], "RegExp": [25974.358974358973], "Earley": [801.924619085806], "Boyer": [11952.380952380952], "RayTrace": [1992.03187250996]}, "summary": {"lowerIsBetter": false, "suite": 19821.491008374036, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.4665499999999, "unit": "score", "value": 345.4665499999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 953.7265229999995, "unit": "score", "value": 953.7265229999995}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 130.30410899999995, "unit": "score", "value": 130.30410899999995}, "RegExp": {"lowerIsBetter": false, "filtered": 35.072472852912156, "unit": "score", "value": 35.072472852912156}, "Richards": {"lowerIsBetter": false, "filtered": 213.5771000000001, "unit": "score", "value": 213.5771000000001}, "Earley": {"lowerIsBetter": false, "filtered": 831.079361, "unit": "score", "value": 831.079361}, "Boyer": {"lowerIsBetter": false, "filtered": 55.75985258964142, "unit": "score", "value": 55.75985258964142}, "RayTrace": {"lowerIsBetter": false, "filtered": 371.474478, "unit": "score", "value": 371.474478}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447450240, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113130131", "branch": "Fx-Team-Non-PGO", "revision": "697fb66c4494f8df72f4e8e5e97d7b842e0a0cfe"}}] 13:50:57 INFO - RETURN: dromaeo_css: 6066.20 13:50:57 INFO - RETURN: kraken: 1520.10 13:50:57 INFO - RETURN: v8_7: 19821.49 13:50:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19821.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6066.20"}}} 13:50:57 INFO - Return code: 0 13:50:57 INFO - # TBPL SUCCESS # 13:50:57 INFO - Running post-action listener: _resource_record_post_action 13:50:57 INFO - Running post-run listener: _resource_record_post_run 13:50:58 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 514138112; Read time: 0; Write time: 408868 13:50:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 170090496; Read time: 0; Write time: 184376 13:50:58 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 344047616; Read time: 0; Write time: 224492 13:50:58 INFO - Running post-run listener: _upload_blobber_files 13:50:58 INFO - Blob upload gear active. 13:50:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:50:58 INFO - Copying logs to upload dir... 13:50:58 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1258.297643 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-13 13:50:58.100402) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 13:50:58.104402) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009939 build_url: 'https://queue.taskcluster.net/v1/task/Az2MuzwLSAaUxJANr0rRFw/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-13 13:50:58.156825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:50:58.157186) ========= 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=d6a7e047ef025f707024e163000001c3-1447450197.823275-1418373597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 13:50:58.206909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 13:50:58.207260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 13:50:58.207613) ========= ========= Total master_lag: 0.24 =========