builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1455300886.12 results: success (0) buildid: 20160212074915 builduid: 066824049d7240118c09b83e2d003829 revision: ce08fa9d4ed6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.117890) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.118458) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.118805) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006372 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.142254) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.142601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.155942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.156264) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.205539) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.205862) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.206271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.206594) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-12 10:14:46-- 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% 50.0M=0s 2016-02-12 10:14:46 (50.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.327259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.327580) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022186 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.380374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.380770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ce08fa9d4ed6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ce08fa9d4ed6 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-12 10:14:46,788 Setting DEBUG logging. 2016-02-12 10:14:46,788 attempt 1/10 2016-02-12 10:14:46,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ce08fa9d4ed6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 10:14:47,102 unpacking tar archive at: mozilla-beta-ce08fa9d4ed6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.983521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:46.984167) ========= echo ce08fa9d4ed6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ce08fa9d4ed6'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ce08fa9d4ed6 program finished with exit code 0 elapsedTime=0.004027 script_repo_revision: 'ce08fa9d4ed6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:47.034242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:47.034623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:14:47.044635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-12 10:14:47.045018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:47 INFO - MultiFileLogger online at 20160212 10:14:47 in /builds/slave/test-pgo 10:14:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:14:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:14:47 INFO - {'append_to_log': False, 10:14:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:14:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:14:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:14:47 INFO - 'branch': 'Mozilla-Beta', 10:14:47 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:47 INFO - 'config_files': ('talos/linux_config.py',), 10:14:47 INFO - 'default_actions': ('clobber', 10:14:47 INFO - 'read-buildbot-config', 10:14:47 INFO - 'download-and-extract', 10:14:47 INFO - 'populate-webroot', 10:14:47 INFO - 'create-virtualenv', 10:14:47 INFO - 'install', 10:14:47 INFO - 'run-tests'), 10:14:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:47 INFO - 'download_minidump_stackwalk': True, 10:14:47 INFO - 'download_symbols': 'ondemand', 10:14:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:47 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:47 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:47 INFO - 'installer_path': 'installer.exe', 10:14:47 INFO - 'log_level': 'info', 10:14:47 INFO - 'log_name': 'talos', 10:14:47 INFO - 'log_to_console': True, 10:14:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:47 INFO - 'opt_config_files': (), 10:14:47 INFO - 'pip_index': False, 10:14:47 INFO - 'sps_profile': False, 10:14:47 INFO - 'sps_profile_interval': 0, 10:14:47 INFO - 'suite': 'dromaeojs', 10:14:47 INFO - 'system_bits': '32', 10:14:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:47 INFO - 'title': 'talos-linux64-ix-059', 10:14:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:47 INFO - 'use_talos_json': True, 10:14:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:14:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:47 INFO - 'work_dir': 'build'} 10:14:47 INFO - ##### 10:14:47 INFO - ##### Running clobber step. 10:14:47 INFO - ##### 10:14:47 INFO - Running pre-action listener: _resource_record_pre_action 10:14:47 INFO - Running main action method: clobber 10:14:47 INFO - rmtree: /builds/slave/test-pgo/build 10:14:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:14:48 INFO - Running post-action listener: _resource_record_post_action 10:14:48 INFO - ##### 10:14:48 INFO - ##### Running read-buildbot-config step. 10:14:48 INFO - ##### 10:14:48 INFO - Running pre-action listener: _resource_record_pre_action 10:14:48 INFO - Running main action method: read_buildbot_config 10:14:48 INFO - Using buildbot properties: 10:14:48 INFO - { 10:14:48 INFO - "properties": { 10:14:48 INFO - "buildnumber": 106, 10:14:48 INFO - "product": "firefox", 10:14:48 INFO - "script_repo_revision": "production", 10:14:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:14:48 INFO - "repository": "", 10:14:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:14:48 INFO - "buildid": "20160212074915", 10:14:48 INFO - "slavename": "talos-linux64-ix-059", 10:14:48 INFO - "pgo_build": "True", 10:14:48 INFO - "basedir": "/builds/slave/test-pgo", 10:14:48 INFO - "project": "", 10:14:48 INFO - "platform": "ubuntu64_hw", 10:14:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:14:48 INFO - "slavebuilddir": "test", 10:14:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:14:48 INFO - "branch": "mozilla-beta", 10:14:48 INFO - "repo_path": "releases/mozilla-beta", 10:14:48 INFO - "stage_platform": "linux64-pgo", 10:14:48 INFO - "builduid": "066824049d7240118c09b83e2d003829", 10:14:48 INFO - "revision": "ce08fa9d4ed6" 10:14:48 INFO - }, 10:14:48 INFO - "sourcestamp": { 10:14:48 INFO - "repository": "", 10:14:48 INFO - "hasPatch": false, 10:14:48 INFO - "project": "", 10:14:48 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:14:48 INFO - "changes": [ 10:14:48 INFO - { 10:14:48 INFO - "category": null, 10:14:48 INFO - "files": [ 10:14:48 INFO - { 10:14:48 INFO - "url": null, 10:14:48 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:14:48 INFO - } 10:14:48 INFO - ], 10:14:48 INFO - "repository": "", 10:14:48 INFO - "rev": "ce08fa9d4ed6", 10:14:48 INFO - "who": "sendchange", 10:14:48 INFO - "when": 1455300808, 10:14:48 INFO - "number": 7600917, 10:14:48 INFO - "comments": "Bug 1228103. r=smaug. a=sylvestre", 10:14:48 INFO - "project": "", 10:14:48 INFO - "at": "Fri 12 Feb 2016 10:13:28", 10:14:48 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:14:48 INFO - "revlink": "", 10:14:48 INFO - "properties": [ 10:14:48 INFO - [ 10:14:48 INFO - "buildid", 10:14:48 INFO - "20160212074915", 10:14:48 INFO - "Change" 10:14:48 INFO - ], 10:14:48 INFO - [ 10:14:48 INFO - "builduid", 10:14:48 INFO - "066824049d7240118c09b83e2d003829", 10:14:48 INFO - "Change" 10:14:48 INFO - ], 10:14:48 INFO - [ 10:14:48 INFO - "pgo_build", 10:14:48 INFO - "True", 10:14:48 INFO - "Change" 10:14:48 INFO - ] 10:14:48 INFO - ], 10:14:48 INFO - "revision": "ce08fa9d4ed6" 10:14:48 INFO - } 10:14:48 INFO - ], 10:14:48 INFO - "revision": "ce08fa9d4ed6" 10:14:48 INFO - } 10:14:48 INFO - } 10:14:48 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:14:48 INFO - Running post-action listener: _resource_record_post_action 10:14:48 INFO - ##### 10:14:48 INFO - ##### Running download-and-extract step. 10:14:48 INFO - ##### 10:14:48 INFO - Running pre-action listener: _resource_record_pre_action 10:14:48 INFO - Running main action method: download_and_extract 10:14:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:14:48 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')]} 10:14:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/test_packages.json 10:14:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:14:48 INFO - Downloaded 1270 bytes. 10:14:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:14:48 INFO - Using the following test package requirements: 10:14:48 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:14:48 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:48 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'jsshell-linux-x86_64.zip'], 10:14:48 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:48 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:14:48 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:14:48 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:14:48 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:48 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:14:48 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:14:48 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:48 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:48 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')]} 10:14:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:48 INFO - Downloaded 21581705 bytes. 10:14:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:14:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:14:50 INFO - Return code: 0 10:14:50 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:14:50 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')]} 10:14:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:50 INFO - Downloaded 21581705 bytes. 10:14:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:14:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:14:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:14:51 INFO - Return code: 0 10:14:51 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')]} 10:14:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:52 INFO - Downloaded 11132038 bytes. 10:14:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:14:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:14:52 INFO - Return code: 0 10:14: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')]} 10:14:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:52 INFO - Downloaded 57936231 bytes. 10:14:52 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:52 INFO - mkdir: /builds/slave/test-pgo/properties 10:14:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:14:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:14:52 INFO - Contents: 10:14:52 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:53 INFO - Running post-action listener: _resource_record_post_action 10:14:53 INFO - Running post-action listener: set_extra_try_arguments 10:14:53 INFO - ##### 10:14:53 INFO - ##### Running populate-webroot step. 10:14:53 INFO - ##### 10:14:53 INFO - Running pre-action listener: _resource_record_pre_action 10:14:53 INFO - Running main action method: populate_webroot 10:14:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:53 INFO - '--tppagecycles', 10:14:53 INFO - '7'], 10:14:53 INFO - 'tests': ['tsvgm']}}, 10:14:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:14:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:14:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:14:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'tests': ['damp', 'tps']}, 10:14:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['damp', 'tps']}, 10:14:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:14:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:53 INFO - 'other': {'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'other_l64': {'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'other_nol64': {'tests': ['a11yr', 10:14:53 INFO - 'ts_paint', 10:14:53 INFO - 'tpaint', 10:14:53 INFO - 'sessionrestore', 10:14:53 INFO - 'sessionrestore_no_auto_restore']}, 10:14:53 INFO - 'svgr': {'tests': ['tsvgx', 10:14:53 INFO - 'tsvgr_opacity', 10:14:53 INFO - 'tart', 10:14:53 INFO - 'tscrollx', 10:14:53 INFO - 'cart']}, 10:14:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['tsvgx', 10:14:53 INFO - 'tsvgr_opacity', 10:14:53 INFO - 'tart', 10:14:53 INFO - 'tscrollx', 10:14:53 INFO - 'cart']}, 10:14:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'tests': ['tp5o']}, 10:14:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'talos_options': ['--e10s'], 10:14:53 INFO - 'tests': ['tp5o']}, 10:14:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'talos_options': ['--xperf_path', 10:14:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:53 INFO - 'tests': ['tp5n']}, 10:14:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:53 INFO - 'talos_options': ['--e10s', 10:14:53 INFO - '--xperf_path', 10:14:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:53 INFO - 'tests': ['tp5n']}}, 10:14:53 INFO - 'talos.zip': {'path': '', 10:14:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:53 INFO - Running post-action listener: _resource_record_post_action 10:14:53 INFO - ##### 10:14:53 INFO - ##### Running create-virtualenv step. 10:14:53 INFO - ##### 10:14:53 INFO - Running pre-action listener: _resource_record_pre_action 10:14:53 INFO - Running main action method: create_virtualenv 10:14:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:14:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:14:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:14:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:53 INFO - Using real prefix '/usr' 10:14:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:55 INFO - Installing pip.................done. 10:14:55 INFO - Return code: 0 10:14:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:14:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 10:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:14:55 INFO - Using env: {'DISPLAY': ':0', 10:14:55 INFO - 'HOME': '/home/cltbld', 10:14:55 INFO - 'LANG': 'en_US.UTF-8', 10:14:55 INFO - 'LANGUAGE': 'en_US:en', 10:14:55 INFO - 'LOGNAME': 'cltbld', 10:14:55 INFO - 'MAIL': '/var/mail/cltbld', 10:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:55 INFO - 'MOZ_NO_REMOTE': '1', 10:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:55 INFO - 'NO_EM_RESTART': '1', 10:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:55 INFO - 'SHELL': '/bin/bash', 10:14:55 INFO - 'SHLVL': '1', 10:14:55 INFO - 'TERM': 'linux', 10:14:55 INFO - 'TMOUT': '86400', 10:14:55 INFO - 'USER': 'cltbld', 10:14:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:55 INFO - '_': '/tools/buildbot/bin/python'} 10:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:55 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 10:14:55 INFO - Cleaning up... 10:14:55 INFO - Return code: 0 10:14:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:14:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 10:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:14:55 INFO - Using env: {'DISPLAY': ':0', 10:14:55 INFO - 'HOME': '/home/cltbld', 10:14:55 INFO - 'LANG': 'en_US.UTF-8', 10:14:55 INFO - 'LANGUAGE': 'en_US:en', 10:14:55 INFO - 'LOGNAME': 'cltbld', 10:14:55 INFO - 'MAIL': '/var/mail/cltbld', 10:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:55 INFO - 'MOZ_NO_REMOTE': '1', 10:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:55 INFO - 'NO_EM_RESTART': '1', 10:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:55 INFO - 'SHELL': '/bin/bash', 10:14:55 INFO - 'SHLVL': '1', 10:14:55 INFO - 'TERM': 'linux', 10:14:55 INFO - 'TMOUT': '86400', 10:14:55 INFO - 'USER': 'cltbld', 10:14:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:55 INFO - '_': '/tools/buildbot/bin/python'} 10:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:56 INFO - Downloading/unpacking psutil>=0.7.1 10:14:56 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 10:14:56 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 10:14:56 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 10:14:56 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 10:14:56 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 10:14:56 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 10:14:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:57 INFO - Installing collected packages: psutil 10:14:57 INFO - Running setup.py install for psutil 10:14:57 INFO - building 'psutil._psutil_linux' extension 10:14:57 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 10:14:58 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 10:14:58 INFO - building 'psutil._psutil_posix' extension 10:14:58 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 10:14:58 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 10:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:58 INFO - Successfully installed psutil 10:14:58 INFO - Cleaning up... 10:14:58 INFO - Return code: 0 10:14:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:14:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 10:14:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:14:58 INFO - Using env: {'DISPLAY': ':0', 10:14:58 INFO - 'HOME': '/home/cltbld', 10:14:58 INFO - 'LANG': 'en_US.UTF-8', 10:14:58 INFO - 'LANGUAGE': 'en_US:en', 10:14:58 INFO - 'LOGNAME': 'cltbld', 10:14:58 INFO - 'MAIL': '/var/mail/cltbld', 10:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:58 INFO - 'MOZ_NO_REMOTE': '1', 10:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:58 INFO - 'NO_EM_RESTART': '1', 10:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:58 INFO - 'SHELL': '/bin/bash', 10:14:58 INFO - 'SHLVL': '1', 10:14:58 INFO - 'TERM': 'linux', 10:14:58 INFO - 'TMOUT': '86400', 10:14:58 INFO - 'USER': 'cltbld', 10:14:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:58 INFO - '_': '/tools/buildbot/bin/python'} 10:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:14:58 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 10:14:58 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 10:14:58 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 10:14:58 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 10:14:58 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 10:14:58 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 10:15:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:15:00 INFO - Installing collected packages: mozsystemmonitor 10:15:00 INFO - Running setup.py install for mozsystemmonitor 10:15:00 INFO - Successfully installed mozsystemmonitor 10:15:00 INFO - Cleaning up... 10:15:00 INFO - Return code: 0 10:15:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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-pgo/build 10:15:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:15:00 INFO - Using env: {'DISPLAY': ':0', 10:15:00 INFO - 'HOME': '/home/cltbld', 10:15:00 INFO - 'LANG': 'en_US.UTF-8', 10:15:00 INFO - 'LANGUAGE': 'en_US:en', 10:15:00 INFO - 'LOGNAME': 'cltbld', 10:15:00 INFO - 'MAIL': '/var/mail/cltbld', 10:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:00 INFO - 'MOZ_NO_REMOTE': '1', 10:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:00 INFO - 'NO_EM_RESTART': '1', 10:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:00 INFO - 'SHELL': '/bin/bash', 10:15:00 INFO - 'SHLVL': '1', 10:15:00 INFO - 'TERM': 'linux', 10:15:00 INFO - 'TMOUT': '86400', 10:15:00 INFO - 'USER': 'cltbld', 10:15:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:00 INFO - '_': '/tools/buildbot/bin/python'} 10:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:00 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 10:15:00 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 10:15:00 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 10:15:00 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 10:15:00 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 10:15:00 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 10:15:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:02 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 10:15:02 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 10:15:02 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 10:15:02 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 10:15:02 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 10:15:02 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 10:15:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:03 INFO - Downloading docopt-0.6.1.tar.gz 10:15:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:03 INFO - Running setup.py install for blobuploader 10:15:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:15:03 INFO - Running setup.py install for requests 10:15:03 INFO - Running setup.py install for docopt 10:15:03 INFO - Successfully installed blobuploader requests docopt 10:15:03 INFO - Cleaning up... 10:15:04 INFO - Return code: 0 10:15:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 10:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/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 10:15:04 INFO - Using env: {'DISPLAY': ':0', 10:15:04 INFO - 'HOME': '/home/cltbld', 10:15:04 INFO - 'LANG': 'en_US.UTF-8', 10:15:04 INFO - 'LANGUAGE': 'en_US:en', 10:15:04 INFO - 'LOGNAME': 'cltbld', 10:15:04 INFO - 'MAIL': '/var/mail/cltbld', 10:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:04 INFO - 'MOZ_NO_REMOTE': '1', 10:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:04 INFO - 'NO_EM_RESTART': '1', 10:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:04 INFO - 'SHELL': '/bin/bash', 10:15:04 INFO - 'SHLVL': '1', 10:15:04 INFO - 'TERM': 'linux', 10:15:04 INFO - 'TMOUT': '86400', 10:15:04 INFO - 'USER': 'cltbld', 10:15:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:04 INFO - '_': '/tools/buildbot/bin/python'} 10:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:15:04 INFO - Running setup.py (path:/tmp/pip-f1J1qf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:15:04 INFO - Running setup.py (path:/tmp/pip-36DJj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:15:04 INFO - Running setup.py (path:/tmp/pip-uE0c6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:15:04 INFO - Running setup.py (path:/tmp/pip-KVk3I9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:15:04 INFO - Running setup.py (path:/tmp/pip-HkD9Ib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:15:04 INFO - Running setup.py (path:/tmp/pip-uT4__w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:15:04 INFO - Running setup.py (path:/tmp/pip-F7ov1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:15:04 INFO - Running setup.py (path:/tmp/pip-apIwkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:15:04 INFO - Running setup.py (path:/tmp/pip-911koH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:15:04 INFO - Running setup.py (path:/tmp/pip-X7If_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:15:04 INFO - Running setup.py (path:/tmp/pip-FFvSdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:15:05 INFO - Running setup.py (path:/tmp/pip-uDRAgY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:15:05 INFO - Running setup.py (path:/tmp/pip-eA6YJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:15:05 INFO - Running setup.py (path:/tmp/pip-pQtLjs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:15:05 INFO - Running setup.py (path:/tmp/pip-W_Lgk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:15:05 INFO - Running setup.py (path:/tmp/pip-XfliHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:15:05 INFO - Running setup.py (path:/tmp/pip-Nkw0Os-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:05 INFO - Running setup.py install for manifestparser 10:15:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:15:05 INFO - Running setup.py install for mozcrash 10:15:05 INFO - Running setup.py install for mozdebug 10:15:05 INFO - Running setup.py install for mozdevice 10:15:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:15:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:15:05 INFO - Running setup.py install for mozfile 10:15:05 INFO - Running setup.py install for mozhttpd 10:15:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozinfo 10:15:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozInstall 10:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozleak 10:15:06 INFO - Running setup.py install for mozlog 10:15:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for moznetwork 10:15:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozprocess 10:15:06 INFO - Running setup.py install for mozprofile 10:15:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozrunner 10:15:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:15:06 INFO - Running setup.py install for mozscreenshot 10:15:07 INFO - Running setup.py install for moztest 10:15:07 INFO - Running setup.py install for mozversion 10:15:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:07 INFO - Cleaning up... 10:15:07 INFO - Return code: 0 10:15:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:15:07 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')]} 10:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 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')]} 10:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 10:15:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 10:15:07 INFO - Using env: {'DISPLAY': ':0', 10:15:07 INFO - 'HOME': '/home/cltbld', 10:15:07 INFO - 'LANG': 'en_US.UTF-8', 10:15:07 INFO - 'LANGUAGE': 'en_US:en', 10:15:07 INFO - 'LOGNAME': 'cltbld', 10:15:07 INFO - 'MAIL': '/var/mail/cltbld', 10:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:07 INFO - 'MOZ_NO_REMOTE': '1', 10:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:07 INFO - 'NO_EM_RESTART': '1', 10:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:07 INFO - 'SHELL': '/bin/bash', 10:15:07 INFO - 'SHLVL': '1', 10:15:07 INFO - 'TERM': 'linux', 10:15:07 INFO - 'TMOUT': '86400', 10:15:07 INFO - 'USER': 'cltbld', 10:15:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:07 INFO - '_': '/tools/buildbot/bin/python'} 10:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:15:07 INFO - Running setup.py (path:/tmp/pip-7ejaVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:15:07 INFO - Running setup.py (path:/tmp/pip-i2X648-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:15:07 INFO - Running setup.py (path:/tmp/pip-dpkocF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:15:07 INFO - Running setup.py (path:/tmp/pip-b7IBnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:15:07 INFO - Running setup.py (path:/tmp/pip-m3mOLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:15:07 INFO - Running setup.py (path:/tmp/pip-xsnvTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:15:07 INFO - Running setup.py (path:/tmp/pip-ijqFp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:15:07 INFO - Running setup.py (path:/tmp/pip-mmLc13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:15:08 INFO - Running setup.py (path:/tmp/pip-bJSICe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:15:08 INFO - Running setup.py (path:/tmp/pip-Me7hkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:15:08 INFO - Running setup.py (path:/tmp/pip-I0xV9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:15:08 INFO - Running setup.py (path:/tmp/pip-cNhILS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:15:08 INFO - Running setup.py (path:/tmp/pip-pyzCqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:15:08 INFO - Running setup.py (path:/tmp/pip-2xlARn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:15:08 INFO - Running setup.py (path:/tmp/pip-IrWorv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:15:08 INFO - Running setup.py (path:/tmp/pip-dMPTjk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:15:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:15:08 INFO - Running setup.py (path:/tmp/pip-AQ0ln_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:10 INFO - Downloading blessings-1.6.tar.gz 10:15:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:10 INFO - Installing collected packages: blessings 10:15:10 INFO - Running setup.py install for blessings 10:15:10 INFO - Successfully installed blessings 10:15:10 INFO - Cleaning up... 10:15:10 INFO - Return code: 0 10:15:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:15:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:15:10 INFO - Reading from file tmpfile_stdout 10:15:10 INFO - Current package versions: 10:15:10 INFO - argparse == 1.2.1 10:15:10 INFO - blessings == 1.6 10:15:10 INFO - blobuploader == 1.2.4 10:15:10 INFO - docopt == 0.6.1 10:15:10 INFO - manifestparser == 1.1 10:15:10 INFO - mozInstall == 1.12 10:15:10 INFO - mozcrash == 0.16 10:15:10 INFO - mozdebug == 0.1 10:15:10 INFO - mozdevice == 0.47 10:15:10 INFO - mozfile == 1.2 10:15:10 INFO - mozhttpd == 0.7 10:15:10 INFO - mozinfo == 0.9 10:15:10 INFO - mozleak == 0.1 10:15:10 INFO - mozlog == 3.1 10:15:10 INFO - moznetwork == 0.27 10:15:10 INFO - mozprocess == 0.22 10:15:10 INFO - mozprofile == 0.27 10:15:10 INFO - mozrunner == 6.11 10:15:10 INFO - mozscreenshot == 0.1 10:15:10 INFO - mozsystemmonitor == 0.0 10:15:10 INFO - moztest == 0.7 10:15:10 INFO - mozversion == 1.4 10:15:10 INFO - psutil == 3.1.1 10:15:10 INFO - requests == 1.2.3 10:15:10 INFO - wsgiref == 0.1.2 10:15:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 10:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 10:15:10 INFO - Using env: {'DISPLAY': ':0', 10:15:10 INFO - 'HOME': '/home/cltbld', 10:15:10 INFO - 'LANG': 'en_US.UTF-8', 10:15:10 INFO - 'LANGUAGE': 'en_US:en', 10:15:10 INFO - 'LOGNAME': 'cltbld', 10:15:10 INFO - 'MAIL': '/var/mail/cltbld', 10:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:10 INFO - 'MOZ_NO_REMOTE': '1', 10:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:10 INFO - 'NO_EM_RESTART': '1', 10:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:10 INFO - 'SHELL': '/bin/bash', 10:15:10 INFO - 'SHLVL': '1', 10:15:10 INFO - 'TERM': 'linux', 10:15:10 INFO - 'TMOUT': '86400', 10:15:10 INFO - 'USER': 'cltbld', 10:15:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:10 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:15:11 INFO - Cleaning up... 10:15:11 INFO - Return code: 0 10:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:15:11 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')]} 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 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')]} 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test-pgo/build 10:15:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 jsonschema 10:15:11 INFO - Using env: {'DISPLAY': ':0', 10:15:11 INFO - 'HOME': '/home/cltbld', 10:15:11 INFO - 'LANG': 'en_US.UTF-8', 10:15:11 INFO - 'LANGUAGE': 'en_US:en', 10:15:11 INFO - 'LOGNAME': 'cltbld', 10:15:11 INFO - 'MAIL': '/var/mail/cltbld', 10:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:11 INFO - 'MOZ_NO_REMOTE': '1', 10:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:11 INFO - 'NO_EM_RESTART': '1', 10:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:11 INFO - 'SHELL': '/bin/bash', 10:15:11 INFO - 'SHLVL': '1', 10:15:11 INFO - 'TERM': 'linux', 10:15:11 INFO - 'TMOUT': '86400', 10:15:11 INFO - 'USER': 'cltbld', 10:15:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:11 INFO - '_': '/tools/buildbot/bin/python'} 10:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:11 INFO - Downloading/unpacking jsonschema 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:13 INFO - Downloading/unpacking functools32 (from jsonschema) 10:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:13 INFO - warning: no files found matching '*.txt' 10:15:13 INFO - no previously-included directories found matching 'build' 10:15:13 INFO - no previously-included directories found matching 'dist' 10:15:13 INFO - no previously-included directories found matching '.git*' 10:15:13 INFO - Installing collected packages: jsonschema, functools32 10:15:13 INFO - Running setup.py install for functools32 10:15:13 INFO - warning: no files found matching '*.txt' 10:15:13 INFO - no previously-included directories found matching 'build' 10:15:13 INFO - no previously-included directories found matching 'dist' 10:15:13 INFO - no previously-included directories found matching '.git*' 10:15:13 INFO - Successfully installed jsonschema functools32 10:15:13 INFO - Cleaning up... 10:15:13 INFO - Return code: 0 10:15:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38b016df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 10:15:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 10:15:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 10:15:13 INFO - Using env: {'DISPLAY': ':0', 10:15:13 INFO - 'HOME': '/home/cltbld', 10:15:13 INFO - 'LANG': 'en_US.UTF-8', 10:15:13 INFO - 'LANGUAGE': 'en_US:en', 10:15:13 INFO - 'LOGNAME': 'cltbld', 10:15:13 INFO - 'MAIL': '/var/mail/cltbld', 10:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:13 INFO - 'MOZ_NO_REMOTE': '1', 10:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:13 INFO - 'NO_EM_RESTART': '1', 10:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:13 INFO - 'SHELL': '/bin/bash', 10:15:13 INFO - 'SHLVL': '1', 10:15:13 INFO - 'TERM': 'linux', 10:15:13 INFO - 'TMOUT': '86400', 10:15:13 INFO - 'USER': 'cltbld', 10:15:13 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:13 INFO - '_': '/tools/buildbot/bin/python'} 10:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:13 INFO - Downloading/unpacking flake8 10:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:15:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:15:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:15:16 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 10:15:16 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 10:15:16 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 10:15:16 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 10:15:16 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 10:15:16 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 10:15:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:16 INFO - no previously-included directories found matching 'docs/_build' 10:15:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:15:16 INFO - Running setup.py install for pep8 10:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:15:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:15:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:15:16 INFO - no previously-included directories found matching 'docs/_build' 10:15:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:15:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:15:16 INFO - Cleaning up... 10:15:16 INFO - Return code: 0 10:15:16 INFO - Running post-action listener: _resource_record_post_action 10:15:16 INFO - Running post-action listener: _start_resource_monitoring 10:15:16 INFO - Starting resource monitoring. 10:15:16 INFO - ##### 10:15:16 INFO - ##### Running install step. 10:15:16 INFO - ##### 10:15:16 INFO - Running pre-action listener: _resource_record_pre_action 10:15:16 INFO - Running main action method: install 10:15:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:15:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:15:16 INFO - Reading from file tmpfile_stdout 10:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:15:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:15:16 INFO - Reading from file tmpfile_stdout 10:15:16 INFO - Output received: 10:15:16 INFO - Usage: mozinstall [options] installer 10:15:16 INFO - Options: 10:15:16 INFO - -h, --help show this help message and exit 10:15:16 INFO - -d DEST, --destination=DEST 10:15:16 INFO - Directory to install application into. [default: 10:15:16 INFO - "/builds/slave/test-pgo"] 10:15:16 INFO - --app=APP Application being installed. [default: firefox] 10:15:16 INFO - mkdir: /builds/slave/test-pgo/build/application 10:15:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:15:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:15:31 INFO - Reading from file tmpfile_stdout 10:15:31 INFO - Output received: 10:15:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:15:31 INFO - Running post-action listener: _resource_record_post_action 10:15:31 INFO - ##### 10:15:31 INFO - ##### Running run-tests step. 10:15:31 INFO - ##### 10:15:31 INFO - Running pre-action listener: _resource_record_pre_action 10:15:31 INFO - Running main action method: run_tests 10:15:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:15:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:15:31 INFO - Python 2.7.3 10:15:31 INFO - Return code: 0 10:15:31 INFO - grabbing minidump binary from tooltool 10:15:31 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')]} 10:15:31 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-pgo/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 0x145b350>, '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 0x145c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:15:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:15:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:15:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:31 INFO - Return code: 0 10:15:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:15:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:15:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:15:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:15:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:15:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:15:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:15:32 INFO - Return code: 0 10:15:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:15:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 10:15:32 INFO - Using env: {'DISPLAY': ':0', 10:15:32 INFO - 'HOME': '/home/cltbld', 10:15:32 INFO - 'LANG': 'en_US.UTF-8', 10:15:32 INFO - 'LANGUAGE': 'en_US:en', 10:15:32 INFO - 'LOGNAME': 'cltbld', 10:15:32 INFO - 'MAIL': '/var/mail/cltbld', 10:15:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:15:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:32 INFO - 'MOZ_NO_REMOTE': '1', 10:15:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:32 INFO - 'NO_EM_RESTART': '1', 10:15:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:15:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:15:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:15:32 INFO - 'SHELL': '/bin/bash', 10:15:32 INFO - 'SHLVL': '1', 10:15:32 INFO - 'TERM': 'linux', 10:15:32 INFO - 'TMOUT': '86400', 10:15:32 INFO - 'USER': 'cltbld', 10:15:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349', 10:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:32 INFO - '_': '/tools/buildbot/bin/python'} 10:15:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 10:15:32 INFO - mozversion INFO | application_buildid: 20160212074915 10:15:32 INFO - mozversion INFO | application_changeset: ce08fa9d4ed6c89d009a29bddd8ea3075bb868fc 10:15:32 INFO - mozversion INFO | application_display_name: Nightly 10:15:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:32 INFO - mozversion INFO | application_name: Firefox 10:15:32 INFO - mozversion INFO | application_remotingname: firefox 10:15:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:15:32 INFO - mozversion INFO | application_vendor: Mozilla 10:15:32 INFO - mozversion INFO | application_version: 45.0 10:15:32 INFO - mozversion INFO | platform_buildid: 20160212074915 10:15:32 INFO - mozversion INFO | platform_changeset: ce08fa9d4ed6c89d009a29bddd8ea3075bb868fc 10:15:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:15:32 INFO - mozversion INFO | platform_version: 45.0 10:15:32 INFO - 2016-02-12 10:15:32,747 DEBUG : using testdate: 1455300932 10:15:32 INFO - 2016-02-12 10:15:32,747 DEBUG : actual date: 1455300932 10:15:32 INFO - 2016-02-12 10:15:32,829 INFO : starting webserver on 'localhost:59037' 10:15:32 INFO - 2016-02-12 10:15:32,830 INFO : Starting test suite talos-linux64-ix-059 10:15:32 INFO - 2016-02-12 10:15:32,830 INFO : Starting test dromaeo_css 10:15:32 INFO - 2016-02-12 10:15:32,830 DEBUG : operating with platform_type : linux_ 10:15:32 INFO - 2016-02-12 10:15:32,831 INFO : Initialising browser for dromaeo_css test... 10:15:32 INFO - 2016-02-12 10:15:32,845 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUWbgxU/profile http://localhost:59037/getInfo.html 10:15:36 INFO - 2016-02-12 10:15:36,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:15:36 INFO - 2016-02-12 10:15:36,381 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:15:36 INFO - 2016-02-12 10:15:36,381 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:15:36 INFO - 2016-02-12 10:15:36,381 DEBUG : BROWSER_OUTPUT: __metrics 10:15:36 INFO - 2016-02-12 10:15:36,510 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:37 INFO - 2016-02-12 10:15:37,436 INFO : Browser initialized. 10:15:37 INFO - 2016-02-12 10:15:37,437 INFO : Running cycle 1/1 for dromaeo_css test... 10:15:37 INFO - 2016-02-12 10:15:37,437 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUWbgxU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:15:49 INFO - 2016-02-12 10:15:49,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 134029312 10:15:49 INFO - 2016-02-12 10:15:49,137 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2016-02-12 10:16:40,622 DEBUG : BROWSER_OUTPUT: 1455301000615 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] 10:18:47 INFO - 2016-02-12 10:18:47,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59037/tests/dromaeo/cssquery-ext.html) 10:18:48 INFO - 2016-02-12 10:18:48,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 227737600 10:18:48 INFO - 2016-02-12 10:18:48,478 DEBUG : BROWSER_OUTPUT: 10:21:50 INFO - 2016-02-12 10:21:50,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-ext.html (next: http://localhost:59037/tests/dromaeo/cssquery-jquery.html) 10:21:51 INFO - 2016-02-12 10:21:51,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 211369984 10:21:51 INFO - 2016-02-12 10:21:51,041 DEBUG : BROWSER_OUTPUT: 10:24:52 INFO - 2016-02-12 10:24:52,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59037/tests/dromaeo/cssquery-mootools.html) 10:24:53 INFO - 2016-02-12 10:24:53,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 208781312 10:24:53 INFO - 2016-02-12 10:24:53,286 DEBUG : BROWSER_OUTPUT: 10:27:54 INFO - 2016-02-12 10:27:54,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59037/tests/dromaeo/cssquery-prototype.html) 10:27:55 INFO - 2016-02-12 10:27:55,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 193163264 10:27:55 INFO - 2016-02-12 10:27:55,493 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2016-02-12 10:30:57,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59037/tests/dromaeo/cssquery-yui.html) 10:30:58 INFO - 2016-02-12 10:30:58,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 198062080 10:30:58 INFO - 2016-02-12 10:30:58,407 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/dromaeo/cssquery-yui.html (next: http://localhost:59037/tests/dromaeo/cssquery-dojo.html) 10:34:00 INFO - 2016-02-12 10:34:00,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 233517056 10:34:00 INFO - 2016-02-12 10:34:00,739 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,741 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:34:00 INFO - 2016-02-12 10:34:00,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:34:00 INFO - 2016-02-12 10:34:00,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:34:00 INFO - 2016-02-12 10:34:00,741 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:34:00 INFO - 2016-02-12 10:34:00,742 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3196.376706542222;3230.612326520816;3237.401080800052;3248.496483045128;3251.040942921838;5275.0768615492325;5317.175837745146;5320.201969704546;5332.680039197651;5355.437679043698;5291.391489978653;5310.973445132769;5313.442088580701;5318.734063296839;5385.407605163438;4702.576768090871;4802.135615589193;4857.028594281141;4867.926981095268;4909.631777616675;4810.230363141898;4834.540718631724;4857.975710121462;4880.145974454474;4929.162042452774;4883.29192267121;4975.054739599483;4994.425641051271;4995.175795993657;4995.975020124894;4889.6088312935235;4958.801647934079;4967.180415231483;4977.726225057639;4987.476314986929;4704.482506924235;4757.857264282077;4771.904561908777;4848.8302909398;4898.755062246873;5234.345706786652;5259.2899958505495;5259.552938000236;5259.947400526023;5270.789168433258;5779.219805326269;5783.88432231353;5801.796937107181;5809.448102430305;5821.446962538552;5520.779168833242;5620.185073164409;5700.7149642518125;5747.425257474261;5817.360090390053;5378.91931621026;5380.515753582157;5380.569554435675;5382.730863456812;5386.542143917772;5542.722863856791;5735.655860648374;5786.652800831964;5788.855278618068;5790.88418231633;5466.781328746885;5540.418256083134;5576.888462230732;5583.69289689071;5590.273264475592;5763.85590360236;5788.21859049023;5788.305403351541;5789.305283366023;5793.623414478046;5492.148716948879;5764.827055188351;5766.3368712598585;5767.88464230713;5769.826905192851;5536.086545719912;5591.776328946878;5612.326520817446;5638.210650508932;5645.407232240637;4345.3699213613845;4348.0869017506675;4352.608265256142;4356.956430435718;4357.607815296638;3893.377059670439;3970.82131304092;3973.324534829086;3982.522097348337;4009.5389030261895;5360.973195134077;5430.42980487051;5438.809641662523;5445.101558242845;5472.398036216013;5734.7132643368495;5812.680302583314;5828.766849326064;5829.795957141479;5832.12518122285;5330;5421.078416669176;5454.672719636835;5528.640638358494;5547.972260138674;5060.392752869606;5063.569596584258;5064.569511591556;5075.111855425286;5081.00920320534;5888.705564721832;5936.376680448577;5939.316978547436;5940.79207227745;5945;5550.361708403585;5599.832005039855;5646.520045796154;5793.044147715748;5808.012637851575;5875.618084824473;5885.087811389241;5887.646741195542;5891.49922256613;5938.406159384027;5641.37944826077;5666.291713535808;5666.433356664301;5668.7165641718575;5671.376148623565;5568.888622227614;5623.746931388179;5670.319561652628;5694.572907031907;5750.5112065474905;5678.3186017678145;5680.346760122474;5715.31416230055;5715.31416230055;5719.542436604978;5693.829185124453;5694.971525142348;5699.173619825185;5707.885842283048;5710;5348.705821179872;5431.185322201543;5444.183372493999;5542.944570554243;5585.162225666182;5627.718614069362;5629.915551266652;5659.717014149359;5662.575306852085;5680.545556355399;5474.890502190014;5487.039768040657;5539.612227144061;5544.445555444423;5545.750441230235 10:34:00 INFO - 2016-02-12 10:34:00,744 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.4829653312019;627.6767464755654;630.3035146163489;633.8605506788508;678.2031113441705;33659.15852103695;42206.36690449642;42944;43002.7849860751;43127.56872431278;45552;46303.76848115763;46315;46386.072278554406;46389;8175.5503447310375;8319.83360332793;9068.501232432214;9193.724188274362;9234.769130771718;10801.67594972152;11074.446277686124;11077.723056923602;11088.33469991799;11089.2237543372;10682.145428365711;10806.081483073947;10808.405537695462;10815.621453249138;10819.513121909533;10675.679729608124;10699.946500267488;10763.192760542912;10763.892361076367;10773.138148948065;10611;10751.247412681116;10765.62320318793;10769.730756731065;10773.5690572377;43466.34800477995;43751;43821.27519160875;43835.78082109601;43916;3230.8384580770867;3349.112485191426;3362.680545348188;3720.683741881943;4199.265128602482;31905.202369940704;32555.83722081398;32580.511292330633;32811.343773124405;33306;4120.711550191488;4183.853565125206;4221.366794980747;4236.364545318196;4364.934525982113;285620;285876;286239;287515;287734;61353.69323153356;61987.38012619816;74591;75782;75834.62082689551;67093;67155.66422167956;67278;67341.66329168323;67555;15428.84571154274;15548.144852033021;15681.05913645185;15704;15744.763828542582;13903.165810051429;13992;14003.229822359664;14026.228557429235;14091.647708807157;22189.889050554644;22560.548789024455;22561.4359641007;22573.32280031602;22584.66123008156;8258.793530161794;8491;8517.659293628309;8523.403361764616;8648.740537783877;1050.8896565860628;1053.2206167436043;1115.2806439846254;1137.0392018744149;1151.8272259161192;35071.64928350735;35316.47025294622;35478.82260588732;35616.1507079433;35719;1125.9528638366235;1199.244475980127;1239.4360565942475;1255.9434825432877;1261.703499677575;14951.626209344853;15649.217539122998;15914.0451572906;16269;18273.17770700322;407096;408656;412363;415120;415530;59636.701816491506;60000.69999650061;60137.699311503166;60220;60257.39742602606;1338.1703343926633;1415.6248594122567;1488.7171437426855;1492.9178895160653;1524.8246451657978;34406;34705.82647086748;34757.47863782096;34805.65194348024;34883.47674784931;54088.729556351966;54693.453065468835;54769.45230547803;54919.725401372736;54931.725341373036;311812;312691;314068;314124;314357;34917.650823491436;35348.64651353556;35479.46780798342;35633.28733425369;35861.46207806937;46193.30710039285;46749.2987605193;46809;46841.76579117082;47174.764126180526;38129.428058579695;38263.61736382601;38280;38602;39110.804445977585;39328.2134357317;45720.31419528643;45934.31098533458;46610.76694616505;47777.04445911132;38800.22399552049;38987.80506097451;39290.01774955649;39319;39433.605663942995;33212.335753284315;34449.48325775065;34836.651633484355;34884;35080;27060.594091089042;27301.317467063483;27485.31286717848;27492.075554710977;27536.311592210353 10:34:00 INFO - 2016-02-12 10:34:00,745 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.80570491934355;362.35139101009196;373.71037445979346;376.7249907567474;379.0618219905734;14739.85260147401;16104.597385065379;17506.474805755817;18903.905480472597;19470.90264548677;16648;16682.58293542662;16892.1553922304;17078.31686732529;17102;5466.480684334992;5694.316681998145;5698.629589076718;5711.885762284773;5712.22884910538;4367.759773212472;4494.865154045384;5665.23519324892;6074.757009719606;6278.30938596754;6102;6214.130021796929;6222.315545290015;6245.594036387621;6263.937360626381;6212.65830379329;6227.875442491148;6247.031710084944;6251.874962500748;6256.092866534327;5384.515393614593;5491.258680078178;5492.642978206404;5506.256655351516;5515.972420137874;21117;21217.257395991066;21416.250431234832;22272.554548909095;22451.101955921906;2200.5928903152967;2204.9669254961186;2207;2240.406292332533;2298.321995011476;9162.404443711137;9270.675526356545;9386.765330866714;9400.20098291646;9597.47213903235;1837.9724304135448;1865.1047497201284;1870.1864688860253;1915.7796853361901;1928.4503916383762;62928;64154.358456415306;64250.35749642537;65158.3484165157;65685.3431465684;10392.740181495372;10393.37639741618;10410.739731506774;10442.112420444348;10470.214733894989;12946;12963.935180324039;12968.35158242084;12998.740025199442;13010.804837927439;7709.961450192825;7720.112187098443;7777.300042996158;7781;7906.169852165554;7449.441291903129;7519.624018799038;7522.172561018284;7564.924350756422;7592.354649854714;4238.703290769617;4245.702800803976;4298.677599180074;4338.327559228262;4368.650507959355;1709.8717596180336;1756.1482680899753;1785.4554360920044;1811.9909400452914;1831.835134837871;938.2775263047415;946.4132238012339;975.3708857786688;989.9851502227473;1057.7567159553191;14378.56864294052;15293.464728734441;15906.52280431589;16056.277467513757;16309.836901630832;1010.6917390196061;1026.4508487959056;1052.6157952347492;1088.0134032081985;1118.1948996722347;9928.156106730865;10038.799224015478;10125.696229113139;10132.73340832396;10149.746256343651;609190;610076;616332;626060;642188;79333.60333198412;80713;81090.59454702689;81320.59339703263;82965.58517207376;1111.3387534417009;1121.1815374776295;1121.9439028048564;1146.1232157399595;1149.2874417860812;15794.447194348142;15811.841881581036;15871.761923570924;16136.435224767547;16274.267657955184;35592.288154237285;36328.81835590805;36455.453168201966;37284.6271537292;38108.047298816644;49244.507554925425;49533.75233123956;50018;52052;53226.93546128978;9271.814563708824;9419.199368053793;9428.717138485856;9570.090841370058;9576.856347154937;10943.124550036136;11046.558137674403;11047.944760276147;17011.404600838912;17891.10544472797;14892.702145956804;15081.622959426102;15178.77231841501;15317.46388876384;15468.767968480257;14076.085054471427;14125.223112728898;14671.633209169857;15379.923100384427;15429;12333.691657708629;14421.42314307416;15313.770293445385;15442.613934651723;15593.922030389775;9671.806563868542;9766.121049105615;9816.65641702537;9839.557219925264;9849.95075024649;13830.930845345709;14072.366743496363;14541.41834326615;14945.701085978437;15297 10:34:00 INFO - 2016-02-12 10:34:00,746 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1527.9541613751592;1530.0743050454469;1719.5958949646838;1794.7397627344033;1827.4243613261822;6976.093107895973;7489.513181643196;7495.138059123189;7506.624668766567;7534.924650753491;7414.925850741491;7450.515716478439;7454.850902981937;7519.172890982001;7537.020187375647;2205.1620384254043;2210.204326442479;2247.7752224777555;2248.820094392453;2248.977510224893;2214.678871563622;2247.0337754765446;2247.3033359658557;2248.4154119928853;2251.324602619208;1996.4809149621058;2032.1871251499444;2177.7822217778175;2217.5675743230076;2266.9206577769783;2233.4974630708125;2245.820334373246;2264.071730590458;2264.3659775262954;2266.9659955100688;2192.331338941622;2259.35608351619;2261.4233370490583;2264.1396269417683;2265.3883451468178;6480.384363485461;6635.900461493082;7151.57090574562;7309.086364204474;7321.231270716551;4492.595666390008;4543.795529201161;4547.931781023287;4556.3621093047;4565.589096981287;2884.5817356483403;2941.911742647724;2942.9117126486026;2959.1270575180374;2975.5685425613383;926.9536523173882;930.1675000874247;941.5292353823088;959.4051687953513;966.1063516247514;9565.521723913776;9591.280653950911;9623;9630.807383852354;9642.276829237766;3921.686265098785;3925.3523168676847;3981.2634662587516;3982.2831890259454;3986.063275130342;8455.408121431563;8473.49159050459;8490.830183396421;8497.787555311166;8518.063013068557;4515.841945531891;4521.886952826206;4522.547745225451;4525.7510836904285;4531.27499600069;4101.5488296287385;4132.421460995463;4137.958620413758;4140.91718165641;4147.129102888367;3373.241020770307;3433.639467855889;3448.8792892248653;3454.2227998700596;3455.2571197192724;1059.2161800267747;1060.6817954613584;1061.9256652034437;1069.1179776684266;1069.5561342042965;1444.7399468095844;1458.3291685824427;1468.6548661064642;1485.2647939269914;1491.36616937801;7207.5675459472595;7225.963870180721;7230.457715671346;7241;7251.1661158966335;437.33525041936076;439.4748275810376;441.7614488176413;443.60740744440756;450.6507456721067;5405.189221616789;5817.011108111631;5905.173275741399;5909.468147866627;5914.349421563625;7762.534247945141;8312.83374332522;8322.16778322175;8469.576521173916;8481.236688698047;8172.959135204286;8272.586370681442;8340.582970851434;8347.833043339098;8355;7070.186928503185;7136.7145314186855;7195.136583609896;7215.062041934515;7220.602866842479;7111.502194846311;7131.393831524171;7183.784486465414;7189.532680375759;7224.855502890018;7859.685612575433;7875.251851074138;7916.247956444128;8084.555349455836;8095.676172953252;8086.11052784205;8096.311813495919;8107;8254.133316001973;8270.048944371474;6735.865282694416;6771.085903402977;6799.830004249933;6802.183737951477;6811.795646130624;7334.889976650248;7361;7377.225391333833;7400.555966642019;7434.702611895464;6750.459963202834;6942;6948.756793512202;6984.580925144508;7017.2631873652535;6881.346272104142;6882.931170688429;6931.549449285781;6993.475489338218;7048.647567621701;6951.200611929693;7024.4029257513685;7062.858742825218;7063.894041589483;7070.328318809705;6505.772297969548;6577.835554111186;6578.342165783383;6578.901316480353;6586.0450234714735;6414.422701956846;6480.902786458113;6488.578242414228;6579.703913324008;6643 10:34:00 INFO - 2016-02-12 10:34:00,746 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.2194513715711;321.64940215165467;329.7905829798076;332.88515462165543;339.595880901727;5981.461668449839;6016.187814645022;6087.208662873832;6101.206843110395;6131.754729810802;5707.971460142693;5818.5926985111055;5867.383924687911;5969.910451343233;5982.102684597302;4610.746408947506;4620.861374158764;4625.306204069383;4632.745199014062;4644.930326045112;4563.931541026887;4594.931076033862;4612.654050946176;4635.096156249533;4649.8837529061875;4349.304111342186;4457.687961842672;4457.88855278619;4567.13224487348;4568.84009059683;4553.4535855697195;4565.908681826378;4579.427571553556;4580.129775342708;4590.449146102455;4009.51885773709;4009.719319647626;4011.2178125265586;4012.197560487914;4012.2376748417705;5721.7711291548285;5731.828045158611;5733.741981610838;5734.254546908917;5752.137179423078;5093.490650934914;5220.243064755589;5230.058589453897;5236.162214045772;5270.762815673265;6331.39851714091;6340.3659634036685;6341.143945567335;6342.968285158545;6345.17512723343;4318.82724691012;4327.06968001878;4330.826766929319;4340.587644173798;4345.587169218919;6456.160699109133;6513.967430162867;6549.1158693576235;6566.0150977353305;6577.835554111186;4452.977735111303;4458.353538736865;4469.530699276529;4479.641628669699;4490.842820501267;4498.707584007095;4534.750588717652;4539.863804085882;4541.954580454153;4549.0447006128425;5267.657602255841;5280.471952804689;5281.313429254173;5281.573975026721;5284.497972692588;6188.2883468400805;6343.841403964938;6356.523260755462;6363.045543168561;6374.458171055419;1544.1430006346586;1544.938202471911;1545.5208885245386;1559.4230134849952;1561.149173700336;1027.2963020331097;1050.7373156710823;1056.9894301057045;1077.1544337694872;1080.254624309224;6204.81385558434;6207.131001659771;6215.160953271341;6219.689015549205;6220.875582488416;6585.6707164641575;6587.670616469158;6590.110335104795;6590.242122155918;6602;5987.251593550806;5995.760169593254;6163;6166.876662466815;6168.9691551542855;3557.7153827693724;3573.5533058367705;3593.2094939113354;3597.2985267872514;3604.459331100356;6785.830354241183;6786;6792.8301792454595;6793.524453288322;6794.72821087151;6637.734490620321;6702.83242918931;6788.694508747119;6805.591664500146;6810.31896810315;6768.864622707617;6773.983902414579;6778.830529236809;6782.728690852311;6785.59286442815;6618.371254730793;6623;6625.4037136657935;6630.204375474974;6636.933630663824;6428.774992875227;6597.571157874723;6608.339166083546;6614.66926653675;6617.2721000688925;6818.795436136924;6828.7268509259075;6830.419414349836;6837.35045170708;6841.110655614738;4451.3545535896465;4475.351074094173;4477.731336119843;4478.373027776049;4485.259932111296;6559.540832141895;6694.497912656668;6701.0953521274005;6702.229243636849;6715.3620406061345;6476.70854811544;6517.804465866032;6523.967380163069;6530.738770449128;6534.052562378523;6487.156669632917;6492.188476440445;6494.805155845333;6502.122213501117;6503.25212600557;6237.875242495215;6380.489560835215;6395.552311338348;6398.93601064002;6399.712012959521;6537.5096867734155;6542.313057128933;6546.410823025951;6547.574407663486;6551.44312733423;6234.501239900887;6359.7456101755415;6364.649944252926;6367.840803979752;6377.362263773585 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: |5;yui.html;850.7362717557555;895.7178488776033;927.1655510040962;941.199980016986;957.3872721458264;14587.70824583509;15176.620584485394;15224.162671053087;15240.771388429155;15271.618209544753;14220.786688199685;14287.14277143372;14291.928540357283;14303.070300430465;14313.642158946006;762.7482930632892;771.756896577579;912.726182145357;927.5176908007832;927.9118483744068;905.027095871937;912.4023764434273;916.3677062826662;918.42598376015;922.2575826459731;803.4616806739499;949.1837020162654;955.2883102088954;955.6655170690237;955.8327292723781;803.6825453945688;950.7908260182784;952.347641865321;959.0744931141481;959.8608201810698;699.464909344352;699.5173330402006;699.7795694356313;700.8878579427267;705.6224919668005;13530.323483825769;13936.93031534846;13944.023918325722;13944.093633913762;13950.860491395058;12953.158044727063;13357.398917048757;13536.05247632666;14073.71852562943;14091.929540352336;10790.51442685081;10915.890841091566;10946.616868409568;11092.389918554476;11141.053010494037;3881.611838816124;3944.408338749182;3947.822347994347;3975.185087057146;4036.8788936331957;46591.30113048307;47467.52532474665;47554.76222618865;48942.265866012036;49183.75408122972;11026.748397882438;11064.944675276733;11080.279781814157;11190.440477976068;11291.040261577693;20894.47763805917;20934.685979710317;20965.47586310324;20975;21033.68449473259;7968.243016913384;8063.354931605458;8207.302379297707;8245.670173193004;8268.173182681683;4530.77346132692;4540.228161212602;4552.658550608651;4568.428946381702;4639.8144074237325;3296.0606227225126;3296.0606227225603;3316.1378041708845;3321.3523362943993;3321.717653999437;580.3876909860138;597.6444015810586;598.2730981857064;602.6986506746626;612.8314713453835;657.81252343082;721.2751185058983;734.1630541183056;738.1621859189751;772.5828052851509;8564.186402291773;8729.738107856774;8976.551172441352;9269.675561355454;9690;688.2291833146808;721.5526373648372;750.9399248060142;759.2673070487007;762.954222746637;4077.347624380085;4163.146554956226;4277;4334.241507736197;4359.302511598129;54438.18342724862;62887;63584;63622;63676.68161659162;52815;53408.46591534113;54157.72921135448;54412.72793636007;55220.72389638026;47539.52460475351;49408.42593332795;49696;50224.74887625612;53399.199012014076;8692.869606955774;8759.291365257808;9069.274458043208;9114.40756350835;9182.540872956459;36388.27223455569;36699.44950825686;37165.6283437173;37584.43623345597;38501.42247866228;45830.31254531118;47649;47796.522034780595;49467.75266123646;49647.50352496573;11559.537618495166;11565.421728913689;11617.302961822317;11882.524699011943;12144;12604.30676312775;12618;12705.17416367933;12891.806622900476;12917.741645167232;11785.410729463321;11879.465424055765;12012.519499220283;12020.699482512657;12247.57133500359;11775.587854425054;11974.760504790029;12111.333876636869;12144.878551214375;12238.571649992564;9288.907110928803;11331.320120792449;11543.538258469567;11574.6527604172;11765.294082355085;9322.440653560809;9340.392874463138;9444.102810233016;9516.19112375428;9818.263630227904;8659.393842430969;8878.911210887809;8895.73312800617;9084.18242358191;9105.180533751729 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,752 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1455302040739__endTimestamp 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,748 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5325.57 Median:5536.09 stddev:581.64 (10.5%) stddev-sans-first:558.92 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: Values: 3196.4 3230.6 3237.4 3248.5 3251.0 5275.1 5317.2 5320.2 5332.7 5355.4 5291.4 5311.0 5313.4 5318.7 5385.4 4702.6 4802.1 4857.0 4867.9 4909.6 4810.2 4834.5 4858.0 4880.1 4929.2 4883.3 4975.1 4994.4 4995.2 4996.0 4889.6 4958.8 4967.2 4977.7 4987.5 4704.5 4757.9 4771.9 4848.8 4898.8 5234.3 5259.3 5259.6 5259.9 5270.8 5779.2 5783.9 5801.8 5809.4 5821.4 5520.8 5620.2 5700.7 5747.4 5817.4 5378.9 5380.5 5380.6 5382.7 5386.5 5542.7 5735.7 5786.7 5788.9 5790.9 5466.8 5540.4 5576.9 5583.7 5590.3 5763.9 5788.2 5788.3 5789.3 5793.6 5492.1 5764.8 5766.3 5767.9 5769.8 5536.1 5591.8 5612.3 5638.2 5645.4 4345.4 4348.1 4352.6 4357.0 4357.6 3893.4 3970.8 3973.3 3982.5 4009.5 5361.0 5430.4 5438.8 5445.1 5472.4 5734.7 5812.7 5828.8 5829.8 5832.1 5330.0 5421.1 5454.7 5528.6 5548.0 5060.4 5063.6 5064.6 5075.1 5081.0 5888.7 5936.4 5939.3 5940.8 5945.0 5550.4 5599.8 5646.5 5793.0 5808.0 5875.6 5885.1 5887.6 5891.5 5938.4 5641.4 5666.3 5666.4 5668.7 5671.4 5568.9 5623.7 5670.3 5694.6 5750.5 5678.3 5680.3 5715.3 5715.3 5719.5 5693.8 5695.0 5699.2 5707.9 5710.0 5348.7 5431.2 5444.2 5542.9 5585.2 5627.7 5629.9 5659.7 5662.6 5680.5 5474.9 5487.0 5539.6 5544.4 5545.8 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52924.64 Median:35198.24 stddev:89490.60 (254.2%) stddev-sans-first:89655.33 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: Values: 574.5 627.7 630.3 633.9 678.2 33659.2 42206.4 42944.0 43002.8 43127.6 45552.0 46303.8 46315.0 46386.1 46389.0 8175.6 8319.8 9068.5 9193.7 9234.8 10801.7 11074.4 11077.7 11088.3 11089.2 10682.1 10806.1 10808.4 10815.6 10819.5 10675.7 10699.9 10763.2 10763.9 10773.1 10611.0 10751.2 10765.6 10769.7 10773.6 43466.3 43751.0 43821.3 43835.8 43916.0 3230.8 3349.1 3362.7 3720.7 4199.3 31905.2 32555.8 32580.5 32811.3 33306.0 4120.7 4183.9 4221.4 4236.4 4364.9 285620.0 285876.0 286239.0 287515.0 287734.0 61353.7 61987.4 74591.0 75782.0 75834.6 67093.0 67155.7 67278.0 67341.7 67555.0 15428.8 15548.1 15681.1 15704.0 15744.8 13903.2 13992.0 14003.2 14026.2 14091.6 22189.9 22560.5 22561.4 22573.3 22584.7 8258.8 8491.0 8517.7 8523.4 8648.7 1050.9 1053.2 1115.3 1137.0 1151.8 35071.6 35316.5 35478.8 35616.2 35719.0 1126.0 1199.2 1239.4 1255.9 1261.7 14951.6 15649.2 15914.0 16269.0 18273.2 407096.0 408656.0 412363.0 415120.0 415530.0 59636.7 60000.7 60137.7 60220.0 60257.4 1338.2 1415.6 1488.7 1492.9 1524.8 34406.0 34705.8 34757.5 34805.7 34883.5 54088.7 54693.5 54769.5 54919.7 54931.7 311812.0 312691.0 314068.0 314124.0 314357.0 34917.7 35348.6 35479.5 35633.3 35861.5 46193.3 46749.3 46809.0 46841.8 47174.8 38129.4 38263.6 38280.0 38602.0 39110.8 39328.2 45720.3 45934.3 46610.8 47777.0 38800.2 38987.8 39290.0 39319.0 39433.6 33212.3 34449.5 34836.7 34884.0 35080.0 27060.6 27301.3 27485.3 27492.1 27536.3 10:34:00 INFO - 2016-02-12 10:34:00,749 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,750 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31502.68 Median:17976.05 stddev:101392.98 (564.0%) stddev-sans-first:101650.44 10:34:00 INFO - 2016-02-12 10:34:00,751 DEBUG : BROWSER_OUTPUT: Values: 359.8 362.4 373.7 376.7 379.1 14739.9 16104.6 17506.5 18903.9 19470.9 16648.0 16682.6 16892.2 17078.3 17102.0 5466.5 5694.3 5698.6 5711.9 5712.2 4367.8 4494.9 5665.2 6074.8 6278.3 6102.0 6214.1 6222.3 6245.6 6263.9 6212.7 6227.9 6247.0 6251.9 6256.1 5384.5 5491.3 5492.6 5506.3 5516.0 21117.0 21217.3 21416.3 22272.6 22451.1 2200.6 2205.0 2207.0 2240.4 2298.3 9162.4 9270.7 9386.8 9400.2 9597.5 1838.0 1865.1 1870.2 1915.8 1928.5 62928.0 64154.4 64250.4 65158.3 65685.3 10392.7 10393.4 10410.7 10442.1 10470.2 12946.0 12963.9 12968.4 12998.7 13010.8 7710.0 7720.1 7777.3 7781.0 7906.2 7449.4 7519.6 7522.2 7564.9 7592.4 4238.7 4245.7 4298.7 4338.3 4368.7 1709.9 1756.1 1785.5 1812.0 1831.8 938.3 946.4 975.4 990.0 1057.8 14378.6 15293.5 15906.5 16056.3 16309.8 1010.7 1026.5 1052.6 1088.0 1118.2 9928.2 10038.8 10125.7 10132.7 10149.7 609190.0 610076.0 616332.0 626060.0 642188.0 79333.6 80713.0 81090.6 81320.6 82965.6 1111.3 1121.2 1121.9 1146.1 1149.3 15794.4 15811.8 15871.8 16136.4 16274.3 35592.3 36328.8 36455.5 37284.6 38108.0 49244.5 49533.8 50018.0 52052.0 53226.9 9271.8 9419.2 9428.7 9570.1 9576.9 10943.1 11046.6 11047.9 17011.4 17891.1 14892.7 15081.6 15178.8 15317.5 15468.8 14076.1 14125.2 14671.6 15379.9 15429.0 12333.7 14421.4 15313.8 15442.6 15593.9 9671.8 9766.1 9816.7 9839.6 9850.0 13830.9 14072.4 14541.4 14945.7 15297.0 10:34:00 INFO - 2016-02-12 10:34:00,751 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,751 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5233.80 Median:6639.45 stddev:2653.09 (40.0%) stddev-sans-first:2645.91 10:34:00 INFO - 2016-02-12 10:34:00,752 DEBUG : BROWSER_OUTPUT: Values: 1528.0 1530.1 1719.6 1794.7 1827.4 6976.1 7489.5 7495.1 7506.6 7534.9 7414.9 7450.5 7454.9 7519.2 7537.0 2205.2 2210.2 2247.8 2248.8 2249.0 2214.7 2247.0 2247.3 2248.4 2251.3 1996.5 2032.2 2177.8 2217.6 2266.9 2233.5 2245.8 2264.1 2264.4 2267.0 2192.3 2259.4 2261.4 2264.1 2265.4 6480.4 6635.9 7151.6 7309.1 7321.2 4492.6 4543.8 4547.9 4556.4 4565.6 2884.6 2941.9 2942.9 2959.1 2975.6 927.0 930.2 941.5 959.4 966.1 9565.5 9591.3 9623.0 9630.8 9642.3 3921.7 3925.4 3981.3 3982.3 3986.1 8455.4 8473.5 8490.8 8497.8 8518.1 4515.8 4521.9 4522.5 4525.8 4531.3 4101.5 4132.4 4138.0 4140.9 4147.1 3373.2 3433.6 3448.9 3454.2 3455.3 1059.2 1060.7 1061.9 1069.1 1069.6 1444.7 1458.3 1468.7 1485.3 1491.4 7207.6 7226.0 7230.5 7241.0 7251.2 437.3 439.5 441.8 443.6 450.7 5405.2 5817.0 5905.2 5909.5 5914.3 7762.5 8312.8 8322.2 8469.6 8481.2 8173.0 8272.6 8340.6 8347.8 8355.0 7070.2 7136.7 7195.1 7215.1 7220.6 7111.5 7131.4 7183.8 7189.5 7224.9 7859.7 7875.3 7916.2 8084.6 8095.7 8086.1 8096.3 8107.0 8254.1 8270.0 6735.9 6771.1 6799.8 6802.2 6811.8 7334.9 7361.0 7377.2 7400.6 7434.7 6750.5 6942.0 6948.8 6984.6 7017.3 6881.3 6882.9 6931.5 6993.5 7048.6 6951.2 7024.4 7062.9 7063.9 7070.3 6505.8 6577.8 6578.3 6578.9 6586.0 6414.4 6480.9 6488.6 6579.7 6643.0 10:34:00 INFO - 2016-02-12 10:34:00,752 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,752 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5338.19 Median:6116.48 stddev:1629.81 (26.6%) stddev-sans-first:1590.12 10:34:00 INFO - 2016-02-12 10:34:00,754 DEBUG : BROWSER_OUTPUT: Values: 312.2 321.6 329.8 332.9 339.6 5981.5 6016.2 6087.2 6101.2 6131.8 5708.0 5818.6 5867.4 5969.9 5982.1 4610.7 4620.9 4625.3 4632.7 4644.9 4563.9 4594.9 4612.7 4635.1 4649.9 4349.3 4457.7 4457.9 4567.1 4568.8 4553.5 4565.9 4579.4 4580.1 4590.4 4009.5 4009.7 4011.2 4012.2 4012.2 5721.8 5731.8 5733.7 5734.3 5752.1 5093.5 5220.2 5230.1 5236.2 5270.8 6331.4 6340.4 6341.1 6343.0 6345.2 4318.8 4327.1 4330.8 4340.6 4345.6 6456.2 6514.0 6549.1 6566.0 6577.8 4453.0 4458.4 4469.5 4479.6 4490.8 4498.7 4534.8 4539.9 4542.0 4549.0 5267.7 5280.5 5281.3 5281.6 5284.5 6188.3 6343.8 6356.5 6363.0 6374.5 1544.1 1544.9 1545.5 1559.4 1561.1 1027.3 1050.7 1057.0 1077.2 1080.3 6204.8 6207.1 6215.2 6219.7 6220.9 6585.7 6587.7 6590.1 6590.2 6602.0 5987.3 5995.8 6163.0 6166.9 6169.0 3557.7 3573.6 3593.2 3597.3 3604.5 6785.8 6786.0 6792.8 6793.5 6794.7 6637.7 6702.8 6788.7 6805.6 6810.3 6768.9 6774.0 6778.8 6782.7 6785.6 6618.4 6623.0 6625.4 6630.2 6636.9 6428.8 6597.6 6608.3 6614.7 6617.3 6818.8 6828.7 6830.4 6837.4 6841.1 4451.4 4475.4 4477.7 4478.4 4485.3 6559.5 6694.5 6701.1 6702.2 6715.4 6476.7 6517.8 6524.0 6530.7 6534.1 6487.2 6492.2 6494.8 6502.1 6503.3 6237.9 6380.5 6395.6 6398.9 6399.7 6537.5 6542.3 6546.4 6547.6 6551.4 6234.5 6359.7 6364.6 6367.8 6377.4 10:34:00 INFO - 2016-02-12 10:34:00,754 DEBUG : BROWSER_OUTPUT: 10:34:00 INFO - 2016-02-12 10:34:00,754 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14624.91 Median:48369.39 stddev:16894.92 (34.9%) stddev-sans-first:16910.65 10:34:00 INFO - 2016-02-12 10:34:00,754 DEBUG : BROWSER_OUTPUT: Values: 850.7 895.7 927.2 941.2 957.4 14587.7 15176.6 15224.2 15240.8 15271.6 14220.8 14287.1 14291.9 14303.1 14313.6 762.7 771.8 912.7 927.5 927.9 905.0 912.4 916.4 918.4 922.3 803.5 949.2 955.3 955.7 955.8 803.7 950.8 952.3 959.1 959.9 699.5 699.5 699.8 700.9 705.6 13530.3 13936.9 13944.0 13944.1 13950.9 12953.2 13357.4 13536.1 14073.7 14091.9 10790.5 10915.9 10946.6 11092.4 11141.1 3881.6 3944.4 3947.8 3975.2 4036.9 46591.3 47467.5 47554.8 48942.3 49183.8 11026.7 11064.9 11080.3 11190.4 11291.0 20894.5 20934.7 20965.5 20975.0 21033.7 7968.2 8063.4 8207.3 8245.7 8268.2 4530.8 4540.2 4552.7 4568.4 4639.8 3296.1 3296.1 3316.1 3321.4 3321.7 580.4 597.6 598.3 602.7 612.8 657.8 721.3 734.2 738.2 772.6 8564.2 8729.7 8976.6 9269.7 9690.0 688.2 721.6 750.9 759.3 763.0 4077.3 4163.1 4277.0 4334.2 4359.3 54438.2 62887.0 63584.0 63622.0 63676.7 52815.0 53408.5 54157.7 54412.7 55220.7 47539.5 49408.4 49696.0 50224.7 53399.2 8692.9 8759.3 9069.3 9114.4 9182.5 36388.3 36699.4 37165.6 37584.4 38501.4 45830.3 47649.0 47796.5 49467.8 49647.5 11559.5 11565.4 11617.3 11882.5 12144.0 12604.3 12618.0 12705.2 12891.8 12917.7 11785.4 11879.5 12012.5 12020.7 12247.6 11775.6 11974.8 12111.3 12144.9 12238.6 9288.9 11331.3 11543.5 11574.7 11765.3 9322.4 9340.4 9444.1 9516.2 9818.3 8659.4 8878.9 8895.7 9084.2 9105.2 10:34:00 INFO - 2016-02-12 10:34:00,755 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:34:00 INFO - 2016-02-12 10:34:00,755 DEBUG : BROWSER_OUTPUT: 10:34:01 INFO - 2016-02-12 10:34:01,288 INFO : Browser exited with error code: 0 10:34:01 INFO - 2016-02-12 10:34:01,304 INFO : Completed test dromaeo_css (00:18:28) 10:34:01 INFO - 2016-02-12 10:34:01,304 INFO : Starting test kraken 10:34:01 INFO - 2016-02-12 10:34:01,304 DEBUG : operating with platform_type : linux_ 10:34:01 INFO - 2016-02-12 10:34:01,304 INFO : Initialising browser for kraken test... 10:34:01 INFO - 2016-02-12 10:34:01,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp46lV2/profile http://localhost:59037/getInfo.html 10:34:04 INFO - 2016-02-12 10:34:04,646 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:34:04 INFO - 2016-02-12 10:34:04,646 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:34:04 INFO - 2016-02-12 10:34:04,647 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:34:04 INFO - 2016-02-12 10:34:04,647 DEBUG : BROWSER_OUTPUT: __metrics 10:34:04 INFO - 2016-02-12 10:34:04,788 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:05 INFO - 2016-02-12 10:34:05,827 INFO : Browser initialized. 10:34:05 INFO - 2016-02-12 10:34:05,828 INFO : Running cycle 1/1 for kraken test... 10:34:05 INFO - 2016-02-12 10:34:05,828 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp46lV2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:34:17 INFO - 2016-02-12 10:34:17,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 133959680 10:34:17 INFO - 2016-02-12 10:34:17,515 DEBUG : BROWSER_OUTPUT: 10:34:19 INFO - 2016-02-12 10:34:19,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59037/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:20 INFO - 2016-02-12 10:34:20,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 166113280 10:34:20 INFO - 2016-02-12 10:34:20,539 DEBUG : BROWSER_OUTPUT: 10:34:23 INFO - 2016-02-12 10:34:23,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59037/tests/kraken/driver.html?testName=audio-dft) 10:34:23 INFO - 2016-02-12 10:34:23,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 162844672 10:34:23 INFO - 2016-02-12 10:34:23,648 DEBUG : BROWSER_OUTPUT: 10:34:26 INFO - 2016-02-12 10:34:26,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59037/tests/kraken/driver.html?testName=audio-fft) 10:34:26 INFO - 2016-02-12 10:34:26,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 160370688 10:34:26 INFO - 2016-02-12 10:34:26,987 DEBUG : BROWSER_OUTPUT: 10:34:28 INFO - 2016-02-12 10:34:28,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59037/tests/kraken/driver.html?testName=audio-oscillator) 10:34:29 INFO - 2016-02-12 10:34:29,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 160628736 10:34:29 INFO - 2016-02-12 10:34:29,516 DEBUG : BROWSER_OUTPUT: 10:34:31 INFO - 2016-02-12 10:34:31,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59037/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:32 INFO - 2016-02-12 10:34:32,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 159531008 10:34:32 INFO - 2016-02-12 10:34:32,243 DEBUG : BROWSER_OUTPUT: 10:34:35 INFO - 2016-02-12 10:34:35,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59037/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:35 INFO - 2016-02-12 10:34:35,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 159326208 10:34:35 INFO - 2016-02-12 10:34:35,647 DEBUG : BROWSER_OUTPUT: 10:34:38 INFO - 2016-02-12 10:34:38,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59037/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:39 INFO - 2016-02-12 10:34:39,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 159887360 10:34:39 INFO - 2016-02-12 10:34:39,558 DEBUG : BROWSER_OUTPUT: 10:34:42 INFO - 2016-02-12 10:34:42,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59037/tests/kraken/driver.html?testName=json-parse-financial) 10:34:42 INFO - 2016-02-12 10:34:42,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 161009664 10:34:42 INFO - 2016-02-12 10:34:42,822 DEBUG : BROWSER_OUTPUT: 10:34:44 INFO - 2016-02-12 10:34:44,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59037/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:44 INFO - 2016-02-12 10:34:44,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 167120896 10:34:44 INFO - 2016-02-12 10:34:44,928 DEBUG : BROWSER_OUTPUT: 10:34:46 INFO - 2016-02-12 10:34:46,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:47 INFO - 2016-02-12 10:34:47,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 164339712 10:34:47 INFO - 2016-02-12 10:34:47,280 DEBUG : BROWSER_OUTPUT: 10:34:49 INFO - 2016-02-12 10:34:49,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:49 INFO - 2016-02-12 10:34:49,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 170856448 10:34:49 INFO - 2016-02-12 10:34:49,799 DEBUG : BROWSER_OUTPUT: 10:34:52 INFO - 2016-02-12 10:34:52,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:52 INFO - 2016-02-12 10:34:52,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 177283072 10:34:52 INFO - 2016-02-12 10:34:52,739 DEBUG : BROWSER_OUTPUT: 10:34:55 INFO - 2016-02-12 10:34:55,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:55 INFO - 2016-02-12 10:34:55,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 176082944 10:34:55 INFO - 2016-02-12 10:34:55,802 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59037/tests/kraken/driver.html?testName=ai-astar) 10:34:57 INFO - 2016-02-12 10:34:57,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 234487808 10:34:57 INFO - 2016-02-12 10:34:57,700 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,700 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;103;108;109;109;99;109;108;109 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;129;148;166;121;143;154;123;162;121 10:34:57 INFO - 2016-02-12 10:34:57,701 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;158;160;159;159;164;160;160 10:34:57 INFO - 2016-02-12 10:34:57,702 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;156;73;72;72;71;146;71 10:34:57 INFO - 2016-02-12 10:34:57,702 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;140;92;93;92;135;91;92;140 10:34:57 INFO - 2016-02-12 10:34:57,702 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;109;109;109;109 10:34:57 INFO - 2016-02-12 10:34:57,702 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;146;147;147;146;146;146;146 10:34:57 INFO - 2016-02-12 10:34:57,702 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;95;96;95;95 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;58;59;59;57;59;56;57 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;64;66;65;64;65;65;65 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;78;78;85;78;78;78;79;77 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;111;117;111;119;120;114;117;112;111 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;142;142;142;142;143;157;143;145;132 10:34:57 INFO - 2016-02-12 10:34:57,703 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;63;65;65;66;63;64;63;64;63 10:34:57 INFO - 2016-02-12 10:34:57,704 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:34:57 INFO - 2016-02-12 10:34:57,704 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:34:57 INFO - 2016-02-12 10:34:57,704 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,912 10:34:57 INFO - 2016-02-12 10:34:57,704 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:34:57 INFO - 2016-02-12 10:34:57,704 DEBUG : BROWSER_OUTPUT: __startTimestamp1455302097694__endTimestamp 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.60 (3.3%) stddev-sans-first:3.77 10:34:57 INFO - 2016-02-12 10:34:57,705 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 103.0 108.0 109.0 109.0 99.0 109.0 108.0 109.0 10:34:57 INFO - 2016-02-12 10:34:57,706 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,706 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.50 stddev:17.05 (11.5%) stddev-sans-first:17.87 10:34:57 INFO - 2016-02-12 10:34:57,706 DEBUG : BROWSER_OUTPUT: Values: 149.0 129.0 148.0 166.0 121.0 143.0 154.0 123.0 162.0 121.0 10:34:57 INFO - 2016-02-12 10:34:57,706 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,706 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 158.0 160.0 159.0 159.0 164.0 160.0 160.0 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:33.35 (46.3%) stddev-sans-first:34.93 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 156.0 73.0 72.0 72.0 71.0 146.0 71.0 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:22.36 (24.3%) stddev-sans-first:23.14 10:34:57 INFO - 2016-02-12 10:34:57,707 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 140.0 92.0 93.0 92.0 135.0 91.0 92.0 140.0 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,708 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:34:57 INFO - 2016-02-12 10:34:57,709 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 10:34:57 INFO - 2016-02-12 10:34:57,709 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:1.07 (1.9%) stddev-sans-first:1.12 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 58.0 59.0 59.0 57.0 59.0 56.0 57.0 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 64.0 66.0 65.0 64.0 65.0 65.0 65.0 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.46 (3.2%) stddev-sans-first:2.55 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 78.0 78.0 85.0 78.0 78.0 78.0 79.0 77.0 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:117.00 stddev:3.70 (3.2%) stddev-sans-first:3.64 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: Values: 119.0 111.0 117.0 111.0 119.0 120.0 114.0 117.0 112.0 111.0 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.40 Median:142.50 stddev:6.42 (4.5%) stddev-sans-first:6.37 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: Values: 136.0 142.0 142.0 142.0 142.0 143.0 157.0 143.0 145.0 132.0 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: 10:34:57 INFO - 2016-02-12 10:34:57,710 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 10:34:57 INFO - 2016-02-12 10:34:57,711 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 65.0 65.0 66.0 63.0 64.0 63.0 64.0 63.0 10:34:57 INFO - 2016-02-12 10:34:57,711 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:34:57 INFO - 2016-02-12 10:34:57,711 DEBUG : BROWSER_OUTPUT: 10:34:58 INFO - 2016-02-12 10:34:58,344 INFO : Browser exited with error code: 0 10:34:58 INFO - 2016-02-12 10:34:58,394 INFO : Completed test kraken (00:00:57) 10:34:58 INFO - 2016-02-12 10:34:58,394 INFO : Starting test v8_7 10:34:58 INFO - 2016-02-12 10:34:58,394 DEBUG : operating with platform_type : linux_ 10:34:58 INFO - 2016-02-12 10:34:58,395 INFO : Initialising browser for v8_7 test... 10:34:58 INFO - 2016-02-12 10:34:58,401 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplHjPwd/profile http://localhost:59037/getInfo.html 10:35:01 INFO - 2016-02-12 10:35:01,980 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:35:01 INFO - 2016-02-12 10:35:01,980 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:35:01 INFO - 2016-02-12 10:35:01,980 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:35:01 INFO - 2016-02-12 10:35:01,980 DEBUG : BROWSER_OUTPUT: __metrics 10:35:02 INFO - 2016-02-12 10:35:02,117 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:35:02 INFO - 2016-02-12 10:35:02,943 INFO : Browser initialized. 10:35:02 INFO - 2016-02-12 10:35:02,944 INFO : Running cycle 1/1 for v8_7 test... 10:35:02 INFO - 2016-02-12 10:35:02,944 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplHjPwd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:35:14 INFO - 2016-02-12 10:35:14,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 132063232 10:35:14 INFO - 2016-02-12 10:35:14,641 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59037/tests/v8_7/run.html (next: http://localhost:59037/tests/v8_7/run.html) 10:35:36 INFO - 2016-02-12 10:35:36,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 423469056 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: |0;Richards;167.50418760469012 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.39256945586058 10:35:36 INFO - 2016-02-12 10:35:36,258 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5213.541666666667 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |5;Earley;538.5029617662897 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |6;Boyer;10568.421052631578 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |7;RegExp;24142.85714285714 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |8;Splay;524.1090146750524 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:35:36 INFO - 2016-02-12 10:35:36,259 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1455302136255__endTimestamp 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,260 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,261 DEBUG : BROWSER_OUTPUT: Values: 167.5 10:35:36 INFO - 2016-02-12 10:35:36,261 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,261 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.39 Median:164.39 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,261 DEBUG : BROWSER_OUTPUT: Values: 164.4 10:35:36 INFO - 2016-02-12 10:35:36,261 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,262 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,262 DEBUG : BROWSER_OUTPUT: Values: 278.7 10:35:36 INFO - 2016-02-12 10:35:36,262 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,262 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: Values: 5213.5 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: Values: 950.6 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,263 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:538.50 Median:538.50 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: Values: 538.5 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10568.42 Median:10568.42 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: Values: 10568.4 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24142.86 Median:24142.86 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: Values: 24142.9 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.11 Median:524.11 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,264 DEBUG : BROWSER_OUTPUT: Values: 524.1 10:35:36 INFO - 2016-02-12 10:35:36,265 DEBUG : BROWSER_OUTPUT: 10:35:36 INFO - 2016-02-12 10:35:36,265 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:35:36 INFO - 2016-02-12 10:35:36,265 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:35:36 INFO - 2016-02-12 10:35:36,266 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:35:36 INFO - 2016-02-12 10:35:36,266 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2016-02-12 10:35:37,015 INFO : Browser exited with error code: 0 10:35:37 INFO - 2016-02-12 10:35:37,032 INFO : Completed test v8_7 (00:00:38) 10:35:37 INFO - 2016-02-12 10:35:37,324 INFO : Completed test suite (00:20:04) 10:35:37 INFO - 2016-02-12 10:35:37,324 DEBUG : Working with test: dromaeo_css 10:35:37 INFO - 2016-02-12 10:35:37,324 DEBUG : Generating results file: dromaeo_css 10:35:37 INFO - 2016-02-12 10:35:37,326 DEBUG : Working with test: kraken 10:35:37 INFO - 2016-02-12 10:35:37,326 DEBUG : Generating results file: kraken 10:35:37 INFO - 2016-02-12 10:35:37,326 INFO : javascript benchmark 10:35:37 INFO - 2016-02-12 10:35:37,327 DEBUG : Working with test: v8_7 10:35:37 INFO - 2016-02-12 10:35:37,327 DEBUG : Generating results file: v8_7 10:35:37 INFO - 2016-02-12 10:35:37,327 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:35:37 INFO - 2016-02-12 10:35:37,378 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:35:37 INFO - 2016-02-12 10:35:37,378 DEBUG : process_Request line: dromaeo_css 7196.81 graph.html#tests=[[72,53,35]] 10:35:37 INFO - 2016-02-12 10:35:37,378 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:35:37 INFO - 2016-02-12 10:35:37,494 DEBUG : process_Request line: kraken 1476.30 graph.html#tests=[[232,53,35]] 10:35:37 INFO - 2016-02-12 10:35:37,495 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:35:37 INFO - 2016-02-12 10:35:37,627 DEBUG : process_Request line: v8_7 23295.71 graph.html#tests=[[230,53,35]] 10:35:37 INFO - 2016-02-12 10:35:37,628 INFO : javascript benchmark 10:35:37 INFO - 2016-02-12 10:35:37,631 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3196.376706542222, 3230.612326520816, 3237.401080800052, 3248.496483045128, 3251.040942921838, 5275.0768615492325, 5317.175837745146, 5320.201969704546, 5332.680039197651, 5355.437679043698, 5291.391489978653, 5310.973445132769, 5313.442088580701, 5318.734063296839, 5385.407605163438, 4702.576768090871, 4802.135615589193, 4857.028594281141, 4867.926981095268, 4909.631777616675, 4810.230363141898, 4834.540718631724, 4857.975710121462, 4880.145974454474, 4929.162042452774, 4883.29192267121, 4975.054739599483, 4994.425641051271, 4995.175795993657, 4995.975020124894, 4889.6088312935235, 4958.801647934079, 4967.180415231483, 4977.726225057639, 4987.476314986929, 4704.482506924235, 4757.857264282077, 4771.904561908777, 4848.8302909398, 4898.755062246873, 5234.345706786652, 5259.2899958505495, 5259.552938000236, 5259.947400526023, 5270.789168433258, 5779.219805326269, 5783.88432231353, 5801.796937107181, 5809.448102430305, 5821.446962538552, 5520.779168833242, 5620.185073164409, 5700.7149642518125, 5747.425257474261, 5817.360090390053, 5378.91931621026, 5380.515753582157, 5380.569554435675, 5382.730863456812, 5386.542143917772, 5542.722863856791, 5735.655860648374, 5786.652800831964, 5788.855278618068, 5790.88418231633, 5466.781328746885, 5540.418256083134, 5576.888462230732, 5583.69289689071, 5590.273264475592, 5763.85590360236, 5788.21859049023, 5788.305403351541, 5789.305283366023, 5793.623414478046, 5492.148716948879, 5764.827055188351, 5766.3368712598585, 5767.88464230713, 5769.826905192851, 5536.086545719912, 5591.776328946878, 5612.326520817446, 5638.210650508932, 5645.407232240637, 4345.3699213613845, 4348.0869017506675, 4352.608265256142, 4356.956430435718, 4357.607815296638, 3893.377059670439, 3970.82131304092, 3973.324534829086, 3982.522097348337, 4009.5389030261895, 5360.973195134077, 5430.42980487051, 5438.809641662523, 5445.101558242845, 5472.398036216013, 5734.7132643368495, 5812.680302583314, 5828.766849326064, 5829.795957141479, 5832.12518122285, 5330.0, 5421.078416669176, 5454.672719636835, 5528.640638358494, 5547.972260138674, 5060.392752869606, 5063.569596584258, 5064.569511591556, 5075.111855425286, 5081.00920320534, 5888.705564721832, 5936.376680448577, 5939.316978547436, 5940.79207227745, 5945.0, 5550.361708403585, 5599.832005039855, 5646.520045796154, 5793.044147715748, 5808.012637851575, 5875.618084824473, 5885.087811389241, 5887.646741195542, 5891.49922256613, 5938.406159384027, 5641.37944826077, 5666.291713535808, 5666.433356664301, 5668.7165641718575, 5671.376148623565, 5568.888622227614, 5623.746931388179, 5670.319561652628, 5694.572907031907, 5750.5112065474905, 5678.3186017678145, 5680.346760122474, 5715.31416230055, 5715.31416230055, 5719.542436604978, 5693.829185124453, 5694.971525142348, 5699.173619825185, 5707.885842283048, 5710.0, 5348.705821179872, 5431.185322201543, 5444.183372493999, 5542.944570554243, 5585.162225666182, 5627.718614069362, 5629.915551266652, 5659.717014149359, 5662.575306852085, 5680.545556355399, 5474.890502190014, 5487.039768040657, 5539.612227144061, 5544.445555444423, 5545.750441230235], "unit": "ms", "name": "dojo.html", "value": 5288.434760659749}, {"lowerIsBetter": false, "replicates": [574.4829653312019, 627.6767464755654, 630.3035146163489, 633.8605506788508, 678.2031113441705, 33659.15852103695, 42206.36690449642, 42944.0, 43002.7849860751, 43127.56872431278, 45552.0, 46303.76848115763, 46315.0, 46386.072278554406, 46389.0, 8175.5503447310375, 8319.83360332793, 9068.501232432214, 9193.724188274362, 9234.769130771718, 10801.67594972152, 11074.446277686124, 11077.723056923602, 11088.33469991799, 11089.2237543372, 10682.145428365711, 10806.081483073947, 10808.405537695462, 10815.621453249138, 10819.513121909533, 10675.679729608124, 10699.946500267488, 10763.192760542912, 10763.892361076367, 10773.138148948065, 10611.0, 10751.247412681116, 10765.62320318793, 10769.730756731065, 10773.5690572377, 43466.34800477995, 43751.0, 43821.27519160875, 43835.78082109601, 43916.0, 3230.8384580770867, 3349.112485191426, 3362.680545348188, 3720.683741881943, 4199.265128602482, 31905.202369940704, 32555.83722081398, 32580.511292330633, 32811.343773124405, 33306.0, 4120.711550191488, 4183.853565125206, 4221.366794980747, 4236.364545318196, 4364.934525982113, 285620.0, 285876.0, 286239.0, 287515.0, 287734.0, 61353.69323153356, 61987.38012619816, 74591.0, 75782.0, 75834.62082689551, 67093.0, 67155.66422167956, 67278.0, 67341.66329168323, 67555.0, 15428.84571154274, 15548.144852033021, 15681.05913645185, 15704.0, 15744.763828542582, 13903.165810051429, 13992.0, 14003.229822359664, 14026.228557429235, 14091.647708807157, 22189.889050554644, 22560.548789024455, 22561.4359641007, 22573.32280031602, 22584.66123008156, 8258.793530161794, 8491.0, 8517.659293628309, 8523.403361764616, 8648.740537783877, 1050.8896565860628, 1053.2206167436043, 1115.2806439846254, 1137.0392018744149, 1151.8272259161192, 35071.64928350735, 35316.47025294622, 35478.82260588732, 35616.1507079433, 35719.0, 1125.9528638366235, 1199.244475980127, 1239.4360565942475, 1255.9434825432877, 1261.703499677575, 14951.626209344853, 15649.217539122998, 15914.0451572906, 16269.0, 18273.17770700322, 407096.0, 408656.0, 412363.0, 415120.0, 415530.0, 59636.701816491506, 60000.69999650061, 60137.699311503166, 60220.0, 60257.39742602606, 1338.1703343926633, 1415.6248594122567, 1488.7171437426855, 1492.9178895160653, 1524.8246451657978, 34406.0, 34705.82647086748, 34757.47863782096, 34805.65194348024, 34883.47674784931, 54088.729556351966, 54693.453065468835, 54769.45230547803, 54919.725401372736, 54931.725341373036, 311812.0, 312691.0, 314068.0, 314124.0, 314357.0, 34917.650823491436, 35348.64651353556, 35479.46780798342, 35633.28733425369, 35861.46207806937, 46193.30710039285, 46749.2987605193, 46809.0, 46841.76579117082, 47174.764126180526, 38129.428058579695, 38263.61736382601, 38280.0, 38602.0, 39110.804445977585, 39328.2134357317, 45720.31419528643, 45934.31098533458, 46610.76694616505, 47777.04445911132, 38800.22399552049, 38987.80506097451, 39290.01774955649, 39319.0, 39433.605663942995, 33212.335753284315, 34449.48325775065, 34836.651633484355, 34884.0, 35080.0, 27060.594091089042, 27301.317467063483, 27485.31286717848, 27492.075554710977, 27536.311592210353], "unit": "ms", "name": "ext.html", "value": 20846.86819942231}, {"lowerIsBetter": false, "replicates": [359.80570491934355, 362.35139101009196, 373.71037445979346, 376.7249907567474, 379.0618219905734, 14739.85260147401, 16104.597385065379, 17506.474805755817, 18903.905480472597, 19470.90264548677, 16648.0, 16682.58293542662, 16892.1553922304, 17078.31686732529, 17102.0, 5466.480684334992, 5694.316681998145, 5698.629589076718, 5711.885762284773, 5712.22884910538, 4367.759773212472, 4494.865154045384, 5665.23519324892, 6074.757009719606, 6278.30938596754, 6102.0, 6214.130021796929, 6222.315545290015, 6245.594036387621, 6263.937360626381, 6212.65830379329, 6227.875442491148, 6247.031710084944, 6251.874962500748, 6256.092866534327, 5384.515393614593, 5491.258680078178, 5492.642978206404, 5506.256655351516, 5515.972420137874, 21117.0, 21217.257395991066, 21416.250431234832, 22272.554548909095, 22451.101955921906, 2200.5928903152967, 2204.9669254961186, 2207.0, 2240.406292332533, 2298.321995011476, 9162.404443711137, 9270.675526356545, 9386.765330866714, 9400.20098291646, 9597.47213903235, 1837.9724304135448, 1865.1047497201284, 1870.1864688860253, 1915.7796853361901, 1928.4503916383762, 62928.0, 64154.358456415306, 64250.35749642537, 65158.3484165157, 65685.3431465684, 10392.740181495372, 10393.37639741618, 10410.739731506774, 10442.112420444348, 10470.214733894989, 12946.0, 12963.935180324039, 12968.35158242084, 12998.740025199442, 13010.804837927439, 7709.961450192825, 7720.112187098443, 7777.300042996158, 7781.0, 7906.169852165554, 7449.441291903129, 7519.624018799038, 7522.172561018284, 7564.924350756422, 7592.354649854714, 4238.703290769617, 4245.702800803976, 4298.677599180074, 4338.327559228262, 4368.650507959355, 1709.8717596180336, 1756.1482680899753, 1785.4554360920044, 1811.9909400452914, 1831.835134837871, 938.2775263047415, 946.4132238012339, 975.3708857786688, 989.9851502227473, 1057.7567159553191, 14378.56864294052, 15293.464728734441, 15906.52280431589, 16056.277467513757, 16309.836901630832, 1010.6917390196061, 1026.4508487959056, 1052.6157952347492, 1088.0134032081985, 1118.1948996722347, 9928.156106730865, 10038.799224015478, 10125.696229113139, 10132.73340832396, 10149.746256343651, 609190.0, 610076.0, 616332.0, 626060.0, 642188.0, 79333.60333198412, 80713.0, 81090.59454702689, 81320.59339703263, 82965.58517207376, 1111.3387534417009, 1121.1815374776295, 1121.9439028048564, 1146.1232157399595, 1149.2874417860812, 15794.447194348142, 15811.841881581036, 15871.761923570924, 16136.435224767547, 16274.267657955184, 35592.288154237285, 36328.81835590805, 36455.453168201966, 37284.6271537292, 38108.047298816644, 49244.507554925425, 49533.75233123956, 50018.0, 52052.0, 53226.93546128978, 9271.814563708824, 9419.199368053793, 9428.717138485856, 9570.090841370058, 9576.856347154937, 10943.124550036136, 11046.558137674403, 11047.944760276147, 17011.404600838912, 17891.10544472797, 14892.702145956804, 15081.622959426102, 15178.77231841501, 15317.46388876384, 15468.767968480257, 14076.085054471427, 14125.223112728898, 14671.633209169857, 15379.923100384427, 15429.0, 12333.691657708629, 14421.42314307416, 15313.770293445385, 15442.613934651723, 15593.922030389775, 9671.806563868542, 9766.121049105615, 9816.65641702537, 9839.557219925264, 9849.95075024649, 13830.930845345709, 14072.366743496363, 14541.41834326615, 14945.701085978437, 15297.0], "unit": "ms", "name": "jquery.html", "value": 9137.388156951823}, {"lowerIsBetter": false, "replicates": [1527.9541613751592, 1530.0743050454469, 1719.5958949646838, 1794.7397627344033, 1827.4243613261822, 6976.093107895973, 7489.513181643196, 7495.138059123189, 7506.624668766567, 7534.924650753491, 7414.925850741491, 7450.515716478439, 7454.850902981937, 7519.172890982001, 7537.020187375647, 2205.1620384254043, 2210.204326442479, 2247.7752224777555, 2248.820094392453, 2248.977510224893, 2214.678871563622, 2247.0337754765446, 2247.3033359658557, 2248.4154119928853, 2251.324602619208, 1996.4809149621058, 2032.1871251499444, 2177.7822217778175, 2217.5675743230076, 2266.9206577769783, 2233.4974630708125, 2245.820334373246, 2264.071730590458, 2264.3659775262954, 2266.9659955100688, 2192.331338941622, 2259.35608351619, 2261.4233370490583, 2264.1396269417683, 2265.3883451468178, 6480.384363485461, 6635.900461493082, 7151.57090574562, 7309.086364204474, 7321.231270716551, 4492.595666390008, 4543.795529201161, 4547.931781023287, 4556.3621093047, 4565.589096981287, 2884.5817356483403, 2941.911742647724, 2942.9117126486026, 2959.1270575180374, 2975.5685425613383, 926.9536523173882, 930.1675000874247, 941.5292353823088, 959.4051687953513, 966.1063516247514, 9565.521723913776, 9591.280653950911, 9623.0, 9630.807383852354, 9642.276829237766, 3921.686265098785, 3925.3523168676847, 3981.2634662587516, 3982.2831890259454, 3986.063275130342, 8455.408121431563, 8473.49159050459, 8490.830183396421, 8497.787555311166, 8518.063013068557, 4515.841945531891, 4521.886952826206, 4522.547745225451, 4525.7510836904285, 4531.27499600069, 4101.5488296287385, 4132.421460995463, 4137.958620413758, 4140.91718165641, 4147.129102888367, 3373.241020770307, 3433.639467855889, 3448.8792892248653, 3454.2227998700596, 3455.2571197192724, 1059.2161800267747, 1060.6817954613584, 1061.9256652034437, 1069.1179776684266, 1069.5561342042965, 1444.7399468095844, 1458.3291685824427, 1468.6548661064642, 1485.2647939269914, 1491.36616937801, 7207.5675459472595, 7225.963870180721, 7230.457715671346, 7241.0, 7251.1661158966335, 437.33525041936076, 439.4748275810376, 441.7614488176413, 443.60740744440756, 450.6507456721067, 5405.189221616789, 5817.011108111631, 5905.173275741399, 5909.468147866627, 5914.349421563625, 7762.534247945141, 8312.83374332522, 8322.16778322175, 8469.576521173916, 8481.236688698047, 8172.959135204286, 8272.586370681442, 8340.582970851434, 8347.833043339098, 8355.0, 7070.186928503185, 7136.7145314186855, 7195.136583609896, 7215.062041934515, 7220.602866842479, 7111.502194846311, 7131.393831524171, 7183.784486465414, 7189.532680375759, 7224.855502890018, 7859.685612575433, 7875.251851074138, 7916.247956444128, 8084.555349455836, 8095.676172953252, 8086.11052784205, 8096.311813495919, 8107.0, 8254.133316001973, 8270.048944371474, 6735.865282694416, 6771.085903402977, 6799.830004249933, 6802.183737951477, 6811.795646130624, 7334.889976650248, 7361.0, 7377.225391333833, 7400.555966642019, 7434.702611895464, 6750.459963202834, 6942.0, 6948.756793512202, 6984.580925144508, 7017.2631873652535, 6881.346272104142, 6882.931170688429, 6931.549449285781, 6993.475489338218, 7048.647567621701, 6951.200611929693, 7024.4029257513685, 7062.858742825218, 7063.894041589483, 7070.328318809705, 6505.772297969548, 6577.835554111186, 6578.342165783383, 6578.901316480353, 6586.0450234714735, 6414.422701956846, 6480.902786458113, 6488.578242414228, 6579.703913324008, 6643.0], "unit": "ms", "name": "mootools.html", "value": 4257.292045653819}, {"lowerIsBetter": false, "replicates": [312.2194513715711, 321.64940215165467, 329.7905829798076, 332.88515462165543, 339.595880901727, 5981.461668449839, 6016.187814645022, 6087.208662873832, 6101.206843110395, 6131.754729810802, 5707.971460142693, 5818.5926985111055, 5867.383924687911, 5969.910451343233, 5982.102684597302, 4610.746408947506, 4620.861374158764, 4625.306204069383, 4632.745199014062, 4644.930326045112, 4563.931541026887, 4594.931076033862, 4612.654050946176, 4635.096156249533, 4649.8837529061875, 4349.304111342186, 4457.687961842672, 4457.88855278619, 4567.13224487348, 4568.84009059683, 4553.4535855697195, 4565.908681826378, 4579.427571553556, 4580.129775342708, 4590.449146102455, 4009.51885773709, 4009.719319647626, 4011.2178125265586, 4012.197560487914, 4012.2376748417705, 5721.7711291548285, 5731.828045158611, 5733.741981610838, 5734.254546908917, 5752.137179423078, 5093.490650934914, 5220.243064755589, 5230.058589453897, 5236.162214045772, 5270.762815673265, 6331.39851714091, 6340.3659634036685, 6341.143945567335, 6342.968285158545, 6345.17512723343, 4318.82724691012, 4327.06968001878, 4330.826766929319, 4340.587644173798, 4345.587169218919, 6456.160699109133, 6513.967430162867, 6549.1158693576235, 6566.0150977353305, 6577.835554111186, 4452.977735111303, 4458.353538736865, 4469.530699276529, 4479.641628669699, 4490.842820501267, 4498.707584007095, 4534.750588717652, 4539.863804085882, 4541.954580454153, 4549.0447006128425, 5267.657602255841, 5280.471952804689, 5281.313429254173, 5281.573975026721, 5284.497972692588, 6188.2883468400805, 6343.841403964938, 6356.523260755462, 6363.045543168561, 6374.458171055419, 1544.1430006346586, 1544.938202471911, 1545.5208885245386, 1559.4230134849952, 1561.149173700336, 1027.2963020331097, 1050.7373156710823, 1056.9894301057045, 1077.1544337694872, 1080.254624309224, 6204.81385558434, 6207.131001659771, 6215.160953271341, 6219.689015549205, 6220.875582488416, 6585.6707164641575, 6587.670616469158, 6590.110335104795, 6590.242122155918, 6602.0, 5987.251593550806, 5995.760169593254, 6163.0, 6166.876662466815, 6168.9691551542855, 3557.7153827693724, 3573.5533058367705, 3593.2094939113354, 3597.2985267872514, 3604.459331100356, 6785.830354241183, 6786.0, 6792.8301792454595, 6793.524453288322, 6794.72821087151, 6637.734490620321, 6702.83242918931, 6788.694508747119, 6805.591664500146, 6810.31896810315, 6768.864622707617, 6773.983902414579, 6778.830529236809, 6782.728690852311, 6785.59286442815, 6618.371254730793, 6623.0, 6625.4037136657935, 6630.204375474974, 6636.933630663824, 6428.774992875227, 6597.571157874723, 6608.339166083546, 6614.66926653675, 6617.2721000688925, 6818.795436136924, 6828.7268509259075, 6830.419414349836, 6837.35045170708, 6841.110655614738, 4451.3545535896465, 4475.351074094173, 4477.731336119843, 4478.373027776049, 4485.259932111296, 6559.540832141895, 6694.497912656668, 6701.0953521274005, 6702.229243636849, 6715.3620406061345, 6476.70854811544, 6517.804465866032, 6523.967380163069, 6530.738770449128, 6534.052562378523, 6487.156669632917, 6492.188476440445, 6494.805155845333, 6502.122213501117, 6503.25212600557, 6237.875242495215, 6380.489560835215, 6395.552311338348, 6398.93601064002, 6399.712012959521, 6537.5096867734155, 6542.313057128933, 6546.410823025951, 6547.574407663486, 6551.44312733423, 6234.501239900887, 6359.7456101755415, 6364.649944252926, 6367.840803979752, 6377.362263773585], "unit": "ms", "name": "prototype.html", "value": 4800.882556486615}, {"lowerIsBetter": false, "replicates": [850.7362717557555, 895.7178488776033, 927.1655510040962, 941.199980016986, 957.3872721458264, 14587.70824583509, 15176.620584485394, 15224.162671053087, 15240.771388429155, 15271.618209544753, 14220.786688199685, 14287.14277143372, 14291.928540357283, 14303.070300430465, 14313.642158946006, 762.7482930632892, 771.756896577579, 912.726182145357, 927.5176908007832, 927.9118483744068, 905.027095871937, 912.4023764434273, 916.3677062826662, 918.42598376015, 922.2575826459731, 803.4616806739499, 949.1837020162654, 955.2883102088954, 955.6655170690237, 955.8327292723781, 803.6825453945688, 950.7908260182784, 952.347641865321, 959.0744931141481, 959.8608201810698, 699.464909344352, 699.5173330402006, 699.7795694356313, 700.8878579427267, 705.6224919668005, 13530.323483825769, 13936.93031534846, 13944.023918325722, 13944.093633913762, 13950.860491395058, 12953.158044727063, 13357.398917048757, 13536.05247632666, 14073.71852562943, 14091.929540352336, 10790.51442685081, 10915.890841091566, 10946.616868409568, 11092.389918554476, 11141.053010494037, 3881.611838816124, 3944.408338749182, 3947.822347994347, 3975.185087057146, 4036.8788936331957, 46591.30113048307, 47467.52532474665, 47554.76222618865, 48942.265866012036, 49183.75408122972, 11026.748397882438, 11064.944675276733, 11080.279781814157, 11190.440477976068, 11291.040261577693, 20894.47763805917, 20934.685979710317, 20965.47586310324, 20975.0, 21033.68449473259, 7968.243016913384, 8063.354931605458, 8207.302379297707, 8245.670173193004, 8268.173182681683, 4530.77346132692, 4540.228161212602, 4552.658550608651, 4568.428946381702, 4639.8144074237325, 3296.0606227225126, 3296.0606227225603, 3316.1378041708845, 3321.3523362943993, 3321.717653999437, 580.3876909860138, 597.6444015810586, 598.2730981857064, 602.6986506746626, 612.8314713453835, 657.81252343082, 721.2751185058983, 734.1630541183056, 738.1621859189751, 772.5828052851509, 8564.186402291773, 8729.738107856774, 8976.551172441352, 9269.675561355454, 9690.0, 688.2291833146808, 721.5526373648372, 750.9399248060142, 759.2673070487007, 762.954222746637, 4077.347624380085, 4163.146554956226, 4277.0, 4334.241507736197, 4359.302511598129, 54438.18342724862, 62887.0, 63584.0, 63622.0, 63676.68161659162, 52815.0, 53408.46591534113, 54157.72921135448, 54412.72793636007, 55220.72389638026, 47539.52460475351, 49408.42593332795, 49696.0, 50224.74887625612, 53399.199012014076, 8692.869606955774, 8759.291365257808, 9069.274458043208, 9114.40756350835, 9182.540872956459, 36388.27223455569, 36699.44950825686, 37165.6283437173, 37584.43623345597, 38501.42247866228, 45830.31254531118, 47649.0, 47796.522034780595, 49467.75266123646, 49647.50352496573, 11559.537618495166, 11565.421728913689, 11617.302961822317, 11882.524699011943, 12144.0, 12604.30676312775, 12618.0, 12705.17416367933, 12891.806622900476, 12917.741645167232, 11785.410729463321, 11879.465424055765, 12012.519499220283, 12020.699482512657, 12247.57133500359, 11775.587854425054, 11974.760504790029, 12111.333876636869, 12144.878551214375, 12238.571649992564, 9288.907110928803, 11331.320120792449, 11543.538258469567, 11574.6527604172, 11765.294082355085, 9322.440653560809, 9340.392874463138, 9444.102810233016, 9516.19112375428, 9818.263630227904, 8659.393842430969, 8878.911210887809, 8895.73312800617, 9084.18242358191, 9105.180533751729], "unit": "ms", "name": "yui.html", "value": 6747.645802229572}], "name": "dromaeo_css", "value": 7196.815138941417}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 108.0, 109.0, 109.0, 99.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [149.0, 129.0, 148.0, 166.0, 121.0, 143.0, 154.0, 123.0, 162.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 158.0, 160.0, 159.0, 159.0, 164.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 156.0, 73.0, 72.0, 72.0, 71.0, 146.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 140.0, 92.0, 93.0, 92.0, 135.0, 91.0, 92.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 58.0, 59.0, 59.0, 57.0, 59.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 78.0, 78.0, 85.0, 78.0, 78.0, 78.0, 79.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [119.0, 111.0, 117.0, 111.0, 119.0, 120.0, 114.0, 117.0, 112.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.1}, {"lowerIsBetter": true, "replicates": [136.0, 142.0, 142.0, 142.0, 142.0, 143.0, 157.0, 143.0, 145.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.4}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 65.0, 66.0, 63.0, 64.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1476.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [164.39256945586058], "unit": "score", "name": "DeltaBlue", "value": 402.195794}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [538.5029617662897], "unit": "score", "name": "Earley", "value": 1237.621791}, {"lowerIsBetter": false, "replicates": [10568.421052631578], "unit": "score", "name": "Boyer", "value": 63.06173804780874}, {"lowerIsBetter": false, "replicates": [24142.85714285714], "unit": "score", "name": "RegExp", "value": 37.73310650887576}, {"lowerIsBetter": false, "replicates": [524.1090146750524], "unit": "score", "name": "Splay", "value": 155.48482799999994}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23295.70866793765}]} 10:35:37 INFO - RETURN: dromaeo_css: 7196.81 10:35:37 INFO - RETURN: kraken: 1476.30 10:35:37 INFO - RETURN: v8_7: 23295.71 10:35:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23295.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1476.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7196.81"}}} 10:35:37 INFO - Return code: 0 10:35:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:35:37 INFO - # TBPL SUCCESS # 10:35:37 INFO - Running post-action listener: _resource_record_post_action 10:35:37 INFO - Running post-run listener: _resource_record_post_run 10:35:38 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 319488; Write bytes: 517500928; Read time: 80; Write time: 557824 10:35:38 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 251498496; Read time: 0; Write time: 361788 10:35:38 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 319488; Write bytes: 265744384; Read time: 80; Write time: 195996 10:35:38 INFO - Running post-run listener: _upload_blobber_files 10:35:38 INFO - Blob upload gear active. 10:35:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:35:38 INFO - Copying logs to upload dir... 10:35:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1251.466143 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-12 10:35:38.505384) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:35:38.509333) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009929 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455292155/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:35:38.560775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:35:38.561117) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1455297215.253390-1841195349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:35:38.610645) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 10:35:38.610963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 10:35:38.611254) ========= ========= Total master_lag: 0.25 =========