builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1448308164.07 results: success (0) buildid: 20151123050554 builduid: 1951b743c8f04fd2b9d29c2608cfd14d revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.074163) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.074515) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.074812) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009128 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.111233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.111503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.230249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.230499) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.333305) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.333567) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.333899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.334182) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 11:49:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-11-23 11:49:24 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.559679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.559955) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017246 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.612532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:24.612842) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 11:49:24,810 truncating revision to first 12 chars 2015-11-23 11:49:24,810 Setting DEBUG logging. 2015-11-23 11:49:24,810 attempt 1/10 2015-11-23 11:49:24,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 11:49:25,041 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.140368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.140641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.150710) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.150982) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 11:49:25.151363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-23 11:49:25.151660) ========= /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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:25 INFO - MultiFileLogger online at 20151123 11:49:25 in /builds/slave/test 11:49:25 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 11:49:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:25 INFO - {'append_to_log': False, 11:49:25 INFO - 'base_work_dir': '/builds/slave/test', 11:49:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:25 INFO - 'branch': 'Fx-Team-Non-PGO', 11:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:25 INFO - 'config_files': ('talos/linux_config.py',), 11:49:25 INFO - 'default_actions': ('clobber', 11:49:25 INFO - 'read-buildbot-config', 11:49:25 INFO - 'download-and-extract', 11:49:25 INFO - 'populate-webroot', 11:49:25 INFO - 'create-virtualenv', 11:49:25 INFO - 'install', 11:49:25 INFO - 'run-tests'), 11:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:25 INFO - 'download_minidump_stackwalk': True, 11:49:25 INFO - 'download_symbols': 'ondemand', 11:49:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:25 INFO - 'installer_path': 'installer.exe', 11:49:25 INFO - 'log_level': 'info', 11:49:25 INFO - 'log_name': 'talos', 11:49:25 INFO - 'log_to_console': True, 11:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:25 INFO - 'opt_config_files': (), 11:49:25 INFO - 'pip_index': False, 11:49:25 INFO - 'sps_profile': False, 11:49:25 INFO - 'sps_profile_interval': 0, 11:49:25 INFO - 'suite': 'dromaeojs', 11:49:25 INFO - 'system_bits': '64', 11:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:25 INFO - 'title': 'talos-linux64-ix-005', 11:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:25 INFO - 'use_talos_json': True, 11:49:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:25 INFO - 'work_dir': 'build'} 11:49:25 INFO - ##### 11:49:25 INFO - ##### Running clobber step. 11:49:25 INFO - ##### 11:49:25 INFO - Running pre-action listener: _resource_record_pre_action 11:49:25 INFO - Running main action method: clobber 11:49:25 INFO - rmtree: /builds/slave/test/build 11:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:25 INFO - Running post-action listener: _resource_record_post_action 11:49:25 INFO - ##### 11:49:25 INFO - ##### Running read-buildbot-config step. 11:49:25 INFO - ##### 11:49:25 INFO - Running pre-action listener: _resource_record_pre_action 11:49:25 INFO - Running main action method: read_buildbot_config 11:49:25 INFO - Using buildbot properties: 11:49:25 INFO - { 11:49:25 INFO - "properties": { 11:49:25 INFO - "buildnumber": 1120, 11:49:25 INFO - "product": "firefox", 11:49:25 INFO - "script_repo_revision": "production", 11:49:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:49:25 INFO - "repository": "", 11:49:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:49:25 INFO - "buildid": "20151123050554", 11:49:25 INFO - "slavename": "talos-linux64-ix-005", 11:49:25 INFO - "pgo_build": "False", 11:49:25 INFO - "basedir": "/builds/slave/test", 11:49:25 INFO - "project": "", 11:49:25 INFO - "platform": "ubuntu64_hw", 11:49:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:49:25 INFO - "slavebuilddir": "test", 11:49:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:49:25 INFO - "branch": "fx-team", 11:49:25 INFO - "repo_path": "integration/fx-team", 11:49:25 INFO - "stage_platform": "linux64", 11:49:25 INFO - "builduid": "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:25 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:25 INFO - }, 11:49:25 INFO - "sourcestamp": { 11:49:25 INFO - "repository": "", 11:49:25 INFO - "hasPatch": false, 11:49:25 INFO - "project": "", 11:49:25 INFO - "branch": "fx-team-linux64-talos", 11:49:25 INFO - "changes": [ 11:49:25 INFO - { 11:49:25 INFO - "category": null, 11:49:25 INFO - "files": [ 11:49:25 INFO - { 11:49:25 INFO - "url": null, 11:49:25 INFO - "name": "https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:49:25 INFO - } 11:49:25 INFO - ], 11:49:25 INFO - "repository": "", 11:49:25 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 11:49:25 INFO - "who": "pbrosset@mozilla.com", 11:49:25 INFO - "when": 1448285946, 11:49:25 INFO - "number": 6694867, 11:49:25 INFO - "comments": "Bug 1198073 - Introduce a pref to set the max length of attributes or not truncat them; r=pbro", 11:49:25 INFO - "project": "", 11:49:25 INFO - "at": "Mon 23 Nov 2015 05:39:06", 11:49:25 INFO - "branch": "fx-team-linux64-talos", 11:49:25 INFO - "revlink": "", 11:49:25 INFO - "properties": [ 11:49:25 INFO - [ 11:49:25 INFO - "buildid", 11:49:25 INFO - "20151123050554", 11:49:25 INFO - "Change" 11:49:25 INFO - ], 11:49:25 INFO - [ 11:49:25 INFO - "builduid", 11:49:25 INFO - "1951b743c8f04fd2b9d29c2608cfd14d", 11:49:25 INFO - "Change" 11:49:25 INFO - ], 11:49:25 INFO - [ 11:49:25 INFO - "pgo_build", 11:49:25 INFO - "False", 11:49:25 INFO - "Change" 11:49:25 INFO - ] 11:49:25 INFO - ], 11:49:25 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:25 INFO - } 11:49:25 INFO - ], 11:49:25 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 11:49:25 INFO - } 11:49:25 INFO - } 11:49:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:49:25 INFO - Running post-action listener: _resource_record_post_action 11:49:25 INFO - ##### 11:49:25 INFO - ##### Running download-and-extract step. 11:49:25 INFO - ##### 11:49:25 INFO - Running pre-action listener: _resource_record_pre_action 11:49:25 INFO - Running main action method: download_and_extract 11:49:25 INFO - mkdir: /builds/slave/test/build/tests 11:49: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')]} 11:49:25 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json 11:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:49:29 INFO - Downloaded 1302 bytes. 11:49:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:49:29 INFO - Using the following test package requirements: 11:49:29 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:29 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:49:29 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'jsshell-linux-x86_64.zip'], 11:49:29 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:49:29 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:29 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:49:29 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:49:29 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:49:29 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:49:29 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:49:29 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:49:29 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:29 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:33 INFO - Downloaded 21339409 bytes. 11:49:33 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 11:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:33 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 11:49:34 INFO - Return code: 0 11:49:34 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 11:49:34 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')]} 11:49:34 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:49:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:38 INFO - Downloaded 21339409 bytes. 11:49:38 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 11:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:49:38 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 11:49:39 INFO - Return code: 0 11:49: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')]} 11:49:39 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:40 INFO - Downloaded 11130997 bytes. 11:49:40 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 11:49:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:40 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 11:49:40 INFO - Return code: 0 11:49:40 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')]} 11:49:40 INFO - https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gewOLAYdT8SnmmRBdBc0dA/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 11:49:42 INFO - Downloaded 55911868 bytes. 11:49:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:42 INFO - mkdir: /builds/slave/test/properties 11:49:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:42 INFO - Contents: 11:49:42 INFO - build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:49:42 INFO - Running post-action listener: _resource_record_post_action 11:49:42 INFO - Running post-action listener: set_extra_try_arguments 11:49:42 INFO - ##### 11:49:42 INFO - ##### Running populate-webroot step. 11:49:42 INFO - ##### 11:49:42 INFO - Running pre-action listener: _resource_record_pre_action 11:49:42 INFO - Running main action method: populate_webroot 11:49:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:49:42 INFO - '../fennec_ids.txt'], 11:49:42 INFO - 'tests': ['tcheck2']}, 11:49:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:42 INFO - '--tppagecycles', 11:49:42 INFO - '7'], 11:49:42 INFO - 'tests': ['tsvgm']}}, 11:49:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:49:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:49:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['damp', 'tps']}, 11:49:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['damp', 'tps']}, 11:49:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:49:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:42 INFO - 'other': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'other_l64': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'other_nol64': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore']}, 11:49:42 INFO - 'svgr': {'tests': ['tsvgx', 11:49:42 INFO - 'tsvgr_opacity', 11:49:42 INFO - 'tart', 11:49:42 INFO - 'tscrollx', 11:49:42 INFO - 'cart']}, 11:49:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['tsvgx', 11:49:42 INFO - 'tsvgr_opacity', 11:49:42 INFO - 'tart', 11:49:42 INFO - 'tscrollx', 11:49:42 INFO - 'cart']}, 11:49:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['tp5o']}, 11:49:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--e10s'], 11:49:42 INFO - 'tests': ['tp5o']}, 11:49:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--xperf_path', 11:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:42 INFO - 'tests': ['tp5n']}, 11:49:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--e10s', 11:49:42 INFO - '--xperf_path', 11:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:42 INFO - 'tests': ['tp5n']}}, 11:49:42 INFO - 'talos.zip': {'path': '', 11:49:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:42 INFO - Running post-action listener: _resource_record_post_action 11:49:42 INFO - ##### 11:49:42 INFO - ##### Running create-virtualenv step. 11:49:42 INFO - ##### 11:49:42 INFO - Running pre-action listener: _resource_record_pre_action 11:49:42 INFO - Running main action method: create_virtualenv 11:49:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:42 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 11:49:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:42 INFO - Using real prefix '/usr' 11:49:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:44 INFO - Installing pip.................done. 11:49:44 INFO - Return code: 0 11:49:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:44 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:44 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 11:49:44 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 11:49:44 INFO - Using env: {'DISPLAY': ':0', 11:49:44 INFO - 'HOME': '/home/cltbld', 11:49:44 INFO - 'LANG': 'en_US.UTF-8', 11:49:44 INFO - 'LANGUAGE': 'en_US:en', 11:49:44 INFO - 'LOGNAME': 'cltbld', 11:49:44 INFO - 'MAIL': '/var/mail/cltbld', 11:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:44 INFO - 'MOZ_NO_REMOTE': '1', 11:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:44 INFO - 'NO_EM_RESTART': '1', 11:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:44 INFO - 'PWD': '/builds/slave/test', 11:49:44 INFO - 'SHELL': '/bin/bash', 11:49:44 INFO - 'SHLVL': '1', 11:49:44 INFO - 'TERM': 'linux', 11:49:44 INFO - 'TMOUT': '86400', 11:49:44 INFO - 'USER': 'cltbld', 11:49:44 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:44 INFO - '_': '/tools/buildbot/bin/python'} 11:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:44 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 11:49:44 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:45 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 11:49:45 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 11:49:45 INFO - Using env: {'DISPLAY': ':0', 11:49:45 INFO - 'HOME': '/home/cltbld', 11:49:45 INFO - 'LANG': 'en_US.UTF-8', 11:49:45 INFO - 'LANGUAGE': 'en_US:en', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MAIL': '/var/mail/cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SHLVL': '1', 11:49:45 INFO - 'TERM': 'linux', 11:49:45 INFO - 'TMOUT': '86400', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - '_': '/tools/buildbot/bin/python'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Downloading/unpacking psutil>=0.7.1 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:49:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:47 INFO - Installing collected packages: psutil 11:49:47 INFO - Running setup.py install for psutil 11:49:47 INFO - building 'psutil._psutil_linux' extension 11:49:47 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 11:49:47 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 11:49:47 INFO - building 'psutil._psutil_posix' extension 11:49:47 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 11:49:47 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 11:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:47 INFO - Successfully installed psutil 11:49:47 INFO - Cleaning up... 11:49:47 INFO - Return code: 0 11:49:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:47 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')]} 11:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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')]} 11:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:47 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:47 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 11:49:47 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 11:49:47 INFO - Using env: {'DISPLAY': ':0', 11:49:47 INFO - 'HOME': '/home/cltbld', 11:49:47 INFO - 'LANG': 'en_US.UTF-8', 11:49:47 INFO - 'LANGUAGE': 'en_US:en', 11:49:47 INFO - 'LOGNAME': 'cltbld', 11:49:47 INFO - 'MAIL': '/var/mail/cltbld', 11:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:47 INFO - 'MOZ_NO_REMOTE': '1', 11:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:47 INFO - 'NO_EM_RESTART': '1', 11:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:47 INFO - 'PWD': '/builds/slave/test', 11:49:47 INFO - 'SHELL': '/bin/bash', 11:49:47 INFO - 'SHLVL': '1', 11:49:47 INFO - 'TERM': 'linux', 11:49:47 INFO - 'TMOUT': '86400', 11:49:47 INFO - 'USER': 'cltbld', 11:49:47 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:47 INFO - '_': '/tools/buildbot/bin/python'} 11:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:49 INFO - Installing collected packages: mozsystemmonitor 11:49:49 INFO - Running setup.py install for mozsystemmonitor 11:49:49 INFO - Successfully installed mozsystemmonitor 11:49:49 INFO - Cleaning up... 11:49:49 INFO - Return code: 0 11:49:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:49 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')]} 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:49 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')]} 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:49 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:49 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 11:49:49 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 11:49:49 INFO - Using env: {'DISPLAY': ':0', 11:49:49 INFO - 'HOME': '/home/cltbld', 11:49:49 INFO - 'LANG': 'en_US.UTF-8', 11:49:49 INFO - 'LANGUAGE': 'en_US:en', 11:49:49 INFO - 'LOGNAME': 'cltbld', 11:49:49 INFO - 'MAIL': '/var/mail/cltbld', 11:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:49 INFO - 'MOZ_NO_REMOTE': '1', 11:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:49 INFO - 'NO_EM_RESTART': '1', 11:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:49 INFO - 'PWD': '/builds/slave/test', 11:49:49 INFO - 'SHELL': '/bin/bash', 11:49:49 INFO - 'SHLVL': '1', 11:49:49 INFO - 'TERM': 'linux', 11:49:49 INFO - 'TMOUT': '86400', 11:49:49 INFO - 'USER': 'cltbld', 11:49:49 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:49 INFO - '_': '/tools/buildbot/bin/python'} 11:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:51 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:52 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 11:49:52 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 11:49:52 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 11:49:52 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 11:49:52 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 11:49:52 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 11:49:52 INFO - Downloading docopt-0.6.1.tar.gz 11:49:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:52 INFO - Running setup.py install for blobuploader 11:49:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:52 INFO - Running setup.py install for requests 11:49:52 INFO - Running setup.py install for docopt 11:49:52 INFO - Successfully installed blobuploader requests docopt 11:49:52 INFO - Cleaning up... 11:49:52 INFO - Return code: 0 11:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:52 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')]} 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 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')]} 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:52 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:52 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 11:49:52 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 11:49:52 INFO - Using env: {'DISPLAY': ':0', 11:49:52 INFO - 'HOME': '/home/cltbld', 11:49:52 INFO - 'LANG': 'en_US.UTF-8', 11:49:52 INFO - 'LANGUAGE': 'en_US:en', 11:49:52 INFO - 'LOGNAME': 'cltbld', 11:49:52 INFO - 'MAIL': '/var/mail/cltbld', 11:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:52 INFO - 'MOZ_NO_REMOTE': '1', 11:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:52 INFO - 'NO_EM_RESTART': '1', 11:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:52 INFO - 'PWD': '/builds/slave/test', 11:49:52 INFO - 'SHELL': '/bin/bash', 11:49:52 INFO - 'SHLVL': '1', 11:49:52 INFO - 'TERM': 'linux', 11:49:52 INFO - 'TMOUT': '86400', 11:49:52 INFO - 'USER': 'cltbld', 11:49:52 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:52 INFO - '_': '/tools/buildbot/bin/python'} 11:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:53 INFO - Running setup.py (path:/tmp/pip-PeZftl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:53 INFO - Running setup.py (path:/tmp/pip-gl3xDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:53 INFO - Running setup.py (path:/tmp/pip-OrZ_j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:53 INFO - Running setup.py (path:/tmp/pip-pjqzig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:53 INFO - Running setup.py (path:/tmp/pip-N14T1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 INFO - Running setup.py (path:/tmp/pip-JgBMYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 INFO - Running setup.py (path:/tmp/pip-0Kgmm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 INFO - Running setup.py (path:/tmp/pip-6r4v5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:53 INFO - Running setup.py (path:/tmp/pip-kniUrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Running setup.py (path:/tmp/pip-Nytu_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Running setup.py (path:/tmp/pip-C6I9lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:53 INFO - Running setup.py (path:/tmp/pip-YnguUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:54 INFO - Running setup.py (path:/tmp/pip-IjYXpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:54 INFO - Running setup.py (path:/tmp/pip-7i1rBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:54 INFO - Running setup.py (path:/tmp/pip-LOwInW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:54 INFO - Running setup.py (path:/tmp/pip-IJrvir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:54 INFO - Running setup.py (path:/tmp/pip-FBpMM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:54 INFO - Running setup.py install for manifestparser 11:49:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Running setup.py install for mozcrash 11:49:54 INFO - Running setup.py install for mozdebug 11:49:54 INFO - Running setup.py install for mozdevice 11:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Running setup.py install for mozfile 11:49:54 INFO - Running setup.py install for mozhttpd 11:49:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozinfo 11:49:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozInstall 11:49:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozleak 11:49:55 INFO - Running setup.py install for mozlog 11:49:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for moznetwork 11:49:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozprocess 11:49:55 INFO - Running setup.py install for mozprofile 11:49:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozrunner 11:49:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozscreenshot 11:49:55 INFO - Running setup.py install for moztest 11:49:56 INFO - Running setup.py install for mozversion 11:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:56 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 11:49:56 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 11:49:56 INFO - Using env: {'DISPLAY': ':0', 11:49:56 INFO - 'HOME': '/home/cltbld', 11:49:56 INFO - 'LANG': 'en_US.UTF-8', 11:49:56 INFO - 'LANGUAGE': 'en_US:en', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MAIL': '/var/mail/cltbld', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SHLVL': '1', 11:49:56 INFO - 'TERM': 'linux', 11:49:56 INFO - 'TMOUT': '86400', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:56 INFO - Running setup.py (path:/tmp/pip-UE0PrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:56 INFO - Running setup.py (path:/tmp/pip-qVK6p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:56 INFO - Running setup.py (path:/tmp/pip-H0FVvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:56 INFO - Running setup.py (path:/tmp/pip-50Oedz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:56 INFO - Running setup.py (path:/tmp/pip-NrmIo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:56 INFO - Running setup.py (path:/tmp/pip-i51QZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:56 INFO - Running setup.py (path:/tmp/pip-ejBqEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:56 INFO - Running setup.py (path:/tmp/pip-PQz2uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:56 INFO - Running setup.py (path:/tmp/pip-KtmUHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:57 INFO - Running setup.py (path:/tmp/pip-lyIwh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:57 INFO - Running setup.py (path:/tmp/pip-EpGN4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:57 INFO - Running setup.py (path:/tmp/pip-cdZfvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:57 INFO - Running setup.py (path:/tmp/pip-2JCM0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:57 INFO - Running setup.py (path:/tmp/pip-F0I14l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:57 INFO - Running setup.py (path:/tmp/pip-gSK0P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:57 INFO - Running setup.py (path:/tmp/pip-uY35IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:57 INFO - Running setup.py (path:/tmp/pip-so83td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:57 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)) 11:49:57 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)) 11:49:57 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)) 11:49:57 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)) 11:49:57 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)) 11:49:57 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)) 11:49:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:57 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 11:49:59 INFO - Downloading blessings-1.5.1.tar.gz 11:49:59 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 11:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:59 INFO - Installing collected packages: blessings 11:49:59 INFO - Running setup.py install for blessings 11:49:59 INFO - Successfully installed blessings 11:49:59 INFO - Cleaning up... 11:49:59 INFO - Return code: 0 11:49:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:59 INFO - Reading from file tmpfile_stdout 11:49:59 INFO - Current package versions: 11:49:59 INFO - argparse == 1.2.1 11:49:59 INFO - blessings == 1.5.1 11:49:59 INFO - blobuploader == 1.2.4 11:49:59 INFO - docopt == 0.6.1 11:49:59 INFO - manifestparser == 1.1 11:49:59 INFO - mozInstall == 1.12 11:49:59 INFO - mozcrash == 0.16 11:49:59 INFO - mozdebug == 0.1 11:49:59 INFO - mozdevice == 0.47 11:49:59 INFO - mozfile == 1.2 11:49:59 INFO - mozhttpd == 0.7 11:49:59 INFO - mozinfo == 0.9 11:49:59 INFO - mozleak == 0.1 11:49:59 INFO - mozlog == 3.0 11:49:59 INFO - moznetwork == 0.27 11:49:59 INFO - mozprocess == 0.22 11:49:59 INFO - mozprofile == 0.27 11:49:59 INFO - mozrunner == 6.11 11:49:59 INFO - mozscreenshot == 0.1 11:49:59 INFO - mozsystemmonitor == 0.0 11:49:59 INFO - moztest == 0.7 11:49:59 INFO - mozversion == 1.4 11:49:59 INFO - psutil == 3.1.1 11:49:59 INFO - requests == 1.2.3 11:49:59 INFO - wsgiref == 0.1.2 11:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fb8027f0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebd900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', '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 11:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 11:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 11:49:59 INFO - Using env: {'DISPLAY': ':0', 11:49:59 INFO - 'HOME': '/home/cltbld', 11:49:59 INFO - 'LANG': 'en_US.UTF-8', 11:49:59 INFO - 'LANGUAGE': 'en_US:en', 11:49:59 INFO - 'LOGNAME': 'cltbld', 11:49:59 INFO - 'MAIL': '/var/mail/cltbld', 11:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:59 INFO - 'MOZ_NO_REMOTE': '1', 11:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:59 INFO - 'NO_EM_RESTART': '1', 11:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:59 INFO - 'PWD': '/builds/slave/test', 11:49:59 INFO - 'SHELL': '/bin/bash', 11:49:59 INFO - 'SHLVL': '1', 11:49:59 INFO - 'TERM': 'linux', 11:49:59 INFO - 'TMOUT': '86400', 11:49:59 INFO - 'USER': 'cltbld', 11:49:59 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:59 INFO - '_': '/tools/buildbot/bin/python'} 11:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 INFO - Cleaning up... 11:50:00 INFO - Return code: 0 11:50:00 INFO - Running post-action listener: _resource_record_post_action 11:50:00 INFO - Running post-action listener: _start_resource_monitoring 11:50:00 INFO - Starting resource monitoring. 11:50:00 INFO - ##### 11:50:00 INFO - ##### Running install step. 11:50:00 INFO - ##### 11:50:00 INFO - Running pre-action listener: _resource_record_pre_action 11:50:00 INFO - Running main action method: install 11:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:00 INFO - Reading from file tmpfile_stdout 11:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:00 INFO - Reading from file tmpfile_stdout 11:50:00 INFO - Output received: 11:50:00 INFO - Usage: mozinstall [options] installer 11:50:00 INFO - Options: 11:50:00 INFO - -h, --help show this help message and exit 11:50:00 INFO - -d DEST, --destination=DEST 11:50:00 INFO - Directory to install application into. [default: 11:50:00 INFO - "/builds/slave/test"] 11:50:00 INFO - --app=APP Application being installed. [default: firefox] 11:50:00 INFO - mkdir: /builds/slave/test/build/application 11:50:00 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'] 11:50:00 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 11:50:14 INFO - Reading from file tmpfile_stdout 11:50:14 INFO - Output received: 11:50:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:14 INFO - Running post-action listener: _resource_record_post_action 11:50:14 INFO - ##### 11:50:14 INFO - ##### Running run-tests step. 11:50:14 INFO - ##### 11:50:14 INFO - Running pre-action listener: _resource_record_pre_action 11:50:14 INFO - Running main action method: run_tests 11:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:14 INFO - Python 2.7.3 11:50:14 INFO - Return code: 0 11:50:14 INFO - grabbing minidump binary from tooltool 11:50:14 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')]} 11:50:14 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 0xf03b70>, '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 0xf54dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf55250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:14 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 11:50:14 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 11:50:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:14 INFO - Return code: 0 11:50:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:14 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] in /builds/slave/test/build 11:50:14 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost 11:50:14 INFO - Using env: {'DISPLAY': ':0', 11:50:14 INFO - 'HOME': '/home/cltbld', 11:50:14 INFO - 'LANG': 'en_US.UTF-8', 11:50:14 INFO - 'LANGUAGE': 'en_US:en', 11:50:14 INFO - 'LOGNAME': 'cltbld', 11:50:14 INFO - 'MAIL': '/var/mail/cltbld', 11:50:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:14 INFO - 'MOZ_NO_REMOTE': '1', 11:50:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:14 INFO - 'NO_EM_RESTART': '1', 11:50:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:14 INFO - 'PWD': '/builds/slave/test', 11:50:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:14 INFO - 'SHELL': '/bin/bash', 11:50:14 INFO - 'SHLVL': '1', 11:50:14 INFO - 'TERM': 'linux', 11:50:14 INFO - 'TMOUT': '86400', 11:50:14 INFO - 'USER': 'cltbld', 11:50:14 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097', 11:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:14 INFO - '_': '/tools/buildbot/bin/python'} 11:50:14 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/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] with output_timeout 3600 11:50:14 INFO - mozversion INFO | application_buildid: 20151123050554 11:50:14 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:14 INFO - mozversion INFO | application_display_name: Nightly 11:50:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:14 INFO - mozversion INFO | application_name: Firefox 11:50:14 INFO - mozversion INFO | application_remotingname: firefox 11:50:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:50:14 INFO - mozversion INFO | application_vendor: Mozilla 11:50:14 INFO - mozversion INFO | application_version: 45.0a1 11:50:14 INFO - mozversion INFO | platform_buildid: 20151123050554 11:50:14 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 11:50:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:14 INFO - mozversion INFO | platform_version: 45.0a1 11:50:14 INFO - 2015-11-23 11:50:14,716 DEBUG : using testdate: 1448308214 11:50:14 INFO - 2015-11-23 11:50:14,716 DEBUG : actual date: 1448308214 11:50:14 INFO - 2015-11-23 11:50:14,726 INFO : starting webserver on 'localhost:43154' 11:50:14 INFO - 2015-11-23 11:50:14,726 INFO : Starting test suite talos-linux64-ix-005 11:50:14 INFO - 2015-11-23 11:50:14,727 INFO : Starting test dromaeo_css 11:50:14 INFO - 2015-11-23 11:50:14,727 DEBUG : operating with platform_type : linux_ 11:50:14 INFO - 2015-11-23 11:50:14,727 INFO : Initialising browser for dromaeo_css test... 11:50:14 INFO - 2015-11-23 11:50:14,739 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwUYY6/profile http://localhost:43154/getInfo.html 11:50:19 INFO - 2015-11-23 11:50:19,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:50:19 INFO - 2015-11-23 11:50:19,062 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:50:19 INFO - 2015-11-23 11:50:19,062 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:50:19 INFO - 2015-11-23 11:50:19,062 DEBUG : BROWSER_OUTPUT: __metrics 11:50:19 INFO - 2015-11-23 11:50:19,150 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:50:20 INFO - 2015-11-23 11:50:20,309 INFO : Browser initialized. 11:50:20 INFO - 2015-11-23 11:50:20,310 INFO : Running cycle 1/1 for dromaeo_css test... 11:50:20 INFO - 2015-11-23 11:50:20,310 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwUYY6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:50:32 INFO - 2015-11-23 11:50:32,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 11:50:32 INFO - 2015-11-23 11:50:32,331 DEBUG : BROWSER_OUTPUT: 11:51:23 INFO - 2015-11-23 11:51:23,861 DEBUG : BROWSER_OUTPUT: 1448308283858 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] 11:53:35 INFO - 2015-11-23 11:53:35,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43154/tests/dromaeo/cssquery-ext.html) 11:53:37 INFO - 2015-11-23 11:53:37,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 239968256 11:53:37 INFO - 2015-11-23 11:53:37,144 DEBUG : BROWSER_OUTPUT: 11:56:39 INFO - 2015-11-23 11:56:39,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-ext.html (next: http://localhost:43154/tests/dromaeo/cssquery-jquery.html) 11:56:40 INFO - 2015-11-23 11:56:40,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 219705344 11:56:40 INFO - 2015-11-23 11:56:40,300 DEBUG : BROWSER_OUTPUT: 11:59:42 INFO - 2015-11-23 11:59:42,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43154/tests/dromaeo/cssquery-mootools.html) 11:59:42 INFO - 2015-11-23 11:59:42,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 214495232 11:59:42 INFO - 2015-11-23 11:59:42,919 DEBUG : BROWSER_OUTPUT: 12:02:44 INFO - 2015-11-23 12:02:44,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43154/tests/dromaeo/cssquery-prototype.html) 12:02:45 INFO - 2015-11-23 12:02:45,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 201871360 12:02:45 INFO - 2015-11-23 12:02:45,466 DEBUG : BROWSER_OUTPUT: 12:05:48 INFO - 2015-11-23 12:05:48,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43154/tests/dromaeo/cssquery-yui.html) 12:05:48 INFO - 2015-11-23 12:05:48,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 207101952 12:05:48 INFO - 2015-11-23 12:05:48,871 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/dromaeo/cssquery-yui.html (next: http://localhost:43154/tests/dromaeo/cssquery-dojo.html) 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 246964224 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:08:51 INFO - 2015-11-23 12:08:51,572 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2656.747608977147;2725.8364498130113;2740.671119465662;2750.0649779075125;2762.557990721484;4573.24541450661;4704.082703872747;4713.3401323814605;4721.811127554894;4726.527347265272;4586.403767510219;4595.770211489421;4670.369500117483;4685.086408150403;4694.9765251173785;4364.912701745955;4369.169857727037;4393.780310984438;4394.6703997200175;4424.734515929054;4217.114405974734;4432.8005239764125;4448.599626033656;4494.123645889053;4494.8202071917085;4306.784660766981;4311.719738217006;4372.715773474746;4401.295792673157;4409.140217657558;4303.074838909618;4353.172897149531;4355.346697995295;4388.275934470808;4388.824447022115;4139.586041395866;4318.568143185687;4318.719283246579;4338.696291259613;4386.254336762758;4519.661025423106;4560.954390456086;4581.8396356127705;4689.88275293117;4720.527947205286;5080.974595127001;5103.872403189913;5106.591472682214;5125.282460455539;5150.871228219287;4773;5130.486951304877;5158.74206289684;5166.61250406221;5167.199084141964;4532.954670453253;4605.240135377625;4605.309203619484;4621.260598304255;4634.467036290802;5220.947790522122;5221.399539052982;5222.843314700565;5228.37259528859;5271.182966640177;5017.84946451607;5017.9247311290355;5021.974890125526;5029.446760856303;5069.087564238473;4849.4908034656555;4930.6795058321095;4952.331435256195;4955.876103097451;5100.38795344561;4909.877253068702;4913.336699545587;4915.336429582032;4949.901001980013;5009.348784658044;4886.413630364379;4887.902241955141;4889.755512224375;4903.4606193318705;4955.776990035457;3991.3613821788376;4117.958820411817;4123.958760412417;4163.208990291835;4209.579042095827;3708.9258214835554;3713.1088538750505;3717.9628203718157;3743.438484227333;3750.137468382233;4379.9781001095425;4381.18947994622;4382.233109205877;4390.341448782644;4417.4036505072045;4845.927311090337;4961.4046314441775;4963.205887058053;5086.847394578169;5135.075686376488;4233.5131459882505;4288.549702281278;4316.136772645484;4317.179735850178;4352.194843953878;4484.506704262529;4498.302763071729;4510.233260345683;4511.977440112844;4552.954470455253;4821.975890120527;4827.758612069312;4828.806847726051;4830.565249127455;4874.2444921037295;4806.47128815837;4916.139675556692;4929.260610908393;4929.876753081202;5026.899462010666;4705.952940470552;4706.599939005223;4709.246520556694;4724.669273150984;4773.76131193432;4881.463039065629;4888.584470320063;4890.682105663121;4899.069176856386;4915.238138088602;4738.123447162286;4795.760211989317;4849.878753031061;4928.137575924271;5030.522100400456;4851.95148048515;4884.65807393479;4899.191633380452;4902.63230257725;4937.604991600735;4878.341423907869;4897.314375987436;4899;4906.215005599087;4935.111679897509;4584.793684284148;4698.671093023592;4707.62339012885;4710.505396933273;4715.198416269174;4854.927176092432;4932.334134891744;4972.0801651694555;4985.601151907911;4987.47631498702;4794.976025119852;4814.133455977958;4820.156472617208;4823.155947709067;4858.757062146808 12:08:51 INFO - 2015-11-23 12:08:51,573 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.1099518258743;570.6690119730557;575.3441077172025;575.6172145523227;577.6303165973775;27799.305017374576;28742.281442963937;36444.27111457769;37275.254494910085;37318.81340593293;40917;41408;41473.792631036806;41535.79232103835;41538.7923060385;6921.584704917721;7873.8818917716135;7970.282674559288;8026.157253488358;8052.557109358983;7079.1858936222225;9944.5524951377;10134.543945522433;10139.797204055914;10148.695539133838;9973.950130249375;10053.899461005369;10057.597696092147;10058.89941100587;10065.949670251675;7156.177039640456;7323.304286092813;9958.053984871425;9967.40195588267;10214.89785102147;9735.17251033663;9847.261455390875;9849.21206303494;9852.310338276251;9856.90143098567;37563;38140.23719525622;38156;38158.618413815784;38165.61834381648;2664.467106578692;2892;3144.0724986128916;3250.951235731466;3415.3202359711936;28430.289242769097;28463.71536284652;28663.426731465253;28836.134915952556;29121.708782912112;3361.193313604742;3521.9295614087573;3544.0962554548423;3566.946495802565;3638.8362523686496;229237;231126;231202;231659;231874;53421.1986820198;54197;54240;57618.42381576131;58042.709786450796;60673.39326606766;61645.691771540856;61903.690481548205;62042.37957620456;62057.37942620516;13171.868281317256;13358.131721438076;13370.46518139283;13372.997025223147;13376.331183440789;9291.953540232256;9314.813703726024;9336.346455748168;9340.112689294507;9346.392484488486;18912.905435472734;19070.14184361707;19859.665524563472;19885.204591816455;19960.10179541924;7501.699932002768;7771.844563108706;7801.258880406353;7801.336886364609;7826.804329891798;787.6573690444675;818.7830224990382;935.7146070448442;1009.3187098708343;1028.89711028898;26600.60099098515;26769.732302677112;26862.865685671837;26928.730712693014;27056;927.7031349967946;938.2259635800356;984.7095106943469;999.5252255178732;1038.4184856480244;13764.449422023006;14008.06161950754;14060.367283472267;14073.648158795908;14129.929350353388;281261;285048;285746;285801;286264;38625.61374386276;38952.61047389547;46363.536364636595;47089;47177;1132.750794825137;1156.5778490850778;1163.7032556698157;1195.4321697193764;1196.5094311332311;25078.3730406734;26486.735132648428;26816.865915670296;26924;27021.459570808867;36413.27173456463;37104.81447592745;37834.43248351222;42431;43221.567784321756;175421;176003;177354;177619;177894.11052944654;27653.446931060862;28091.297717557223;28095.43809123847;28096.85951570229;28115.297117572223;39174;39965.20069598534;39974.40038399484;40079.59920400759;40534.594654054265;38213.61786382212;38426.807865960494;39598.80200598978;40124.3981340286;40158.79920600378;34242.31515369629;38198.42702359522;39510;39928;40463.797681011405;35175.47236791501;35387.82306088453;38832.417513737884;39498.40752388659;39629.80185099056;29418.411631766816;30670.693293066783;31175.688243117278;31264.687353126177;31355.529667055467;24203;24263.393415164057;24406.633900491153;24542;24624.753752462246 12:08:51 INFO - 2015-11-23 12:08:51,573 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.0699087994335;341.50311297062774;341.64980894583056;343.85214357826135;347.6888185074358;12452.31512266825;12732.236065836034;14917.179555124463;15217.315220815062;15962.600934976632;14247.14517128973;14260.857391426083;14635.19506427146;14654.267286635652;14759.631009224775;3763.3978563429855;4092.1815636872598;4512.323151527273;4638.141943740419;4640.953590464086;3334.1664583854035;3443.707284880788;4598.770061496928;5101.591872650179;5316.548093412064;5258.605604579653;5279.128943724281;5287.524122828944;5313.362396512404;5321.281626980366;5244.55421289189;5343.839684809462;5729.598928075036;5731.598788084857;5733.655980641175;5076.720780357079;5077.390713114413;5082.822101226439;5084.567811736007;5091.1854103343285;19017.61964760697;19206.711899321523;19884.80115198844;19889.20443182271;19903.90048049765;1849.7965223825368;1856.3409989453685;1902.980970190308;1922.9615407691908;2002.2291417804104;8574.657013719443;8780.770692103111;8965.148310910454;9194.770130746785;9211.677591284273;1700.6853732059485;1724.2585688154088;1785.7857057153224;1798.9460316190534;1807.150639199574;47307.290390644164;47850.52149478495;48965;56447.71776141134;57148;9878.616993620899;9895.604175832887;9910.702678919644;9946.254030947708;9958.30291879576;12633.494660213672;12646.30445325516;12675.93662031684;12676.30280334572;12679.112462127563;6492.545521813522;6543.280239173687;6547.181602299713;6620.304867988888;6902.378785909192;6054.757809687651;6465.224173099258;6520;6538.476921846241;6545.770898018546;4161.542230354658;4184.790760461965;4193.874183774492;4221.767802770877;4252.319628859368;1615.2811998660718;1654.9586260343588;1670.490500397366;1707.4280116160976;1738.9217485213196;375.69944044764077;379.65451439190207;747.637395863006;767.1216457156636;806.1776987472745;9776.441781299112;10503.264771465923;16197.4330898418;16670.333186672397;17261.39585114515;739.4343327354578;799.4403917257943;800.6037011679256;813.5362843179331;822.3174764945081;8733.388662793543;8911.821763564822;8981.416207946462;9017.188453039258;9158.954205229065;509250;517941;521843;536091.2368067099;538293;69912;70427;70434.64782676054;70664.2933570668;71515.28484715191;1067.0609863320228;1072.158355690779;1077.095239998405;1077.515118196799;1077.9083777878811;13927.123891378835;14075.648108796953;14184.290785460893;14287.57137285883;14382.195471882882;30781.846090769403;31221;31459.685403145675;31940;32439.513407298437;43763.78118109389;43913.56086439094;44070;45661.315080274486;47197.528024719315;8948.73153805387;9118.863217051618;9267;9335.206507446672;9375;10802.837957430802;10843.240973131806;12039.33783641873;16760.916195418944;17105.14474276306;13942.930285348508;14136.858631413554;14272.500462483764;14361.425542978164;14512.709745805236;13331.400086995915;13731.24478153711;14046.648833778829;14115.858841411455;14166.929165354108;11267.380294083903;13760.65598360049;14086.15483071019;14476.203808790618;14723.190224537753;9072;9283.907160928304;9290.489023103793;9305.441673499612;9322.813543729224;9514.19129374011;9530.142287194185;9550.188234000188;9632;13668.248246346546 12:08:51 INFO - 2015-11-23 12:08:51,574 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1217.5373358123911;1544.07355586648;1600.679864027194;1627.9430219942296;1683.1920678074523;5621.325440947087;6205.751769929203;6328.177336946196;6349.142865713127;6349.396807303298;6490.935090649092;6591.472682185426;6591.5715478493985;6596.7691130810435;6611.636360000198;2026.858119931609;2029.553498230387;2035.1248962946001;2044.7341845560131;2045.5806559655234;2048.5288383671764;2049.4568939231117;2050.8974551272377;2082.375287413777;2087.290321290761;2014.909329080195;2021.070307658479;2034.6541088015074;2035.7862424445443;2036.1448191759423;2015.5085236924645;2031.7155598216261;2032.0449388787247;2034.8168664820237;2034.9084291206932;2040.4286799696108;2061.68043953186;2077.096463038568;2078.262216912989;2079.376187143866;5616.550675945915;5766.0486019806685;6556.213254409454;6556.672166391661;6572.244191917943;3867.4778904847767;3956.960430395688;3964.920701585981;3970.1861118470642;3977.8209980550655;2712.6744790625053;2722.060888993314;2751.4222013377216;2755.0357374918817;2865.6991015943445;868.5830801215388;883.8099808541131;884.7434244069276;888.1518150166576;907.9773005674845;8589.398742088057;8626.353023523197;8639.438436501607;8661.653533858638;8661.826763464695;3848.5958974307296;3877.3408520551575;3878.553966293856;3916.1776027034643;3925.725199236083;7595;7600.961995189989;7601.961990190013;7623.847523049508;7632.19861914491;4092.46797916269;4098.73358231714;4125.690573207022;4140.420341152241;4145.854895078658;3727.4967879336486;3754.3805272129794;3757.361248587692;3757.887263382103;3764.5670747864347;3208.4866421372467;3220.8872689455757;3221.903342899717;3223.9194020149216;3237.4010808000594;1045.717656232813;1053.3416614615865;1075.725689949058;1076.8653918260218;1087.7606926476162;897.4211633496358;929.9770252722087;1160.0255785140523;1169.771894480568;1178.8290697848763;6396.968015159894;6455.354464553507;6460.160179176771;6474.514411419163;6476.125723027425;1022.7801022780138;1026.2457094035879;1026.712520494263;1040.3185913226848;1066.1257768629805;4562.041971186088;5074.340335756328;5115.488451154854;5117.283580298761;5117.897642047138;6806.931930680729;7592.278733520307;7671.156172821097;7718.614069296513;7726.4591478597085;7629.122650895107;7682.231776822385;7744.612769361509;7764.961175194201;7771.261730135628;5872.0898260769645;6051.273847138372;6077.301110372276;6077.969610152009;6158.291796443376;6257.874842503215;6306.621602703853;6311.463525600192;6315.936840631535;6317.052442133717;7033.929660703532;7187.425005999612;7220.675069621985;7262.455315851226;7266.527675701062;6685.866282674417;6852.965735171292;6872.793816185523;6873.1442510522875;7311.926880731125;6111.816645500642;6415.615063096229;6452.064450654722;6461.289258181502;6470.870582588416;6355.90466142999;6405.935940640534;6416.358364163546;6421.743130274736;6423.100765892686;5918.408159184047;6045.576809623284;6114;6193.194884664965;6211.068339749074;5851.795187168599;5945.167676525203;5977.432143946318;5999.040153575407;6038.849028774316;6083.756649733961;6111.908321375272;6181.690915454299;6195.287541932736;6199.938000619936;5598.776048957996;5646.0683987141665;5673.120666296731;5679.801206957736;5684.488396044376;5647.971760141173;5677.574181936288;5718.571107167062;5719.28508936383;5719.971400142973 12:08:51 INFO - 2015-11-23 12:08:51,575 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.3963589907378;318.3775718470389;319.7921351121772;321.79887570268585;322.55809540928925;5389.407165211824;5394.703291318976;5415.458454154583;5416.214648875915;5425.403205647375;5083.745812709368;5189.6886186828815;5252.973735131329;5369.5704343652515;5372.194170874371;4181.247375472413;4200.432941552897;4212.55768144345;4214.620684138427;4218.4937807463075;3996.8800935971967;4210.3894935234375;4215.725977811432;4220.53574106848;4222.19778242133;4020.4572382728397;4074.3684728867074;4194.853180138696;4200.810963506649;4215.199112168678;4202.348635961431;4203.159368126372;4203.97898010511;4206.0115872769875;4206.810693518783;3711.0722319420147;3711.628837116267;3716.0338312038793;3720.386136287509;3721.5534135903863;5180.171172612364;5187.844364669066;5191.974040129813;5198.064348417283;5205.713685747282;4680.321353403771;4821.566059054702;4827.85516434504;4829;4870;5684.2326285951285;5719.542436605062;5728.914066289009;5731.99690054243;5739.82780516581;3965.920681586352;3970.960290397088;3971.086650070471;3972.324704800191;3972.3644216925154;5935.9406405935815;6011.068284415923;6013.75944962201;6017.909731354077;6022.578419510636;3977.0455090778005;4104.548499665035;4105.158442519277;4107.466029416217;4127;4151.501819781585;4157.5010998679745;4165.83336666536;4169.10364271683;4169.1661667666585;4764.190087685102;4782.139214941274;4785.808567657255;4787.928181077286;4798.47216806151;5694.060480020833;5696.746715722535;5705.343885453143;5705.372409035002;5708.885822283531;1432.3769160415252;1453.840077591464;1461.8684318411395;1462.144645382463;1471.8896082793833;978.1441238915949;989.7871957529165;991.1426615977127;1002.0430488883245;1003.1623594298842;4905.2151655734915;4933.605311575066;4990.2035267303745;4992.350994370709;4994.975025124923;5864.9413505864395;5870;5873.911891321633;5879.441453062038;5881.676507792027;4836.419629644465;4929.383827021622;4935;4984.077945580079;5081.136206844845;3167.651558328582;3184.1084496341064;3204.9359012819614;3211.775175737676;3213.839308034636;5640.182173584807;5641.379448260688;5644.068728659725;5644.85887852807;5647.068233741386;6113.57204995646;6136.294326152461;6140.478059364915;6140.8771824563255;6141.907871381933;5640.717964101696;5643.984082865041;5644.322681278273;5644.899244647254;5648.830535083872;5961.642301461926;5970;5971.970140149445;5977.133315669116;5984.1921340618455;5771.7402716877;5829.271341082364;5833;5838.532917366685;5842.766289348378;5521.972390138184;5637.661740295595;5656.236408084856;5664.745086471201;5664.773409063591;4103.425520427202;4110.445089912823;4111.424400583861;4113.506379234511;4114.547399786081;5966.0454327307425;5970.58205925581;5972.522198224218;5975.25309336333;5987.43119403656;5605.355384130877;5727.055035919193;5730.684812335361;5735.684537350486;5736.942630573641;5721.170430287501;5726.914096288476;5735.799247026334;5737.340205876378;5737.8524295140305;5609.80365687199;5616.382197958303;5617.269754931996;5620.381758006534;5622.8313150605545;5632.943670563406;5738.081906894877;5748.137779333133;5769.076947688518;5770.163326317576;5619.466150715675;5627.099664053731;5628.127640215773;5632.239647647679;5633.8309850704545 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.3072462175513;768.8846672999049;777.1761932351711;777.9662450195732;788.9013873265843;11294.774104517905;11611.303321800677;11631.941840290787;11644.30134191948;11657.417129143541;11917.880821191786;12027.278363298186;12038.097142714289;12043.09676774241;12068.094892883048;775.5424299663198;805.7341077444429;806.0408114343941;806.4596720197482;806.5523634382915;798.4291231769283;809.76516810125;809.9311558517533;810.0846043970305;810.3638643664724;841.4446465332882;845.8096928191169;848.1476116502906;848.8896443462372;849.0405841399211;846.5005646668495;847.4788005376711;847.8516259654566;848.3764433141636;848.5078654380444;621.3879328861068;625.1529177963885;628.4281304013326;628.6228263042184;629.8299459146051;11644.41777911101;11678.357690327028;11750.118741094451;11750.529978800838;11773.764524709457;11033.779324413466;11100;11187.608433704781;11334.206605537616;11846.289222646668;9427.292953028482;9528.618855245782;9750.853737193947;9759.756006099833;9782.706518804447;3149.9685003149903;3222.9677703223138;3257.2996805686653;3268.0522648431925;3279.6556361582166;34194;34861;38195.42706859399;39052.21895562073;41054.79472602618;8985.415947963362;9042.547872606343;9111.27109831212;9245.410608802864;9528.047195280416;15924.840751592568;16246.268917898722;16254.91156680227;16275.186240688156;16293.51119466418;6393.136926514954;6433.195850518685;6462.7738029169695;6484.481241500669;6534.085228068075;3565.2512972275595;3566.589842168132;3581.54754778722;3598.3882739934274;3640.2719456108352;2793.580962855547;2840.8721607527295;2844.900428484993;2846.5018621741115;2849.6722876869426;476.3521610609568;482.9903401931942;486.3021564055592;487.06969687895946;502.2466300549176;482.4692837878306;496.91304021796043;518.8650950752832;573.6214098694842;603.4116736182187;7792.220777922275;8032.236937490929;8034.196580341919;8066;8175.795605109801;582.6329412470202;607.4714997951722;609.7103875659116;612.5467154305782;619.1115748900343;3587.318409502186;3773.2264885698914;3875.1668391296007;3906.5898080701118;4162;48543.5145648546;48791.26813097807;49146.50853491491;50171.49828501741;51663;39650.801745991084;40222.59777402189;40373.77009839206;40816.591834081875;40870.59129408668;34126.82936585351;40113.598864010986;40324;40634.390484142765;41227.7938610311;8010.879836802569;8158.755237342889;8236.711715089943;8354.329134173067;8536.573171341532;31476.685233147375;31762.205944851565;32633.836830816643;33630.831845840614;34340.14149646279;39410.80294598509;39504.80247598859;40129.39805902972;40197.397039043855;40372.3944140844;9459.527023648652;9991.70024899225;10347.689569312932;10421.739456513344;10451.059404653617;11213.15901307389;11260.09919206478;11272;11485.540578376771;11566.94216528912;10652.946735266274;10667.433774916652;10882.29265097766;10987.340759554452;11199;10422;10532.420716860646;10666.093382062612;10836.891631083588;11021.889781102087;10195.286329956833;10371.533281002525;10452.529636166239;10545.456347141928;10666.626668066581;8450.239478446969;9473;9549.140577348073;9560.61757529691;9632.855507167258;8893.333000024895;9005.819883602422;9120.954395227982;9190.448573085636;9278.582463789011 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1148 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309331565__endTimestamp 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,579 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4633.53 Median:4724.67 stddev:470.83 (10.0%) stddev-sans-first:446.01 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: Values: 2656.7 2725.8 2740.7 2750.1 2762.6 4573.2 4704.1 4713.3 4721.8 4726.5 4586.4 4595.8 4670.4 4685.1 4695.0 4364.9 4369.2 4393.8 4394.7 4424.7 4217.1 4432.8 4448.6 4494.1 4494.8 4306.8 4311.7 4372.7 4401.3 4409.1 4303.1 4353.2 4355.3 4388.3 4388.8 4139.6 4318.6 4318.7 4338.7 4386.3 4519.7 4561.0 4581.8 4689.9 4720.5 5081.0 5103.9 5106.6 5125.3 5150.9 4773.0 5130.5 5158.7 5166.6 5167.2 4533.0 4605.2 4605.3 4621.3 4634.5 5220.9 5221.4 5222.8 5228.4 5271.2 5017.8 5017.9 5022.0 5029.4 5069.1 4849.5 4930.7 4952.3 4955.9 5100.4 4909.9 4913.3 4915.3 4949.9 5009.3 4886.4 4887.9 4889.8 4903.5 4955.8 3991.4 4118.0 4124.0 4163.2 4209.6 3708.9 3713.1 3718.0 3743.4 3750.1 4380.0 4381.2 4382.2 4390.3 4417.4 4845.9 4961.4 4963.2 5086.8 5135.1 4233.5 4288.5 4316.1 4317.2 4352.2 4484.5 4498.3 4510.2 4512.0 4553.0 4822.0 4827.8 4828.8 4830.6 4874.2 4806.5 4916.1 4929.3 4929.9 5026.9 4706.0 4706.6 4709.2 4724.7 4773.8 4881.5 4888.6 4890.7 4899.1 4915.2 4738.1 4795.8 4849.9 4928.1 5030.5 4852.0 4884.7 4899.2 4902.6 4937.6 4878.3 4897.3 4899.0 4906.2 4935.1 4584.8 4698.7 4707.6 4710.5 4715.2 4854.9 4932.3 4972.1 4985.6 4987.5 4795.0 4814.1 4820.2 4823.2 4858.8 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,580 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40186.12 Median:20026.05 stddev:61247.47 (305.8%) stddev-sans-first:61347.03 12:08:51 INFO - 2015-11-23 12:08:51,581 DEBUG : BROWSER_OUTPUT: Values: 565.1 570.7 575.3 575.6 577.6 27799.3 28742.3 36444.3 37275.3 37318.8 40917.0 41408.0 41473.8 41535.8 41538.8 6921.6 7873.9 7970.3 8026.2 8052.6 7079.2 9944.6 10134.5 10139.8 10148.7 9974.0 10053.9 10057.6 10058.9 10065.9 7156.2 7323.3 9958.1 9967.4 10214.9 9735.2 9847.3 9849.2 9852.3 9856.9 37563.0 38140.2 38156.0 38158.6 38165.6 2664.5 2892.0 3144.1 3251.0 3415.3 28430.3 28463.7 28663.4 28836.1 29121.7 3361.2 3521.9 3544.1 3566.9 3638.8 229237.0 231126.0 231202.0 231659.0 231874.0 53421.2 54197.0 54240.0 57618.4 58042.7 60673.4 61645.7 61903.7 62042.4 62057.4 13171.9 13358.1 13370.5 13373.0 13376.3 9292.0 9314.8 9336.3 9340.1 9346.4 18912.9 19070.1 19859.7 19885.2 19960.1 7501.7 7771.8 7801.3 7801.3 7826.8 787.7 818.8 935.7 1009.3 1028.9 26600.6 26769.7 26862.9 26928.7 27056.0 927.7 938.2 984.7 999.5 1038.4 13764.4 14008.1 14060.4 14073.6 14129.9 281261.0 285048.0 285746.0 285801.0 286264.0 38625.6 38952.6 46363.5 47089.0 47177.0 1132.8 1156.6 1163.7 1195.4 1196.5 25078.4 26486.7 26816.9 26924.0 27021.5 36413.3 37104.8 37834.4 42431.0 43221.6 175421.0 176003.0 177354.0 177619.0 177894.1 27653.4 28091.3 28095.4 28096.9 28115.3 39174.0 39965.2 39974.4 40079.6 40534.6 38213.6 38426.8 39598.8 40124.4 40158.8 34242.3 38198.4 39510.0 39928.0 40463.8 35175.5 35387.8 38832.4 39498.4 39629.8 29418.4 30670.7 31175.7 31264.7 31355.5 24203.0 24263.4 24406.6 24542.0 24624.8 12:08:51 INFO - 2015-11-23 12:08:51,581 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,581 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27071.62 Median:24008.05 stddev:85650.30 (356.8%) stddev-sans-first:85867.05 12:08:51 INFO - 2015-11-23 12:08:51,581 DEBUG : BROWSER_OUTPUT: Values: 340.1 341.5 341.6 343.9 347.7 12452.3 12732.2 14917.2 15217.3 15962.6 14247.1 14260.9 14635.2 14654.3 14759.6 3763.4 4092.2 4512.3 4638.1 4641.0 3334.2 3443.7 4598.8 5101.6 5316.5 5258.6 5279.1 5287.5 5313.4 5321.3 5244.6 5343.8 5729.6 5731.6 5733.7 5076.7 5077.4 5082.8 5084.6 5091.2 19017.6 19206.7 19884.8 19889.2 19903.9 1849.8 1856.3 1903.0 1923.0 2002.2 8574.7 8780.8 8965.1 9194.8 9211.7 1700.7 1724.3 1785.8 1798.9 1807.2 47307.3 47850.5 48965.0 56447.7 57148.0 9878.6 9895.6 9910.7 9946.3 9958.3 12633.5 12646.3 12675.9 12676.3 12679.1 6492.5 6543.3 6547.2 6620.3 6902.4 6054.8 6465.2 6520.0 6538.5 6545.8 4161.5 4184.8 4193.9 4221.8 4252.3 1615.3 1655.0 1670.5 1707.4 1738.9 375.7 379.7 747.6 767.1 806.2 9776.4 10503.3 16197.4 16670.3 17261.4 739.4 799.4 800.6 813.5 822.3 8733.4 8911.8 8981.4 9017.2 9159.0 509250.0 517941.0 521843.0 536091.2 538293.0 69912.0 70427.0 70434.6 70664.3 71515.3 1067.1 1072.2 1077.1 1077.5 1077.9 13927.1 14075.6 14184.3 14287.6 14382.2 30781.8 31221.0 31459.7 31940.0 32439.5 43763.8 43913.6 44070.0 45661.3 47197.5 8948.7 9118.9 9267.0 9335.2 9375.0 10802.8 10843.2 12039.3 16760.9 17105.1 13942.9 14136.9 14272.5 14361.4 14512.7 13331.4 13731.2 14046.6 14115.9 14166.9 11267.4 13760.7 14086.2 14476.2 14723.2 9072.0 9283.9 9290.5 9305.4 9322.8 9514.2 9530.1 9550.2 9632.0 13668.2 12:08:51 INFO - 2015-11-23 12:08:51,581 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,582 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4672.43 Median:5808.92 stddev:2300.55 (39.6%) stddev-sans-first:2292.34 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: Values: 1217.5 1544.1 1600.7 1627.9 1683.2 5621.3 6205.8 6328.2 6349.1 6349.4 6490.9 6591.5 6591.6 6596.8 6611.6 2026.9 2029.6 2035.1 2044.7 2045.6 2048.5 2049.5 2050.9 2082.4 2087.3 2014.9 2021.1 2034.7 2035.8 2036.1 2015.5 2031.7 2032.0 2034.8 2034.9 2040.4 2061.7 2077.1 2078.3 2079.4 5616.6 5766.0 6556.2 6556.7 6572.2 3867.5 3957.0 3964.9 3970.2 3977.8 2712.7 2722.1 2751.4 2755.0 2865.7 868.6 883.8 884.7 888.2 908.0 8589.4 8626.4 8639.4 8661.7 8661.8 3848.6 3877.3 3878.6 3916.2 3925.7 7595.0 7601.0 7602.0 7623.8 7632.2 4092.5 4098.7 4125.7 4140.4 4145.9 3727.5 3754.4 3757.4 3757.9 3764.6 3208.5 3220.9 3221.9 3223.9 3237.4 1045.7 1053.3 1075.7 1076.9 1087.8 897.4 930.0 1160.0 1169.8 1178.8 6397.0 6455.4 6460.2 6474.5 6476.1 1022.8 1026.2 1026.7 1040.3 1066.1 4562.0 5074.3 5115.5 5117.3 5117.9 6806.9 7592.3 7671.2 7718.6 7726.5 7629.1 7682.2 7744.6 7765.0 7771.3 5872.1 6051.3 6077.3 6078.0 6158.3 6257.9 6306.6 6311.5 6315.9 6317.1 7033.9 7187.4 7220.7 7262.5 7266.5 6685.9 6853.0 6872.8 6873.1 7311.9 6111.8 6415.6 6452.1 6461.3 6470.9 6355.9 6405.9 6416.4 6421.7 6423.1 5918.4 6045.6 6114.0 6193.2 6211.1 5851.8 5945.2 5977.4 5999.0 6038.8 6083.8 6111.9 6181.7 6195.3 6199.9 5598.8 5646.1 5673.1 5679.8 5684.5 5648.0 5677.6 5718.6 5719.3 5720.0 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4739.71 Median:5370.88 stddev:1395.12 (26.0%) stddev-sans-first:1358.91 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: Values: 314.4 318.4 319.8 321.8 322.6 5389.4 5394.7 5415.5 5416.2 5425.4 5083.7 5189.7 5253.0 5369.6 5372.2 4181.2 4200.4 4212.6 4214.6 4218.5 3996.9 4210.4 4215.7 4220.5 4222.2 4020.5 4074.4 4194.9 4200.8 4215.2 4202.3 4203.2 4204.0 4206.0 4206.8 3711.1 3711.6 3716.0 3720.4 3721.6 5180.2 5187.8 5192.0 5198.1 5205.7 4680.3 4821.6 4827.9 4829.0 4870.0 5684.2 5719.5 5728.9 5732.0 5739.8 3965.9 3971.0 3971.1 3972.3 3972.4 5935.9 6011.1 6013.8 6017.9 6022.6 3977.0 4104.5 4105.2 4107.5 4127.0 4151.5 4157.5 4165.8 4169.1 4169.2 4764.2 4782.1 4785.8 4787.9 4798.5 5694.1 5696.7 5705.3 5705.4 5708.9 1432.4 1453.8 1461.9 1462.1 1471.9 978.1 989.8 991.1 1002.0 1003.2 4905.2 4933.6 4990.2 4992.4 4995.0 5864.9 5870.0 5873.9 5879.4 5881.7 4836.4 4929.4 4935.0 4984.1 5081.1 3167.7 3184.1 3204.9 3211.8 3213.8 5640.2 5641.4 5644.1 5644.9 5647.1 6113.6 6136.3 6140.5 6140.9 6141.9 5640.7 5644.0 5644.3 5644.9 5648.8 5961.6 5970.0 5972.0 5977.1 5984.2 5771.7 5829.3 5833.0 5838.5 5842.8 5522.0 5637.7 5656.2 5664.7 5664.8 4103.4 4110.4 4111.4 4113.5 4114.5 5966.0 5970.6 5972.5 5975.3 5987.4 5605.4 5727.1 5730.7 5735.7 5736.9 5721.2 5726.9 5735.8 5737.3 5737.9 5609.8 5616.4 5617.3 5620.4 5622.8 5632.9 5738.1 5748.1 5769.1 5770.2 5619.5 5627.1 5628.1 5632.2 5633.8 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: 12:08:51 INFO - 2015-11-23 12:08:51,583 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12101.72 Median:41141.29 stddev:13380.19 (32.5%) stddev-sans-first:13390.27 12:08:51 INFO - 2015-11-23 12:08:51,584 DEBUG : BROWSER_OUTPUT: Values: 689.3 768.9 777.2 778.0 788.9 11294.8 11611.3 11631.9 11644.3 11657.4 11917.9 12027.3 12038.1 12043.1 12068.1 775.5 805.7 806.0 806.5 806.6 798.4 809.8 809.9 810.1 810.4 841.4 845.8 848.1 848.9 849.0 846.5 847.5 847.9 848.4 848.5 621.4 625.2 628.4 628.6 629.8 11644.4 11678.4 11750.1 11750.5 11773.8 11033.8 11100.0 11187.6 11334.2 11846.3 9427.3 9528.6 9750.9 9759.8 9782.7 3150.0 3223.0 3257.3 3268.1 3279.7 34194.0 34861.0 38195.4 39052.2 41054.8 8985.4 9042.5 9111.3 9245.4 9528.0 15924.8 16246.3 16254.9 16275.2 16293.5 6393.1 6433.2 6462.8 6484.5 6534.1 3565.3 3566.6 3581.5 3598.4 3640.3 2793.6 2840.9 2844.9 2846.5 2849.7 476.4 483.0 486.3 487.1 502.2 482.5 496.9 518.9 573.6 603.4 7792.2 8032.2 8034.2 8066.0 8175.8 582.6 607.5 609.7 612.5 619.1 3587.3 3773.2 3875.2 3906.6 4162.0 48543.5 48791.3 49146.5 50171.5 51663.0 39650.8 40222.6 40373.8 40816.6 40870.6 34126.8 40113.6 40324.0 40634.4 41227.8 8010.9 8158.8 8236.7 8354.3 8536.6 31476.7 31762.2 32633.8 33630.8 34340.1 39410.8 39504.8 40129.4 40197.4 40372.4 9459.5 9991.7 10347.7 10421.7 10451.1 11213.2 11260.1 11272.0 11485.5 11566.9 10652.9 10667.4 10882.3 10987.3 11199.0 10422.0 10532.4 10666.1 10836.9 11021.9 10195.3 10371.5 10452.5 10545.5 10666.6 8450.2 9473.0 9549.1 9560.6 9632.9 8893.3 9005.8 9121.0 9190.4 9278.6 12:08:51 INFO - 2015-11-23 12:08:51,585 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:08:51 INFO - 2015-11-23 12:08:51,585 DEBUG : BROWSER_OUTPUT: 12:08:52 INFO - 2015-11-23 12:08:52,286 INFO : Browser exited with error code: 0 12:08:52 INFO - 2015-11-23 12:08:52,307 INFO : Completed test dromaeo_css (00:18:37) 12:08:52 INFO - 2015-11-23 12:08:52,307 INFO : Starting test kraken 12:08:52 INFO - 2015-11-23 12:08:52,307 DEBUG : operating with platform_type : linux_ 12:08:52 INFO - 2015-11-23 12:08:52,307 INFO : Initialising browser for kraken test... 12:08:52 INFO - 2015-11-23 12:08:52,313 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLw91ne/profile http://localhost:43154/getInfo.html 12:08:55 INFO - 2015-11-23 12:08:55,848 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:08:55 INFO - 2015-11-23 12:08:55,848 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:08:55 INFO - 2015-11-23 12:08:55,849 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:08:55 INFO - 2015-11-23 12:08:55,849 DEBUG : BROWSER_OUTPUT: __metrics 12:08:55 INFO - 2015-11-23 12:08:55,977 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:08:57 INFO - 2015-11-23 12:08:57,133 INFO : Browser initialized. 12:08:57 INFO - 2015-11-23 12:08:57,134 INFO : Running cycle 1/1 for kraken test... 12:08:57 INFO - 2015-11-23 12:08:57,134 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLw91ne/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:08 INFO - 2015-11-23 12:09:08,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 12:09:08 INFO - 2015-11-23 12:09:08,997 DEBUG : BROWSER_OUTPUT: 12:09:11 INFO - 2015-11-23 12:09:11,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43154/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:12 INFO - 2015-11-23 12:09:12,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 175149056 12:09:12 INFO - 2015-11-23 12:09:12,198 DEBUG : BROWSER_OUTPUT: 12:09:14 INFO - 2015-11-23 12:09:14,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43154/tests/kraken/driver.html?testName=audio-dft) 12:09:15 INFO - 2015-11-23 12:09:15,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 166264832 12:09:15 INFO - 2015-11-23 12:09:15,481 DEBUG : BROWSER_OUTPUT: 12:09:18 INFO - 2015-11-23 12:09:18,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43154/tests/kraken/driver.html?testName=audio-fft) 12:09:19 INFO - 2015-11-23 12:09:19,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 150708224 12:09:19 INFO - 2015-11-23 12:09:19,042 DEBUG : BROWSER_OUTPUT: 12:09:21 INFO - 2015-11-23 12:09:21,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43154/tests/kraken/driver.html?testName=audio-oscillator) 12:09:21 INFO - 2015-11-23 12:09:21,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 153808896 12:09:21 INFO - 2015-11-23 12:09:21,653 DEBUG : BROWSER_OUTPUT: 12:09:23 INFO - 2015-11-23 12:09:23,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:24 INFO - 2015-11-23 12:09:24,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 155660288 12:09:24 INFO - 2015-11-23 12:09:24,420 DEBUG : BROWSER_OUTPUT: 12:09:27 INFO - 2015-11-23 12:09:27,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43154/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:28 INFO - 2015-11-23 12:09:28,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 12:09:28 INFO - 2015-11-23 12:09:28,005 DEBUG : BROWSER_OUTPUT: 12:09:31 INFO - 2015-11-23 12:09:31,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43154/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:31 INFO - 2015-11-23 12:09:31,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 157208576 12:09:31 INFO - 2015-11-23 12:09:31,980 DEBUG : BROWSER_OUTPUT: 12:09:34 INFO - 2015-11-23 12:09:34,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43154/tests/kraken/driver.html?testName=json-parse-financial) 12:09:35 INFO - 2015-11-23 12:09:35,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 156692480 12:09:35 INFO - 2015-11-23 12:09:35,366 DEBUG : BROWSER_OUTPUT: 12:09:37 INFO - 2015-11-23 12:09:37,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:37 INFO - 2015-11-23 12:09:37,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 163176448 12:09:37 INFO - 2015-11-23 12:09:37,677 DEBUG : BROWSER_OUTPUT: 12:09:39 INFO - 2015-11-23 12:09:39,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:40 INFO - 2015-11-23 12:09:40,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 163987456 12:09:40 INFO - 2015-11-23 12:09:40,149 DEBUG : BROWSER_OUTPUT: 12:09:42 INFO - 2015-11-23 12:09:42,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:42 INFO - 2015-11-23 12:09:42,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 172027904 12:09:42 INFO - 2015-11-23 12:09:42,867 DEBUG : BROWSER_OUTPUT: 12:09:45 INFO - 2015-11-23 12:09:45,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:45 INFO - 2015-11-23 12:09:45,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 180346880 12:09:45 INFO - 2015-11-23 12:09:45,943 DEBUG : BROWSER_OUTPUT: 12:09:48 INFO - 2015-11-23 12:09:48,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:49 INFO - 2015-11-23 12:09:49,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 175800320 12:09:49 INFO - 2015-11-23 12:09:49,151 DEBUG : BROWSER_OUTPUT: 12:09:50 INFO - 2015-11-23 12:09:50,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43154/tests/kraken/driver.html?testName=ai-astar) 12:09:51 INFO - 2015-11-23 12:09:51,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 235143168 12:09:51 INFO - 2015-11-23 12:09:51,150 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,150 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:09:51 INFO - 2015-11-23 12:09:51,150 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;111;112;113;102;110;104;112 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;150;162;129;161;157;134;166;139 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;160;161;161;163;161;165;161;162 12:09:51 INFO - 2015-11-23 12:09:51,151 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;93;73;73;74;92;89;72 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;124;91;91;92;124;90;91;126 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;110 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;147;146;146;146;146;146 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;69;70;67;69;68;69;76;67;68 12:09:51 INFO - 2015-11-23 12:09:51,152 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;68;68;68;68;69;69 12:09:51 INFO - 2015-11-23 12:09:51,154 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;85;81;82;82;83;83;86;83 12:09:51 INFO - 2015-11-23 12:09:51,154 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;127;117;126;125;117;125;121;119;118 12:09:51 INFO - 2015-11-23 12:09:51,154 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;150;151;161;146;140;149;157;146;134 12:09:51 INFO - 2015-11-23 12:09:51,154 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;68;68;68;70;70;71;68;68;68 12:09:51 INFO - 2015-11-23 12:09:51,154 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:09:51 INFO - 2015-11-23 12:09:51,155 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:09:51 INFO - 2015-11-23 12:09:51,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 12:09:51 INFO - 2015-11-23 12:09:51,155 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:09:51 INFO - 2015-11-23 12:09:51,155 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309391149__endTimestamp 12:09:51 INFO - 2015-11-23 12:09:51,155 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,159 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:09:51 INFO - 2015-11-23 12:09:51,159 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:09:51 INFO - 2015-11-23 12:09:51,159 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,159 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:3.92 (3.5%) stddev-sans-first:4.15 12:09:51 INFO - 2015-11-23 12:09:51,160 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 111.0 112.0 113.0 102.0 110.0 104.0 112.0 12:09:51 INFO - 2015-11-23 12:09:51,160 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,160 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.50 stddev:14.14 (9.0%) stddev-sans-first:14.72 12:09:51 INFO - 2015-11-23 12:09:51,160 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 150.0 162.0 129.0 161.0 157.0 134.0 166.0 139.0 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.48 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 160.0 161.0 161.0 163.0 161.0 165.0 161.0 162.0 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:77.00 stddev:8.72 (11.3%) stddev-sans-first:8.95 12:09:51 INFO - 2015-11-23 12:09:51,161 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 93.0 73.0 73.0 74.0 92.0 89.0 72.0 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.20 Median:91.00 stddev:16.21 (17.8%) stddev-sans-first:16.85 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 124.0 91.0 91.0 92.0 124.0 90.0 91.0 126.0 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 12:09:51 INFO - 2015-11-23 12:09:51,162 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,163 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 12:09:51 INFO - 2015-11-23 12:09:51,163 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:2.60 (3.8%) stddev-sans-first:2.73 12:09:51 INFO - 2015-11-23 12:09:51,164 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 67.0 69.0 68.0 69.0 76.0 67.0 68.0 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.60 (1.9%) stddev-sans-first:1.54 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 85.0 81.0 82.0 82.0 83.0 83.0 86.0 83.0 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:125.00 stddev:4.09 (3.3%) stddev-sans-first:4.09 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 117.0 126.0 125.0 117.0 125.0 121.0 119.0 118.0 12:09:51 INFO - 2015-11-23 12:09:51,165 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.50 stddev:7.72 (5.2%) stddev-sans-first:8.15 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: Values: 146.0 150.0 151.0 161.0 146.0 140.0 149.0 157.0 146.0 134.0 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.52 (2.2%) stddev-sans-first:1.20 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: Values: 72.0 68.0 68.0 68.0 70.0 70.0 71.0 68.0 68.0 68.0 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:09:51 INFO - 2015-11-23 12:09:51,166 DEBUG : BROWSER_OUTPUT: 12:09:52 INFO - 2015-11-23 12:09:52,146 INFO : Browser exited with error code: 0 12:09:52 INFO - 2015-11-23 12:09:52,196 INFO : Completed test kraken (00:00:59) 12:09:52 INFO - 2015-11-23 12:09:52,196 INFO : Starting test v8_7 12:09:52 INFO - 2015-11-23 12:09:52,196 DEBUG : operating with platform_type : linux_ 12:09:52 INFO - 2015-11-23 12:09:52,196 INFO : Initialising browser for v8_7 test... 12:09:52 INFO - 2015-11-23 12:09:52,202 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnDGxum/profile http://localhost:43154/getInfo.html 12:09:55 INFO - 2015-11-23 12:09:55,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:55 INFO - 2015-11-23 12:09:55,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:55 INFO - 2015-11-23 12:09:55,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:09:55 INFO - 2015-11-23 12:09:55,760 DEBUG : BROWSER_OUTPUT: __metrics 12:09:55 INFO - 2015-11-23 12:09:55,841 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:56 INFO - 2015-11-23 12:09:56,974 INFO : Browser initialized. 12:09:56 INFO - 2015-11-23 12:09:56,974 INFO : Running cycle 1/1 for v8_7 test... 12:09:56 INFO - 2015-11-23 12:09:56,974 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnDGxum/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:10:08 INFO - 2015-11-23 12:10:08,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 139911168 12:10:08 INFO - 2015-11-23 12:10:08,843 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43154/tests/v8_7/run.html (next: http://localhost:43154/tests/v8_7/run.html) 12:10:30 INFO - 2015-11-23 12:10:30,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 440950784 12:10:30 INFO - 2015-11-23 12:10:30,612 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: |0;Richards;164.33853738701725 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.60402436773123 12:10:30 INFO - 2015-11-23 12:10:30,614 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.251256281407 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |5;Earley;780.2026500389711 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |6;Boyer;12035.714285714286 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |8;Splay;597.2797161442933 12:10:30 INFO - 2015-11-23 12:10:30,615 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: __startTimestamp1448309430612__endTimestamp 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:10:30 INFO - 2015-11-23 12:10:30,616 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.34 Median:164.34 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: Values: 164.3 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.60 Median:184.60 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: Values: 184.6 12:10:30 INFO - 2015-11-23 12:10:30,617 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,618 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: Values: 280.7 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.25 Median:5050.25 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: Values: 5050.3 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: Values: 1984.1 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.20 Median:780.20 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: Values: 780.2 12:10:30 INFO - 2015-11-23 12:10:30,619 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12035.71 Median:12035.71 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: Values: 12035.7 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: Values: 26763.2 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.28 Median:597.28 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: Values: 597.3 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: Values: 4859.2 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:10:30 INFO - 2015-11-23 12:10:30,620 DEBUG : BROWSER_OUTPUT: 12:10:31 INFO - 2015-11-23 12:10:31,526 INFO : Browser exited with error code: 0 12:10:31 INFO - 2015-11-23 12:10:31,542 INFO : Completed test v8_7 (00:00:39) 12:10:32 INFO - 2015-11-23 12:10:32,019 INFO : Completed test suite (00:20:17) 12:10:32 INFO - 2015-11-23 12:10:32,019 DEBUG : Working with test: dromaeo_css 12:10:32 INFO - 2015-11-23 12:10:32,019 DEBUG : Generating results file: dromaeo_css 12:10:32 INFO - 2015-11-23 12:10:32,020 DEBUG : Working with test: kraken 12:10:32 INFO - 2015-11-23 12:10:32,020 DEBUG : Generating results file: kraken 12:10:32 INFO - 2015-11-23 12:10:32,021 INFO : javascript benchmark 12:10:32 INFO - 2015-11-23 12:10:32,021 DEBUG : Working with test: v8_7 12:10:32 INFO - 2015-11-23 12:10:32,021 DEBUG : Generating results file: v8_7 12:10:32 INFO - 2015-11-23 12:10:32,021 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:32 INFO - 2015-11-23 12:10:32,085 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:10:32 INFO - 2015-11-23 12:10:32,085 DEBUG : process_Request line: dromaeo_css 6290.26 graph.html#tests=[[72,132,35]] 12:10:32 INFO - 2015-11-23 12:10:32,085 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:32 INFO - 2015-11-23 12:10:32,118 DEBUG : process_Request line: kraken 1509.60 graph.html#tests=[[232,132,35]] 12:10:32 INFO - 2015-11-23 12:10:32,118 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:10:32 INFO - 2015-11-23 12:10:32,150 DEBUG : process_Request line: v8_7 19952.26 graph.html#tests=[[230,132,35]] 12:10:32 INFO - 2015-11-23 12:10:32,151 INFO : javascript benchmark 12:10:32 INFO - 2015-11-23 12:10:32,154 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2656.747608977147, 2725.8364498130113, 2740.671119465662, 2750.0649779075125, 2762.557990721484, 4573.24541450661, 4704.082703872747, 4713.3401323814605, 4721.811127554894, 4726.527347265272, 4586.403767510219, 4595.770211489421, 4670.369500117483, 4685.086408150403, 4694.9765251173785, 4364.912701745955, 4369.169857727037, 4393.780310984438, 4394.6703997200175, 4424.734515929054, 4217.114405974734, 4432.8005239764125, 4448.599626033656, 4494.123645889053, 4494.8202071917085, 4306.784660766981, 4311.719738217006, 4372.715773474746, 4401.295792673157, 4409.140217657558, 4303.074838909618, 4353.172897149531, 4355.346697995295, 4388.275934470808, 4388.824447022115, 4139.586041395866, 4318.568143185687, 4318.719283246579, 4338.696291259613, 4386.254336762758, 4519.661025423106, 4560.954390456086, 4581.8396356127705, 4689.88275293117, 4720.527947205286, 5080.974595127001, 5103.872403189913, 5106.591472682214, 5125.282460455539, 5150.871228219287, 4773.0, 5130.486951304877, 5158.74206289684, 5166.61250406221, 5167.199084141964, 4532.954670453253, 4605.240135377625, 4605.309203619484, 4621.260598304255, 4634.467036290802, 5220.947790522122, 5221.399539052982, 5222.843314700565, 5228.37259528859, 5271.182966640177, 5017.84946451607, 5017.9247311290355, 5021.974890125526, 5029.446760856303, 5069.087564238473, 4849.4908034656555, 4930.6795058321095, 4952.331435256195, 4955.876103097451, 5100.38795344561, 4909.877253068702, 4913.336699545587, 4915.336429582032, 4949.901001980013, 5009.348784658044, 4886.413630364379, 4887.902241955141, 4889.755512224375, 4903.4606193318705, 4955.776990035457, 3991.3613821788376, 4117.958820411817, 4123.958760412417, 4163.208990291835, 4209.579042095827, 3708.9258214835554, 3713.1088538750505, 3717.9628203718157, 3743.438484227333, 3750.137468382233, 4379.9781001095425, 4381.18947994622, 4382.233109205877, 4390.341448782644, 4417.4036505072045, 4845.927311090337, 4961.4046314441775, 4963.205887058053, 5086.847394578169, 5135.075686376488, 4233.5131459882505, 4288.549702281278, 4316.136772645484, 4317.179735850178, 4352.194843953878, 4484.506704262529, 4498.302763071729, 4510.233260345683, 4511.977440112844, 4552.954470455253, 4821.975890120527, 4827.758612069312, 4828.806847726051, 4830.565249127455, 4874.2444921037295, 4806.47128815837, 4916.139675556692, 4929.260610908393, 4929.876753081202, 5026.899462010666, 4705.952940470552, 4706.599939005223, 4709.246520556694, 4724.669273150984, 4773.76131193432, 4881.463039065629, 4888.584470320063, 4890.682105663121, 4899.069176856386, 4915.238138088602, 4738.123447162286, 4795.760211989317, 4849.878753031061, 4928.137575924271, 5030.522100400456, 4851.95148048515, 4884.65807393479, 4899.191633380452, 4902.63230257725, 4937.604991600735, 4878.341423907869, 4897.314375987436, 4899.0, 4906.215005599087, 4935.111679897509, 4584.793684284148, 4698.671093023592, 4707.62339012885, 4710.505396933273, 4715.198416269174, 4854.927176092432, 4932.334134891744, 4972.0801651694555, 4985.601151907911, 4987.47631498702, 4794.976025119852, 4814.133455977958, 4820.156472617208, 4823.155947709067, 4858.757062146808], "unit": "ms", "name": "dojo.html", "value": 4605.202935433859}, {"lowerIsBetter": false, "replicates": [565.1099518258743, 570.6690119730557, 575.3441077172025, 575.6172145523227, 577.6303165973775, 27799.305017374576, 28742.281442963937, 36444.27111457769, 37275.254494910085, 37318.81340593293, 40917.0, 41408.0, 41473.792631036806, 41535.79232103835, 41538.7923060385, 6921.584704917721, 7873.8818917716135, 7970.282674559288, 8026.157253488358, 8052.557109358983, 7079.1858936222225, 9944.5524951377, 10134.543945522433, 10139.797204055914, 10148.695539133838, 9973.950130249375, 10053.899461005369, 10057.597696092147, 10058.89941100587, 10065.949670251675, 7156.177039640456, 7323.304286092813, 9958.053984871425, 9967.40195588267, 10214.89785102147, 9735.17251033663, 9847.261455390875, 9849.21206303494, 9852.310338276251, 9856.90143098567, 37563.0, 38140.23719525622, 38156.0, 38158.618413815784, 38165.61834381648, 2664.467106578692, 2892.0, 3144.0724986128916, 3250.951235731466, 3415.3202359711936, 28430.289242769097, 28463.71536284652, 28663.426731465253, 28836.134915952556, 29121.708782912112, 3361.193313604742, 3521.9295614087573, 3544.0962554548423, 3566.946495802565, 3638.8362523686496, 229237.0, 231126.0, 231202.0, 231659.0, 231874.0, 53421.1986820198, 54197.0, 54240.0, 57618.42381576131, 58042.709786450796, 60673.39326606766, 61645.691771540856, 61903.690481548205, 62042.37957620456, 62057.37942620516, 13171.868281317256, 13358.131721438076, 13370.46518139283, 13372.997025223147, 13376.331183440789, 9291.953540232256, 9314.813703726024, 9336.346455748168, 9340.112689294507, 9346.392484488486, 18912.905435472734, 19070.14184361707, 19859.665524563472, 19885.204591816455, 19960.10179541924, 7501.699932002768, 7771.844563108706, 7801.258880406353, 7801.336886364609, 7826.804329891798, 787.6573690444675, 818.7830224990382, 935.7146070448442, 1009.3187098708343, 1028.89711028898, 26600.60099098515, 26769.732302677112, 26862.865685671837, 26928.730712693014, 27056.0, 927.7031349967946, 938.2259635800356, 984.7095106943469, 999.5252255178732, 1038.4184856480244, 13764.449422023006, 14008.06161950754, 14060.367283472267, 14073.648158795908, 14129.929350353388, 281261.0, 285048.0, 285746.0, 285801.0, 286264.0, 38625.61374386276, 38952.61047389547, 46363.536364636595, 47089.0, 47177.0, 1132.750794825137, 1156.5778490850778, 1163.7032556698157, 1195.4321697193764, 1196.5094311332311, 25078.3730406734, 26486.735132648428, 26816.865915670296, 26924.0, 27021.459570808867, 36413.27173456463, 37104.81447592745, 37834.43248351222, 42431.0, 43221.567784321756, 175421.0, 176003.0, 177354.0, 177619.0, 177894.11052944654, 27653.446931060862, 28091.297717557223, 28095.43809123847, 28096.85951570229, 28115.297117572223, 39174.0, 39965.20069598534, 39974.40038399484, 40079.59920400759, 40534.594654054265, 38213.61786382212, 38426.807865960494, 39598.80200598978, 40124.3981340286, 40158.79920600378, 34242.31515369629, 38198.42702359522, 39510.0, 39928.0, 40463.797681011405, 35175.47236791501, 35387.82306088453, 38832.417513737884, 39498.40752388659, 39629.80185099056, 29418.411631766816, 30670.693293066783, 31175.688243117278, 31264.687353126177, 31355.529667055467, 24203.0, 24263.393415164057, 24406.633900491153, 24542.0, 24624.753752462246], "unit": "ms", "name": "ext.html", "value": 17328.895049232004}, {"lowerIsBetter": false, "replicates": [340.0699087994335, 341.50311297062774, 341.64980894583056, 343.85214357826135, 347.6888185074358, 12452.31512266825, 12732.236065836034, 14917.179555124463, 15217.315220815062, 15962.600934976632, 14247.14517128973, 14260.857391426083, 14635.19506427146, 14654.267286635652, 14759.631009224775, 3763.3978563429855, 4092.1815636872598, 4512.323151527273, 4638.141943740419, 4640.953590464086, 3334.1664583854035, 3443.707284880788, 4598.770061496928, 5101.591872650179, 5316.548093412064, 5258.605604579653, 5279.128943724281, 5287.524122828944, 5313.362396512404, 5321.281626980366, 5244.55421289189, 5343.839684809462, 5729.598928075036, 5731.598788084857, 5733.655980641175, 5076.720780357079, 5077.390713114413, 5082.822101226439, 5084.567811736007, 5091.1854103343285, 19017.61964760697, 19206.711899321523, 19884.80115198844, 19889.20443182271, 19903.90048049765, 1849.7965223825368, 1856.3409989453685, 1902.980970190308, 1922.9615407691908, 2002.2291417804104, 8574.657013719443, 8780.770692103111, 8965.148310910454, 9194.770130746785, 9211.677591284273, 1700.6853732059485, 1724.2585688154088, 1785.7857057153224, 1798.9460316190534, 1807.150639199574, 47307.290390644164, 47850.52149478495, 48965.0, 56447.71776141134, 57148.0, 9878.616993620899, 9895.604175832887, 9910.702678919644, 9946.254030947708, 9958.30291879576, 12633.494660213672, 12646.30445325516, 12675.93662031684, 12676.30280334572, 12679.112462127563, 6492.545521813522, 6543.280239173687, 6547.181602299713, 6620.304867988888, 6902.378785909192, 6054.757809687651, 6465.224173099258, 6520.0, 6538.476921846241, 6545.770898018546, 4161.542230354658, 4184.790760461965, 4193.874183774492, 4221.767802770877, 4252.319628859368, 1615.2811998660718, 1654.9586260343588, 1670.490500397366, 1707.4280116160976, 1738.9217485213196, 375.69944044764077, 379.65451439190207, 747.637395863006, 767.1216457156636, 806.1776987472745, 9776.441781299112, 10503.264771465923, 16197.4330898418, 16670.333186672397, 17261.39585114515, 739.4343327354578, 799.4403917257943, 800.6037011679256, 813.5362843179331, 822.3174764945081, 8733.388662793543, 8911.821763564822, 8981.416207946462, 9017.188453039258, 9158.954205229065, 509250.0, 517941.0, 521843.0, 536091.2368067099, 538293.0, 69912.0, 70427.0, 70434.64782676054, 70664.2933570668, 71515.28484715191, 1067.0609863320228, 1072.158355690779, 1077.095239998405, 1077.515118196799, 1077.9083777878811, 13927.123891378835, 14075.648108796953, 14184.290785460893, 14287.57137285883, 14382.195471882882, 30781.846090769403, 31221.0, 31459.685403145675, 31940.0, 32439.513407298437, 43763.78118109389, 43913.56086439094, 44070.0, 45661.315080274486, 47197.528024719315, 8948.73153805387, 9118.863217051618, 9267.0, 9335.206507446672, 9375.0, 10802.837957430802, 10843.240973131806, 12039.33783641873, 16760.916195418944, 17105.14474276306, 13942.930285348508, 14136.858631413554, 14272.500462483764, 14361.425542978164, 14512.709745805236, 13331.400086995915, 13731.24478153711, 14046.648833778829, 14115.858841411455, 14166.929165354108, 11267.380294083903, 13760.65598360049, 14086.15483071019, 14476.203808790618, 14723.190224537753, 9072.0, 9283.907160928304, 9290.489023103793, 9305.441673499612, 9322.813543729224, 9514.19129374011, 9530.142287194185, 9550.188234000188, 9632.0, 13668.248246346546], "unit": "ms", "name": "jquery.html", "value": 8027.432594487908}, {"lowerIsBetter": false, "replicates": [1217.5373358123911, 1544.07355586648, 1600.679864027194, 1627.9430219942296, 1683.1920678074523, 5621.325440947087, 6205.751769929203, 6328.177336946196, 6349.142865713127, 6349.396807303298, 6490.935090649092, 6591.472682185426, 6591.5715478493985, 6596.7691130810435, 6611.636360000198, 2026.858119931609, 2029.553498230387, 2035.1248962946001, 2044.7341845560131, 2045.5806559655234, 2048.5288383671764, 2049.4568939231117, 2050.8974551272377, 2082.375287413777, 2087.290321290761, 2014.909329080195, 2021.070307658479, 2034.6541088015074, 2035.7862424445443, 2036.1448191759423, 2015.5085236924645, 2031.7155598216261, 2032.0449388787247, 2034.8168664820237, 2034.9084291206932, 2040.4286799696108, 2061.68043953186, 2077.096463038568, 2078.262216912989, 2079.376187143866, 5616.550675945915, 5766.0486019806685, 6556.213254409454, 6556.672166391661, 6572.244191917943, 3867.4778904847767, 3956.960430395688, 3964.920701585981, 3970.1861118470642, 3977.8209980550655, 2712.6744790625053, 2722.060888993314, 2751.4222013377216, 2755.0357374918817, 2865.6991015943445, 868.5830801215388, 883.8099808541131, 884.7434244069276, 888.1518150166576, 907.9773005674845, 8589.398742088057, 8626.353023523197, 8639.438436501607, 8661.653533858638, 8661.826763464695, 3848.5958974307296, 3877.3408520551575, 3878.553966293856, 3916.1776027034643, 3925.725199236083, 7595.0, 7600.961995189989, 7601.961990190013, 7623.847523049508, 7632.19861914491, 4092.46797916269, 4098.73358231714, 4125.690573207022, 4140.420341152241, 4145.854895078658, 3727.4967879336486, 3754.3805272129794, 3757.361248587692, 3757.887263382103, 3764.5670747864347, 3208.4866421372467, 3220.8872689455757, 3221.903342899717, 3223.9194020149216, 3237.4010808000594, 1045.717656232813, 1053.3416614615865, 1075.725689949058, 1076.8653918260218, 1087.7606926476162, 897.4211633496358, 929.9770252722087, 1160.0255785140523, 1169.771894480568, 1178.8290697848763, 6396.968015159894, 6455.354464553507, 6460.160179176771, 6474.514411419163, 6476.125723027425, 1022.7801022780138, 1026.2457094035879, 1026.712520494263, 1040.3185913226848, 1066.1257768629805, 4562.041971186088, 5074.340335756328, 5115.488451154854, 5117.283580298761, 5117.897642047138, 6806.931930680729, 7592.278733520307, 7671.156172821097, 7718.614069296513, 7726.4591478597085, 7629.122650895107, 7682.231776822385, 7744.612769361509, 7764.961175194201, 7771.261730135628, 5872.0898260769645, 6051.273847138372, 6077.301110372276, 6077.969610152009, 6158.291796443376, 6257.874842503215, 6306.621602703853, 6311.463525600192, 6315.936840631535, 6317.052442133717, 7033.929660703532, 7187.425005999612, 7220.675069621985, 7262.455315851226, 7266.527675701062, 6685.866282674417, 6852.965735171292, 6872.793816185523, 6873.1442510522875, 7311.926880731125, 6111.816645500642, 6415.615063096229, 6452.064450654722, 6461.289258181502, 6470.870582588416, 6355.90466142999, 6405.935940640534, 6416.358364163546, 6421.743130274736, 6423.100765892686, 5918.408159184047, 6045.576809623284, 6114.0, 6193.194884664965, 6211.068339749074, 5851.795187168599, 5945.167676525203, 5977.432143946318, 5999.040153575407, 6038.849028774316, 6083.756649733961, 6111.908321375272, 6181.690915454299, 6195.287541932736, 6199.938000619936, 5598.776048957996, 5646.0683987141665, 5673.120666296731, 5679.801206957736, 5684.488396044376, 5647.971760141173, 5677.574181936288, 5718.571107167062, 5719.28508936383, 5719.971400142973], "unit": "ms", "name": "mootools.html", "value": 3911.31837626383}, {"lowerIsBetter": false, "replicates": [314.3963589907378, 318.3775718470389, 319.7921351121772, 321.79887570268585, 322.55809540928925, 5389.407165211824, 5394.703291318976, 5415.458454154583, 5416.214648875915, 5425.403205647375, 5083.745812709368, 5189.6886186828815, 5252.973735131329, 5369.5704343652515, 5372.194170874371, 4181.247375472413, 4200.432941552897, 4212.55768144345, 4214.620684138427, 4218.4937807463075, 3996.8800935971967, 4210.3894935234375, 4215.725977811432, 4220.53574106848, 4222.19778242133, 4020.4572382728397, 4074.3684728867074, 4194.853180138696, 4200.810963506649, 4215.199112168678, 4202.348635961431, 4203.159368126372, 4203.97898010511, 4206.0115872769875, 4206.810693518783, 3711.0722319420147, 3711.628837116267, 3716.0338312038793, 3720.386136287509, 3721.5534135903863, 5180.171172612364, 5187.844364669066, 5191.974040129813, 5198.064348417283, 5205.713685747282, 4680.321353403771, 4821.566059054702, 4827.85516434504, 4829.0, 4870.0, 5684.2326285951285, 5719.542436605062, 5728.914066289009, 5731.99690054243, 5739.82780516581, 3965.920681586352, 3970.960290397088, 3971.086650070471, 3972.324704800191, 3972.3644216925154, 5935.9406405935815, 6011.068284415923, 6013.75944962201, 6017.909731354077, 6022.578419510636, 3977.0455090778005, 4104.548499665035, 4105.158442519277, 4107.466029416217, 4127.0, 4151.501819781585, 4157.5010998679745, 4165.83336666536, 4169.10364271683, 4169.1661667666585, 4764.190087685102, 4782.139214941274, 4785.808567657255, 4787.928181077286, 4798.47216806151, 5694.060480020833, 5696.746715722535, 5705.343885453143, 5705.372409035002, 5708.885822283531, 1432.3769160415252, 1453.840077591464, 1461.8684318411395, 1462.144645382463, 1471.8896082793833, 978.1441238915949, 989.7871957529165, 991.1426615977127, 1002.0430488883245, 1003.1623594298842, 4905.2151655734915, 4933.605311575066, 4990.2035267303745, 4992.350994370709, 4994.975025124923, 5864.9413505864395, 5870.0, 5873.911891321633, 5879.441453062038, 5881.676507792027, 4836.419629644465, 4929.383827021622, 4935.0, 4984.077945580079, 5081.136206844845, 3167.651558328582, 3184.1084496341064, 3204.9359012819614, 3211.775175737676, 3213.839308034636, 5640.182173584807, 5641.379448260688, 5644.068728659725, 5644.85887852807, 5647.068233741386, 6113.57204995646, 6136.294326152461, 6140.478059364915, 6140.8771824563255, 6141.907871381933, 5640.717964101696, 5643.984082865041, 5644.322681278273, 5644.899244647254, 5648.830535083872, 5961.642301461926, 5970.0, 5971.970140149445, 5977.133315669116, 5984.1921340618455, 5771.7402716877, 5829.271341082364, 5833.0, 5838.532917366685, 5842.766289348378, 5521.972390138184, 5637.661740295595, 5656.236408084856, 5664.745086471201, 5664.773409063591, 4103.425520427202, 4110.445089912823, 4111.424400583861, 4113.506379234511, 4114.547399786081, 5966.0454327307425, 5970.58205925581, 5972.522198224218, 5975.25309336333, 5987.43119403656, 5605.355384130877, 5727.055035919193, 5730.684812335361, 5735.684537350486, 5736.942630573641, 5721.170430287501, 5726.914096288476, 5735.799247026334, 5737.340205876378, 5737.8524295140305, 5609.80365687199, 5616.382197958303, 5617.269754931996, 5620.381758006534, 5622.8313150605545, 5632.943670563406, 5738.081906894877, 5748.137779333133, 5769.076947688518, 5770.163326317576, 5619.466150715675, 5627.099664053731, 5628.127640215773, 5632.239647647679, 5633.8309850704545], "unit": "ms", "name": "prototype.html", "value": 4293.872832138675}, {"lowerIsBetter": false, "replicates": [689.3072462175513, 768.8846672999049, 777.1761932351711, 777.9662450195732, 788.9013873265843, 11294.774104517905, 11611.303321800677, 11631.941840290787, 11644.30134191948, 11657.417129143541, 11917.880821191786, 12027.278363298186, 12038.097142714289, 12043.09676774241, 12068.094892883048, 775.5424299663198, 805.7341077444429, 806.0408114343941, 806.4596720197482, 806.5523634382915, 798.4291231769283, 809.76516810125, 809.9311558517533, 810.0846043970305, 810.3638643664724, 841.4446465332882, 845.8096928191169, 848.1476116502906, 848.8896443462372, 849.0405841399211, 846.5005646668495, 847.4788005376711, 847.8516259654566, 848.3764433141636, 848.5078654380444, 621.3879328861068, 625.1529177963885, 628.4281304013326, 628.6228263042184, 629.8299459146051, 11644.41777911101, 11678.357690327028, 11750.118741094451, 11750.529978800838, 11773.764524709457, 11033.779324413466, 11100.0, 11187.608433704781, 11334.206605537616, 11846.289222646668, 9427.292953028482, 9528.618855245782, 9750.853737193947, 9759.756006099833, 9782.706518804447, 3149.9685003149903, 3222.9677703223138, 3257.2996805686653, 3268.0522648431925, 3279.6556361582166, 34194.0, 34861.0, 38195.42706859399, 39052.21895562073, 41054.79472602618, 8985.415947963362, 9042.547872606343, 9111.27109831212, 9245.410608802864, 9528.047195280416, 15924.840751592568, 16246.268917898722, 16254.91156680227, 16275.186240688156, 16293.51119466418, 6393.136926514954, 6433.195850518685, 6462.7738029169695, 6484.481241500669, 6534.085228068075, 3565.2512972275595, 3566.589842168132, 3581.54754778722, 3598.3882739934274, 3640.2719456108352, 2793.580962855547, 2840.8721607527295, 2844.900428484993, 2846.5018621741115, 2849.6722876869426, 476.3521610609568, 482.9903401931942, 486.3021564055592, 487.06969687895946, 502.2466300549176, 482.4692837878306, 496.91304021796043, 518.8650950752832, 573.6214098694842, 603.4116736182187, 7792.220777922275, 8032.236937490929, 8034.196580341919, 8066.0, 8175.795605109801, 582.6329412470202, 607.4714997951722, 609.7103875659116, 612.5467154305782, 619.1115748900343, 3587.318409502186, 3773.2264885698914, 3875.1668391296007, 3906.5898080701118, 4162.0, 48543.5145648546, 48791.26813097807, 49146.50853491491, 50171.49828501741, 51663.0, 39650.801745991084, 40222.59777402189, 40373.77009839206, 40816.591834081875, 40870.59129408668, 34126.82936585351, 40113.598864010986, 40324.0, 40634.390484142765, 41227.7938610311, 8010.879836802569, 8158.755237342889, 8236.711715089943, 8354.329134173067, 8536.573171341532, 31476.685233147375, 31762.205944851565, 32633.836830816643, 33630.831845840614, 34340.14149646279, 39410.80294598509, 39504.80247598859, 40129.39805902972, 40197.397039043855, 40372.3944140844, 9459.527023648652, 9991.70024899225, 10347.689569312932, 10421.739456513344, 10451.059404653617, 11213.15901307389, 11260.09919206478, 11272.0, 11485.540578376771, 11566.94216528912, 10652.946735266274, 10667.433774916652, 10882.29265097766, 10987.340759554452, 11199.0, 10422.0, 10532.420716860646, 10666.093382062612, 10836.891631083588, 11021.889781102087, 10195.286329956833, 10371.533281002525, 10452.529636166239, 10545.456347141928, 10666.626668066581, 8450.239478446969, 9473.0, 9549.140577348073, 9560.61757529691, 9632.855507167258, 8893.333000024895, 9005.819883602422, 9120.954395227982, 9190.448573085636, 9278.582463789011], "unit": "ms", "name": "yui.html", "value": 5757.019469418999}], "name": "dromaeo_css", "value": 6290.263841912713}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 111.0, 112.0, 113.0, 102.0, 110.0, 104.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 150.0, 162.0, 129.0, 161.0, 157.0, 134.0, 166.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0, 165.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 80.0, 93.0, 73.0, 73.0, 74.0, 92.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 124.0, 91.0, 91.0, 92.0, 124.0, 90.0, 91.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 101.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 67.0, 69.0, 68.0, 69.0, 76.0, 67.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 69.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 85.0, 81.0, 82.0, 82.0, 83.0, 83.0, 86.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 117.0, 126.0, 125.0, 117.0, 125.0, 121.0, 119.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [146.0, 150.0, 151.0, 161.0, 146.0, 140.0, 149.0, 157.0, 146.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 68.0, 68.0, 70.0, 70.0, 71.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1509.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.33853738701725], "unit": "score", "name": "Richards", "value": 214.81267000000008}, {"lowerIsBetter": false, "replicates": [184.60402436773123], "unit": "score", "name": "DeltaBlue", "value": 358.16120599999994}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5050.251256281407], "unit": "score", "name": "Decrypt", "value": 52.70648656716413}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [780.2026500389711], "unit": "score", "name": "Earley", "value": 854.2178111888112}, {"lowerIsBetter": false, "replicates": [12035.714285714286], "unit": "score", "name": "Boyer", "value": 55.37378041543021}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [597.2797161442933], "unit": "score", "name": "Splay", "value": 136.43691188118814}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19952.261136643257}]} 12:10:32 INFO - RETURN: dromaeo_css: 6290.26 12:10:32 INFO - RETURN: kraken: 1509.60 12:10:32 INFO - RETURN: v8_7: 19952.26 12:10:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19952.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1509.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6290.26"}}} 12:10:32 INFO - Return code: 0 12:10:32 INFO - # TBPL SUCCESS # 12:10:32 INFO - Running post-action listener: _resource_record_post_action 12:10:32 INFO - Running post-run listener: _resource_record_post_run 12:10:33 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509964288; Read time: 92; Write time: 333068 12:10:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 132501504; Read time: 0; Write time: 86992 12:10:33 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 333176832; Read time: 0; Write time: 224192 12:10:33 INFO - Running post-run listener: _upload_blobber_files 12:10:33 INFO - Blob upload gear active. 12:10:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:10:33 INFO - Copying logs to upload dir... 12:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.024517 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-23 12:10:33.170856) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:33.176009) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010061 build_url: 'https://queue.taskcluster.net/v1/task/gewOLAYdT8SnmmRBdBc0dA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:33.240155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:33.240499) ========= 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=cd88c086d1ff67493cfd1714000001ba-1448302114.886836-306954097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:10:33.291416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:33.291718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:10:33.291987) ========= ========= Total master_lag: 0.29 =========