builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1455636567.61 results: success (0) buildid: 20160216050951 builduid: b72ff8994be346258afa8a5744caaf81 revision: 149fdfdb40d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.612561) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.613071) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.613413) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006304 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.649561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.649890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.688917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.689206) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.739090) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.739434) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.739821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.740107) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-16 07:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-02-16 07:29:28 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.882983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.883290) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022368 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.932739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:27.933089) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 149fdfdb40d1 --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 149fdfdb40d1 --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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-16 07:29:28,354 Setting DEBUG logging. 2016-02-16 07:29:28,354 attempt 1/10 2016-02-16 07:29:28,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/149fdfdb40d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 07:29:28,627 unpacking tar archive at: mozilla-beta-149fdfdb40d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:28.544437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:28.544776) ========= echo 149fdfdb40d1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'149fdfdb40d1'] 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 149fdfdb40d1 program finished with exit code 0 elapsedTime=0.004642 script_repo_revision: '149fdfdb40d1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:28.595897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:28.596211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 07:29:28.616091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-16 07:29:28.616366) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:29 INFO - MultiFileLogger online at 20160216 07:29:29 in /builds/slave/test-pgo 07:29:29 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 07:29:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:29:29 INFO - {'append_to_log': False, 07:29:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:29:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:29:29 INFO - 'branch': 'Mozilla-Beta', 07:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:29 INFO - 'config_files': ('talos/linux_config.py',), 07:29:29 INFO - 'default_actions': ('clobber', 07:29:29 INFO - 'read-buildbot-config', 07:29:29 INFO - 'download-and-extract', 07:29:29 INFO - 'populate-webroot', 07:29:29 INFO - 'create-virtualenv', 07:29:29 INFO - 'install', 07:29:29 INFO - 'run-tests'), 07:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:29 INFO - 'download_minidump_stackwalk': True, 07:29:29 INFO - 'download_symbols': 'ondemand', 07:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:29 INFO - 'installer_path': 'installer.exe', 07:29:29 INFO - 'log_level': 'info', 07:29:29 INFO - 'log_name': 'talos', 07:29:29 INFO - 'log_to_console': True, 07:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:29 INFO - 'opt_config_files': (), 07:29:29 INFO - 'pip_index': False, 07:29:29 INFO - 'sps_profile': False, 07:29:29 INFO - 'sps_profile_interval': 0, 07:29:29 INFO - 'suite': 'dromaeojs', 07:29:29 INFO - 'system_bits': '32', 07:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:29 INFO - 'title': 'talos-linux64-ix-066', 07:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:29 INFO - 'use_talos_json': True, 07:29:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:29 INFO - 'work_dir': 'build'} 07:29:29 INFO - ##### 07:29:29 INFO - ##### Running clobber step. 07:29:29 INFO - ##### 07:29:29 INFO - Running pre-action listener: _resource_record_pre_action 07:29:29 INFO - Running main action method: clobber 07:29:29 INFO - rmtree: /builds/slave/test-pgo/build 07:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:29:29 INFO - Running post-action listener: _resource_record_post_action 07:29:29 INFO - ##### 07:29:29 INFO - ##### Running read-buildbot-config step. 07:29:29 INFO - ##### 07:29:29 INFO - Running pre-action listener: _resource_record_pre_action 07:29:29 INFO - Running main action method: read_buildbot_config 07:29:29 INFO - Using buildbot properties: 07:29:29 INFO - { 07:29:29 INFO - "properties": { 07:29:29 INFO - "buildnumber": 125, 07:29:29 INFO - "product": "firefox", 07:29:29 INFO - "script_repo_revision": "production", 07:29:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:29:29 INFO - "repository": "", 07:29:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 07:29:29 INFO - "buildid": "20160216050951", 07:29:29 INFO - "slavename": "talos-linux64-ix-066", 07:29:29 INFO - "pgo_build": "True", 07:29:29 INFO - "basedir": "/builds/slave/test-pgo", 07:29:29 INFO - "project": "", 07:29:29 INFO - "platform": "ubuntu64_hw", 07:29:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:29:29 INFO - "slavebuilddir": "test", 07:29:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 07:29:29 INFO - "branch": "mozilla-beta", 07:29:29 INFO - "repo_path": "releases/mozilla-beta", 07:29:29 INFO - "stage_platform": "linux64-pgo", 07:29:29 INFO - "builduid": "b72ff8994be346258afa8a5744caaf81", 07:29:29 INFO - "revision": "149fdfdb40d1" 07:29:29 INFO - }, 07:29:29 INFO - "sourcestamp": { 07:29:29 INFO - "repository": "", 07:29:29 INFO - "hasPatch": false, 07:29:29 INFO - "project": "", 07:29:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 07:29:29 INFO - "changes": [ 07:29:29 INFO - { 07:29:29 INFO - "category": null, 07:29:29 INFO - "files": [ 07:29:29 INFO - { 07:29:29 INFO - "url": null, 07:29:29 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2" 07:29:29 INFO - } 07:29:29 INFO - ], 07:29:29 INFO - "repository": "", 07:29:29 INFO - "rev": "149fdfdb40d1", 07:29:29 INFO - "who": "sendchange", 07:29:29 INFO - "when": 1455636489, 07:29:29 INFO - "number": 7609666, 07:29:29 INFO - "comments": "Port bug 1228998 to fix bustage from bug 1239828 - Update Loop_s build configuration to use new Hierarchical structures. r=mshal,a=bustage-fix for CLOSED TREE", 07:29:29 INFO - "project": "", 07:29:29 INFO - "at": "Tue 16 Feb 2016 07:28:09", 07:29:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 07:29:29 INFO - "revlink": "", 07:29:29 INFO - "properties": [ 07:29:29 INFO - [ 07:29:29 INFO - "buildid", 07:29:29 INFO - "20160216050951", 07:29:29 INFO - "Change" 07:29:29 INFO - ], 07:29:29 INFO - [ 07:29:29 INFO - "builduid", 07:29:29 INFO - "b72ff8994be346258afa8a5744caaf81", 07:29:29 INFO - "Change" 07:29:29 INFO - ], 07:29:29 INFO - [ 07:29:29 INFO - "pgo_build", 07:29:29 INFO - "True", 07:29:29 INFO - "Change" 07:29:29 INFO - ] 07:29:29 INFO - ], 07:29:29 INFO - "revision": "149fdfdb40d1" 07:29:29 INFO - } 07:29:29 INFO - ], 07:29:29 INFO - "revision": "149fdfdb40d1" 07:29:29 INFO - } 07:29:29 INFO - } 07:29:29 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2. 07:29:29 INFO - Running post-action listener: _resource_record_post_action 07:29:29 INFO - ##### 07:29:29 INFO - ##### Running download-and-extract step. 07:29:29 INFO - ##### 07:29:29 INFO - Running pre-action listener: _resource_record_pre_action 07:29:29 INFO - Running main action method: download_and_extract 07:29:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/test_packages.json 07:29:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:29:29 INFO - Downloaded 1270 bytes. 07:29:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:29:29 INFO - Using the following test package requirements: 07:29:29 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:29:29 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 07:29:29 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'jsshell-linux-x86_64.zip'], 07:29:29 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 07:29:29 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:29:29 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 07:29:29 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 07:29:29 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 07:29:29 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 07:29:29 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 07:29:29 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 07:29:29 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:29:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:30 INFO - Downloaded 22211759 bytes. 07:29:30 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 07:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:29:30 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 07:29:31 INFO - Return code: 0 07:29:31 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 07:29: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')]} 07:29:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:29:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:32 INFO - Downloaded 22211759 bytes. 07:29:32 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 07:29:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 07:29:32 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 07:29:34 INFO - Return code: 0 07:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 07:29:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:37 INFO - Downloaded 11132038 bytes. 07:29:37 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 07:29:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 07:29:37 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 07:29:37 INFO - Return code: 0 07:29:37 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')]} 07:29:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:29:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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 07:29:40 INFO - Downloaded 58291221 bytes. 07:29:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:29:40 INFO - mkdir: /builds/slave/test-pgo/properties 07:29:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:29:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:29:40 INFO - Contents: 07:29:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2 07:29:40 INFO - Running post-action listener: _resource_record_post_action 07:29:40 INFO - Running post-action listener: set_extra_try_arguments 07:29:40 INFO - ##### 07:29:40 INFO - ##### Running populate-webroot step. 07:29:40 INFO - ##### 07:29:40 INFO - Running pre-action listener: _resource_record_pre_action 07:29:40 INFO - Running main action method: populate_webroot 07:29:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:40 INFO - '--tppagecycles', 07:29:40 INFO - '7'], 07:29:40 INFO - 'tests': ['tsvgm']}}, 07:29:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:29:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:29:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'tests': ['damp', 'tps']}, 07:29:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['damp', 'tps']}, 07:29:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:29:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:40 INFO - 'other': {'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'other_l64': {'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'other_nol64': {'tests': ['a11yr', 07:29:40 INFO - 'ts_paint', 07:29:40 INFO - 'tpaint', 07:29:40 INFO - 'sessionrestore', 07:29:40 INFO - 'sessionrestore_no_auto_restore']}, 07:29:40 INFO - 'svgr': {'tests': ['tsvgx', 07:29:40 INFO - 'tsvgr_opacity', 07:29:40 INFO - 'tart', 07:29:40 INFO - 'tscrollx', 07:29:40 INFO - 'cart']}, 07:29:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['tsvgx', 07:29:40 INFO - 'tsvgr_opacity', 07:29:40 INFO - 'tart', 07:29:40 INFO - 'tscrollx', 07:29:40 INFO - 'cart']}, 07:29:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'tests': ['tp5o']}, 07:29:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'talos_options': ['--e10s'], 07:29:40 INFO - 'tests': ['tp5o']}, 07:29:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'talos_options': ['--xperf_path', 07:29:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:40 INFO - 'tests': ['tp5n']}, 07:29:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:29:40 INFO - 'talos_options': ['--e10s', 07:29:40 INFO - '--xperf_path', 07:29:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:40 INFO - 'tests': ['tp5n']}}, 07:29:40 INFO - 'talos.zip': {'path': '', 07:29:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:40 INFO - Running post-action listener: _resource_record_post_action 07:29:40 INFO - ##### 07:29:40 INFO - ##### Running create-virtualenv step. 07:29:40 INFO - ##### 07:29:40 INFO - Running pre-action listener: _resource_record_pre_action 07:29:40 INFO - Running main action method: create_virtualenv 07:29:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:29:40 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 07:29:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:29:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:41 INFO - Using real prefix '/usr' 07:29:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:29:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:43 INFO - Installing pip.................done. 07:29:43 INFO - Return code: 0 07:29:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:29:43 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')]} 07:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:43 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')]} 07:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:43 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:43 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 07:29:43 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 07:29:43 INFO - Using env: {'DISPLAY': ':0', 07:29:43 INFO - 'HOME': '/home/cltbld', 07:29:43 INFO - 'LANG': 'en_US.UTF-8', 07:29:43 INFO - 'LANGUAGE': 'en_US:en', 07:29:43 INFO - 'LOGNAME': 'cltbld', 07:29:43 INFO - 'MAIL': '/var/mail/cltbld', 07:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:43 INFO - 'MOZ_NO_REMOTE': '1', 07:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:43 INFO - 'NO_EM_RESTART': '1', 07:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:43 INFO - 'SHELL': '/bin/bash', 07:29:43 INFO - 'SHLVL': '1', 07:29:43 INFO - 'TERM': 'linux', 07:29:43 INFO - 'TMOUT': '86400', 07:29:43 INFO - 'USER': 'cltbld', 07:29:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:43 INFO - '_': '/tools/buildbot/bin/python'} 07:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:43 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 07:29:43 INFO - Cleaning up... 07:29:43 INFO - Return code: 0 07:29:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:29:43 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')]} 07:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:43 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')]} 07:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:43 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:43 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 07:29:43 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 07:29:43 INFO - Using env: {'DISPLAY': ':0', 07:29:43 INFO - 'HOME': '/home/cltbld', 07:29:43 INFO - 'LANG': 'en_US.UTF-8', 07:29:43 INFO - 'LANGUAGE': 'en_US:en', 07:29:43 INFO - 'LOGNAME': 'cltbld', 07:29:43 INFO - 'MAIL': '/var/mail/cltbld', 07:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:43 INFO - 'MOZ_NO_REMOTE': '1', 07:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:43 INFO - 'NO_EM_RESTART': '1', 07:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:43 INFO - 'SHELL': '/bin/bash', 07:29:43 INFO - 'SHLVL': '1', 07:29:43 INFO - 'TERM': 'linux', 07:29:43 INFO - 'TMOUT': '86400', 07:29:43 INFO - 'USER': 'cltbld', 07:29:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:43 INFO - '_': '/tools/buildbot/bin/python'} 07:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:43 INFO - Downloading/unpacking psutil>=0.7.1 07:29:43 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 07:29:43 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 07:29:43 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 07:29:43 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 07:29:43 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 07:29:43 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 07:29:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:45 INFO - Installing collected packages: psutil 07:29:45 INFO - Running setup.py install for psutil 07:29:45 INFO - building 'psutil._psutil_linux' extension 07:29:45 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 07:29:46 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 07:29:46 INFO - building 'psutil._psutil_posix' extension 07:29:46 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 07:29:46 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 07:29:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:46 INFO - Successfully installed psutil 07:29:46 INFO - Cleaning up... 07:29:46 INFO - Return code: 0 07:29:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:29:46 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')]} 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:46 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')]} 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:46 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:46 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 07:29:46 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 07:29:46 INFO - Using env: {'DISPLAY': ':0', 07:29:46 INFO - 'HOME': '/home/cltbld', 07:29:46 INFO - 'LANG': 'en_US.UTF-8', 07:29:46 INFO - 'LANGUAGE': 'en_US:en', 07:29:46 INFO - 'LOGNAME': 'cltbld', 07:29:46 INFO - 'MAIL': '/var/mail/cltbld', 07:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:46 INFO - 'MOZ_NO_REMOTE': '1', 07:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:46 INFO - 'NO_EM_RESTART': '1', 07:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:46 INFO - 'SHELL': '/bin/bash', 07:29:46 INFO - 'SHLVL': '1', 07:29:46 INFO - 'TERM': 'linux', 07:29:46 INFO - 'TMOUT': '86400', 07:29:46 INFO - 'USER': 'cltbld', 07:29:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:46 INFO - '_': '/tools/buildbot/bin/python'} 07:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:29:46 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 07:29:46 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 07:29:46 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 07:29:46 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 07:29:46 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 07:29:46 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 07:29:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:29:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:29:48 INFO - Installing collected packages: mozsystemmonitor 07:29:48 INFO - Running setup.py install for mozsystemmonitor 07:29:48 INFO - Successfully installed mozsystemmonitor 07:29:48 INFO - Cleaning up... 07:29:48 INFO - Return code: 0 07:29:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:29: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')]} 07:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:48 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:48 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 07:29:48 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 07:29:48 INFO - Using env: {'DISPLAY': ':0', 07:29:48 INFO - 'HOME': '/home/cltbld', 07:29:48 INFO - 'LANG': 'en_US.UTF-8', 07:29:48 INFO - 'LANGUAGE': 'en_US:en', 07:29:48 INFO - 'LOGNAME': 'cltbld', 07:29:48 INFO - 'MAIL': '/var/mail/cltbld', 07:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:48 INFO - 'MOZ_NO_REMOTE': '1', 07:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:48 INFO - 'NO_EM_RESTART': '1', 07:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:48 INFO - 'SHELL': '/bin/bash', 07:29:48 INFO - 'SHLVL': '1', 07:29:48 INFO - 'TERM': 'linux', 07:29:48 INFO - 'TMOUT': '86400', 07:29:48 INFO - 'USER': 'cltbld', 07:29:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:48 INFO - '_': '/tools/buildbot/bin/python'} 07:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 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 07:29:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:50 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 07:29:50 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 07:29:50 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 07:29:50 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 07:29:50 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 07:29:50 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 07:29:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:29:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:51 INFO - Downloading docopt-0.6.1.tar.gz 07:29:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:51 INFO - Running setup.py install for blobuploader 07:29:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:29:51 INFO - Running setup.py install for requests 07:29:51 INFO - Running setup.py install for docopt 07:29:51 INFO - Successfully installed blobuploader requests docopt 07:29:51 INFO - Cleaning up... 07:29:52 INFO - Return code: 0 07:29:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29: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')]} 07:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:52 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:52 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 07:29:52 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 07:29:52 INFO - Using env: {'DISPLAY': ':0', 07:29:52 INFO - 'HOME': '/home/cltbld', 07:29:52 INFO - 'LANG': 'en_US.UTF-8', 07:29:52 INFO - 'LANGUAGE': 'en_US:en', 07:29:52 INFO - 'LOGNAME': 'cltbld', 07:29:52 INFO - 'MAIL': '/var/mail/cltbld', 07:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:52 INFO - 'MOZ_NO_REMOTE': '1', 07:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:52 INFO - 'NO_EM_RESTART': '1', 07:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:52 INFO - 'SHELL': '/bin/bash', 07:29:52 INFO - 'SHLVL': '1', 07:29:52 INFO - 'TERM': 'linux', 07:29:52 INFO - 'TMOUT': '86400', 07:29:52 INFO - 'USER': 'cltbld', 07:29:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:52 INFO - '_': '/tools/buildbot/bin/python'} 07:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:52 INFO - Running setup.py (path:/tmp/pip-f7KrfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:52 INFO - Running setup.py (path:/tmp/pip-ECb2ss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:52 INFO - Running setup.py (path:/tmp/pip-z6qKap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:52 INFO - Running setup.py (path:/tmp/pip-YXBgtr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:52 INFO - Running setup.py (path:/tmp/pip-oughDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:52 INFO - Running setup.py (path:/tmp/pip-_iQtQc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:52 INFO - Running setup.py (path:/tmp/pip-jVwUJ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:52 INFO - Running setup.py (path:/tmp/pip-yrI1KK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:52 INFO - Running setup.py (path:/tmp/pip-fKoGUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:52 INFO - Running setup.py (path:/tmp/pip-TMEndZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:52 INFO - Running setup.py (path:/tmp/pip-UcWm24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:53 INFO - Running setup.py (path:/tmp/pip-yLcUdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:53 INFO - Running setup.py (path:/tmp/pip-iRGtyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:53 INFO - Running setup.py (path:/tmp/pip-DDxnSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:53 INFO - Running setup.py (path:/tmp/pip-BFDCpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:53 INFO - Running setup.py (path:/tmp/pip-kDMNpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:53 INFO - Running setup.py (path:/tmp/pip-qFCtVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:53 INFO - Running setup.py install for manifestparser 07:29:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:29:53 INFO - Running setup.py install for mozcrash 07:29:53 INFO - Running setup.py install for mozdebug 07:29:53 INFO - Running setup.py install for mozdevice 07:29:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:29:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:29:53 INFO - Running setup.py install for mozfile 07:29:53 INFO - Running setup.py install for mozhttpd 07:29:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozinfo 07:29:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozInstall 07:29:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozleak 07:29:54 INFO - Running setup.py install for mozlog 07:29:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for moznetwork 07:29:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozprocess 07:29:54 INFO - Running setup.py install for mozprofile 07:29:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozrunner 07:29:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:29:54 INFO - Running setup.py install for mozscreenshot 07:29:54 INFO - Running setup.py install for moztest 07:29:55 INFO - Running setup.py install for mozversion 07:29:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:29:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:55 INFO - Cleaning up... 07:29:55 INFO - Return code: 0 07:29:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29: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')]} 07:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:55 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:55 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 07:29:55 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 07:29:55 INFO - Using env: {'DISPLAY': ':0', 07:29:55 INFO - 'HOME': '/home/cltbld', 07:29:55 INFO - 'LANG': 'en_US.UTF-8', 07:29:55 INFO - 'LANGUAGE': 'en_US:en', 07:29:55 INFO - 'LOGNAME': 'cltbld', 07:29:55 INFO - 'MAIL': '/var/mail/cltbld', 07:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:55 INFO - 'MOZ_NO_REMOTE': '1', 07:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:55 INFO - 'NO_EM_RESTART': '1', 07:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:55 INFO - 'SHELL': '/bin/bash', 07:29:55 INFO - 'SHLVL': '1', 07:29:55 INFO - 'TERM': 'linux', 07:29:55 INFO - 'TMOUT': '86400', 07:29:55 INFO - 'USER': 'cltbld', 07:29:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:55 INFO - '_': '/tools/buildbot/bin/python'} 07:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:55 INFO - Running setup.py (path:/tmp/pip-XKgvlb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:55 INFO - Running setup.py (path:/tmp/pip-FVGDPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:55 INFO - Running setup.py (path:/tmp/pip-SC0WtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:55 INFO - Running setup.py (path:/tmp/pip-1zIWYH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:55 INFO - Running setup.py (path:/tmp/pip-6uv3b5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:55 INFO - Running setup.py (path:/tmp/pip-bsFS9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:55 INFO - Running setup.py (path:/tmp/pip-GiF78B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:29:55 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)) 07:29:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:55 INFO - Running setup.py (path:/tmp/pip-HGsS3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:56 INFO - Running setup.py (path:/tmp/pip-gg9Pl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:56 INFO - Running setup.py (path:/tmp/pip-Mj8i2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:56 INFO - Running setup.py (path:/tmp/pip-u5uV8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:56 INFO - Running setup.py (path:/tmp/pip-hCa1d2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:56 INFO - Running setup.py (path:/tmp/pip-vONpHJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:56 INFO - Running setup.py (path:/tmp/pip-AXlo3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:56 INFO - Running setup.py (path:/tmp/pip-yHIezQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:56 INFO - Running setup.py (path:/tmp/pip-Mumeo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:29:56 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)) 07:29:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:56 INFO - Running setup.py (path:/tmp/pip-NXlGBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:29:56 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)) 07:29:56 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)) 07:29:56 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)) 07:29:56 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)) 07:29:56 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)) 07:29:56 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)) 07:29:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:58 INFO - Downloading blessings-1.6.tar.gz 07:29:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:58 INFO - Installing collected packages: blessings 07:29:58 INFO - Running setup.py install for blessings 07:29:58 INFO - Successfully installed blessings 07:29:58 INFO - Cleaning up... 07:29:58 INFO - Return code: 0 07:29:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:29:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:29:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:29:58 INFO - Reading from file tmpfile_stdout 07:29:58 INFO - Current package versions: 07:29:58 INFO - argparse == 1.2.1 07:29:58 INFO - blessings == 1.6 07:29:58 INFO - blobuploader == 1.2.4 07:29:58 INFO - docopt == 0.6.1 07:29:58 INFO - manifestparser == 1.1 07:29:58 INFO - mozInstall == 1.12 07:29:58 INFO - mozcrash == 0.16 07:29:58 INFO - mozdebug == 0.1 07:29:58 INFO - mozdevice == 0.47 07:29:58 INFO - mozfile == 1.2 07:29:58 INFO - mozhttpd == 0.7 07:29:58 INFO - mozinfo == 0.9 07:29:58 INFO - mozleak == 0.1 07:29:58 INFO - mozlog == 3.1 07:29:58 INFO - moznetwork == 0.27 07:29:58 INFO - mozprocess == 0.22 07:29:58 INFO - mozprofile == 0.27 07:29:58 INFO - mozrunner == 6.11 07:29:58 INFO - mozscreenshot == 0.1 07:29:58 INFO - mozsystemmonitor == 0.0 07:29:58 INFO - moztest == 0.7 07:29:58 INFO - mozversion == 1.4 07:29:58 INFO - psutil == 3.1.1 07:29:58 INFO - requests == 1.2.3 07:29:58 INFO - wsgiref == 0.1.2 07:29:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:29: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')]} 07:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29: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')]} 07:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:58 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:58 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 07:29:58 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 07:29:58 INFO - Using env: {'DISPLAY': ':0', 07:29:58 INFO - 'HOME': '/home/cltbld', 07:29:58 INFO - 'LANG': 'en_US.UTF-8', 07:29:58 INFO - 'LANGUAGE': 'en_US:en', 07:29:58 INFO - 'LOGNAME': 'cltbld', 07:29:58 INFO - 'MAIL': '/var/mail/cltbld', 07:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:58 INFO - 'MOZ_NO_REMOTE': '1', 07:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:58 INFO - 'NO_EM_RESTART': '1', 07:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:58 INFO - 'SHELL': '/bin/bash', 07:29:58 INFO - 'SHLVL': '1', 07:29:58 INFO - 'TERM': 'linux', 07:29:58 INFO - 'TMOUT': '86400', 07:29:58 INFO - 'USER': 'cltbld', 07:29:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:58 INFO - '_': '/tools/buildbot/bin/python'} 07:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 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)) 07:29:59 INFO - Cleaning up... 07:29:59 INFO - Return code: 0 07:29:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:59 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:29:59 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 07:29:59 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 07:29:59 INFO - Using env: {'DISPLAY': ':0', 07:29:59 INFO - 'HOME': '/home/cltbld', 07:29:59 INFO - 'LANG': 'en_US.UTF-8', 07:29:59 INFO - 'LANGUAGE': 'en_US:en', 07:29:59 INFO - 'LOGNAME': 'cltbld', 07:29:59 INFO - 'MAIL': '/var/mail/cltbld', 07:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:59 INFO - 'MOZ_NO_REMOTE': '1', 07:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:59 INFO - 'NO_EM_RESTART': '1', 07:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:29:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:29:59 INFO - 'SHELL': '/bin/bash', 07:29:59 INFO - 'SHLVL': '1', 07:29:59 INFO - 'TERM': 'linux', 07:29:59 INFO - 'TMOUT': '86400', 07:29:59 INFO - 'USER': 'cltbld', 07:29:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:59 INFO - '_': '/tools/buildbot/bin/python'} 07:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:59 INFO - Downloading/unpacking jsonschema 07:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:01 INFO - Downloading/unpacking functools32 (from jsonschema) 07:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:01 INFO - warning: no files found matching '*.txt' 07:30:01 INFO - no previously-included directories found matching 'build' 07:30:01 INFO - no previously-included directories found matching 'dist' 07:30:01 INFO - no previously-included directories found matching '.git*' 07:30:01 INFO - Installing collected packages: jsonschema, functools32 07:30:01 INFO - Running setup.py install for functools32 07:30:01 INFO - warning: no files found matching '*.txt' 07:30:01 INFO - no previously-included directories found matching 'build' 07:30:01 INFO - no previously-included directories found matching 'dist' 07:30:01 INFO - no previously-included directories found matching '.git*' 07:30:01 INFO - Successfully installed jsonschema functools32 07:30:01 INFO - Cleaning up... 07:30:01 INFO - Return code: 0 07:30:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:01 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 0x7f4fe88bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', '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 07:30:01 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 07:30:01 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 07:30:01 INFO - Using env: {'DISPLAY': ':0', 07:30:01 INFO - 'HOME': '/home/cltbld', 07:30:01 INFO - 'LANG': 'en_US.UTF-8', 07:30:01 INFO - 'LANGUAGE': 'en_US:en', 07:30:01 INFO - 'LOGNAME': 'cltbld', 07:30:01 INFO - 'MAIL': '/var/mail/cltbld', 07:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:01 INFO - 'MOZ_NO_REMOTE': '1', 07:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:01 INFO - 'NO_EM_RESTART': '1', 07:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:01 INFO - 'SHELL': '/bin/bash', 07:30:01 INFO - 'SHLVL': '1', 07:30:01 INFO - 'TERM': 'linux', 07:30:01 INFO - 'TMOUT': '86400', 07:30:01 INFO - 'USER': 'cltbld', 07:30:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:01 INFO - '_': '/tools/buildbot/bin/python'} 07:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:01 INFO - Downloading/unpacking flake8 07:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:30:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:30:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:06 INFO - no previously-included directories found matching 'docs/_build' 07:30:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:30:06 INFO - Running setup.py install for pep8 07:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:30:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:30:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:30:06 INFO - no previously-included directories found matching 'docs/_build' 07:30:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:30:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:30:06 INFO - Cleaning up... 07:30:06 INFO - Return code: 0 07:30:06 INFO - Running post-action listener: _resource_record_post_action 07:30:06 INFO - Running post-action listener: _start_resource_monitoring 07:30:06 INFO - Starting resource monitoring. 07:30:06 INFO - ##### 07:30:06 INFO - ##### Running install step. 07:30:06 INFO - ##### 07:30:06 INFO - Running pre-action listener: _resource_record_pre_action 07:30:06 INFO - Running main action method: install 07:30:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:30:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:30:06 INFO - Reading from file tmpfile_stdout 07:30:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:30:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:30:06 INFO - Reading from file tmpfile_stdout 07:30:06 INFO - Output received: 07:30:06 INFO - Usage: mozinstall [options] installer 07:30:06 INFO - Options: 07:30:06 INFO - -h, --help show this help message and exit 07:30:06 INFO - -d DEST, --destination=DEST 07:30:06 INFO - Directory to install application into. [default: 07:30:06 INFO - "/builds/slave/test-pgo"] 07:30:06 INFO - --app=APP Application being installed. [default: firefox] 07:30:06 INFO - mkdir: /builds/slave/test-pgo/build/application 07:30:06 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'] 07:30:06 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 07:30:21 INFO - Reading from file tmpfile_stdout 07:30:21 INFO - Output received: 07:30:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:30:21 INFO - Running post-action listener: _resource_record_post_action 07:30:21 INFO - ##### 07:30:21 INFO - ##### Running run-tests step. 07:30:21 INFO - ##### 07:30:21 INFO - Running pre-action listener: _resource_record_pre_action 07:30:21 INFO - Running main action method: run_tests 07:30:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:30:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:30:21 INFO - Python 2.7.3 07:30:21 INFO - Return code: 0 07:30:21 INFO - grabbing minidump binary from tooltool 07:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:30:21 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 0x2d38350>, '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 0x2d39250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d396e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:30:21 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 07:30:21 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 07:30:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:21 INFO - Return code: 0 07:30:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:30:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:30:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:30:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:30:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:30:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:30:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:30:22 INFO - Return code: 0 07:30:22 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/1455628191/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:30:22 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/1455628191/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 07:30:22 INFO - Using env: {'DISPLAY': ':0', 07:30:22 INFO - 'HOME': '/home/cltbld', 07:30:22 INFO - 'LANG': 'en_US.UTF-8', 07:30:22 INFO - 'LANGUAGE': 'en_US:en', 07:30:22 INFO - 'LOGNAME': 'cltbld', 07:30:22 INFO - 'MAIL': '/var/mail/cltbld', 07:30:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:30:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:22 INFO - 'MOZ_NO_REMOTE': '1', 07:30:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:22 INFO - 'NO_EM_RESTART': '1', 07:30:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:30:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:30:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:30:22 INFO - 'SHELL': '/bin/bash', 07:30:22 INFO - 'SHLVL': '1', 07:30:22 INFO - 'TERM': 'linux', 07:30:22 INFO - 'TMOUT': '86400', 07:30:22 INFO - 'USER': 'cltbld', 07:30:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918', 07:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:22 INFO - '_': '/tools/buildbot/bin/python'} 07:30:22 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/1455628191/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 07:30:22 INFO - mozversion INFO | application_buildid: 20160216050951 07:30:22 INFO - mozversion INFO | application_changeset: 149fdfdb40d101f3da74cd4c1c1f5630ef19a8ff 07:30:22 INFO - mozversion INFO | application_display_name: Nightly 07:30:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:22 INFO - mozversion INFO | application_name: Firefox 07:30:22 INFO - mozversion INFO | application_remotingname: firefox 07:30:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:30:22 INFO - mozversion INFO | application_vendor: Mozilla 07:30:22 INFO - mozversion INFO | application_version: 45.0 07:30:22 INFO - mozversion INFO | platform_buildid: 20160216050951 07:30:22 INFO - mozversion INFO | platform_changeset: 149fdfdb40d101f3da74cd4c1c1f5630ef19a8ff 07:30:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:30:22 INFO - mozversion INFO | platform_version: 45.0 07:30:22 INFO - 2016-02-16 07:30:22,710 DEBUG : using testdate: 1455636622 07:30:22 INFO - 2016-02-16 07:30:22,710 DEBUG : actual date: 1455636622 07:30:22 INFO - 2016-02-16 07:30:22,719 INFO : starting webserver on 'localhost:35357' 07:30:22 INFO - 2016-02-16 07:30:22,720 INFO : Starting test suite talos-linux64-ix-066 07:30:22 INFO - 2016-02-16 07:30:22,720 INFO : Starting test dromaeo_css 07:30:22 INFO - 2016-02-16 07:30:22,720 DEBUG : operating with platform_type : linux_ 07:30:22 INFO - 2016-02-16 07:30:22,721 INFO : Initialising browser for dromaeo_css test... 07:30:22 INFO - 2016-02-16 07:30:22,737 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppD1B6Y/profile http://localhost:35357/getInfo.html 07:30:26 INFO - 2016-02-16 07:30:26,941 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:30:26 INFO - 2016-02-16 07:30:26,942 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:30:26 INFO - 2016-02-16 07:30:26,942 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:30:26 INFO - 2016-02-16 07:30:26,942 DEBUG : BROWSER_OUTPUT: __metrics 07:30:27 INFO - 2016-02-16 07:30:27,252 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] 07:30:28 INFO - 2016-02-16 07:30:28,273 INFO : Browser initialized. 07:30:28 INFO - 2016-02-16 07:30:28,274 INFO : Running cycle 1/1 for dromaeo_css test... 07:30:28 INFO - 2016-02-16 07:30:28,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppD1B6Y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:30:39 INFO - 2016-02-16 07:30:39,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 134451200 07:30:39 INFO - 2016-02-16 07:30:39,984 DEBUG : BROWSER_OUTPUT: 07:31:30 INFO - 2016-02-16 07:31:30,915 DEBUG : BROWSER_OUTPUT: 1455636690907 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] 07:33:39 INFO - 2016-02-16 07:33:39,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35357/tests/dromaeo/cssquery-ext.html) 07:33:40 INFO - 2016-02-16 07:33:40,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 238616576 07:33:40 INFO - 2016-02-16 07:33:40,308 DEBUG : BROWSER_OUTPUT: 07:36:42 INFO - 2016-02-16 07:36:42,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-ext.html (next: http://localhost:35357/tests/dromaeo/cssquery-jquery.html) 07:36:43 INFO - 2016-02-16 07:36:43,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 212660224 07:36:43 INFO - 2016-02-16 07:36:43,029 DEBUG : BROWSER_OUTPUT: 07:39:44 INFO - 2016-02-16 07:39:44,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35357/tests/dromaeo/cssquery-mootools.html) 07:39:45 INFO - 2016-02-16 07:39:45,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 214781952 07:39:45 INFO - 2016-02-16 07:39:45,368 DEBUG : BROWSER_OUTPUT: 07:42:46 INFO - 2016-02-16 07:42:46,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35357/tests/dromaeo/cssquery-prototype.html) 07:42:47 INFO - 2016-02-16 07:42:47,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 197640192 07:42:47 INFO - 2016-02-16 07:42:47,532 DEBUG : BROWSER_OUTPUT: 07:45:49 INFO - 2016-02-16 07:45:49,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35357/tests/dromaeo/cssquery-yui.html) 07:45:50 INFO - 2016-02-16 07:45:50,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 198156288 07:45:50 INFO - 2016-02-16 07:45:50,494 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/dromaeo/cssquery-yui.html (next: http://localhost:35357/tests/dromaeo/cssquery-dojo.html) 07:48:52 INFO - 2016-02-16 07:48:52,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 266518528 07:48:52 INFO - 2016-02-16 07:48:52,814 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,815 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:48:52 INFO - 2016-02-16 07:48:52,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:48:52 INFO - 2016-02-16 07:48:52,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:48:52 INFO - 2016-02-16 07:48:52,816 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:48:52 INFO - 2016-02-16 07:48:52,817 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3319.2697606526563;3379.7803142795733;3415.4193787056197;3422.264213194163;3440.0367896988837;5543.307086614173;5560.4135332710375;5568.387477377485;5582.972085139574;5585.720713964301;5603.2435621191225;5603.579731520143;5613.550915926727;5624.100143976964;5631.493165615094;4970.925436118443;5040.873978150539;5087.6693014954;5111.386633603955;5180.3006594109875;4968.155413579682;4988;5003.374578177728;5025.195968645017;5149.176131818891;5073.188289873621;5221.347331583552;5237.319148510688;5239;5251.2385704072885;5072.923906141411;5146.897062058757;5151.896962060775;5155.072087024334;5182.32629758129;4850.320955066293;4908.460069392364;4924.60603151747;5041.0422019816115;5042.571381432583;5361.115415956362;5366.114591092465;5368.30212072432;5379.811706590251;5388.461153884619;5934.228550288435;5938.079597662369;5938.8218353449465;5941.049432090845;5986.880262394771;5663.235463212455;5820.708964551798;6020.518358531307;6135.5398345124295;6137.223770008885;5679.346875109332;5683.971580142114;5689.288838895138;5700.800471983503;5702.45826646468;5858.8242352729485;6139.355367686418;6160.383961603804;6172.382761723792;6179.62922224668;5689.34572524165;5825.1844741736195;5918.585699001029;5919.052951527735;5959.7914073008105;6011.188489553854;6019.608725432833;6021.488173505213;6022.3676513966275;6029.78895738647;5648.802291919763;5741.311042674905;5975.492083172892;5991.64050156992;6009.1587177795145;5789.652620842763;5894.086416605433;5897.380775018647;5898.675572843535;5927;4543.636509079266;4597.655175861823;4610.308453731967;4615.723056616546;4639.072185562901;3985.501812273466;4039.8990025249605;4067.2272268268935;4093.201825643971;4168.291390463629;5606.719664016864;5615.691136987505;5619.80330688424;5634.464725851038;5639.520640745583;5961.374055724174;5974.4324289192455;5976.402359763989;5977.312609049928;5992.67040312787;5472.50747432733;5518.613697041249;5572.3034620672415;5623.240862483594;5629;5098.056859481007;5200.115980283361;5205.7397130143345;5210.97394513025;5218;6146.6004709693725;6169.352218017044;6173.228346456693;6174.351693072163;6176.197094377702;5712.257406537124;5824.737886795189;5850.2102216200265;5913.2608423947;5940.019896717166;6154;6190.442860142429;6195;6197.81406557804;6198.876022479615;5637.774489020393;5896.115582662635;5903.675297858487;5905.852353691193;5906.173135761082;5782.971085144547;5873.853153671193;5948.583599148018;5976.252968378953;5989.670568118795;5607.43925607436;5792.797252096157;5852.414758524284;5865.560082993878;5868.119782032559;5622.915656265078;5835.095560188178;5872.500837428866;5882;5882.794102206402;5600.131979543177;5645.125005624135;5716.228309178374;5737.56968227393;5772.5381969441505;5882.882342353215;5895.94104058954;5896.115582662635;5902.38025007368;5911.822645320647;5464.91802622953;5626.549876009827;5783.103618939072;5785.132230165341;5805.883882322414 07:48:52 INFO - 2016-02-16 07:48:52,820 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.7713268957796;633.5406830048215;634.6509419819098;641.4900154377269;646.5635695905263;31971.20071998201;38692.41961370582;39094.60905390945;39107.804460977655;39288.60711392882;45340.5062721551;45650.54349456504;45908;45947.54052459474;45971;7665.846683066336;7754.728584499544;9244.907550924489;9421.48181849998;10535.63125290615;10838.566457341736;10944.890551094506;10959.397233152173;10965.287256328313;10980.176486763485;10814.837777433344;10937.398443085627;10950.34297942126;10956.397398143099;10960.451977401139;10916.01755841974;11020.393878336688;11023.503942322535;11024;11025.283356581876;10766.56933722658;10898.782024359547;10910;10917.072048875854;10932.344059356465;43882.780586097186;43884.561154388364;44295.335569966475;44369.77815110936;44417.55582444167;3375.6793104655017;3387.5426817379584;3415.55597772288;3558.679718825318;3820.4842346283176;33078.6692133078;33403.331933361194;33461;33478.66521334804;33489;4211.0946146578635;4248.34150706641;4252;4304.375865499485;4400.361947517624;487586;493965.9999999964;495457;496284;496446;58929;65444;66100.33899661039;66116.66941665261;66405.33594664089;52158.217626735626;52364.47635523672;52499.73750131225;73091.26908730951;74444.62777686077;15723;15805.446809361618;15861.286242118902;15864.127472988866;15866;11994.64016079519;12013.219140755999;12034.879651203551;12043.277403355827;12075.154739168174;22028.229011984502;22269;22292.66561001586;22355.32934011982;22361.664575031387;8474.237318641352;8658.87011694825;8763.211310981915;8845.380823342304;8845.380823342433;996.6561536269975;1063.234471180764;1090.3512410115968;1128.503458478267;1139.2480962564669;30267.69732302649;30588.69411305903;31061.223469413446;33531.329373412394;34277.828610856785;1053.942033188182;1055.7518983038979;1147.1396452660504;1148.8104462763552;1157.976840463186;14025;15149.469768558269;15353.385864565516;17490.300387984338;17625.471235862944;407026;407417;409876;411010;411435;59650.40349596535;59714.10428843571;60141.69929150326;60197.699011504665;60199;1268.3277862732766;1358.4905660377358;1407.113518483349;1497.5657059452637;1499.6101013736507;30394.54408183923;30406.54390184193;30668.386632267677;30993;31840;47660.285095722895;48187.5181248183;48196.518034820605;48260.7586962077;48332;269279;271531;273955;274242;274524;34649.480257796655;35577.64422355847;35741;35839.104022399646;36095.27809443849;45391;46142;46361.53638463572;46769.53230467652;46997.76501117473;38946.4158037624;39828.40257396199;44699.32951005673;45422.545774543156;47247.29129062998;39586.604133958295;40151.397729034674;40571;40817.59182408138;40859.59140408558;41869.58130418657;42033.57966420419;42517.362239567046;42620.147597048504;44111.77944110259;33965.83017084899;33980.49029264612;35318.29363412769;36044.819775902004;36086.45870312;26937;27270.590941136295;27795.583066253617;27987.720122799325;28136.718632814227 07:48:52 INFO - 2016-02-16 07:48:52,821 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.0759446315;391.9353306704394;395.101144895363;395.3180763183509;400.52337718115456;13832.861671383283;17315.22081506332;17916.731249031276;18507.907460462695;18523.444296671103;11332.60335888242;11470.311781293129;11475.426228688573;18323.90838045808;18687.719684204712;5007.849764507061;5109.463506331819;5110.054639891632;5134.794608215686;5137.409197942228;3882.864099756509;3989.68082553395;5084.898302033957;5492.340919089695;5616.9157462638095;5569;5573.888522229573;5581.6371935824245;5604;5617.8033768818095;5471.644343117685;5605.607607467479;5615.326160860682;5618.634788738719;5620.747066382022;5384.865378365533;5395.244665746799;5401.891962160735;5408.3509978802795;5408.702521361323;19700.901495492573;21757.45606359838;22164;22218.11127554896;22253.332400028026;2207.4260692220137;2216.8669879807103;2277.5786479501344;2316.4556329262778;2397.484540823731;9973.80052398948;10030;10222.591096356211;11904.98807601355;12917.095803293772;1922.2887531613253;1942.3978566644244;1946.3577019583504;1959.9118039688249;1966.8229859312587;66807.33192668109;67432.662836686;68506.3149368505;68823.65588172077;68853;11174.714907785708;11247.437628118561;11273.661790146309;11296.717582060513;11321.943390282995;14973.70052598942;15093.54719358421;15122.243887805565;15122.848771512145;15128.39486420553;7702.8844567331535;7755.108162561378;7776.922230777733;8054.993125859268;8106.756797296091;7413.443991700644;7817.570033648204;7850.2934735872905;7853.332466740391;7895.9210407896335;4529.796159172845;4788.664793464493;4824.252240902666;4828.179209534387;4848.7090774553635;1757.5798011761708;1806.5935164588125;1882.8305452509067;1949.8162058494577;1956.9725893905813;435.1340831744805;971.9757006074905;1011.9747006324753;1067.0876400677464;1069.3209811769582;10890.29213101146;11026.834597480884;11138.94430527842;11176.161787865942;11232.831507527393;435.08414786873806;439.760330619813;439.83726021371655;441.7349590245827;455.7835028361568;6093.512518998469;6154.753809847556;10243;10368.688939331832;10568.682939511827;620164;629173;633044;634113;651523;86033.56983215043;89277;89934.55032724925;90022.54988725146;91582;1143.3768596115137;1164.85439320085;1165.1785491228663;1166.2943918929095;1178.7230000949942;16464.506064818073;16734.48220839315;16783.412580559623;16870.57823554421;16989.320427182774;39428.40857387084;39601.603983959794;39623.00942476461;39956;40469.19061618692;51761.74119129531;53374.199387010005;53380.73309633427;55623;56319.54634765156;9905;10152.39085654863;10159.034891685278;10201.642942496977;10218.897811021794;11977.760444791229;15458.768118478007;18842;18999;19079.904600476908;15771.44799931997;15781.526554203392;15800.76298855541;15904.204789760235;15960.920195399412;15432.614184645474;15667.216639168224;15814.209289535247;15836.52490425289;16183.75724364159;12506.562270320495;15994.360225590846;16067;16129.11289879068;16285.267162977458;8634.611442484978;9779.85330220033;9789.070038346346;9806.117449429586;9856.31005829585;14509.274536273355;15216.771748423562;15455;15749;16095.02242085218 07:48:52 INFO - 2016-02-16 07:48:52,822 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1581.098773698992;1623.6752649470104;1676.9664606707865;1847.2333981397721;1906.247032422194;8240.91759082409;8437.915620843789;8440.45137066091;8443.83112337753;8445;8165.183481651847;8232.094469608339;8233.752987410373;8264;8266.462679925815;2387.7015373078366;2392.5573768852773;2431.039739302983;2434.5982912819363;2437.439388940536;2401;2432.19737486629;2459.016393442628;2460.3972026853357;2462.1997850698503;2015.8588898777018;2046.1815273890488;2321.419645088728;2408.6989126359204;2440.316711320824;2265.9433514162115;2274.55646149001;2283.041122728458;2286.131270117353;2287.0737351372723;2309.618912879373;2385.439421735891;2386.4630458146953;2389.163792672568;2389.259329607827;7131.607761573111;7293.854122917512;7902.446828721992;8082.717104901359;8084.434089613729;4943.456219815817;4991.201407774775;5020.397552293712;5023.623228257895;5024.447310795809;3046.1318524220715;3074.2314421394653;3077.830719310437;3091.9536206956914;3118.033409642995;1004.4726518577733;1025.1183981775666;1028.136365453023;1036.3626369782605;1081.9891801081967;11101.44492775358;11238.66284011481;11266.493007814668;11269.267497612711;11316.660500185008;4589.816407343669;4602.88492787683;4634.443866736014;4655.86032419028;4674.766261686902;9762.463064531377;9764.023597640322;9783.119519243302;9789.608415663293;9795.265355098396;5132.743362831843;5138.897222055538;5140.485951404829;5144.279800827887;5149.433562308143;4668.883277918079;4674.74288914113;4675.509071547506;4679.181143299909;4682.578567928903;3827.2919509890758;3856.8777845030404;3875.8837234883;3904.1020565270146;3919.980400097981;1257.5975687780006;1262.9684257893625;1271.5613113475836;1274.3182397417338;1274.7769140400392;1342.6307765364602;1353.587155917435;1354.0724603646534;1372.2726954714017;1400.7618704820204;7632.885506717404;7634.236576342432;7645.235476452422;7648.541087534766;7683.116441609286;500.4220125754759;506.25327641728154;514.5977212097081;514.8584139361631;517.7592419524939;5581.469760372758;6218.689065546704;6319.6208227506495;6322.936770632326;6331.240251169797;8490.320774338039;9587.18508926749;10110.949445252874;10114.190864730952;10119.24105692076;9675.516224188763;9879.16027137687;9922.50387480623;9991.150752186146;9996.200303975664;7681.270279323456;7836.177201393772;7837.529748215012;7837.843243135106;7842.254985776228;7687.5387476751575;7716.729914453192;7785.571793551182;7786.221377862168;7803.219678032151;8834.602442889956;8916.19754222123;8985.820283594423;9012.41419307743;9026.413283136575;8945.19493245611;9165.908340916505;9188.264938804747;9193.402428842104;9196.35625506208;7335.193128755725;7383.889241661272;7393.260673932778;7395.667194976347;7395.9645649610175;7733.419993500623;7862.33170180541;7865.213478652089;7883.881741773764;7888.2506161914525;7522.247775222434;7564.583947882919;7600.543967361976;7635.198304178203;7650.349720273839;7424.071991001125;7471.066116735408;7475.514091584029;7521.3982881368265;7546.24537546241;7502.812429689083;7638.541687498768;7641.732539361095;7643.273888980538;7659.119201291923;7028.0863487746265;7062.964685176541;7063.540869843444;7079.362857342864;7082.079329687108;7000.789976300719;7025.68384422692;7173.641317933978;7186.425085993213;7186.568805871664 07:48:52 INFO - 2016-02-16 07:48:52,823 DEBUG : BROWSER_OUTPUT: |4;prototype.html;360.0476739025278;364.2878173171451;365.4773673646684;366.17245026240687;376.7005230841481;6078.966575682133;6176.382361763822;6181.350958149397;6181.350958149397;6182.443580077792;5809.854753631162;5873.794417195399;5966.8806623867495;5990.640561566309;6063.211782468273;4726.881827954311;4728.148933192024;4735.12400205963;4746.145693775119;4759.571638552529;4508.887277818065;4756.120117778205;4758.167320718878;4762.690425122356;4768.356271903283;4538.115067561826;4586.1744885920525;4684.320773487842;4706.435227772655;4723.669343145981;4629.51390104041;4659.510751371125;4680.110778952006;4691.390119284488;4696.342512048316;4142.544320124784;4194.412782210493;4197.706160568731;4198.496180458334;4206.074663574009;5667.121596152603;5782.10377391505;5782.855428614318;5785.826425207209;5789.855253618651;5539.778408863641;5540.722963851832;5541.750621222014;5547.55619550439;5552.194931734876;6462.095306657072;6519.250286217051;6519.445847103002;6522.543421960465;6522.804315870531;4671.906561868744;4691.437027556681;4692.694974826625;4699.459562150362;4712.128256272601;6594.07682924391;6651.600903945779;6721.495887808385;6737.427318677918;6742.865142697167;4771.904561908743;4811.254255590389;4816.975915120402;4818.204996175662;4819.927701084486;4854.441739200037;4874.2201247800185;4874.7562621868765;4875.219964805614;4876.414830220397;5414.512693857571;5530.142827861688;5533.059379905345;5535.557155427556;5537.473939975695;6504.902426463606;6507.121538592324;6513.706883190268;6514.771982980667;6532.346765323429;1692.3061544766585;1709.8546623537138;1709.9743503847453;1710.2474911039103;1710.324421853361;1182.3674334231316;1182.3733421286731;1182.9940850295693;1205.9758804823855;1207.619599826052;6291.653959032205;6316.431521163117;6319.9368006320265;6334.1765570475545;6336.588121772163;6437.25971513282;6664.366885145903;6715.630640314829;6716.630585317855;6723.361280678328;6218.067289906459;6256.249250090018;6364.395382438661;6377.681115944184;6392.328805475451;3599.3161299353037;3635.0003748969243;3658.32321020612;3659.1766852457986;3661.4690869823726;6828.692708828015;6955.269696681776;6969;6978.162620485574;6981.371676549135;6902.447804175654;6910.136232970879;6913.446924246048;6914.032035515032;6916.273791251947;6925.376716095677;6971.930280697229;6973.302669733088;6980;6982.057422247932;6631.469482441296;6772.458203343819;6774.458043356618;6778.356056174655;6791.694373753094;6674.966625167037;6679.198496180489;6684.398404143651;6686.297938716365;6690.330966903465;6847.486438517031;6921.7231310747;6923.9653801730665;6949.4440444765305;6974.163100427981;4788.467690339197;4828.106800241966;4855.757212139309;4863.10032643962;4863.440704319049;6776.186857577122;6777.220619628806;6783.18601767791;6786.76246331376;6791.864162716619;6589.275179730322;6608.7356505739235;6610.8016759497295;6613.636250006103;6619.602823830585;6435.967820160869;6586.769463068769;6589.604623722592;6599.4720422365135;6607.306232845482;6461.483081353575;6501.382368674968;6506.512011599054;6508.414242718178;6514.57655252407;6616.206055273398;6624.403803657694;6624.900626490703;6634.900476492953;6638.17022872141;6278.46633036197;6455.289918109098;6473.287938326875;6477.967610161919;6480.125183100221 07:48:52 INFO - 2016-02-16 07:48:52,823 DEBUG : BROWSER_OUTPUT: |5;yui.html;819.3772732723129;834.0783434305089;871.4771137317609;903.3360480047164;937.4375374775136;13831.515896943609;14021.228832414214;14023.088499247542;14024.789628155573;14026.298685065743;13336.133151345155;13356.398962046707;13445;13446.663833404169;13455.461781528751;702.5187746393711;709.7090193020863;881.3478026260585;885.2121611765517;899.1682693508511;877.6796469288696;881.3610132653839;881.5019513974615;889.1242126505387;889.968851090212;730.6456368661195;872.3152325424543;926.2775035472342;935.0135606934681;936.4287784451514;734.2290594875386;914.4833169259381;922.4741897118679;928.1507420710042;929.0291645230683;687.5084314714953;687.5359132585485;688.0779755128102;688.1295161620554;688.8622275544911;12852;12920.741585168244;12931.48274069036;12945.87054129456;12999.935000324938;12822.551210707581;13008.414621342063;13198.73602527944;13287.269200193985;13647.317634118353;10889;10942.124630029579;11054.447277636085;11169.72075698106;11232.21374503785;3867.1105645701646;3872.8644497442456;3909.7263191576603;3929.960700392988;3960.584138665456;44437.55562444367;44603.33095003577;45024.3246351305;46767.29849052267;46802.531974680154;10286.485675716334;10502.422366769748;10726.785464290671;10765.892341076646;10852.348859068481;18381.448556543324;18398.356057537923;18400.53998650018;18418.539536511693;18418.907905460386;7973.521588704696;7987.281144697005;8089.919100809035;8116.83766324682;8175.877361839577;4584.770761461914;4633.397658304399;4646.372739680168;4653.464851542116;4666.300054991779;3398.082517720202;3419.8461069251944;3423.9144021399165;3425.880094196691;3434.793912365266;579.6377264209868;598.8622616798161;599.6821684507219;602.8161410769758;612.7793994162098;656.3502132888501;674.4065222604077;683.5215349255442;689.1867596236489;706.2266817834566;8594.140585941355;8872.423292486097;9154.40496367734;9166.724998250063;9173.220276276592;657.7533424965637;668.6556423441931;680.5406350713249;703.9507234493639;716.1012928774355;3786.545614526219;4036.677065834785;4051.1897620476025;4079.204555111784;4123.484564429446;54358.728206359505;55802.44197557973;56588.717056414454;56633.7168314164;56985.43014569884;52536;53023.73488132612;53447.19829202565;53532.46467535353;53639.19541206807;47145.5285447148;47661.285080723814;48065.27902081471;48131.75934120307;48225.517744823504;7736.1103473099065;7930;7951.32413744815;7970.083440404428;8202.71160719614;35113.824430877685;35358.93923182309;35813.1046723834;36000.81999589985;36100.81949590235;41736.165276694905;42468.362974556025;47147.29279060885;47320.52679473299;47374.526254737015;11746.471408786454;12173.087018473827;12225.572104976283;12236.877631223573;12591.748165036464;13379;13884.861151388357;13904.235267060409;14004.78992815129;14077.084989475652;11939.34333611625;12064.457099430721;12172.634820955385;12329.938350308192;12417.937910310391;12082.214656047328;12292.631221063382;12467.875321247035;12484.438200280827;12694.682632934251;10074.14369778577;11261.605843795427;11735.471903764523;11978.281303121841;12146.453409596412;10093.14208292274;10283.742906427398;10322.225833062701;10338.328008679411;10347.172226222036;8529.786755331166;9954.751131221488;10397.532111055172;10551.050405463546;10765.354078754986 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,759 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: __startTimestamp1455637732814__endTimestamp 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5532.76 Median:5689.35 stddev:604.18 (10.6%) stddev-sans-first:580.54 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: Values: 3319.3 3379.8 3415.4 3422.3 3440.0 5543.3 5560.4 5568.4 5583.0 5585.7 5603.2 5603.6 5613.6 5624.1 5631.5 4970.9 5040.9 5087.7 5111.4 5180.3 4968.2 4988.0 5003.4 5025.2 5149.2 5073.2 5221.3 5237.3 5239.0 5251.2 5072.9 5146.9 5151.9 5155.1 5182.3 4850.3 4908.5 4924.6 5041.0 5042.6 5361.1 5366.1 5368.3 5379.8 5388.5 5934.2 5938.1 5938.8 5941.0 5986.9 5663.2 5820.7 6020.5 6135.5 6137.2 5679.3 5684.0 5689.3 5700.8 5702.5 5858.8 6139.4 6160.4 6172.4 6179.6 5689.3 5825.2 5918.6 5919.1 5959.8 6011.2 6019.6 6021.5 6022.4 6029.8 5648.8 5741.3 5975.5 5991.6 6009.2 5789.7 5894.1 5897.4 5898.7 5927.0 4543.6 4597.7 4610.3 4615.7 4639.1 3985.5 4039.9 4067.2 4093.2 4168.3 5606.7 5615.7 5619.8 5634.5 5639.5 5961.4 5974.4 5976.4 5977.3 5992.7 5472.5 5518.6 5572.3 5623.2 5629.0 5098.1 5200.1 5205.7 5211.0 5218.0 6146.6 6169.4 6173.2 6174.4 6176.2 5712.3 5824.7 5850.2 5913.3 5940.0 6154.0 6190.4 6195.0 6197.8 6198.9 5637.8 5896.1 5903.7 5905.9 5906.2 5783.0 5873.9 5948.6 5976.3 5989.7 5607.4 5792.8 5852.4 5865.6 5868.1 5622.9 5835.1 5872.5 5882.0 5882.8 5600.1 5645.1 5716.2 5737.6 5772.5 5882.9 5895.9 5896.1 5902.4 5911.8 5464.9 5626.5 5783.1 5785.1 5805.9 07:48:52 INFO - 2016-02-16 07:48:52,825 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56769.93 Median:35790.05 stddev:106355.28 (297.2%) stddev-sans-first:106570.03 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: Values: 601.8 633.5 634.7 641.5 646.6 31971.2 38692.4 39094.6 39107.8 39288.6 45340.5 45650.5 45908.0 45947.5 45971.0 7665.8 7754.7 9244.9 9421.5 10535.6 10838.6 10944.9 10959.4 10965.3 10980.2 10814.8 10937.4 10950.3 10956.4 10960.5 10916.0 11020.4 11023.5 11024.0 11025.3 10766.6 10898.8 10910.0 10917.1 10932.3 43882.8 43884.6 44295.3 44369.8 44417.6 3375.7 3387.5 3415.6 3558.7 3820.5 33078.7 33403.3 33461.0 33478.7 33489.0 4211.1 4248.3 4252.0 4304.4 4400.4 487586.0 493966.0 495457.0 496284.0 496446.0 58929.0 65444.0 66100.3 66116.7 66405.3 52158.2 52364.5 52499.7 73091.3 74444.6 15723.0 15805.4 15861.3 15864.1 15866.0 11994.6 12013.2 12034.9 12043.3 12075.2 22028.2 22269.0 22292.7 22355.3 22361.7 8474.2 8658.9 8763.2 8845.4 8845.4 996.7 1063.2 1090.4 1128.5 1139.2 30267.7 30588.7 31061.2 33531.3 34277.8 1053.9 1055.8 1147.1 1148.8 1158.0 14025.0 15149.5 15353.4 17490.3 17625.5 407026.0 407417.0 409876.0 411010.0 411435.0 59650.4 59714.1 60141.7 60197.7 60199.0 1268.3 1358.5 1407.1 1497.6 1499.6 30394.5 30406.5 30668.4 30993.0 31840.0 47660.3 48187.5 48196.5 48260.8 48332.0 269279.0 271531.0 273955.0 274242.0 274524.0 34649.5 35577.6 35741.0 35839.1 36095.3 45391.0 46142.0 46361.5 46769.5 46997.8 38946.4 39828.4 44699.3 45422.5 47247.3 39586.6 40151.4 40571.0 40817.6 40859.6 41869.6 42033.6 42517.4 42620.1 44111.8 33965.8 33980.5 35318.3 36044.8 36086.5 26937.0 27270.6 27795.6 27987.7 28136.7 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32413.46 Median:12265.46 stddev:103646.58 (845.0%) stddev-sans-first:103909.44 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: Values: 389.1 391.9 395.1 395.3 400.5 13832.9 17315.2 17916.7 18507.9 18523.4 11332.6 11470.3 11475.4 18323.9 18687.7 5007.8 5109.5 5110.1 5134.8 5137.4 3882.9 3989.7 5084.9 5492.3 5616.9 5569.0 5573.9 5581.6 5604.0 5617.8 5471.6 5605.6 5615.3 5618.6 5620.7 5384.9 5395.2 5401.9 5408.4 5408.7 19700.9 21757.5 22164.0 22218.1 22253.3 2207.4 2216.9 2277.6 2316.5 2397.5 9973.8 10030.0 10222.6 11905.0 12917.1 1922.3 1942.4 1946.4 1959.9 1966.8 66807.3 67432.7 68506.3 68823.7 68853.0 11174.7 11247.4 11273.7 11296.7 11321.9 14973.7 15093.5 15122.2 15122.8 15128.4 7702.9 7755.1 7776.9 8055.0 8106.8 7413.4 7817.6 7850.3 7853.3 7895.9 4529.8 4788.7 4824.3 4828.2 4848.7 1757.6 1806.6 1882.8 1949.8 1957.0 435.1 972.0 1012.0 1067.1 1069.3 10890.3 11026.8 11138.9 11176.2 11232.8 435.1 439.8 439.8 441.7 455.8 6093.5 6154.8 10243.0 10368.7 10568.7 620164.0 629173.0 633044.0 634113.0 651523.0 86033.6 89277.0 89934.6 90022.5 91582.0 1143.4 1164.9 1165.2 1166.3 1178.7 16464.5 16734.5 16783.4 16870.6 16989.3 39428.4 39601.6 39623.0 39956.0 40469.2 51761.7 53374.2 53380.7 55623.0 56319.5 9905.0 10152.4 10159.0 10201.6 10218.9 11977.8 15458.8 18842.0 18999.0 19079.9 15771.4 15781.5 15800.8 15904.2 15960.9 15432.6 15667.2 15814.2 15836.5 16183.8 12506.6 15994.4 16067.0 16129.1 16285.3 8634.6 9779.9 9789.1 9806.1 9856.3 14509.3 15216.8 15455.0 15749.0 16095.0 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,826 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5793.42 Median:6321.28 stddev:3026.60 (47.9%) stddev-sans-first:3018.53 07:48:52 INFO - 2016-02-16 07:48:52,827 DEBUG : BROWSER_OUTPUT: Values: 1581.1 1623.7 1677.0 1847.2 1906.2 8240.9 8437.9 8440.5 8443.8 8445.0 8165.2 8232.1 8233.8 8264.0 8266.5 2387.7 2392.6 2431.0 2434.6 2437.4 2401.0 2432.2 2459.0 2460.4 2462.2 2015.9 2046.2 2321.4 2408.7 2440.3 2265.9 2274.6 2283.0 2286.1 2287.1 2309.6 2385.4 2386.5 2389.2 2389.3 7131.6 7293.9 7902.4 8082.7 8084.4 4943.5 4991.2 5020.4 5023.6 5024.4 3046.1 3074.2 3077.8 3092.0 3118.0 1004.5 1025.1 1028.1 1036.4 1082.0 11101.4 11238.7 11266.5 11269.3 11316.7 4589.8 4602.9 4634.4 4655.9 4674.8 9762.5 9764.0 9783.1 9789.6 9795.3 5132.7 5138.9 5140.5 5144.3 5149.4 4668.9 4674.7 4675.5 4679.2 4682.6 3827.3 3856.9 3875.9 3904.1 3920.0 1257.6 1263.0 1271.6 1274.3 1274.8 1342.6 1353.6 1354.1 1372.3 1400.8 7632.9 7634.2 7645.2 7648.5 7683.1 500.4 506.3 514.6 514.9 517.8 5581.5 6218.7 6319.6 6322.9 6331.2 8490.3 9587.2 10110.9 10114.2 10119.2 9675.5 9879.2 9922.5 9991.2 9996.2 7681.3 7836.2 7837.5 7837.8 7842.3 7687.5 7716.7 7785.6 7786.2 7803.2 8834.6 8916.2 8985.8 9012.4 9026.4 8945.2 9165.9 9188.3 9193.4 9196.4 7335.2 7383.9 7393.3 7395.7 7396.0 7733.4 7862.3 7865.2 7883.9 7888.3 7522.2 7564.6 7600.5 7635.2 7650.3 7424.1 7471.1 7475.5 7521.4 7546.2 7502.8 7638.5 7641.7 7643.3 7659.1 7028.1 7063.0 7063.5 7079.4 7082.1 7000.8 7025.7 7173.6 7186.4 7186.6 07:48:52 INFO - 2016-02-16 07:48:52,827 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,827 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5491.42 Median:6237.16 stddev:1623.08 (26.0%) stddev-sans-first:1581.27 07:48:52 INFO - 2016-02-16 07:48:52,827 DEBUG : BROWSER_OUTPUT: Values: 360.0 364.3 365.5 366.2 376.7 6079.0 6176.4 6181.4 6181.4 6182.4 5809.9 5873.8 5966.9 5990.6 6063.2 4726.9 4728.1 4735.1 4746.1 4759.6 4508.9 4756.1 4758.2 4762.7 4768.4 4538.1 4586.2 4684.3 4706.4 4723.7 4629.5 4659.5 4680.1 4691.4 4696.3 4142.5 4194.4 4197.7 4198.5 4206.1 5667.1 5782.1 5782.9 5785.8 5789.9 5539.8 5540.7 5541.8 5547.6 5552.2 6462.1 6519.3 6519.4 6522.5 6522.8 4671.9 4691.4 4692.7 4699.5 4712.1 6594.1 6651.6 6721.5 6737.4 6742.9 4771.9 4811.3 4817.0 4818.2 4819.9 4854.4 4874.2 4874.8 4875.2 4876.4 5414.5 5530.1 5533.1 5535.6 5537.5 6504.9 6507.1 6513.7 6514.8 6532.3 1692.3 1709.9 1710.0 1710.2 1710.3 1182.4 1182.4 1183.0 1206.0 1207.6 6291.7 6316.4 6319.9 6334.2 6336.6 6437.3 6664.4 6715.6 6716.6 6723.4 6218.1 6256.2 6364.4 6377.7 6392.3 3599.3 3635.0 3658.3 3659.2 3661.5 6828.7 6955.3 6969.0 6978.2 6981.4 6902.4 6910.1 6913.4 6914.0 6916.3 6925.4 6971.9 6973.3 6980.0 6982.1 6631.5 6772.5 6774.5 6778.4 6791.7 6675.0 6679.2 6684.4 6686.3 6690.3 6847.5 6921.7 6924.0 6949.4 6974.2 4788.5 4828.1 4855.8 4863.1 4863.4 6776.2 6777.2 6783.2 6786.8 6791.9 6589.3 6608.7 6610.8 6613.6 6619.6 6436.0 6586.8 6589.6 6599.5 6607.3 6461.5 6501.4 6506.5 6508.4 6514.6 6616.2 6624.4 6624.9 6634.9 6638.2 6278.5 6455.3 6473.3 6478.0 6480.1 07:48:52 INFO - 2016-02-16 07:48:52,828 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2016-02-16 07:48:52,828 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14098.76 Median:44520.44 stddev:15909.83 (35.7%) stddev-sans-first:15923.20 07:48:52 INFO - 2016-02-16 07:48:52,828 DEBUG : BROWSER_OUTPUT: Values: 819.4 834.1 871.5 903.3 937.4 13831.5 14021.2 14023.1 14024.8 14026.3 13336.1 13356.4 13445.0 13446.7 13455.5 702.5 709.7 881.3 885.2 899.2 877.7 881.4 881.5 889.1 890.0 730.6 872.3 926.3 935.0 936.4 734.2 914.5 922.5 928.2 929.0 687.5 687.5 688.1 688.1 688.9 12852.0 12920.7 12931.5 12945.9 12999.9 12822.6 13008.4 13198.7 13287.3 13647.3 10889.0 10942.1 11054.4 11169.7 11232.2 3867.1 3872.9 3909.7 3930.0 3960.6 44437.6 44603.3 45024.3 46767.3 46802.5 10286.5 10502.4 10726.8 10765.9 10852.3 18381.4 18398.4 18400.5 18418.5 18418.9 7973.5 7987.3 8089.9 8116.8 8175.9 4584.8 4633.4 4646.4 4653.5 4666.3 3398.1 3419.8 3423.9 3425.9 3434.8 579.6 598.9 599.7 602.8 612.8 656.4 674.4 683.5 689.2 706.2 8594.1 8872.4 9154.4 9166.7 9173.2 657.8 668.7 680.5 704.0 716.1 3786.5 4036.7 4051.2 4079.2 4123.5 54358.7 55802.4 56588.7 56633.7 56985.4 52536.0 53023.7 53447.2 53532.5 53639.2 47145.5 47661.3 48065.3 48131.8 48225.5 7736.1 7930.0 7951.3 7970.1 8202.7 35113.8 35358.9 35813.1 36000.8 36100.8 41736.2 42468.4 47147.3 47320.5 47374.5 11746.5 12173.1 12225.6 12236.9 12591.7 13379.0 13884.9 13904.2 14004.8 14077.1 11939.3 12064.5 12172.6 12329.9 12417.9 12082.2 12292.6 12467.9 12484.4 12694.7 10074.1 11261.6 11735.5 11978.3 12146.5 10093.1 10283.7 10322.2 10338.3 10347.2 8529.8 9954.8 10397.5 10551.1 10765.4 07:48:52 INFO - 2016-02-16 07:48:52,828 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:48:52 INFO - 2016-02-16 07:48:52,828 DEBUG : BROWSER_OUTPUT: 07:48:53 INFO - 2016-02-16 07:48:53,382 INFO : Browser exited with error code: 0 07:48:53 INFO - 2016-02-16 07:48:53,403 INFO : Completed test dromaeo_css (00:18:30) 07:48:53 INFO - 2016-02-16 07:48:53,403 INFO : Starting test kraken 07:48:53 INFO - 2016-02-16 07:48:53,403 DEBUG : operating with platform_type : linux_ 07:48:53 INFO - 2016-02-16 07:48:53,403 INFO : Initialising browser for kraken test... 07:48:53 INFO - 2016-02-16 07:48:53,410 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIRd62/profile http://localhost:35357/getInfo.html 07:48:57 INFO - 2016-02-16 07:48:57,395 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:48:57 INFO - 2016-02-16 07:48:57,396 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:48:57 INFO - 2016-02-16 07:48:57,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:48:57 INFO - 2016-02-16 07:48:57,396 DEBUG : BROWSER_OUTPUT: __metrics 07:48:57 INFO - 2016-02-16 07:48:57,573 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] 07:48:58 INFO - 2016-02-16 07:48:58,753 INFO : Browser initialized. 07:48:58 INFO - 2016-02-16 07:48:58,754 INFO : Running cycle 1/1 for kraken test... 07:48:58 INFO - 2016-02-16 07:48:58,754 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAIRd62/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:10 INFO - 2016-02-16 07:49:10,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 134619136 07:49:10 INFO - 2016-02-16 07:49:10,421 DEBUG : BROWSER_OUTPUT: 07:49:12 INFO - 2016-02-16 07:49:12,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35357/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:13 INFO - 2016-02-16 07:49:13,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 164134912 07:49:13 INFO - 2016-02-16 07:49:13,424 DEBUG : BROWSER_OUTPUT: 07:49:16 INFO - 2016-02-16 07:49:16,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35357/tests/kraken/driver.html?testName=audio-dft) 07:49:16 INFO - 2016-02-16 07:49:16,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 161210368 07:49:16 INFO - 2016-02-16 07:49:16,580 DEBUG : BROWSER_OUTPUT: 07:49:19 INFO - 2016-02-16 07:49:19,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35357/tests/kraken/driver.html?testName=audio-fft) 07:49:19 INFO - 2016-02-16 07:49:19,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 158142464 07:49:19 INFO - 2016-02-16 07:49:19,938 DEBUG : BROWSER_OUTPUT: 07:49:21 INFO - 2016-02-16 07:49:21,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35357/tests/kraken/driver.html?testName=audio-oscillator) 07:49:22 INFO - 2016-02-16 07:49:22,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 158973952 07:49:22 INFO - 2016-02-16 07:49:22,468 DEBUG : BROWSER_OUTPUT: 07:49:24 INFO - 2016-02-16 07:49:24,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35357/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:25 INFO - 2016-02-16 07:49:25,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 158294016 07:49:25 INFO - 2016-02-16 07:49:25,183 DEBUG : BROWSER_OUTPUT: 07:49:28 INFO - 2016-02-16 07:49:28,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35357/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:28 INFO - 2016-02-16 07:49:28,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 159457280 07:49:28 INFO - 2016-02-16 07:49:28,623 DEBUG : BROWSER_OUTPUT: 07:49:31 INFO - 2016-02-16 07:49:31,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35357/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:32 INFO - 2016-02-16 07:49:32,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 158994432 07:49:32 INFO - 2016-02-16 07:49:32,524 DEBUG : BROWSER_OUTPUT: 07:49:35 INFO - 2016-02-16 07:49:35,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35357/tests/kraken/driver.html?testName=json-parse-financial) 07:49:35 INFO - 2016-02-16 07:49:35,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 160030720 07:49:35 INFO - 2016-02-16 07:49:35,830 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2016-02-16 07:49:37,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35357/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:37 INFO - 2016-02-16 07:49:37,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 166576128 07:49:37 INFO - 2016-02-16 07:49:37,922 DEBUG : BROWSER_OUTPUT: 07:49:39 INFO - 2016-02-16 07:49:39,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:40 INFO - 2016-02-16 07:49:40,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 165654528 07:49:40 INFO - 2016-02-16 07:49:40,312 DEBUG : BROWSER_OUTPUT: 07:49:42 INFO - 2016-02-16 07:49:42,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:42 INFO - 2016-02-16 07:49:42,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 168927232 07:49:42 INFO - 2016-02-16 07:49:42,864 DEBUG : BROWSER_OUTPUT: 07:49:45 INFO - 2016-02-16 07:49:45,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:45 INFO - 2016-02-16 07:49:45,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 174923776 07:49:45 INFO - 2016-02-16 07:49:45,790 DEBUG : BROWSER_OUTPUT: 07:49:48 INFO - 2016-02-16 07:49:48,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:48 INFO - 2016-02-16 07:49:48,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 173588480 07:49:48 INFO - 2016-02-16 07:49:48,873 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35357/tests/kraken/driver.html?testName=ai-astar) 07:49:50 INFO - 2016-02-16 07:49:50,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 232005632 07:49:50 INFO - 2016-02-16 07:49:50,805 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;105;108;109;109;99;108;108;108 07:49:50 INFO - 2016-02-16 07:49:50,809 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;135;157;163;130;141;156;125;170;122 07:49:50 INFO - 2016-02-16 07:49:50,810 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;159;159;161;160;161;161;160;159 07:49:50 INFO - 2016-02-16 07:49:50,810 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;139;70;70;70;80;158;74 07:49:50 INFO - 2016-02-16 07:49:50,810 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;141;92;92;93;135;92;92;130 07:49:50 INFO - 2016-02-16 07:49:50,810 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;109;109 07:49:50 INFO - 2016-02-16 07:49:50,810 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;146;145;146;145;146;145 07:49:50 INFO - 2016-02-16 07:49:50,811 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;96;96;95;96;96 07:49:50 INFO - 2016-02-16 07:49:50,811 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;62;56;56;56;55;57;56;54;54 07:49:50 INFO - 2016-02-16 07:49:50,811 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;66;66;67;66;66;65;65 07:49:50 INFO - 2016-02-16 07:49:50,811 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;78;79;78;87;78;77;78;77 07:49:50 INFO - 2016-02-16 07:49:50,811 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;117;111;111;115;109;121;112;120;121 07:49:50 INFO - 2016-02-16 07:49:50,812 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;152;141;139;140;140;141;140;140;152 07:49:50 INFO - 2016-02-16 07:49:50,812 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;67;63;74;65;63;64;64;63;63 07:49:50 INFO - 2016-02-16 07:49:50,812 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:49:50 INFO - 2016-02-16 07:49:50,812 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:49:50 INFO - 2016-02-16 07:49:50,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 07:49:50 INFO - 2016-02-16 07:49:50,813 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:49:50 INFO - 2016-02-16 07:49:50,813 DEBUG : BROWSER_OUTPUT: __startTimestamp1455637790807__endTimestamp 07:49:50 INFO - 2016-02-16 07:49:50,813 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,814 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:49:50 INFO - 2016-02-16 07:49:50,815 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:49:50 INFO - 2016-02-16 07:49:50,815 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,815 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.27 (3.0%) stddev-sans-first:3.33 07:49:50 INFO - 2016-02-16 07:49:50,815 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 105.0 108.0 109.0 109.0 99.0 108.0 108.0 108.0 07:49:50 INFO - 2016-02-16 07:49:50,815 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.80 Median:152.50 stddev:16.67 (10.9%) stddev-sans-first:17.61 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: Values: 149.0 135.0 157.0 163.0 130.0 141.0 156.0 125.0 170.0 122.0 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 159.0 159.0 161.0 160.0 161.0 161.0 160.0 159.0 07:49:50 INFO - 2016-02-16 07:49:50,816 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,817 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.60 Median:71.50 stddev:32.54 (45.5%) stddev-sans-first:34.03 07:49:50 INFO - 2016-02-16 07:49:50,817 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 139.0 70.0 70.0 70.0 80.0 158.0 74.0 07:49:50 INFO - 2016-02-16 07:49:50,817 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,817 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:92.00 stddev:20.96 (22.8%) stddev-sans-first:21.76 07:49:50 INFO - 2016-02-16 07:49:50,818 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 141.0 92.0 92.0 93.0 135.0 92.0 92.0 130.0 07:49:50 INFO - 2016-02-16 07:49:50,818 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,818 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:49:50 INFO - 2016-02-16 07:49:50,818 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.36 (4.2%) stddev-sans-first:2.39 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: Values: 54.0 62.0 56.0 56.0 56.0 55.0 57.0 56.0 54.0 54.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 66.0 66.0 67.0 66.0 66.0 65.0 65.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.00 stddev:3.06 (3.9%) stddev-sans-first:3.24 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 78.0 79.0 78.0 87.0 78.0 77.0 78.0 77.0 07:49:50 INFO - 2016-02-16 07:49:50,819 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:117.00 stddev:4.48 (3.8%) stddev-sans-first:4.71 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 111.0 111.0 115.0 109.0 121.0 112.0 120.0 121.0 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:140.50 stddev:5.29 (3.8%) stddev-sans-first:5.26 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: Values: 137.0 152.0 141.0 139.0 140.0 140.0 141.0 140.0 140.0 152.0 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.00 stddev:3.45 (5.4%) stddev-sans-first:3.59 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: Values: 63.0 67.0 63.0 74.0 65.0 63.0 64.0 64.0 63.0 63.0 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:49:50 INFO - 2016-02-16 07:49:50,820 DEBUG : BROWSER_OUTPUT: 07:49:51 INFO - 2016-02-16 07:49:51,533 INFO : Browser exited with error code: 0 07:49:51 INFO - 2016-02-16 07:49:51,587 INFO : Completed test kraken (00:00:58) 07:49:51 INFO - 2016-02-16 07:49:51,587 INFO : Starting test v8_7 07:49:51 INFO - 2016-02-16 07:49:51,587 DEBUG : operating with platform_type : linux_ 07:49:51 INFO - 2016-02-16 07:49:51,587 INFO : Initialising browser for v8_7 test... 07:49:51 INFO - 2016-02-16 07:49:51,593 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpD7gB/profile http://localhost:35357/getInfo.html 07:49:55 INFO - 2016-02-16 07:49:55,432 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:49:55 INFO - 2016-02-16 07:49:55,432 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:49:55 INFO - 2016-02-16 07:49:55,432 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:49:55 INFO - 2016-02-16 07:49:55,432 DEBUG : BROWSER_OUTPUT: __metrics 07:49:55 INFO - 2016-02-16 07:49:55,730 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] 07:49:56 INFO - 2016-02-16 07:49:56,737 INFO : Browser initialized. 07:49:56 INFO - 2016-02-16 07:49:56,738 INFO : Running cycle 1/1 for v8_7 test... 07:49:56 INFO - 2016-02-16 07:49:56,738 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpD7gB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:50:08 INFO - 2016-02-16 07:50:08,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 134975488 07:50:08 INFO - 2016-02-16 07:50:08,404 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35357/tests/v8_7/run.html (next: http://localhost:35357/tests/v8_7/run.html) 07:50:29 INFO - 2016-02-16 07:50:29,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 425005056 07:50:29 INFO - 2016-02-16 07:50:29,987 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |0;Richards;172.41379310344828 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.80567139282735 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |4;RayTrace;956.0229445506692 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |5;Earley;539.3743257820928 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |6;Boyer;10468.75 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |8;Splay;517.3305742369374 07:50:29 INFO - 2016-02-16 07:50:29,988 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: __startTimestamp1455637829980__endTimestamp 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.41 Median:172.41 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: Values: 172.4 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: Values: 166.8 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: Values: 278.7 07:50:29 INFO - 2016-02-16 07:50:29,989 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 5133.3 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:956.02 Median:956.02 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 956.0 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.37 Median:539.37 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 539.4 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10468.75 Median:10468.75 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 10468.8 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 24166.7 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.33 Median:517.33 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,990 DEBUG : BROWSER_OUTPUT: Values: 517.3 07:50:29 INFO - 2016-02-16 07:50:29,991 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2016-02-16 07:50:29,991 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:50:29 INFO - 2016-02-16 07:50:29,991 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:50:29 INFO - 2016-02-16 07:50:29,991 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:50:29 INFO - 2016-02-16 07:50:29,991 DEBUG : BROWSER_OUTPUT: 07:50:30 INFO - 2016-02-16 07:50:30,718 INFO : Browser exited with error code: 0 07:50:30 INFO - 2016-02-16 07:50:30,732 INFO : Completed test v8_7 (00:00:39) 07:50:31 INFO - 2016-02-16 07:50:31,033 INFO : Completed test suite (00:20:08) 07:50:31 INFO - 2016-02-16 07:50:31,034 DEBUG : Working with test: dromaeo_css 07:50:31 INFO - 2016-02-16 07:50:31,034 DEBUG : Generating results file: dromaeo_css 07:50:31 INFO - 2016-02-16 07:50:31,035 DEBUG : Working with test: kraken 07:50:31 INFO - 2016-02-16 07:50:31,036 DEBUG : Generating results file: kraken 07:50:31 INFO - 2016-02-16 07:50:31,036 INFO : javascript benchmark 07:50:31 INFO - 2016-02-16 07:50:31,036 DEBUG : Working with test: v8_7 07:50:31 INFO - 2016-02-16 07:50:31,036 DEBUG : Generating results file: v8_7 07:50:31 INFO - 2016-02-16 07:50:31,037 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:31 INFO - 2016-02-16 07:50:31,091 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 07:50:31 INFO - 2016-02-16 07:50:31,091 DEBUG : process_Request line: dromaeo_css 7343.49 graph.html#tests=[[72,53,35]] 07:50:31 INFO - 2016-02-16 07:50:31,091 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:31 INFO - 2016-02-16 07:50:31,197 DEBUG : process_Request line: kraken 1478.10 graph.html#tests=[[232,53,35]] 07:50:31 INFO - 2016-02-16 07:50:31,197 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:50:31 INFO - 2016-02-16 07:50:31,302 DEBUG : process_Request line: v8_7 23260.81 graph.html#tests=[[230,53,35]] 07:50:31 INFO - 2016-02-16 07:50:31,303 INFO : javascript benchmark 07:50:31 INFO - 2016-02-16 07:50:31,306 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.2697606526563, 3379.7803142795733, 3415.4193787056197, 3422.264213194163, 3440.0367896988837, 5543.307086614173, 5560.4135332710375, 5568.387477377485, 5582.972085139574, 5585.720713964301, 5603.2435621191225, 5603.579731520143, 5613.550915926727, 5624.100143976964, 5631.493165615094, 4970.925436118443, 5040.873978150539, 5087.6693014954, 5111.386633603955, 5180.3006594109875, 4968.155413579682, 4988.0, 5003.374578177728, 5025.195968645017, 5149.176131818891, 5073.188289873621, 5221.347331583552, 5237.319148510688, 5239.0, 5251.2385704072885, 5072.923906141411, 5146.897062058757, 5151.896962060775, 5155.072087024334, 5182.32629758129, 4850.320955066293, 4908.460069392364, 4924.60603151747, 5041.0422019816115, 5042.571381432583, 5361.115415956362, 5366.114591092465, 5368.30212072432, 5379.811706590251, 5388.461153884619, 5934.228550288435, 5938.079597662369, 5938.8218353449465, 5941.049432090845, 5986.880262394771, 5663.235463212455, 5820.708964551798, 6020.518358531307, 6135.5398345124295, 6137.223770008885, 5679.346875109332, 5683.971580142114, 5689.288838895138, 5700.800471983503, 5702.45826646468, 5858.8242352729485, 6139.355367686418, 6160.383961603804, 6172.382761723792, 6179.62922224668, 5689.34572524165, 5825.1844741736195, 5918.585699001029, 5919.052951527735, 5959.7914073008105, 6011.188489553854, 6019.608725432833, 6021.488173505213, 6022.3676513966275, 6029.78895738647, 5648.802291919763, 5741.311042674905, 5975.492083172892, 5991.64050156992, 6009.1587177795145, 5789.652620842763, 5894.086416605433, 5897.380775018647, 5898.675572843535, 5927.0, 4543.636509079266, 4597.655175861823, 4610.308453731967, 4615.723056616546, 4639.072185562901, 3985.501812273466, 4039.8990025249605, 4067.2272268268935, 4093.201825643971, 4168.291390463629, 5606.719664016864, 5615.691136987505, 5619.80330688424, 5634.464725851038, 5639.520640745583, 5961.374055724174, 5974.4324289192455, 5976.402359763989, 5977.312609049928, 5992.67040312787, 5472.50747432733, 5518.613697041249, 5572.3034620672415, 5623.240862483594, 5629.0, 5098.056859481007, 5200.115980283361, 5205.7397130143345, 5210.97394513025, 5218.0, 6146.6004709693725, 6169.352218017044, 6173.228346456693, 6174.351693072163, 6176.197094377702, 5712.257406537124, 5824.737886795189, 5850.2102216200265, 5913.2608423947, 5940.019896717166, 6154.0, 6190.442860142429, 6195.0, 6197.81406557804, 6198.876022479615, 5637.774489020393, 5896.115582662635, 5903.675297858487, 5905.852353691193, 5906.173135761082, 5782.971085144547, 5873.853153671193, 5948.583599148018, 5976.252968378953, 5989.670568118795, 5607.43925607436, 5792.797252096157, 5852.414758524284, 5865.560082993878, 5868.119782032559, 5622.915656265078, 5835.095560188178, 5872.500837428866, 5882.0, 5882.794102206402, 5600.131979543177, 5645.125005624135, 5716.228309178374, 5737.56968227393, 5772.5381969441505, 5882.882342353215, 5895.94104058954, 5896.115582662635, 5902.38025007368, 5911.822645320647, 5464.91802622953, 5626.549876009827, 5783.103618939072, 5785.132230165341, 5805.883882322414], "unit": "ms", "name": "dojo.html", "value": 5494.6709901114145}, {"lowerIsBetter": false, "replicates": [601.7713268957796, 633.5406830048215, 634.6509419819098, 641.4900154377269, 646.5635695905263, 31971.20071998201, 38692.41961370582, 39094.60905390945, 39107.804460977655, 39288.60711392882, 45340.5062721551, 45650.54349456504, 45908.0, 45947.54052459474, 45971.0, 7665.846683066336, 7754.728584499544, 9244.907550924489, 9421.48181849998, 10535.63125290615, 10838.566457341736, 10944.890551094506, 10959.397233152173, 10965.287256328313, 10980.176486763485, 10814.837777433344, 10937.398443085627, 10950.34297942126, 10956.397398143099, 10960.451977401139, 10916.01755841974, 11020.393878336688, 11023.503942322535, 11024.0, 11025.283356581876, 10766.56933722658, 10898.782024359547, 10910.0, 10917.072048875854, 10932.344059356465, 43882.780586097186, 43884.561154388364, 44295.335569966475, 44369.77815110936, 44417.55582444167, 3375.6793104655017, 3387.5426817379584, 3415.55597772288, 3558.679718825318, 3820.4842346283176, 33078.6692133078, 33403.331933361194, 33461.0, 33478.66521334804, 33489.0, 4211.0946146578635, 4248.34150706641, 4252.0, 4304.375865499485, 4400.361947517624, 487586.0, 493965.9999999964, 495457.0, 496284.0, 496446.0, 58929.0, 65444.0, 66100.33899661039, 66116.66941665261, 66405.33594664089, 52158.217626735626, 52364.47635523672, 52499.73750131225, 73091.26908730951, 74444.62777686077, 15723.0, 15805.446809361618, 15861.286242118902, 15864.127472988866, 15866.0, 11994.64016079519, 12013.219140755999, 12034.879651203551, 12043.277403355827, 12075.154739168174, 22028.229011984502, 22269.0, 22292.66561001586, 22355.32934011982, 22361.664575031387, 8474.237318641352, 8658.87011694825, 8763.211310981915, 8845.380823342304, 8845.380823342433, 996.6561536269975, 1063.234471180764, 1090.3512410115968, 1128.503458478267, 1139.2480962564669, 30267.69732302649, 30588.69411305903, 31061.223469413446, 33531.329373412394, 34277.828610856785, 1053.942033188182, 1055.7518983038979, 1147.1396452660504, 1148.8104462763552, 1157.976840463186, 14025.0, 15149.469768558269, 15353.385864565516, 17490.300387984338, 17625.471235862944, 407026.0, 407417.0, 409876.0, 411010.0, 411435.0, 59650.40349596535, 59714.10428843571, 60141.69929150326, 60197.699011504665, 60199.0, 1268.3277862732766, 1358.4905660377358, 1407.113518483349, 1497.5657059452637, 1499.6101013736507, 30394.54408183923, 30406.54390184193, 30668.386632267677, 30993.0, 31840.0, 47660.285095722895, 48187.5181248183, 48196.518034820605, 48260.7586962077, 48332.0, 269279.0, 271531.0, 273955.0, 274242.0, 274524.0, 34649.480257796655, 35577.64422355847, 35741.0, 35839.104022399646, 36095.27809443849, 45391.0, 46142.0, 46361.53638463572, 46769.53230467652, 46997.76501117473, 38946.4158037624, 39828.40257396199, 44699.32951005673, 45422.545774543156, 47247.29129062998, 39586.604133958295, 40151.397729034674, 40571.0, 40817.59182408138, 40859.59140408558, 41869.58130418657, 42033.57966420419, 42517.362239567046, 42620.147597048504, 44111.77944110259, 33965.83017084899, 33980.49029264612, 35318.29363412769, 36044.819775902004, 36086.45870312, 26937.0, 27270.590941136295, 27795.583066253617, 27987.720122799325, 28136.718632814227], "unit": "ms", "name": "ext.html", "value": 20674.183636259244}, {"lowerIsBetter": false, "replicates": [389.0759446315, 391.9353306704394, 395.101144895363, 395.3180763183509, 400.52337718115456, 13832.861671383283, 17315.22081506332, 17916.731249031276, 18507.907460462695, 18523.444296671103, 11332.60335888242, 11470.311781293129, 11475.426228688573, 18323.90838045808, 18687.719684204712, 5007.849764507061, 5109.463506331819, 5110.054639891632, 5134.794608215686, 5137.409197942228, 3882.864099756509, 3989.68082553395, 5084.898302033957, 5492.340919089695, 5616.9157462638095, 5569.0, 5573.888522229573, 5581.6371935824245, 5604.0, 5617.8033768818095, 5471.644343117685, 5605.607607467479, 5615.326160860682, 5618.634788738719, 5620.747066382022, 5384.865378365533, 5395.244665746799, 5401.891962160735, 5408.3509978802795, 5408.702521361323, 19700.901495492573, 21757.45606359838, 22164.0, 22218.11127554896, 22253.332400028026, 2207.4260692220137, 2216.8669879807103, 2277.5786479501344, 2316.4556329262778, 2397.484540823731, 9973.80052398948, 10030.0, 10222.591096356211, 11904.98807601355, 12917.095803293772, 1922.2887531613253, 1942.3978566644244, 1946.3577019583504, 1959.9118039688249, 1966.8229859312587, 66807.33192668109, 67432.662836686, 68506.3149368505, 68823.65588172077, 68853.0, 11174.714907785708, 11247.437628118561, 11273.661790146309, 11296.717582060513, 11321.943390282995, 14973.70052598942, 15093.54719358421, 15122.243887805565, 15122.848771512145, 15128.39486420553, 7702.8844567331535, 7755.108162561378, 7776.922230777733, 8054.993125859268, 8106.756797296091, 7413.443991700644, 7817.570033648204, 7850.2934735872905, 7853.332466740391, 7895.9210407896335, 4529.796159172845, 4788.664793464493, 4824.252240902666, 4828.179209534387, 4848.7090774553635, 1757.5798011761708, 1806.5935164588125, 1882.8305452509067, 1949.8162058494577, 1956.9725893905813, 435.1340831744805, 971.9757006074905, 1011.9747006324753, 1067.0876400677464, 1069.3209811769582, 10890.29213101146, 11026.834597480884, 11138.94430527842, 11176.161787865942, 11232.831507527393, 435.08414786873806, 439.760330619813, 439.83726021371655, 441.7349590245827, 455.7835028361568, 6093.512518998469, 6154.753809847556, 10243.0, 10368.688939331832, 10568.682939511827, 620164.0, 629173.0, 633044.0, 634113.0, 651523.0, 86033.56983215043, 89277.0, 89934.55032724925, 90022.54988725146, 91582.0, 1143.3768596115137, 1164.85439320085, 1165.1785491228663, 1166.2943918929095, 1178.7230000949942, 16464.506064818073, 16734.48220839315, 16783.412580559623, 16870.57823554421, 16989.320427182774, 39428.40857387084, 39601.603983959794, 39623.00942476461, 39956.0, 40469.19061618692, 51761.74119129531, 53374.199387010005, 53380.73309633427, 55623.0, 56319.54634765156, 9905.0, 10152.39085654863, 10159.034891685278, 10201.642942496977, 10218.897811021794, 11977.760444791229, 15458.768118478007, 18842.0, 18999.0, 19079.904600476908, 15771.44799931997, 15781.526554203392, 15800.76298855541, 15904.204789760235, 15960.920195399412, 15432.614184645474, 15667.216639168224, 15814.209289535247, 15836.52490425289, 16183.75724364159, 12506.562270320495, 15994.360225590846, 16067.0, 16129.11289879068, 16285.267162977458, 8634.611442484978, 9779.85330220033, 9789.070038346346, 9806.117449429586, 9856.31005829585, 14509.274536273355, 15216.771748423562, 15455.0, 15749.0, 16095.02242085218], "unit": "ms", "name": "jquery.html", "value": 9017.596350561604}, {"lowerIsBetter": false, "replicates": [1581.098773698992, 1623.6752649470104, 1676.9664606707865, 1847.2333981397721, 1906.247032422194, 8240.91759082409, 8437.915620843789, 8440.45137066091, 8443.83112337753, 8445.0, 8165.183481651847, 8232.094469608339, 8233.752987410373, 8264.0, 8266.462679925815, 2387.7015373078366, 2392.5573768852773, 2431.039739302983, 2434.5982912819363, 2437.439388940536, 2401.0, 2432.19737486629, 2459.016393442628, 2460.3972026853357, 2462.1997850698503, 2015.8588898777018, 2046.1815273890488, 2321.419645088728, 2408.6989126359204, 2440.316711320824, 2265.9433514162115, 2274.55646149001, 2283.041122728458, 2286.131270117353, 2287.0737351372723, 2309.618912879373, 2385.439421735891, 2386.4630458146953, 2389.163792672568, 2389.259329607827, 7131.607761573111, 7293.854122917512, 7902.446828721992, 8082.717104901359, 8084.434089613729, 4943.456219815817, 4991.201407774775, 5020.397552293712, 5023.623228257895, 5024.447310795809, 3046.1318524220715, 3074.2314421394653, 3077.830719310437, 3091.9536206956914, 3118.033409642995, 1004.4726518577733, 1025.1183981775666, 1028.136365453023, 1036.3626369782605, 1081.9891801081967, 11101.44492775358, 11238.66284011481, 11266.493007814668, 11269.267497612711, 11316.660500185008, 4589.816407343669, 4602.88492787683, 4634.443866736014, 4655.86032419028, 4674.766261686902, 9762.463064531377, 9764.023597640322, 9783.119519243302, 9789.608415663293, 9795.265355098396, 5132.743362831843, 5138.897222055538, 5140.485951404829, 5144.279800827887, 5149.433562308143, 4668.883277918079, 4674.74288914113, 4675.509071547506, 4679.181143299909, 4682.578567928903, 3827.2919509890758, 3856.8777845030404, 3875.8837234883, 3904.1020565270146, 3919.980400097981, 1257.5975687780006, 1262.9684257893625, 1271.5613113475836, 1274.3182397417338, 1274.7769140400392, 1342.6307765364602, 1353.587155917435, 1354.0724603646534, 1372.2726954714017, 1400.7618704820204, 7632.885506717404, 7634.236576342432, 7645.235476452422, 7648.541087534766, 7683.116441609286, 500.4220125754759, 506.25327641728154, 514.5977212097081, 514.8584139361631, 517.7592419524939, 5581.469760372758, 6218.689065546704, 6319.6208227506495, 6322.936770632326, 6331.240251169797, 8490.320774338039, 9587.18508926749, 10110.949445252874, 10114.190864730952, 10119.24105692076, 9675.516224188763, 9879.16027137687, 9922.50387480623, 9991.150752186146, 9996.200303975664, 7681.270279323456, 7836.177201393772, 7837.529748215012, 7837.843243135106, 7842.254985776228, 7687.5387476751575, 7716.729914453192, 7785.571793551182, 7786.221377862168, 7803.219678032151, 8834.602442889956, 8916.19754222123, 8985.820283594423, 9012.41419307743, 9026.413283136575, 8945.19493245611, 9165.908340916505, 9188.264938804747, 9193.402428842104, 9196.35625506208, 7335.193128755725, 7383.889241661272, 7393.260673932778, 7395.667194976347, 7395.9645649610175, 7733.419993500623, 7862.33170180541, 7865.213478652089, 7883.881741773764, 7888.2506161914525, 7522.247775222434, 7564.583947882919, 7600.543967361976, 7635.198304178203, 7650.349720273839, 7424.071991001125, 7471.066116735408, 7475.514091584029, 7521.3982881368265, 7546.24537546241, 7502.812429689083, 7638.541687498768, 7641.732539361095, 7643.273888980538, 7659.119201291923, 7028.0863487746265, 7062.964685176541, 7063.540869843444, 7079.362857342864, 7082.079329687108, 7000.789976300719, 7025.68384422692, 7173.641317933978, 7186.425085993213, 7186.568805871664], "unit": "ms", "name": "mootools.html", "value": 4670.144511372184}, {"lowerIsBetter": false, "replicates": [360.0476739025278, 364.2878173171451, 365.4773673646684, 366.17245026240687, 376.7005230841481, 6078.966575682133, 6176.382361763822, 6181.350958149397, 6181.350958149397, 6182.443580077792, 5809.854753631162, 5873.794417195399, 5966.8806623867495, 5990.640561566309, 6063.211782468273, 4726.881827954311, 4728.148933192024, 4735.12400205963, 4746.145693775119, 4759.571638552529, 4508.887277818065, 4756.120117778205, 4758.167320718878, 4762.690425122356, 4768.356271903283, 4538.115067561826, 4586.1744885920525, 4684.320773487842, 4706.435227772655, 4723.669343145981, 4629.51390104041, 4659.510751371125, 4680.110778952006, 4691.390119284488, 4696.342512048316, 4142.544320124784, 4194.412782210493, 4197.706160568731, 4198.496180458334, 4206.074663574009, 5667.121596152603, 5782.10377391505, 5782.855428614318, 5785.826425207209, 5789.855253618651, 5539.778408863641, 5540.722963851832, 5541.750621222014, 5547.55619550439, 5552.194931734876, 6462.095306657072, 6519.250286217051, 6519.445847103002, 6522.543421960465, 6522.804315870531, 4671.906561868744, 4691.437027556681, 4692.694974826625, 4699.459562150362, 4712.128256272601, 6594.07682924391, 6651.600903945779, 6721.495887808385, 6737.427318677918, 6742.865142697167, 4771.904561908743, 4811.254255590389, 4816.975915120402, 4818.204996175662, 4819.927701084486, 4854.441739200037, 4874.2201247800185, 4874.7562621868765, 4875.219964805614, 4876.414830220397, 5414.512693857571, 5530.142827861688, 5533.059379905345, 5535.557155427556, 5537.473939975695, 6504.902426463606, 6507.121538592324, 6513.706883190268, 6514.771982980667, 6532.346765323429, 1692.3061544766585, 1709.8546623537138, 1709.9743503847453, 1710.2474911039103, 1710.324421853361, 1182.3674334231316, 1182.3733421286731, 1182.9940850295693, 1205.9758804823855, 1207.619599826052, 6291.653959032205, 6316.431521163117, 6319.9368006320265, 6334.1765570475545, 6336.588121772163, 6437.25971513282, 6664.366885145903, 6715.630640314829, 6716.630585317855, 6723.361280678328, 6218.067289906459, 6256.249250090018, 6364.395382438661, 6377.681115944184, 6392.328805475451, 3599.3161299353037, 3635.0003748969243, 3658.32321020612, 3659.1766852457986, 3661.4690869823726, 6828.692708828015, 6955.269696681776, 6969.0, 6978.162620485574, 6981.371676549135, 6902.447804175654, 6910.136232970879, 6913.446924246048, 6914.032035515032, 6916.273791251947, 6925.376716095677, 6971.930280697229, 6973.302669733088, 6980.0, 6982.057422247932, 6631.469482441296, 6772.458203343819, 6774.458043356618, 6778.356056174655, 6791.694373753094, 6674.966625167037, 6679.198496180489, 6684.398404143651, 6686.297938716365, 6690.330966903465, 6847.486438517031, 6921.7231310747, 6923.9653801730665, 6949.4440444765305, 6974.163100427981, 4788.467690339197, 4828.106800241966, 4855.757212139309, 4863.10032643962, 4863.440704319049, 6776.186857577122, 6777.220619628806, 6783.18601767791, 6786.76246331376, 6791.864162716619, 6589.275179730322, 6608.7356505739235, 6610.8016759497295, 6613.636250006103, 6619.602823830585, 6435.967820160869, 6586.769463068769, 6589.604623722592, 6599.4720422365135, 6607.306232845482, 6461.483081353575, 6501.382368674968, 6506.512011599054, 6508.414242718178, 6514.57655252407, 6616.206055273398, 6624.403803657694, 6624.900626490703, 6634.900476492953, 6638.17022872141, 6278.46633036197, 6455.289918109098, 6473.287938326875, 6477.967610161919, 6480.125183100221], "unit": "ms", "name": "prototype.html", "value": 4975.060208449461}, {"lowerIsBetter": false, "replicates": [819.3772732723129, 834.0783434305089, 871.4771137317609, 903.3360480047164, 937.4375374775136, 13831.515896943609, 14021.228832414214, 14023.088499247542, 14024.789628155573, 14026.298685065743, 13336.133151345155, 13356.398962046707, 13445.0, 13446.663833404169, 13455.461781528751, 702.5187746393711, 709.7090193020863, 881.3478026260585, 885.2121611765517, 899.1682693508511, 877.6796469288696, 881.3610132653839, 881.5019513974615, 889.1242126505387, 889.968851090212, 730.6456368661195, 872.3152325424543, 926.2775035472342, 935.0135606934681, 936.4287784451514, 734.2290594875386, 914.4833169259381, 922.4741897118679, 928.1507420710042, 929.0291645230683, 687.5084314714953, 687.5359132585485, 688.0779755128102, 688.1295161620554, 688.8622275544911, 12852.0, 12920.741585168244, 12931.48274069036, 12945.87054129456, 12999.935000324938, 12822.551210707581, 13008.414621342063, 13198.73602527944, 13287.269200193985, 13647.317634118353, 10889.0, 10942.124630029579, 11054.447277636085, 11169.72075698106, 11232.21374503785, 3867.1105645701646, 3872.8644497442456, 3909.7263191576603, 3929.960700392988, 3960.584138665456, 44437.55562444367, 44603.33095003577, 45024.3246351305, 46767.29849052267, 46802.531974680154, 10286.485675716334, 10502.422366769748, 10726.785464290671, 10765.892341076646, 10852.348859068481, 18381.448556543324, 18398.356057537923, 18400.53998650018, 18418.539536511693, 18418.907905460386, 7973.521588704696, 7987.281144697005, 8089.919100809035, 8116.83766324682, 8175.877361839577, 4584.770761461914, 4633.397658304399, 4646.372739680168, 4653.464851542116, 4666.300054991779, 3398.082517720202, 3419.8461069251944, 3423.9144021399165, 3425.880094196691, 3434.793912365266, 579.6377264209868, 598.8622616798161, 599.6821684507219, 602.8161410769758, 612.7793994162098, 656.3502132888501, 674.4065222604077, 683.5215349255442, 689.1867596236489, 706.2266817834566, 8594.140585941355, 8872.423292486097, 9154.40496367734, 9166.724998250063, 9173.220276276592, 657.7533424965637, 668.6556423441931, 680.5406350713249, 703.9507234493639, 716.1012928774355, 3786.545614526219, 4036.677065834785, 4051.1897620476025, 4079.204555111784, 4123.484564429446, 54358.728206359505, 55802.44197557973, 56588.717056414454, 56633.7168314164, 56985.43014569884, 52536.0, 53023.73488132612, 53447.19829202565, 53532.46467535353, 53639.19541206807, 47145.5285447148, 47661.285080723814, 48065.27902081471, 48131.75934120307, 48225.517744823504, 7736.1103473099065, 7930.0, 7951.32413744815, 7970.083440404428, 8202.71160719614, 35113.824430877685, 35358.93923182309, 35813.1046723834, 36000.81999589985, 36100.81949590235, 41736.165276694905, 42468.362974556025, 47147.29279060885, 47320.52679473299, 47374.526254737015, 11746.471408786454, 12173.087018473827, 12225.572104976283, 12236.877631223573, 12591.748165036464, 13379.0, 13884.861151388357, 13904.235267060409, 14004.78992815129, 14077.084989475652, 11939.34333611625, 12064.457099430721, 12172.634820955385, 12329.938350308192, 12417.937910310391, 12082.214656047328, 12292.631221063382, 12467.875321247035, 12484.438200280827, 12694.682632934251, 10074.14369778577, 11261.605843795427, 11735.471903764523, 11978.281303121841, 12146.453409596412, 10093.14208292274, 10283.742906427398, 10322.225833062701, 10338.328008679411, 10347.172226222036, 8529.786755331166, 9954.751131221488, 10397.532111055172, 10551.050405463546, 10765.354078754986], "unit": "ms", "name": "yui.html", "value": 6588.5155593345835}], "name": "dromaeo_css", "value": 7343.494522249389}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 108.0, 109.0, 109.0, 99.0, 108.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [149.0, 135.0, 157.0, 163.0, 130.0, 141.0, 156.0, 125.0, 170.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 159.0, 161.0, 160.0, 161.0, 161.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 139.0, 70.0, 70.0, 70.0, 80.0, 158.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 141.0, 92.0, 92.0, 93.0, 135.0, 92.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 62.0, 56.0, 56.0, 56.0, 55.0, 57.0, 56.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 78.0, 79.0, 78.0, 87.0, 78.0, 77.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 111.0, 111.0, 115.0, 109.0, 121.0, 112.0, 120.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [137.0, 152.0, 141.0, 139.0, 140.0, 140.0, 141.0, 140.0, 140.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 63.0, 74.0, 65.0, 63.0, 64.0, 64.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1478.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.41379310344828], "unit": "score", "name": "Richards", "value": 204.75160000000005}, {"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "DeltaBlue", "value": 396.37741000000017}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [956.0229445506692], "unit": "score", "name": "RayTrace", "value": 774.0284939999998}, {"lowerIsBetter": false, "replicates": [539.3743257820928], "unit": "score", "name": "Earley", "value": 1235.6224020000004}, {"lowerIsBetter": false, "replicates": [10468.75], "unit": "score", "name": "Boyer", "value": 63.66213731343284}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [517.3305742369374], "unit": "score", "name": "Splay", "value": 157.52210300000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23260.811939976007}]} 07:50:31 INFO - RETURN: dromaeo_css: 7343.49 07:50:31 INFO - RETURN: kraken: 1478.10 07:50:31 INFO - RETURN: v8_7: 23260.81 07:50:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23260.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1478.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7343.49"}}} 07:50:31 INFO - Return code: 0 07:50:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:50:31 INFO - # TBPL SUCCESS # 07:50:31 INFO - Running post-action listener: _resource_record_post_action 07:50:31 INFO - Running post-run listener: _resource_record_post_run 07:50:32 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 319488; Write bytes: 364662784; Read time: 84; Write time: 269136 07:50:32 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 101371904; Read time: 0; Write time: 97360 07:50:32 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 319488; Write bytes: 262397952; Read time: 84; Write time: 171744 07:50:32 INFO - Running post-run listener: _upload_blobber_files 07:50:32 INFO - Blob upload gear active. 07:50:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:50:32 INFO - Copying logs to upload dir... 07:50:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.541890 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-16 07:50:32.153040) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-16 07:50:32.156880) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009973 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455628191/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-16 07:50:32.209026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:50:32.209393) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1455636320.721918-1436576918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 07:50:32.259599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 07:50:32.259949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 07:50:32.260281) ========= ========= Total master_lag: 0.26 =========