builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1456316060.03 results: success (0) buildid: 20160224014446 builduid: 4cecd754e575418eb28a0dbeb3e50f47 revision: 697aa430d198 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.026618) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.026979) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.027270) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006591 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.049845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.050142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.064886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.065215) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.113639) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.113900) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.114250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.114517) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 04:14:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-02-24 04:14:20 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.224630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.224904) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:20.273661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 04:14:20.274012) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 697aa430d198 --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 697aa430d198 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 04:14:20,919 Setting DEBUG logging. 2016-02-24 04:14:20,919 attempt 1/10 2016-02-24 04:14:20,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/697aa430d198?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 04:14:22,231 unpacking tar archive at: mozilla-beta-697aa430d198/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 04:14:21.904285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:21.904631) ========= echo 697aa430d198 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'697aa430d198'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 697aa430d198 program finished with exit code 0 elapsedTime=0.004029 script_repo_revision: '697aa430d198' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:21.953781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:21.954096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 04:14:21.964114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-24 04:14:21.964414) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:22 INFO - MultiFileLogger online at 20160224 04:14:22 in /builds/slave/test-pgo 04:14:22 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 04:14:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:14:22 INFO - {'append_to_log': False, 04:14:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:14:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:14:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:14:22 INFO - 'branch': 'Mozilla-Beta', 04:14:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:22 INFO - 'config_files': ('talos/linux_config.py',), 04:14:22 INFO - 'default_actions': ('clobber', 04:14:22 INFO - 'read-buildbot-config', 04:14:22 INFO - 'download-and-extract', 04:14:22 INFO - 'populate-webroot', 04:14:22 INFO - 'create-virtualenv', 04:14:22 INFO - 'install', 04:14:22 INFO - 'run-tests'), 04:14:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:22 INFO - 'download_minidump_stackwalk': True, 04:14:22 INFO - 'download_symbols': 'ondemand', 04:14:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:22 INFO - 'installer_path': 'installer.exe', 04:14:22 INFO - 'log_level': 'info', 04:14:22 INFO - 'log_name': 'talos', 04:14:22 INFO - 'log_to_console': True, 04:14:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:22 INFO - 'opt_config_files': (), 04:14:22 INFO - 'pip_index': False, 04:14:22 INFO - 'sps_profile': False, 04:14:22 INFO - 'sps_profile_interval': 0, 04:14:22 INFO - 'suite': 'dromaeojs', 04:14:22 INFO - 'system_bits': '32', 04:14:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:22 INFO - 'title': 'talos-linux64-ix-041', 04:14:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:22 INFO - 'use_talos_json': True, 04:14:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:14:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:22 INFO - 'work_dir': 'build'} 04:14:22 INFO - ##### 04:14:22 INFO - ##### Running clobber step. 04:14:22 INFO - ##### 04:14:22 INFO - Running pre-action listener: _resource_record_pre_action 04:14:22 INFO - Running main action method: clobber 04:14:22 INFO - rmtree: /builds/slave/test-pgo/build 04:14:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:14:23 INFO - Running post-action listener: _resource_record_post_action 04:14:23 INFO - ##### 04:14:23 INFO - ##### Running read-buildbot-config step. 04:14:23 INFO - ##### 04:14:23 INFO - Running pre-action listener: _resource_record_pre_action 04:14:23 INFO - Running main action method: read_buildbot_config 04:14:23 INFO - Using buildbot properties: 04:14:23 INFO - { 04:14:23 INFO - "properties": { 04:14:23 INFO - "buildnumber": 94, 04:14:23 INFO - "product": "firefox", 04:14:23 INFO - "script_repo_revision": "production", 04:14:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:14:23 INFO - "repository": "", 04:14:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:14:23 INFO - "buildid": "20160224014446", 04:14:23 INFO - "slavename": "talos-linux64-ix-041", 04:14:23 INFO - "pgo_build": "True", 04:14:23 INFO - "basedir": "/builds/slave/test-pgo", 04:14:23 INFO - "project": "", 04:14:23 INFO - "platform": "ubuntu64_hw", 04:14:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:14:23 INFO - "slavebuilddir": "test", 04:14:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:14:23 INFO - "branch": "mozilla-beta", 04:14:23 INFO - "repo_path": "releases/mozilla-beta", 04:14:23 INFO - "stage_platform": "linux64-pgo", 04:14:23 INFO - "builduid": "4cecd754e575418eb28a0dbeb3e50f47", 04:14:23 INFO - "revision": "697aa430d198" 04:14:23 INFO - }, 04:14:23 INFO - "sourcestamp": { 04:14:23 INFO - "repository": "", 04:14:23 INFO - "hasPatch": false, 04:14:23 INFO - "project": "", 04:14:23 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:14:23 INFO - "changes": [ 04:14:23 INFO - { 04:14:23 INFO - "category": null, 04:14:23 INFO - "files": [ 04:14:23 INFO - { 04:14:23 INFO - "url": null, 04:14:23 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2" 04:14:23 INFO - } 04:14:23 INFO - ], 04:14:23 INFO - "repository": "", 04:14:23 INFO - "rev": "697aa430d198", 04:14:23 INFO - "who": "sendchange", 04:14:23 INFO - "when": 1456316017, 04:14:23 INFO - "number": 7645444, 04:14:23 INFO - "comments": "Bug 1250661 - disable windows 8/8.1 on-screen keyboard support, rs=jaws,me, a=sylvestre", 04:14:23 INFO - "project": "", 04:14:23 INFO - "at": "Wed 24 Feb 2016 04:13:37", 04:14:23 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:14:23 INFO - "revlink": "", 04:14:23 INFO - "properties": [ 04:14:23 INFO - [ 04:14:23 INFO - "buildid", 04:14:23 INFO - "20160224014446", 04:14:23 INFO - "Change" 04:14:23 INFO - ], 04:14:23 INFO - [ 04:14:23 INFO - "builduid", 04:14:23 INFO - "4cecd754e575418eb28a0dbeb3e50f47", 04:14:23 INFO - "Change" 04:14:23 INFO - ], 04:14:23 INFO - [ 04:14:23 INFO - "pgo_build", 04:14:23 INFO - "True", 04:14:23 INFO - "Change" 04:14:23 INFO - ] 04:14:23 INFO - ], 04:14:23 INFO - "revision": "697aa430d198" 04:14:23 INFO - } 04:14:23 INFO - ], 04:14:23 INFO - "revision": "697aa430d198" 04:14:23 INFO - } 04:14:23 INFO - } 04:14:23 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2. 04:14:23 INFO - Running post-action listener: _resource_record_post_action 04:14:23 INFO - ##### 04:14:23 INFO - ##### Running download-and-extract step. 04:14:23 INFO - ##### 04:14:23 INFO - Running pre-action listener: _resource_record_pre_action 04:14:23 INFO - Running main action method: download_and_extract 04:14:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:14:23 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')]} 04:14:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/test_packages.json 04:14:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:14:23 INFO - Downloaded 1270 bytes. 04:14:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:14:23 INFO - Using the following test package requirements: 04:14:23 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:14:23 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:23 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'jsshell-linux-x86_64.zip'], 04:14:23 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:23 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:14:23 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 04:14:23 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 04:14:23 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:23 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 04:14:23 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 04:14:23 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:23 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:23 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')]} 04:14:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:14:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:23 INFO - Downloaded 21583331 bytes. 04:14:23 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 04:14:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:14:23 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 04:14:24 INFO - Return code: 0 04:14:24 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 04:14:24 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')]} 04:14:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:14:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:25 INFO - Downloaded 21583331 bytes. 04:14:25 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 04:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 04:14:25 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 04:14:27 INFO - Return code: 0 04:14:27 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')]} 04:14:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:14:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:27 INFO - Downloaded 11132038 bytes. 04:14:27 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 04:14:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 04:14:27 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 04:14:27 INFO - Return code: 0 04:14:27 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')]} 04:14:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:14:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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 04:14:28 INFO - Downloaded 57941493 bytes. 04:14:28 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:14:28 INFO - mkdir: /builds/slave/test-pgo/properties 04:14:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:14:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:14:28 INFO - Contents: 04:14:28 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2 04:14:28 INFO - Running post-action listener: _resource_record_post_action 04:14:28 INFO - Running post-action listener: set_extra_try_arguments 04:14:28 INFO - ##### 04:14:28 INFO - ##### Running populate-webroot step. 04:14:28 INFO - ##### 04:14:28 INFO - Running pre-action listener: _resource_record_pre_action 04:14:28 INFO - Running main action method: populate_webroot 04:14:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:28 INFO - '--tppagecycles', 04:14:28 INFO - '7'], 04:14:28 INFO - 'tests': ['tsvgm']}}, 04:14:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:14:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:14:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:14:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'tests': ['damp', 'tps']}, 04:14:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['damp', 'tps']}, 04:14:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:14:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:28 INFO - 'other': {'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'other_l64': {'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'other_nol64': {'tests': ['a11yr', 04:14:28 INFO - 'ts_paint', 04:14:28 INFO - 'tpaint', 04:14:28 INFO - 'sessionrestore', 04:14:28 INFO - 'sessionrestore_no_auto_restore']}, 04:14:28 INFO - 'svgr': {'tests': ['tsvgx', 04:14:28 INFO - 'tsvgr_opacity', 04:14:28 INFO - 'tart', 04:14:28 INFO - 'tscrollx', 04:14:28 INFO - 'cart']}, 04:14:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['tsvgx', 04:14:28 INFO - 'tsvgr_opacity', 04:14:28 INFO - 'tart', 04:14:28 INFO - 'tscrollx', 04:14:28 INFO - 'cart']}, 04:14:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'tests': ['tp5o']}, 04:14:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'talos_options': ['--e10s'], 04:14:28 INFO - 'tests': ['tp5o']}, 04:14:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'talos_options': ['--xperf_path', 04:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:28 INFO - 'tests': ['tp5n']}, 04:14:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:28 INFO - 'talos_options': ['--e10s', 04:14:28 INFO - '--xperf_path', 04:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:28 INFO - 'tests': ['tp5n']}}, 04:14:28 INFO - 'talos.zip': {'path': '', 04:14:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:28 INFO - Running post-action listener: _resource_record_post_action 04:14:28 INFO - ##### 04:14:28 INFO - ##### Running create-virtualenv step. 04:14:28 INFO - ##### 04:14:28 INFO - Running pre-action listener: _resource_record_pre_action 04:14:28 INFO - Running main action method: create_virtualenv 04:14:28 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:14:28 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 04:14:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:14:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:28 INFO - Using real prefix '/usr' 04:14:28 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:14:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:31 INFO - Installing pip.................done. 04:14:31 INFO - Return code: 0 04:14:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:14: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')]} 04:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:31 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:31 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 04:14:31 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 04:14:31 INFO - Using env: {'DISPLAY': ':0', 04:14:31 INFO - 'HOME': '/home/cltbld', 04:14:31 INFO - 'LANG': 'en_US.UTF-8', 04:14:31 INFO - 'LANGUAGE': 'en_US:en', 04:14:31 INFO - 'LOGNAME': 'cltbld', 04:14:31 INFO - 'MAIL': '/var/mail/cltbld', 04:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:31 INFO - 'MOZ_NO_REMOTE': '1', 04:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:31 INFO - 'NO_EM_RESTART': '1', 04:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:31 INFO - 'SHELL': '/bin/bash', 04:14:31 INFO - 'SHLVL': '1', 04:14:31 INFO - 'TERM': 'linux', 04:14:31 INFO - 'TMOUT': '86400', 04:14:31 INFO - 'USER': 'cltbld', 04:14:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:31 INFO - '_': '/tools/buildbot/bin/python'} 04:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:31 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 04:14:31 INFO - Cleaning up... 04:14:31 INFO - Return code: 0 04:14:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:14: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')]} 04:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:31 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:31 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 04:14:31 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 04:14:31 INFO - Using env: {'DISPLAY': ':0', 04:14:31 INFO - 'HOME': '/home/cltbld', 04:14:31 INFO - 'LANG': 'en_US.UTF-8', 04:14:31 INFO - 'LANGUAGE': 'en_US:en', 04:14:31 INFO - 'LOGNAME': 'cltbld', 04:14:31 INFO - 'MAIL': '/var/mail/cltbld', 04:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:31 INFO - 'MOZ_NO_REMOTE': '1', 04:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:31 INFO - 'NO_EM_RESTART': '1', 04:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:31 INFO - 'SHELL': '/bin/bash', 04:14:31 INFO - 'SHLVL': '1', 04:14:31 INFO - 'TERM': 'linux', 04:14:31 INFO - 'TMOUT': '86400', 04:14:31 INFO - 'USER': 'cltbld', 04:14:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:31 INFO - '_': '/tools/buildbot/bin/python'} 04:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:31 INFO - Downloading/unpacking psutil>=0.7.1 04:14:31 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 04:14:31 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 04:14:31 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 04:14:31 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 04:14:31 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 04:14:31 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 04:14:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:33 INFO - Installing collected packages: psutil 04:14:33 INFO - Running setup.py install for psutil 04:14:33 INFO - building 'psutil._psutil_linux' extension 04:14:33 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 04:14:34 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 04:14:34 INFO - building 'psutil._psutil_posix' extension 04:14:34 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 04:14:34 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 04:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:34 INFO - Successfully installed psutil 04:14:34 INFO - Cleaning up... 04:14:34 INFO - Return code: 0 04:14:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:14: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')]} 04:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:34 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:34 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 04:14:34 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 04:14:34 INFO - Using env: {'DISPLAY': ':0', 04:14:34 INFO - 'HOME': '/home/cltbld', 04:14:34 INFO - 'LANG': 'en_US.UTF-8', 04:14:34 INFO - 'LANGUAGE': 'en_US:en', 04:14:34 INFO - 'LOGNAME': 'cltbld', 04:14:34 INFO - 'MAIL': '/var/mail/cltbld', 04:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:34 INFO - 'MOZ_NO_REMOTE': '1', 04:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:34 INFO - 'NO_EM_RESTART': '1', 04:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:34 INFO - 'SHELL': '/bin/bash', 04:14:34 INFO - 'SHLVL': '1', 04:14:34 INFO - 'TERM': 'linux', 04:14:34 INFO - 'TMOUT': '86400', 04:14:34 INFO - 'USER': 'cltbld', 04:14:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:34 INFO - '_': '/tools/buildbot/bin/python'} 04:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 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 04:14:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:36 INFO - Installing collected packages: mozsystemmonitor 04:14:36 INFO - Running setup.py install for mozsystemmonitor 04:14:36 INFO - Successfully installed mozsystemmonitor 04:14:36 INFO - Cleaning up... 04:14:36 INFO - Return code: 0 04:14:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:36 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 04:14:36 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 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:36 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 04:14:36 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 04:14:36 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 04:14:36 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 04:14:36 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 04:14:36 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 04:14:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:38 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 04:14:38 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 04:14:38 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 04:14:38 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 04:14:38 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 04:14:38 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 04:14:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:14:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:39 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 04:14:39 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 04:14:39 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 04:14:39 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 04:14:39 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 04:14:39 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 04:14:39 INFO - Downloading docopt-0.6.1.tar.gz 04:14:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:39 INFO - Running setup.py install for blobuploader 04:14:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:14:39 INFO - Running setup.py install for requests 04:14:39 INFO - Running setup.py install for docopt 04:14:39 INFO - Successfully installed blobuploader requests docopt 04:14:39 INFO - Cleaning up... 04:14:39 INFO - Return code: 0 04:14:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:39 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:39 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 04:14:39 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 04:14:39 INFO - Using env: {'DISPLAY': ':0', 04:14:40 INFO - 'HOME': '/home/cltbld', 04:14:40 INFO - 'LANG': 'en_US.UTF-8', 04:14:40 INFO - 'LANGUAGE': 'en_US:en', 04:14:40 INFO - 'LOGNAME': 'cltbld', 04:14:40 INFO - 'MAIL': '/var/mail/cltbld', 04:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:40 INFO - 'MOZ_NO_REMOTE': '1', 04:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:40 INFO - 'NO_EM_RESTART': '1', 04:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:40 INFO - 'SHELL': '/bin/bash', 04:14:40 INFO - 'SHLVL': '1', 04:14:40 INFO - 'TERM': 'linux', 04:14:40 INFO - 'TMOUT': '86400', 04:14:40 INFO - 'USER': 'cltbld', 04:14:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:40 INFO - '_': '/tools/buildbot/bin/python'} 04:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:14:40 INFO - Running setup.py (path:/tmp/pip-WV12On-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:14:40 INFO - Running setup.py (path:/tmp/pip-TDVSqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:14:40 INFO - Running setup.py (path:/tmp/pip-PzW2j7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:14:40 INFO - Running setup.py (path:/tmp/pip-6TnlCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:14:40 INFO - Running setup.py (path:/tmp/pip-dINfUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:14:40 INFO - Running setup.py (path:/tmp/pip-zxPobe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:14:40 INFO - Running setup.py (path:/tmp/pip-7pc2gZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:14:40 INFO - Running setup.py (path:/tmp/pip-vxhBtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:14:40 INFO - Running setup.py (path:/tmp/pip-IaPaO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:14:40 INFO - Running setup.py (path:/tmp/pip-vhmLtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:14:40 INFO - Running setup.py (path:/tmp/pip-9mtblA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:14:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:14:40 INFO - Running setup.py (path:/tmp/pip-e5cPfk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:14:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:14:41 INFO - Running setup.py (path:/tmp/pip-HFTySD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:14:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:14:41 INFO - Running setup.py (path:/tmp/pip-fr4fux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:14:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:14:41 INFO - Running setup.py (path:/tmp/pip-0M_OcW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:14:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:14:41 INFO - Running setup.py (path:/tmp/pip-maCeYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:14:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:14:41 INFO - Running setup.py (path:/tmp/pip-uVBRqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:14:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:41 INFO - Running setup.py install for manifestparser 04:14:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:14:41 INFO - Running setup.py install for mozcrash 04:14:41 INFO - Running setup.py install for mozdebug 04:14:41 INFO - Running setup.py install for mozdevice 04:14:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:14:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:14:41 INFO - Running setup.py install for mozfile 04:14:41 INFO - Running setup.py install for mozhttpd 04:14:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozinfo 04:14:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozInstall 04:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozleak 04:14:42 INFO - Running setup.py install for mozlog 04:14:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for moznetwork 04:14:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozprocess 04:14:42 INFO - Running setup.py install for mozprofile 04:14:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozrunner 04:14:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:14:42 INFO - Running setup.py install for mozscreenshot 04:14:42 INFO - Running setup.py install for moztest 04:14:43 INFO - Running setup.py install for mozversion 04:14:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:43 INFO - Cleaning up... 04:14:43 INFO - Return code: 0 04:14:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:14: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')]} 04:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:43 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:43 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 04:14:43 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 04:14:43 INFO - Using env: {'DISPLAY': ':0', 04:14:43 INFO - 'HOME': '/home/cltbld', 04:14:43 INFO - 'LANG': 'en_US.UTF-8', 04:14:43 INFO - 'LANGUAGE': 'en_US:en', 04:14:43 INFO - 'LOGNAME': 'cltbld', 04:14:43 INFO - 'MAIL': '/var/mail/cltbld', 04:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:43 INFO - 'MOZ_NO_REMOTE': '1', 04:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:43 INFO - 'NO_EM_RESTART': '1', 04:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:43 INFO - 'SHELL': '/bin/bash', 04:14:43 INFO - 'SHLVL': '1', 04:14:43 INFO - 'TERM': 'linux', 04:14:43 INFO - 'TMOUT': '86400', 04:14:43 INFO - 'USER': 'cltbld', 04:14:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:43 INFO - '_': '/tools/buildbot/bin/python'} 04:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:14:43 INFO - Running setup.py (path:/tmp/pip-fVLgHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:14:43 INFO - Running setup.py (path:/tmp/pip-zxDnxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:14:43 INFO - Running setup.py (path:/tmp/pip-eVTUqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:14:43 INFO - Running setup.py (path:/tmp/pip-bDUzTc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:14:43 INFO - Running setup.py (path:/tmp/pip-yowNMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:14:43 INFO - Running setup.py (path:/tmp/pip-M0pEig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:14:43 INFO - Running setup.py (path:/tmp/pip-Y402yP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:14:43 INFO - Running setup.py (path:/tmp/pip-7DJSk1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:14:43 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)) 04:14:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:14:43 INFO - Running setup.py (path:/tmp/pip-mbsWsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:14:44 INFO - Running setup.py (path:/tmp/pip-GTBoSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:14:44 INFO - Running setup.py (path:/tmp/pip-Z485EI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:14:44 INFO - Running setup.py (path:/tmp/pip-0dRCzW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:14:44 INFO - Running setup.py (path:/tmp/pip-ze90rG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:14:44 INFO - Running setup.py (path:/tmp/pip-Wb5JoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:14:44 INFO - Running setup.py (path:/tmp/pip-18qOMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:14:44 INFO - Running setup.py (path:/tmp/pip-3QgnF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:14:44 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)) 04:14:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:14:44 INFO - Running setup.py (path:/tmp/pip-zvNPnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:14:44 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)) 04:14:44 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)) 04:14:44 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)) 04:14:44 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)) 04:14:44 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)) 04:14:44 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)) 04:14:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:44 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 04:14:44 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 04:14:44 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 04:14:44 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 04:14:44 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 04:14:44 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 04:14:46 INFO - Downloading blessings-1.6.tar.gz 04:14:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:46 INFO - Installing collected packages: blessings 04:14:46 INFO - Running setup.py install for blessings 04:14:46 INFO - Successfully installed blessings 04:14:46 INFO - Cleaning up... 04:14:46 INFO - Return code: 0 04:14:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:14:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:14:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:14:46 INFO - Reading from file tmpfile_stdout 04:14:46 INFO - Current package versions: 04:14:46 INFO - argparse == 1.2.1 04:14:46 INFO - blessings == 1.6 04:14:46 INFO - blobuploader == 1.2.4 04:14:46 INFO - docopt == 0.6.1 04:14:46 INFO - manifestparser == 1.1 04:14:46 INFO - mozInstall == 1.12 04:14:46 INFO - mozcrash == 0.16 04:14:46 INFO - mozdebug == 0.1 04:14:46 INFO - mozdevice == 0.47 04:14:46 INFO - mozfile == 1.2 04:14:46 INFO - mozhttpd == 0.7 04:14:46 INFO - mozinfo == 0.9 04:14:46 INFO - mozleak == 0.1 04:14:46 INFO - mozlog == 3.1 04:14:46 INFO - moznetwork == 0.27 04:14:46 INFO - mozprocess == 0.22 04:14:46 INFO - mozprofile == 0.27 04:14:46 INFO - mozrunner == 6.11 04:14:46 INFO - mozscreenshot == 0.1 04:14:46 INFO - mozsystemmonitor == 0.0 04:14:46 INFO - moztest == 0.7 04:14:46 INFO - mozversion == 1.4 04:14:46 INFO - psutil == 3.1.1 04:14:46 INFO - requests == 1.2.3 04:14:46 INFO - wsgiref == 0.1.2 04:14:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:14: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')]} 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:46 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 04:14:46 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 04:14:46 INFO - Using env: {'DISPLAY': ':0', 04:14:46 INFO - 'HOME': '/home/cltbld', 04:14:46 INFO - 'LANG': 'en_US.UTF-8', 04:14:46 INFO - 'LANGUAGE': 'en_US:en', 04:14:46 INFO - 'LOGNAME': 'cltbld', 04:14:46 INFO - 'MAIL': '/var/mail/cltbld', 04:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:46 INFO - 'MOZ_NO_REMOTE': '1', 04:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:46 INFO - 'NO_EM_RESTART': '1', 04:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:46 INFO - 'SHELL': '/bin/bash', 04:14:46 INFO - 'SHLVL': '1', 04:14:46 INFO - 'TERM': 'linux', 04:14:46 INFO - 'TMOUT': '86400', 04:14:46 INFO - 'USER': 'cltbld', 04:14:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:46 INFO - '_': '/tools/buildbot/bin/python'} 04:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 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)) 04:14:47 INFO - Cleaning up... 04:14:47 INFO - Return code: 0 04:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:47 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:47 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 04:14:47 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 04:14:47 INFO - Using env: {'DISPLAY': ':0', 04:14:47 INFO - 'HOME': '/home/cltbld', 04:14:47 INFO - 'LANG': 'en_US.UTF-8', 04:14:47 INFO - 'LANGUAGE': 'en_US:en', 04:14:47 INFO - 'LOGNAME': 'cltbld', 04:14:47 INFO - 'MAIL': '/var/mail/cltbld', 04:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:47 INFO - 'MOZ_NO_REMOTE': '1', 04:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:47 INFO - 'NO_EM_RESTART': '1', 04:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:47 INFO - 'SHELL': '/bin/bash', 04:14:47 INFO - 'SHLVL': '1', 04:14:47 INFO - 'TERM': 'linux', 04:14:47 INFO - 'TMOUT': '86400', 04:14:47 INFO - 'USER': 'cltbld', 04:14:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:47 INFO - '_': '/tools/buildbot/bin/python'} 04:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:47 INFO - Downloading/unpacking jsonschema 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:49 INFO - warning: no files found matching '*.txt' 04:14:49 INFO - no previously-included directories found matching 'build' 04:14:49 INFO - no previously-included directories found matching 'dist' 04:14:49 INFO - no previously-included directories found matching '.git*' 04:14:49 INFO - Installing collected packages: jsonschema, functools32 04:14:49 INFO - Running setup.py install for functools32 04:14:49 INFO - warning: no files found matching '*.txt' 04:14:49 INFO - no previously-included directories found matching 'build' 04:14:49 INFO - no previously-included directories found matching 'dist' 04:14:49 INFO - no previously-included directories found matching '.git*' 04:14:49 INFO - Successfully installed jsonschema functools32 04:14:49 INFO - Cleaning up... 04:14:49 INFO - Return code: 0 04:14:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:49 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 0x7fbb98203f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1098600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', '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 04:14:49 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 04:14:49 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 04:14:49 INFO - Using env: {'DISPLAY': ':0', 04:14:49 INFO - 'HOME': '/home/cltbld', 04:14:49 INFO - 'LANG': 'en_US.UTF-8', 04:14:49 INFO - 'LANGUAGE': 'en_US:en', 04:14:49 INFO - 'LOGNAME': 'cltbld', 04:14:49 INFO - 'MAIL': '/var/mail/cltbld', 04:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:49 INFO - 'MOZ_NO_REMOTE': '1', 04:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:49 INFO - 'NO_EM_RESTART': '1', 04:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:14:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:14:49 INFO - 'SHELL': '/bin/bash', 04:14:49 INFO - 'SHLVL': '1', 04:14:49 INFO - 'TERM': 'linux', 04:14:49 INFO - 'TMOUT': '86400', 04:14:49 INFO - 'USER': 'cltbld', 04:14:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:49 INFO - '_': '/tools/buildbot/bin/python'} 04:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:49 INFO - Downloading/unpacking flake8 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:52 INFO - no previously-included directories found matching 'docs/_build' 04:14:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:52 INFO - Running setup.py install for pep8 04:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:52 INFO - no previously-included directories found matching 'docs/_build' 04:14:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:14:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:52 INFO - Cleaning up... 04:14:52 INFO - Return code: 0 04:14:52 INFO - Running post-action listener: _resource_record_post_action 04:14:52 INFO - Running post-action listener: _start_resource_monitoring 04:14:52 INFO - Starting resource monitoring. 04:14:52 INFO - ##### 04:14:52 INFO - ##### Running install step. 04:14:52 INFO - ##### 04:14:52 INFO - Running pre-action listener: _resource_record_pre_action 04:14:52 INFO - Running main action method: install 04:14:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:14:52 INFO - Reading from file tmpfile_stdout 04:14:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:14:52 INFO - Reading from file tmpfile_stdout 04:14:52 INFO - Output received: 04:14:52 INFO - Usage: mozinstall [options] installer 04:14:52 INFO - Options: 04:14:52 INFO - -h, --help show this help message and exit 04:14:52 INFO - -d DEST, --destination=DEST 04:14:52 INFO - Directory to install application into. [default: 04:14:52 INFO - "/builds/slave/test-pgo"] 04:14:52 INFO - --app=APP Application being installed. [default: firefox] 04:14:52 INFO - mkdir: /builds/slave/test-pgo/build/application 04:14:52 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'] 04:14:52 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 04:15:08 INFO - Reading from file tmpfile_stdout 04:15:08 INFO - Output received: 04:15:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:15:08 INFO - Running post-action listener: _resource_record_post_action 04:15:08 INFO - ##### 04:15:08 INFO - ##### Running run-tests step. 04:15:08 INFO - ##### 04:15:08 INFO - Running pre-action listener: _resource_record_pre_action 04:15:08 INFO - Running main action method: run_tests 04:15:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:15:08 INFO - Python 2.7.3 04:15:08 INFO - Return code: 0 04:15:08 INFO - grabbing minidump binary from tooltool 04:15:08 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')]} 04:15:08 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 0x1127350>, '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 0x1128250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11286e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:15:08 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 04:15:08 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 04:15:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:08 INFO - Return code: 0 04:15:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:15:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:15:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:15:09 INFO - Return code: 0 04:15:09 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/1456307086/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:15:09 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/1456307086/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 04:15:09 INFO - Using env: {'DISPLAY': ':0', 04:15:09 INFO - 'HOME': '/home/cltbld', 04:15:09 INFO - 'LANG': 'en_US.UTF-8', 04:15:09 INFO - 'LANGUAGE': 'en_US:en', 04:15:09 INFO - 'LOGNAME': 'cltbld', 04:15:09 INFO - 'MAIL': '/var/mail/cltbld', 04:15:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:15:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:09 INFO - 'MOZ_NO_REMOTE': '1', 04:15:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:09 INFO - 'NO_EM_RESTART': '1', 04:15:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:15:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:15:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:15:09 INFO - 'SHELL': '/bin/bash', 04:15:09 INFO - 'SHLVL': '1', 04:15:09 INFO - 'TERM': 'linux', 04:15:09 INFO - 'TMOUT': '86400', 04:15:09 INFO - 'USER': 'cltbld', 04:15:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580', 04:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:09 INFO - '_': '/tools/buildbot/bin/python'} 04:15:09 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/1456307086/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 04:15:09 INFO - mozversion INFO | application_buildid: 20160224014446 04:15:09 INFO - mozversion INFO | application_changeset: 697aa430d1985addc1bbd640a0a9b246a3f6889b 04:15:09 INFO - mozversion INFO | application_display_name: Nightly 04:15:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:09 INFO - mozversion INFO | application_name: Firefox 04:15:09 INFO - mozversion INFO | application_remotingname: firefox 04:15:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:15:09 INFO - mozversion INFO | application_vendor: Mozilla 04:15:09 INFO - mozversion INFO | application_version: 45.0 04:15:09 INFO - mozversion INFO | platform_buildid: 20160224014446 04:15:09 INFO - mozversion INFO | platform_changeset: 697aa430d1985addc1bbd640a0a9b246a3f6889b 04:15:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:15:09 INFO - mozversion INFO | platform_version: 45.0 04:15:09 INFO - 2016-02-24 04:15:09,585 DEBUG : using testdate: 1456316109 04:15:09 INFO - 2016-02-24 04:15:09,585 DEBUG : actual date: 1456316109 04:15:09 INFO - 2016-02-24 04:15:09,592 INFO : starting webserver on 'localhost:48931' 04:15:09 INFO - 2016-02-24 04:15:09,594 INFO : Starting test suite talos-linux64-ix-041 04:15:09 INFO - 2016-02-24 04:15:09,594 INFO : Starting test dromaeo_css 04:15:09 INFO - 2016-02-24 04:15:09,594 DEBUG : operating with platform_type : linux_ 04:15:09 INFO - 2016-02-24 04:15:09,594 INFO : Initialising browser for dromaeo_css test... 04:15:09 INFO - 2016-02-24 04:15:09,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqTpOpB/profile http://localhost:48931/getInfo.html 04:15:13 INFO - 2016-02-24 04:15:13,548 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:15:13 INFO - 2016-02-24 04:15:13,548 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:15:13 INFO - 2016-02-24 04:15:13,549 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:15:13 INFO - 2016-02-24 04:15:13,549 DEBUG : BROWSER_OUTPUT: __metrics 04:15:13 INFO - 2016-02-24 04:15:13,786 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] 04:15:15 INFO - 2016-02-24 04:15:15,025 INFO : Browser initialized. 04:15:15 INFO - 2016-02-24 04:15:15,026 INFO : Running cycle 1/1 for dromaeo_css test... 04:15:15 INFO - 2016-02-24 04:15:15,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqTpOpB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:15:26 INFO - 2016-02-24 04:15:26,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 132673536 04:15:26 INFO - 2016-02-24 04:15:26,646 DEBUG : BROWSER_OUTPUT: 04:16:17 INFO - 2016-02-24 04:16:17,329 DEBUG : BROWSER_OUTPUT: 1456316177329 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] 04:18:25 INFO - 2016-02-24 04:18:25,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48931/tests/dromaeo/cssquery-ext.html) 04:18:26 INFO - 2016-02-24 04:18:26,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 236244992 04:18:26 INFO - 2016-02-24 04:18:26,750 DEBUG : BROWSER_OUTPUT: 04:21:28 INFO - 2016-02-24 04:21:28,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-ext.html (next: http://localhost:48931/tests/dromaeo/cssquery-jquery.html) 04:21:29 INFO - 2016-02-24 04:21:29,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 216023040 04:21:29 INFO - 2016-02-24 04:21:29,375 DEBUG : BROWSER_OUTPUT: 04:24:31 INFO - 2016-02-24 04:24:31,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48931/tests/dromaeo/cssquery-mootools.html) 04:24:31 INFO - 2016-02-24 04:24:31,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 208781312 04:24:31 INFO - 2016-02-24 04:24:31,733 DEBUG : BROWSER_OUTPUT: 04:27:33 INFO - 2016-02-24 04:27:33,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48931/tests/dromaeo/cssquery-prototype.html) 04:27:33 INFO - 2016-02-24 04:27:33,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 196243456 04:27:33 INFO - 2016-02-24 04:27:33,977 DEBUG : BROWSER_OUTPUT: 04:30:36 INFO - 2016-02-24 04:30:36,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48931/tests/dromaeo/cssquery-yui.html) 04:30:36 INFO - 2016-02-24 04:30:36,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 196812800 04:30:36 INFO - 2016-02-24 04:30:36,931 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/dromaeo/cssquery-yui.html (next: http://localhost:48931/tests/dromaeo/cssquery-dojo.html) 04:33:39 INFO - 2016-02-24 04:33:39,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 210210816 04:33:39 INFO - 2016-02-24 04:33:39,335 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,336 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:39 INFO - 2016-02-24 04:33:39,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:39 INFO - 2016-02-24 04:33:39,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:39 INFO - 2016-02-24 04:33:39,337 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:39 INFO - 2016-02-24 04:33:39,338 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3265.5101734739787;3333.3499967506345;3365.5961284645846;3371.0561042907993;3374.1733275347538;5373.435789242127;5423.213634023069;5425.565954723623;5457.154141108124;5467.753951072196;5454.91817622736;5487.122060470326;5495.2856128703315;5495.395506494292;5500.669959802414;4928.433230178522;4991.700497970124;5054.671446355975;5078;5108.616853735966;4961.156603377416;5019.121653710586;5019.924701129486;5044.419891712445;5078.873028174288;5023.773930173133;5099.617528685345;5110.412302585194;5123.795048198068;5129.12804823181;5125.769340379655;5133.307003554528;5185.429602743714;5188.403333616645;5197.272381866542;4812.085703716282;4906.779194936201;4944.975275123601;5041.747912604392;5085.745712714386;5298.284731561228;5310;5315.176147697113;5318.707471089088;5322;5870.11948207768;5872.7357268923;5873.500752436005;5874.030784920483;5876.030454974924;5708.571857110692;5810.273715785527;5818.8254352369495;5836.708164591753;5887.381824908409;5602;5604;5607.943920560824;5613.158026296048;5616.550675945915;6046.969765151146;6047.969760151259;6048.213732214872;6048.455638992512;6061.212042434543;5667.093265077568;5737.913931291034;5800.854978625568;5863.296404431496;5895.970520147372;5871.089981052944;5924.763009479659;5929.169916211734;5938.792142275;5942.257217847769;5708.343540492813;5892.970535147382;5893.911591326134;5895.233619629421;5897.7935772247765;5759.769609215668;5854.912176317359;5942.1383899335215;5952.434518720715;5991.55063370249;4475.888102797456;4499.797509112098;4509.7970591323465;4521.253993091169;4536.61438777701;3980.5024371953505;4060.878173654795;4061.4923134608175;4085.1216988347646;4092.570280120604;5570.693611851306;5590.608657394025;5616.354119276336;5619.634723742944;5647.37878833328;5961.165436838846;6012.699365031731;6016.127661489059;6016.699165041818;6019.157317975487;5387.057264978613;5514.476124768141;5620.5503559715125;5701.0308247598;5701.828945131652;5136.743162841843;5137.049645815536;5138.07514647367;5139.177731562932;5157.58739300855;6111.480524155408;6116.418940200763;6122.969385153046;6127.387261273837;6152.507799376039;5755.65466072037;5800.506956908541;5831;5920.940790592125;5946.643201407929;6127;6130.325664177026;6134.539909506716;6149.72326245329;6153.323134455296;5776.7400466979925;5836.066229403445;5838.737256823538;5849.239598852122;5849.473547380756;5703.7433315500075;5820.82537523875;5885.588008839341;5904.261967254093;5932.614380065282;5792.247007888947;5896.204012458264;5904.822855314347;5910.202122713378;5919.023361145363;5616.297962754656;5881.264841894763;5896.321922978741;5899.705014749159;5900.822975310747;5548.805791797429;5655.151727240782;5669.858253543694;5672.943270567406;5673.234113394804;5713.314402271588;5732.426757324234;5756.280464941882;5758.3090029196765;5767.480926716616;5490.5882058844945;5590.077637189818;5654.915176272277;5656.151577263443;5663.518600918968 04:33:39 INFO - 2016-02-24 04:33:39,342 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.2146958666627;625.2934184371659;625.4496043481736;638.3042483692775;646.266487536646;33045.66954330456;33283.334333313316;33603.83198084006;33638.66361336386;33675.83162084189;41150.58849411505;41323.79338103313;41372.79313603435;41404.17191656165;41470.170596588054;8960.238379737713;9125.589348479301;9126.452412855217;9128.497932613704;9144.954275228614;8315.293200078;8369.665213391487;8953.776155596097;9076.047015063423;10822.621208257713;10710.678679639585;10817.026467617912;10843.67468975932;10847.186461015415;10852.294600850959;10691.465426728671;10770.730731731692;10795.46022698862;10796.946015269874;10828.891711082906;10463.529141188665;10547.789044219073;10629.096526795232;10671.306365086244;10673.786524269548;41427.37858932118;41855;41855.581444185475;41891.7905410471;41938;3287.704106630391;3386.762926595139;3478.234788346585;3885.922281554353;4148.942019784936;32186.678133218604;32197.356052879044;32517.512237316223;32555.18612034718;32595;4411.161879242965;4433.911321773547;4443.311286750527;4488.573585509372;4527.750973696446;309846;310823;312620;312657.43671281723;314403;59277.40722592805;59915.700421498485;67058;67374.66312668503;67422;72208.27791722016;72574;72664.27335726681;72744;72890.27109728835;16169.110698911438;16212.75680864788;16303.59241018984;16324.510264692079;16358.345666173458;13136.27750473733;13182.670433239055;13197.076204665582;13238.73522529544;13265.336733163304;21363.25228617022;21547.784522154892;21574;21642;21691;8109.107998120202;8388.951381077366;8389.32885369169;8418.116097809641;8535.701250456204;1049.7270709615402;1054.1514081164737;1103.0458653265027;1155.2490880927296;1245.5391505143155;29697.703022969494;29950.850245748632;31135.377292454024;31205.843970780003;31266.21834454157;1102.459794700591;1116.240956149826;1169.8069818479855;1179.9823002654966;1234.7468768902534;14448.638784030272;14564.198969056804;14893.925530372495;15285.235738213045;16524;441236;453372;454839;455768;456676;58241.41758582445;58542.4145758537;58717;58741.41258587359;58919.70540147272;1333.8599447057918;1427.800107984883;1458.8832893368506;1505.127026324751;1586.9285882135332;29831.229740326482;30353.69646303509;30406.84796576003;31136.377272454876;31214.531782022834;46905.53094469148;47112.52887471081;47449.28826067681;47571.76214118907;47639.52360476351;273544;275882;275882;277073;278299;35276.11809704778;35292.47061294031;36261;36355.45466817947;36421.817890911436;45935.31097033614;46672.766636166605;47190.76404617955;47652.52347476481;47812.2828157571;39249.215015700094;40280.19439611133;45497.772511137235;46134.53865461436;48351.75824120857;44655.776721116184;44998.550014500746;46652.533474666176;46670.29994550152;47133.52866471291;39983.400248995706;40290;40422;40442.79778601088;40572;34088.48867266943;34967.475487868214;35006.64993350034;35383.646163539066;35604.82197588996;26889.596656050566;27772.30569235785;27782.305442364104;27798.305042374104;27801.860990694917 04:33:39 INFO - 2016-02-24 04:33:39,342 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.2039000633711;395.98812035638923;398.4043854437616;400.8617027125641;405.2705130764624;15621.375144994186;16107.758383624256;17901.7314740279;18264.269429222833;18299.45101646951;12408;12545.1218414711;12571.308578028205;14025.36885840137;17623.206955686994;5094.872628184297;5319.760610772524;5472.480114389146;5488.91766623499;5543.307086614173;4006.439098526194;4115.732477388975;5415.241866138744;5433.945660543403;5625.831225063234;5719.714014299289;5751.338596061465;5773.191753154561;5775.740091695884;5776.075827867542;5726.856828579277;5817.8836423271505;6195.783147589836;6206.565540412173;6212.87574248517;5573.08044172711;5581.246531718207;5586.13414920688;5589.469000444951;5595.636283641591;14679.119252844757;14748;18450.907745461187;21693.67459488109;22129.44676383087;2302.643090321003;2369.324742448411;2391.043582566987;2429.6841410616685;2456.6192240202795;10243.436610986393;10290.948545257226;10334.17326613869;10493.790124197474;10539.367637941748;1612.3550579768187;1886.9528261793428;1890.2155605423732;1914.15777058094;1927.9325223617245;66371;67687;68787.31212687859;69618.30381696169;70073;11099.167562432849;11328.71678208035;11363.204575679623;11369.374684392273;11446.427678616035;14493.420263189566;15319.617009574627;15320.463783767515;15330.386784528493;15335.539933802003;7952.84094318122;8031.357491400674;8101.351891848638;8180.304674102649;8254.587270636444;7555.244475552401;7591.316781489582;7598.962005189938;7623.923760762433;7646.923530764732;4855.757212139379;4901.632377571696;4932.926006109911;4961.454240033593;4995.675281106716;1736.106202197002;1910.990445047766;1934.7388102606249;1941.9029048547516;1993.6311782320026;1024.1704219582014;1038.4703801061512;1045.3100953370738;1066.3974854207504;1095.5599417828025;15223.467178648694;15679.764803527956;16138.838611613734;16583.419580314632;18046.097695115193;960.519740129935;1016.6390931219458;1052.8578641883248;1071.3625392891217;1103.757173421846;9859.30984831055;10111.130534675254;10154.441505717257;10314.226433017553;10641.361518308926;667026;672592;673555;687664;703976;82839.58580207061;87436;88975.55512222527;89034.55482722675;89541;1168.0713832503181;1182.3733421286731;1189.3577468167093;1191.1304747534348;1192.2667559450874;16092.597685057966;16212;16271;16499.09254990939;16633.002019878844;36749.26501469902;37621.81189094037;37839.810800945816;37893.43159852659;38307.425388618634;51003.23495147502;51858.481415185364;53396.46603533915;53543.4645653554;53914.46085539251;10298.845517317097;10378.584856605652;10520.684379468628;10521.894781052397;10527.94736026315;14879.628009299855;18395.63208735791;18401.90799045996;18570.53573660615;18922.14850331711;13772.793408098687;14321.64195895111;15472.381104755683;15588.376464941275;15862.365505379656;14434;14740.262986850828;14829.40682372693;14971.77542336844;15024;15349.309281082154;15452.381904723685;15721.449749258722;15722.292496837441;16008.439704610282;9819.558119884765;10425.478726063819;10541.262111652111;10667.306625069346;10677.14582833387;13658.590242292747;13912.165270083828;13961.720765584834;13987.720245594828;14733.55799326022 04:33:39 INFO - 2016-02-24 04:33:39,343 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1541.8843586730998;1736.3054778088763;1811.8369346758789;1825.7261410788385;1847.5104097414187;7110.964445177767;7237.4933754637195;7686.192949740281;8076.1923807619205;8079.434439589224;7599.354054905326;7713.652885620147;7773.844523109535;7798.181190974951;7798.5320880747195;2358.2571489980646;2378.5361854438393;2380.452495925938;2380.583397905368;2381.6070348392495;2042.6323261812868;2078.615456140619;2307;2348.9295321140394;2365.231299827563;2294.541091781642;2297.8965946532444;2305.7578954209816;2311.133325003124;2312.4681323295654;2340.3447034830187;2370.2415227127326;2370.3600027992434;2371.0752806405517;2372.074890792592;2283.897224624896;2316.9073237070497;2322.2220556113552;2322.7793359630978;2323.6863023491783;7633.236676332378;7681.308682218571;7685.193054729285;7694.730684426018;7694.769156925246;4765.2375619900995;4826.22780355145;4861.513848615145;4863.294822250754;4865.245886887503;3179.5071763876635;3227.644959054502;3282.3763484937786;3302.752293577991;3310.867565297385;1031.2162756305263;1035.7410647338165;1043.768353343055;1068.1027936533271;1075.0861767497643;10541.631042913537;10549.156067514581;10553.050225479743;10561.894381056169;10569.418681972566;4289.892752681208;4324.113556720865;4364.869053928387;4366.083122544238;4375.081232941055;9092.318076144316;9098.727038188865;9101.453912765255;9102.90897091034;9105.453672779655;4855.198892182751;4883.267509873547;4883.780229889663;4886.731229782325;4887.144749668793;4402.691811573159;4442.311441726538;4443.466783985942;4445;4445.110977804452;3575.1955809942556;3778.5843557208686;3822.4839646647347;3849.1339448624394;3868.2263547290654;1166.8833116688434;1183.7632473505334;1267.9112462127748;1280.11032332528;1298.2794549025382;1134.7390100276982;1163.313644949484;1165.6036947437913;1187.5368606243571;1210.2375503432781;7588.468807183554;7655.234476552411;7695.345895598937;7697.538147711043;7707.190744971809;1087.16792754874;1145.255583870491;1215.1918973882268;1221.6151912147823;1232.8089146182356;5870.559708021916;5906.49794767441;5908.113782932594;5915.526757859361;5929.970350148222;9186.586603602855;9498.572564234626;9577.138057574852;9631.855522167172;9634.229261659051;9512.09635084666;9538.427694338223;9540.141387275178;9543.47510886894;9569.28230382724;7344.118705755237;7652.464327497133;7677.731279405306;7680.923190768132;7749.380049596019;7414.110306763223;7476.140243872024;7496.25037496246;7504.474686771873;7514.699412023458;8624.525651089;8689.391742577958;8779.429337093068;8799.692010779592;8822.779430514289;8347.41568090252;9003.279737621106;9004.369694121611;9007.054259302678;9016.86474702893;6937.340952609494;7014.263502332182;7020.543664661985;7020.6489675514995;7021.43828493709;7282.308180722823;7291.562506249642;7333.596652184181;7354.154272258545;7539.698412063456;7018.473614478832;7078.681459334445;7082.752103676553;7110.146782386147;7121.109861267341;6878.759243426456;6957.199922008831;6967.09427774386;7050.224475307815;7068.363847253772;6842.076319696777;6896.862062758817;6904.4131248844415;6908.896366554405;6911.205211400753;6425.293217745951;6614.603123812587;6654.13496245485;6660.467162627075;6667.733290668319;6655.767048153291;6672.432843208382;6680.064790929371;6718.865622687616;6723.831904202434 04:33:39 INFO - 2016-02-24 04:33:39,344 DEBUG : BROWSER_OUTPUT: |4;prototype.html;376.9886903392898;377.92630437064764;378.52941322960294;378.78598591795634;384.8960780589243;6045.367750707306;6048.032314829628;6083.0875368694715;6127.724252408641;6131.693415329227;5811.912821307673;5910.34986151523;6015.879682406349;6063.514918806496;6104.603200791946;4753.548412900769;4763.166445871976;4773.90452190956;4786.521347865203;4796.928046079312;4508.6393088553;4777.355057067286;4783.258594917794;4788.257820037899;4789.832355867546;4541.886452838672;4622.052479241765;4686.250199968006;4687.507811679776;4711.340412342275;4664.953350466486;4692.272697731857;4700.4359476862655;4713.34013238147;4727.621790256771;4221.493420789525;4231.61915427613;4233.597808208216;4236.2586547354085;4238.025254191553;5654.773809047633;5766.682832444214;5767.538596912237;5778.133280007991;5784.566157538202;5453.672779633195;5454.4545545445535;5459.044667183227;5459.290292262021;5463.726813659341;6431.935680643181;6438.259600145996;6440.1305823713665;6442.516811239176;6444.420002199825;4565.315202719586;4576.359309696645;4578.267477203632;4579.427571553556;4596.49438561758;6478.190226221723;6603.108580341688;6672.499562532829;6679.398854103154;6681.465482761368;4669.486356500782;4705.882352941136;4712.269598212282;4715.504871988461;4721.15019296523;4772.331873537708;4774.9522504775205;4778.283257511401;4780.49804770501;4781.258904869751;5432.022235997559;5433.592480563973;5434.538064264581;5446.183072539072;5450.945490545123;6285.151504546919;6481.546291759531;6495.577787443801;6497.480201583862;6498.512611554058;1645.2020769926576;1647.3163637090472;1652.339064374236;1658.2703610411381;1661.2441339190639;1139.2480962564832;1143.108375467137;1153.7058050197313;1169.2808922512593;1174.6945794093426;6324.956382196886;6326.810195694136;6332.68336583169;6346.9682651586445;6358.554901156967;6445.16212892321;6687.699053542602;6698.5980841149685;6705.362990515893;6706.295838936939;6208.161898143693;6241.96879015602;6332.430081292706;6391.744330226832;6402.039694045838;3605.7295702822394;3631.3100510903373;3633.4549817527054;3637.1634524059614;3644.2164934538673;6864.176298844171;7005.439564834801;7016.087908571853;7026.964865175743;7027.789166325018;6826.897596536056;6827.590344579341;6837.760678376233;6843.3840954314355;6844.178698556106;6953.478489113337;6957.547759395623;6994.0907682002035;7025.964870175719;7042.718291268395;6594;6737.69680364375;6741.932580674326;6744.527883048336;6745.2242992056545;6611.140551728245;6613.371729685672;6617.272100069084;6620.073189753534;6624.90062649051;6997.1253593300835;7016.228214896255;7025.121859767529;7025.648717564203;7033.050538177281;4570.085982803386;4668.719876807402;4678.391809064799;4681.040386720782;4690.554397332248;6711.3288671132495;6722.899156512754;6723.361280678328;6726.260111387841;6735.9663201685635;6569.507286953402;6569.605823650596;6571.605703657605;6579.407853293226;6580.341965803573;6418;6553.082568440517;6560.671966401756;6567.211934567882;6569.080328754074;6417.2620148681635;6443.291237963726;6448.967755161382;6452.322506136976;6479.222493300834;6531.706073226811;6569.343065693392;6573.342665733579;6576.704048317742;6579.17760279965;6345.238571371465;6409.359064093554;6422.068800023877;6438.3883531064475;6439.259485159079 04:33:39 INFO - 2016-02-24 04:33:39,344 DEBUG : BROWSER_OUTPUT: |5;yui.html;836.3267569606467;880.4937161132347;896.9147930946561;924.4776701163846;937.9249660027197;13196.208227506344;13424.261665608388;13483.595492135251;13503.257320847362;13505.52730654426;12412.503499860017;12509.749805003894;12510;12511.186772859757;12530.2481851089;736.8857827036804;748.0723902361087;912.5118061836919;925.7824411263348;926.1849572376333;912.4023764434273;912.5802131019739;915.9313051521129;918.6600957645647;919.7332773495679;781.2656103262943;789.4671097009524;945.9763505912339;955.4076472586971;955.6320816485668;941.2187884056217;954.0507195340681;955.6273053509137;955.8996305387973;955.904409559042;704.4012589299106;704.933031362025;705.4779463197249;705.5872314695857;706.321930946287;12494.687632809162;12629.936850315782;12644.304563249018;12752.362381880868;12780.169288996185;12645.367731613474;12699.492020319176;12709.74580508394;12990.935045324808;13045.804312935314;10272.178225741924;10531.947340263327;10628.521716522775;10695.09091727204;11887.583934562248;3831.386978083521;3896.2846604296883;3916.608339166089;3927.8625248116177;3932.351162058257;48600;48638.27042594329;48676.75661621705;48685.513144868455;48691.51308486941;10442.582296708199;10537.157027437786;10572.259941804154;10625.681229563126;10673.359598423964;18141.45575632707;18153.7276940846;18589.25642974293;18597.7210341845;18771.34300299483;7751.573663448452;7773.92226077732;7789.182135875765;7923.801904952422;8073.273405393543;3775.7356985011334;3849.364854798927;4409.889752756143;4506.3465797459185;4612.262038073892;3237.708606225451;3260.4457242268873;3270.2478429961243;3270.5748252726994;3275.328557645677;622.5953130465143;627.1063734178776;632.3707910628862;634.4004915354946;640.5964242527178;586.7740919745928;598.1267349669445;603.8067818298102;604.6644112517507;610.5878531990888;8583.18459746323;8676.219140277279;8685.218330350299;8789.296856251485;8976.192142707188;500.4245118114125;526.2185654303356;583.3903570768557;607.9483243924227;635.8346829824186;3928.64642182205;3957.940630890539;3992.9001774955277;4027.1140349123148;4055.3916912463364;58952.70523647354;59209.40790592125;59531;61559.38440615626;61621;56102;56377.71811140918;56855;56934;57217.713911430175;49915.75042124766;51952.48047519552;52547.73726131345;55644.72177639167;55759.442405576236;8556.914430855611;8853;8930.285577153682;8943.329250306122;9069.501177435304;38337.4249386265;38617;38827.6117238824;39030.2193956125;39821.2035759289;44171.77914110409;47955;48364.758176208896;48534.75732621314;48819.75590122027;10431.269811113149;10558.366498010144;10913.563457461612;11028.062614677843;11059.059979901798;12256.632301030982;12358.62924112278;12379.442925068213;12753.872461275269;12963.092583519063;10936.50785714629;11105.888941110808;11223.88776112261;11284.153688473232;11298.661040168809;10975.670729878117;11091.833622495831;11207.271527350696;11229.623264574173;11416.086713063101;10188.592456301962;10671.306365086244;10723;11078.279911805706;11098.445077746243;9712.5143742814;9721.805563888824;9893.258005649748;10005.849912251177;10039.548220330249;9431.00558382162;9613.159364775536;9766.169875560372;9889.06053924876;10061.849072264069 04:33:39 INFO - 2016-02-24 04:33:39,344 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,781 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: __startTimestamp1456317219335__endTimestamp 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5487.63 Median:5669.86 stddev:601.94 (10.6%) stddev-sans-first:578.00 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: Values: 3265.5 3333.3 3365.6 3371.1 3374.2 5373.4 5423.2 5425.6 5457.2 5467.8 5454.9 5487.1 5495.3 5495.4 5500.7 4928.4 4991.7 5054.7 5078.0 5108.6 4961.2 5019.1 5019.9 5044.4 5078.9 5023.8 5099.6 5110.4 5123.8 5129.1 5125.8 5133.3 5185.4 5188.4 5197.3 4812.1 4906.8 4945.0 5041.7 5085.7 5298.3 5310.0 5315.2 5318.7 5322.0 5870.1 5872.7 5873.5 5874.0 5876.0 5708.6 5810.3 5818.8 5836.7 5887.4 5602.0 5604.0 5607.9 5613.2 5616.6 6047.0 6048.0 6048.2 6048.5 6061.2 5667.1 5737.9 5800.9 5863.3 5896.0 5871.1 5924.8 5929.2 5938.8 5942.3 5708.3 5893.0 5893.9 5895.2 5897.8 5759.8 5854.9 5942.1 5952.4 5991.6 4475.9 4499.8 4509.8 4521.3 4536.6 3980.5 4060.9 4061.5 4085.1 4092.6 5570.7 5590.6 5616.4 5619.6 5647.4 5961.2 6012.7 6016.1 6016.7 6019.2 5387.1 5514.5 5620.6 5701.0 5701.8 5136.7 5137.0 5138.1 5139.2 5157.6 6111.5 6116.4 6123.0 6127.4 6152.5 5755.7 5800.5 5831.0 5920.9 5946.6 6127.0 6130.3 6134.5 6149.7 6153.3 5776.7 5836.1 5838.7 5849.2 5849.5 5703.7 5820.8 5885.6 5904.3 5932.6 5792.2 5896.2 5904.8 5910.2 5919.0 5616.3 5881.3 5896.3 5899.7 5900.8 5548.8 5655.2 5669.9 5672.9 5673.2 5713.3 5732.4 5756.3 5758.3 5767.5 5490.6 5590.1 5654.9 5656.2 5663.5 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,345 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52969.04 Median:34987.06 stddev:93480.28 (267.2%) stddev-sans-first:93659.73 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: Values: 573.2 625.3 625.4 638.3 646.3 33045.7 33283.3 33603.8 33638.7 33675.8 41150.6 41323.8 41372.8 41404.2 41470.2 8960.2 9125.6 9126.5 9128.5 9145.0 8315.3 8369.7 8953.8 9076.0 10822.6 10710.7 10817.0 10843.7 10847.2 10852.3 10691.5 10770.7 10795.5 10796.9 10828.9 10463.5 10547.8 10629.1 10671.3 10673.8 41427.4 41855.0 41855.6 41891.8 41938.0 3287.7 3386.8 3478.2 3885.9 4148.9 32186.7 32197.4 32517.5 32555.2 32595.0 4411.2 4433.9 4443.3 4488.6 4527.8 309846.0 310823.0 312620.0 312657.4 314403.0 59277.4 59915.7 67058.0 67374.7 67422.0 72208.3 72574.0 72664.3 72744.0 72890.3 16169.1 16212.8 16303.6 16324.5 16358.3 13136.3 13182.7 13197.1 13238.7 13265.3 21363.3 21547.8 21574.0 21642.0 21691.0 8109.1 8389.0 8389.3 8418.1 8535.7 1049.7 1054.2 1103.0 1155.2 1245.5 29697.7 29950.9 31135.4 31205.8 31266.2 1102.5 1116.2 1169.8 1180.0 1234.7 14448.6 14564.2 14893.9 15285.2 16524.0 441236.0 453372.0 454839.0 455768.0 456676.0 58241.4 58542.4 58717.0 58741.4 58919.7 1333.9 1427.8 1458.9 1505.1 1586.9 29831.2 30353.7 30406.8 31136.4 31214.5 46905.5 47112.5 47449.3 47571.8 47639.5 273544.0 275882.0 275882.0 277073.0 278299.0 35276.1 35292.5 36261.0 36355.5 36421.8 45935.3 46672.8 47190.8 47652.5 47812.3 39249.2 40280.2 45497.8 46134.5 48351.8 44655.8 44998.6 46652.5 46670.3 47133.5 39983.4 40290.0 40422.0 40442.8 40572.0 34088.5 34967.5 35006.6 35383.6 35604.8 26889.6 27772.3 27782.3 27798.3 27801.9 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33693.80 Median:10228.74 stddev:111275.16 (1087.9%) stddev-sans-first:111559.21 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: Values: 391.2 396.0 398.4 400.9 405.3 15621.4 16107.8 17901.7 18264.3 18299.5 12408.0 12545.1 12571.3 14025.4 17623.2 5094.9 5319.8 5472.5 5488.9 5543.3 4006.4 4115.7 5415.2 5433.9 5625.8 5719.7 5751.3 5773.2 5775.7 5776.1 5726.9 5817.9 6195.8 6206.6 6212.9 5573.1 5581.2 5586.1 5589.5 5595.6 14679.1 14748.0 18450.9 21693.7 22129.4 2302.6 2369.3 2391.0 2429.7 2456.6 10243.4 10290.9 10334.2 10493.8 10539.4 1612.4 1887.0 1890.2 1914.2 1927.9 66371.0 67687.0 68787.3 69618.3 70073.0 11099.2 11328.7 11363.2 11369.4 11446.4 14493.4 15319.6 15320.5 15330.4 15335.5 7952.8 8031.4 8101.4 8180.3 8254.6 7555.2 7591.3 7599.0 7623.9 7646.9 4855.8 4901.6 4932.9 4961.5 4995.7 1736.1 1911.0 1934.7 1941.9 1993.6 1024.2 1038.5 1045.3 1066.4 1095.6 15223.5 15679.8 16138.8 16583.4 18046.1 960.5 1016.6 1052.9 1071.4 1103.8 9859.3 10111.1 10154.4 10314.2 10641.4 667026.0 672592.0 673555.0 687664.0 703976.0 82839.6 87436.0 88975.6 89034.6 89541.0 1168.1 1182.4 1189.4 1191.1 1192.3 16092.6 16212.0 16271.0 16499.1 16633.0 36749.3 37621.8 37839.8 37893.4 38307.4 51003.2 51858.5 53396.5 53543.5 53914.5 10298.8 10378.6 10520.7 10521.9 10527.9 14879.6 18395.6 18401.9 18570.5 18922.1 13772.8 14321.6 15472.4 15588.4 15862.4 14434.0 14740.3 14829.4 14971.8 15024.0 15349.3 15452.4 15721.4 15722.3 16008.4 9819.6 10425.5 10541.3 10667.3 10677.1 13658.6 13912.2 13961.7 13987.7 14733.6 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,347 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5560.69 Median:6519.95 stddev:2831.23 (43.4%) stddev-sans-first:2823.05 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: Values: 1541.9 1736.3 1811.8 1825.7 1847.5 7111.0 7237.5 7686.2 8076.2 8079.4 7599.4 7713.7 7773.8 7798.2 7798.5 2358.3 2378.5 2380.5 2380.6 2381.6 2042.6 2078.6 2307.0 2348.9 2365.2 2294.5 2297.9 2305.8 2311.1 2312.5 2340.3 2370.2 2370.4 2371.1 2372.1 2283.9 2316.9 2322.2 2322.8 2323.7 7633.2 7681.3 7685.2 7694.7 7694.8 4765.2 4826.2 4861.5 4863.3 4865.2 3179.5 3227.6 3282.4 3302.8 3310.9 1031.2 1035.7 1043.8 1068.1 1075.1 10541.6 10549.2 10553.1 10561.9 10569.4 4289.9 4324.1 4364.9 4366.1 4375.1 9092.3 9098.7 9101.5 9102.9 9105.5 4855.2 4883.3 4883.8 4886.7 4887.1 4402.7 4442.3 4443.5 4445.0 4445.1 3575.2 3778.6 3822.5 3849.1 3868.2 1166.9 1183.8 1267.9 1280.1 1298.3 1134.7 1163.3 1165.6 1187.5 1210.2 7588.5 7655.2 7695.3 7697.5 7707.2 1087.2 1145.3 1215.2 1221.6 1232.8 5870.6 5906.5 5908.1 5915.5 5930.0 9186.6 9498.6 9577.1 9631.9 9634.2 9512.1 9538.4 9540.1 9543.5 9569.3 7344.1 7652.5 7677.7 7680.9 7749.4 7414.1 7476.1 7496.3 7504.5 7514.7 8624.5 8689.4 8779.4 8799.7 8822.8 8347.4 9003.3 9004.4 9007.1 9016.9 6937.3 7014.3 7020.5 7020.6 7021.4 7282.3 7291.6 7333.6 7354.2 7539.7 7018.5 7078.7 7082.8 7110.1 7121.1 6878.8 6957.2 6967.1 7050.2 7068.4 6842.1 6896.9 6904.4 6908.9 6911.2 6425.3 6614.6 6654.1 6660.5 6667.7 6655.8 6672.4 6680.1 6718.9 6723.8 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5460.59 Median:6225.07 stddev:1624.17 (26.1%) stddev-sans-first:1583.27 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: Values: 377.0 377.9 378.5 378.8 384.9 6045.4 6048.0 6083.1 6127.7 6131.7 5811.9 5910.3 6015.9 6063.5 6104.6 4753.5 4763.2 4773.9 4786.5 4796.9 4508.6 4777.4 4783.3 4788.3 4789.8 4541.9 4622.1 4686.3 4687.5 4711.3 4665.0 4692.3 4700.4 4713.3 4727.6 4221.5 4231.6 4233.6 4236.3 4238.0 5654.8 5766.7 5767.5 5778.1 5784.6 5453.7 5454.5 5459.0 5459.3 5463.7 6431.9 6438.3 6440.1 6442.5 6444.4 4565.3 4576.4 4578.3 4579.4 4596.5 6478.2 6603.1 6672.5 6679.4 6681.5 4669.5 4705.9 4712.3 4715.5 4721.2 4772.3 4775.0 4778.3 4780.5 4781.3 5432.0 5433.6 5434.5 5446.2 5450.9 6285.2 6481.5 6495.6 6497.5 6498.5 1645.2 1647.3 1652.3 1658.3 1661.2 1139.2 1143.1 1153.7 1169.3 1174.7 6325.0 6326.8 6332.7 6347.0 6358.6 6445.2 6687.7 6698.6 6705.4 6706.3 6208.2 6242.0 6332.4 6391.7 6402.0 3605.7 3631.3 3633.5 3637.2 3644.2 6864.2 7005.4 7016.1 7027.0 7027.8 6826.9 6827.6 6837.8 6843.4 6844.2 6953.5 6957.5 6994.1 7026.0 7042.7 6594.0 6737.7 6741.9 6744.5 6745.2 6611.1 6613.4 6617.3 6620.1 6624.9 6997.1 7016.2 7025.1 7025.6 7033.1 4570.1 4668.7 4678.4 4681.0 4690.6 6711.3 6722.9 6723.4 6726.3 6736.0 6569.5 6569.6 6571.6 6579.4 6580.3 6418.0 6553.1 6560.7 6567.2 6569.1 6417.3 6443.3 6449.0 6452.3 6479.2 6531.7 6569.3 6573.3 6576.7 6579.2 6345.2 6409.4 6422.1 6438.4 6439.3 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,349 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14454.24 Median:48449.76 stddev:17240.69 (35.6%) stddev-sans-first:17258.72 04:33:39 INFO - 2016-02-24 04:33:39,350 DEBUG : BROWSER_OUTPUT: Values: 836.3 880.5 896.9 924.5 937.9 13196.2 13424.3 13483.6 13503.3 13505.5 12412.5 12509.7 12510.0 12511.2 12530.2 736.9 748.1 912.5 925.8 926.2 912.4 912.6 915.9 918.7 919.7 781.3 789.5 946.0 955.4 955.6 941.2 954.1 955.6 955.9 955.9 704.4 704.9 705.5 705.6 706.3 12494.7 12629.9 12644.3 12752.4 12780.2 12645.4 12699.5 12709.7 12990.9 13045.8 10272.2 10531.9 10628.5 10695.1 11887.6 3831.4 3896.3 3916.6 3927.9 3932.4 48600.0 48638.3 48676.8 48685.5 48691.5 10442.6 10537.2 10572.3 10625.7 10673.4 18141.5 18153.7 18589.3 18597.7 18771.3 7751.6 7773.9 7789.2 7923.8 8073.3 3775.7 3849.4 4409.9 4506.3 4612.3 3237.7 3260.4 3270.2 3270.6 3275.3 622.6 627.1 632.4 634.4 640.6 586.8 598.1 603.8 604.7 610.6 8583.2 8676.2 8685.2 8789.3 8976.2 500.4 526.2 583.4 607.9 635.8 3928.6 3957.9 3992.9 4027.1 4055.4 58952.7 59209.4 59531.0 61559.4 61621.0 56102.0 56377.7 56855.0 56934.0 57217.7 49915.8 51952.5 52547.7 55644.7 55759.4 8556.9 8853.0 8930.3 8943.3 9069.5 38337.4 38617.0 38827.6 39030.2 39821.2 44171.8 47955.0 48364.8 48534.8 48819.8 10431.3 10558.4 10913.6 11028.1 11059.1 12256.6 12358.6 12379.4 12753.9 12963.1 10936.5 11105.9 11223.9 11284.2 11298.7 10975.7 11091.8 11207.3 11229.6 11416.1 10188.6 10671.3 10723.0 11078.3 11098.4 9712.5 9721.8 9893.3 10005.8 10039.5 9431.0 9613.2 9766.2 9889.1 10061.8 04:33:39 INFO - 2016-02-24 04:33:39,350 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:39 INFO - 2016-02-24 04:33:39,350 DEBUG : BROWSER_OUTPUT: 04:33:39 INFO - 2016-02-24 04:33:39,921 INFO : Browser exited with error code: 0 04:33:39 INFO - 2016-02-24 04:33:39,947 INFO : Completed test dromaeo_css (00:18:30) 04:33:39 INFO - 2016-02-24 04:33:39,947 INFO : Starting test kraken 04:33:39 INFO - 2016-02-24 04:33:39,947 DEBUG : operating with platform_type : linux_ 04:33:39 INFO - 2016-02-24 04:33:39,947 INFO : Initialising browser for kraken test... 04:33:39 INFO - 2016-02-24 04:33:39,954 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXqIbJE/profile http://localhost:48931/getInfo.html 04:33:43 INFO - 2016-02-24 04:33:43,909 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:43 INFO - 2016-02-24 04:33:43,909 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:43 INFO - 2016-02-24 04:33:43,909 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:43 INFO - 2016-02-24 04:33:43,909 DEBUG : BROWSER_OUTPUT: __metrics 04:33:44 INFO - 2016-02-24 04:33:44,072 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] 04:33:44 INFO - 2016-02-24 04:33:44,925 INFO : Browser initialized. 04:33:44 INFO - 2016-02-24 04:33:44,926 INFO : Running cycle 1/1 for kraken test... 04:33:44 INFO - 2016-02-24 04:33:44,926 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXqIbJE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:56 INFO - 2016-02-24 04:33:56,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 132599808 04:33:56 INFO - 2016-02-24 04:33:56,601 DEBUG : BROWSER_OUTPUT: 04:33:59 INFO - 2016-02-24 04:33:59,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48931/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:59 INFO - 2016-02-24 04:33:59,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 163504128 04:33:59 INFO - 2016-02-24 04:33:59,597 DEBUG : BROWSER_OUTPUT: 04:34:02 INFO - 2016-02-24 04:34:02,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48931/tests/kraken/driver.html?testName=audio-dft) 04:34:02 INFO - 2016-02-24 04:34:02,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 161705984 04:34:02 INFO - 2016-02-24 04:34:02,719 DEBUG : BROWSER_OUTPUT: 04:34:05 INFO - 2016-02-24 04:34:05,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48931/tests/kraken/driver.html?testName=audio-fft) 04:34:06 INFO - 2016-02-24 04:34:06,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 158097408 04:34:06 INFO - 2016-02-24 04:34:06,108 DEBUG : BROWSER_OUTPUT: 04:34:08 INFO - 2016-02-24 04:34:08,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48931/tests/kraken/driver.html?testName=audio-oscillator) 04:34:08 INFO - 2016-02-24 04:34:08,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 158842880 04:34:08 INFO - 2016-02-24 04:34:08,654 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2016-02-24 04:34:10,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:11 INFO - 2016-02-24 04:34:11,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 159043584 04:34:11 INFO - 2016-02-24 04:34:11,370 DEBUG : BROWSER_OUTPUT: 04:34:14 INFO - 2016-02-24 04:34:14,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48931/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:14 INFO - 2016-02-24 04:34:14,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 158547968 04:34:14 INFO - 2016-02-24 04:34:14,798 DEBUG : BROWSER_OUTPUT: 04:34:18 INFO - 2016-02-24 04:34:18,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48931/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:18 INFO - 2016-02-24 04:34:18,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 159313920 04:34:18 INFO - 2016-02-24 04:34:18,688 DEBUG : BROWSER_OUTPUT: 04:34:21 INFO - 2016-02-24 04:34:21,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48931/tests/kraken/driver.html?testName=json-parse-financial) 04:34:21 INFO - 2016-02-24 04:34:21,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 158068736 04:34:21 INFO - 2016-02-24 04:34:21,976 DEBUG : BROWSER_OUTPUT: 04:34:23 INFO - 2016-02-24 04:34:23,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:24 INFO - 2016-02-24 04:34:24,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 166027264 04:34:24 INFO - 2016-02-24 04:34:24,091 DEBUG : BROWSER_OUTPUT: 04:34:25 INFO - 2016-02-24 04:34:25,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:26 INFO - 2016-02-24 04:34:26,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 161832960 04:34:26 INFO - 2016-02-24 04:34:26,431 DEBUG : BROWSER_OUTPUT: 04:34:28 INFO - 2016-02-24 04:34:28,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:28 INFO - 2016-02-24 04:34:28,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 168468480 04:34:28 INFO - 2016-02-24 04:34:28,996 DEBUG : BROWSER_OUTPUT: 04:34:31 INFO - 2016-02-24 04:34:31,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:31 INFO - 2016-02-24 04:34:31,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 176029696 04:34:31 INFO - 2016-02-24 04:34:31,945 DEBUG : BROWSER_OUTPUT: 04:34:34 INFO - 2016-02-24 04:34:34,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:35 INFO - 2016-02-24 04:34:35,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 172814336 04:34:35 INFO - 2016-02-24 04:34:35,008 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48931/tests/kraken/driver.html?testName=ai-astar) 04:34:36 INFO - 2016-02-24 04:34:36,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 230920192 04:34:36 INFO - 2016-02-24 04:34:36,913 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,913 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:36 INFO - 2016-02-24 04:34:36,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:36 INFO - 2016-02-24 04:34:36,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:36 INFO - 2016-02-24 04:34:36,914 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:36 INFO - 2016-02-24 04:34:36,914 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;102;108;109;110;97;108;111;110 04:34:36 INFO - 2016-02-24 04:34:36,914 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;122;143;160;128;146;158;124;167;122 04:34:36 INFO - 2016-02-24 04:34:36,915 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;160;159;161;161;161;161;162 04:34:36 INFO - 2016-02-24 04:34:36,916 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;71;152;71;71;73;72;157;71 04:34:36 INFO - 2016-02-24 04:34:36,916 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;137;92;93;93;133;92;93;140 04:34:36 INFO - 2016-02-24 04:34:36,916 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 04:34:36 INFO - 2016-02-24 04:34:36,916 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;145;146;146;146;146;145 04:34:36 INFO - 2016-02-24 04:34:36,916 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;57;57;57;56;56;57;54;54 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;63;63;65;64;63;64;64 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;79;77;77;77;78;77;80;78 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;113;118;117;121;115;121;119;109;113 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;130;145;143;141;141;130;140;139;143;139 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;62;64;62;63;68;68;63;64;65 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,883 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: __startTimestamp1456317276912__endTimestamp 04:34:36 INFO - 2016-02-24 04:34:36,917 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:109.50 stddev:4.34 (4.0%) stddev-sans-first:4.59 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 102.0 108.0 109.0 110.0 97.0 108.0 111.0 110.0 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:145.50 stddev:16.83 (11.6%) stddev-sans-first:17.80 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: Values: 145.0 122.0 143.0 160.0 128.0 146.0 158.0 124.0 167.0 122.0 04:34:36 INFO - 2016-02-24 04:34:36,919 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 160.0 159.0 161.0 161.0 161.0 161.0 162.0 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:71.00 stddev:35.07 (49.4%) stddev-sans-first:36.66 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 152.0 71.0 71.0 73.0 72.0 157.0 71.0 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.50 stddev:21.30 (23.0%) stddev-sans-first:21.99 04:34:36 INFO - 2016-02-24 04:34:36,920 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 137.0 92.0 93.0 93.0 133.0 92.0 93.0 140.0 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:34:36 INFO - 2016-02-24 04:34:36,921 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.15 (2.0%) stddev-sans-first:1.22 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 57.0 57.0 57.0 56.0 56.0 57.0 54.0 54.0 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 63.0 63.0 65.0 64.0 63.0 64.0 64.0 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,922 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:1.06 (1.4%) stddev-sans-first:1.09 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 79.0 77.0 77.0 77.0 78.0 77.0 80.0 78.0 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:117.50 stddev:3.83 (3.3%) stddev-sans-first:4.06 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: Values: 117.0 113.0 118.0 117.0 121.0 115.0 121.0 119.0 109.0 113.0 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.10 Median:141.00 stddev:5.15 (3.7%) stddev-sans-first:4.28 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: Values: 130.0 145.0 143.0 141.0 141.0 130.0 140.0 139.0 143.0 139.0 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: 04:34:36 INFO - 2016-02-24 04:34:36,923 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.16 (3.4%) stddev-sans-first:2.29 04:34:36 INFO - 2016-02-24 04:34:36,924 DEBUG : BROWSER_OUTPUT: Values: 64.0 62.0 64.0 62.0 63.0 68.0 68.0 63.0 64.0 65.0 04:34:36 INFO - 2016-02-24 04:34:36,925 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:36 INFO - 2016-02-24 04:34:36,925 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2016-02-24 04:34:37,602 INFO : Browser exited with error code: 0 04:34:37 INFO - 2016-02-24 04:34:37,656 INFO : Completed test kraken (00:00:57) 04:34:37 INFO - 2016-02-24 04:34:37,656 INFO : Starting test v8_7 04:34:37 INFO - 2016-02-24 04:34:37,656 DEBUG : operating with platform_type : linux_ 04:34:37 INFO - 2016-02-24 04:34:37,656 INFO : Initialising browser for v8_7 test... 04:34:37 INFO - 2016-02-24 04:34:37,662 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL0o_wU/profile http://localhost:48931/getInfo.html 04:34:41 INFO - 2016-02-24 04:34:41,687 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:41 INFO - 2016-02-24 04:34:41,687 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:41 INFO - 2016-02-24 04:34:41,687 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:41 INFO - 2016-02-24 04:34:41,687 DEBUG : BROWSER_OUTPUT: __metrics 04:34:41 INFO - 2016-02-24 04:34:41,864 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] 04:34:42 INFO - 2016-02-24 04:34:42,665 INFO : Browser initialized. 04:34:42 INFO - 2016-02-24 04:34:42,666 INFO : Running cycle 1/1 for v8_7 test... 04:34:42 INFO - 2016-02-24 04:34:42,666 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL0o_wU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:54 INFO - 2016-02-24 04:34:54,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 132456448 04:34:54 INFO - 2016-02-24 04:34:54,455 DEBUG : BROWSER_OUTPUT: 04:35:15 INFO - 2016-02-24 04:35:15,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48931/tests/v8_7/run.html (next: http://localhost:48931/tests/v8_7/run.html) 04:35:16 INFO - 2016-02-24 04:35:16,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 427376640 04:35:16 INFO - 2016-02-24 04:35:16,033 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: |0;Richards;165.34391534391534 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.9620587264929 04:35:16 INFO - 2016-02-24 04:35:16,034 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |5;Earley;540.8328826392644 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |6;Boyer;10557.894736842105 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |8;Splay;512.8205128205128 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:35:16 INFO - 2016-02-24 04:35:16,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: __startTimestamp1456317316027__endTimestamp 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.34 Median:165.34 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,036 DEBUG : BROWSER_OUTPUT: Values: 165.3 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.96 Median:164.96 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: Values: 165.0 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: Values: 278.7 04:35:16 INFO - 2016-02-24 04:35:16,037 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: Values: 5170.1 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: Values: 941.6 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,038 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.83 Median:540.83 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: Values: 540.8 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10557.89 Median:10557.89 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: Values: 10557.9 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: Values: 24238.1 04:35:16 INFO - 2016-02-24 04:35:16,039 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:512.82 Median:512.82 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: Values: 512.8 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:35:16 INFO - 2016-02-24 04:35:16,040 DEBUG : BROWSER_OUTPUT: 04:35:16 INFO - 2016-02-24 04:35:16,686 INFO : Browser exited with error code: 0 04:35:16 INFO - 2016-02-24 04:35:16,700 INFO : Completed test v8_7 (00:00:39) 04:35:17 INFO - 2016-02-24 04:35:17,116 INFO : Completed test suite (00:20:07) 04:35:17 INFO - 2016-02-24 04:35:17,116 DEBUG : Working with test: dromaeo_css 04:35:17 INFO - 2016-02-24 04:35:17,116 DEBUG : Generating results file: dromaeo_css 04:35:17 INFO - 2016-02-24 04:35:17,118 DEBUG : Working with test: kraken 04:35:17 INFO - 2016-02-24 04:35:17,118 DEBUG : Generating results file: kraken 04:35:17 INFO - 2016-02-24 04:35:17,118 INFO : javascript benchmark 04:35:17 INFO - 2016-02-24 04:35:17,119 DEBUG : Working with test: v8_7 04:35:17 INFO - 2016-02-24 04:35:17,119 DEBUG : Generating results file: v8_7 04:35:17 INFO - 2016-02-24 04:35:17,119 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:17 INFO - 2016-02-24 04:35:17,170 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:35:17 INFO - 2016-02-24 04:35:17,170 DEBUG : process_Request line: dromaeo_css 7328.06 graph.html#tests=[[72,53,35]] 04:35:17 INFO - 2016-02-24 04:35:17,170 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:17 INFO - 2016-02-24 04:35:17,204 DEBUG : process_Request line: kraken 1470.10 graph.html#tests=[[232,53,35]] 04:35:17 INFO - 2016-02-24 04:35:17,204 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:35:17 INFO - 2016-02-24 04:35:17,236 DEBUG : process_Request line: v8_7 23393.22 graph.html#tests=[[230,53,35]] 04:35:17 INFO - 2016-02-24 04:35:17,237 INFO : javascript benchmark 04:35:17 INFO - 2016-02-24 04:35:17,241 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3265.5101734739787, 3333.3499967506345, 3365.5961284645846, 3371.0561042907993, 3374.1733275347538, 5373.435789242127, 5423.213634023069, 5425.565954723623, 5457.154141108124, 5467.753951072196, 5454.91817622736, 5487.122060470326, 5495.2856128703315, 5495.395506494292, 5500.669959802414, 4928.433230178522, 4991.700497970124, 5054.671446355975, 5078.0, 5108.616853735966, 4961.156603377416, 5019.121653710586, 5019.924701129486, 5044.419891712445, 5078.873028174288, 5023.773930173133, 5099.617528685345, 5110.412302585194, 5123.795048198068, 5129.12804823181, 5125.769340379655, 5133.307003554528, 5185.429602743714, 5188.403333616645, 5197.272381866542, 4812.085703716282, 4906.779194936201, 4944.975275123601, 5041.747912604392, 5085.745712714386, 5298.284731561228, 5310.0, 5315.176147697113, 5318.707471089088, 5322.0, 5870.11948207768, 5872.7357268923, 5873.500752436005, 5874.030784920483, 5876.030454974924, 5708.571857110692, 5810.273715785527, 5818.8254352369495, 5836.708164591753, 5887.381824908409, 5602.0, 5604.0, 5607.943920560824, 5613.158026296048, 5616.550675945915, 6046.969765151146, 6047.969760151259, 6048.213732214872, 6048.455638992512, 6061.212042434543, 5667.093265077568, 5737.913931291034, 5800.854978625568, 5863.296404431496, 5895.970520147372, 5871.089981052944, 5924.763009479659, 5929.169916211734, 5938.792142275, 5942.257217847769, 5708.343540492813, 5892.970535147382, 5893.911591326134, 5895.233619629421, 5897.7935772247765, 5759.769609215668, 5854.912176317359, 5942.1383899335215, 5952.434518720715, 5991.55063370249, 4475.888102797456, 4499.797509112098, 4509.7970591323465, 4521.253993091169, 4536.61438777701, 3980.5024371953505, 4060.878173654795, 4061.4923134608175, 4085.1216988347646, 4092.570280120604, 5570.693611851306, 5590.608657394025, 5616.354119276336, 5619.634723742944, 5647.37878833328, 5961.165436838846, 6012.699365031731, 6016.127661489059, 6016.699165041818, 6019.157317975487, 5387.057264978613, 5514.476124768141, 5620.5503559715125, 5701.0308247598, 5701.828945131652, 5136.743162841843, 5137.049645815536, 5138.07514647367, 5139.177731562932, 5157.58739300855, 6111.480524155408, 6116.418940200763, 6122.969385153046, 6127.387261273837, 6152.507799376039, 5755.65466072037, 5800.506956908541, 5831.0, 5920.940790592125, 5946.643201407929, 6127.0, 6130.325664177026, 6134.539909506716, 6149.72326245329, 6153.323134455296, 5776.7400466979925, 5836.066229403445, 5838.737256823538, 5849.239598852122, 5849.473547380756, 5703.7433315500075, 5820.82537523875, 5885.588008839341, 5904.261967254093, 5932.614380065282, 5792.247007888947, 5896.204012458264, 5904.822855314347, 5910.202122713378, 5919.023361145363, 5616.297962754656, 5881.264841894763, 5896.321922978741, 5899.705014749159, 5900.822975310747, 5548.805791797429, 5655.151727240782, 5669.858253543694, 5672.943270567406, 5673.234113394804, 5713.314402271588, 5732.426757324234, 5756.280464941882, 5758.3090029196765, 5767.480926716616, 5490.5882058844945, 5590.077637189818, 5654.915176272277, 5656.151577263443, 5663.518600918968], "unit": "ms", "name": "dojo.html", "value": 5449.171897589458}, {"lowerIsBetter": false, "replicates": [573.2146958666627, 625.2934184371659, 625.4496043481736, 638.3042483692775, 646.266487536646, 33045.66954330456, 33283.334333313316, 33603.83198084006, 33638.66361336386, 33675.83162084189, 41150.58849411505, 41323.79338103313, 41372.79313603435, 41404.17191656165, 41470.170596588054, 8960.238379737713, 9125.589348479301, 9126.452412855217, 9128.497932613704, 9144.954275228614, 8315.293200078, 8369.665213391487, 8953.776155596097, 9076.047015063423, 10822.621208257713, 10710.678679639585, 10817.026467617912, 10843.67468975932, 10847.186461015415, 10852.294600850959, 10691.465426728671, 10770.730731731692, 10795.46022698862, 10796.946015269874, 10828.891711082906, 10463.529141188665, 10547.789044219073, 10629.096526795232, 10671.306365086244, 10673.786524269548, 41427.37858932118, 41855.0, 41855.581444185475, 41891.7905410471, 41938.0, 3287.704106630391, 3386.762926595139, 3478.234788346585, 3885.922281554353, 4148.942019784936, 32186.678133218604, 32197.356052879044, 32517.512237316223, 32555.18612034718, 32595.0, 4411.161879242965, 4433.911321773547, 4443.311286750527, 4488.573585509372, 4527.750973696446, 309846.0, 310823.0, 312620.0, 312657.43671281723, 314403.0, 59277.40722592805, 59915.700421498485, 67058.0, 67374.66312668503, 67422.0, 72208.27791722016, 72574.0, 72664.27335726681, 72744.0, 72890.27109728835, 16169.110698911438, 16212.75680864788, 16303.59241018984, 16324.510264692079, 16358.345666173458, 13136.27750473733, 13182.670433239055, 13197.076204665582, 13238.73522529544, 13265.336733163304, 21363.25228617022, 21547.784522154892, 21574.0, 21642.0, 21691.0, 8109.107998120202, 8388.951381077366, 8389.32885369169, 8418.116097809641, 8535.701250456204, 1049.7270709615402, 1054.1514081164737, 1103.0458653265027, 1155.2490880927296, 1245.5391505143155, 29697.703022969494, 29950.850245748632, 31135.377292454024, 31205.843970780003, 31266.21834454157, 1102.459794700591, 1116.240956149826, 1169.8069818479855, 1179.9823002654966, 1234.7468768902534, 14448.638784030272, 14564.198969056804, 14893.925530372495, 15285.235738213045, 16524.0, 441236.0, 453372.0, 454839.0, 455768.0, 456676.0, 58241.41758582445, 58542.4145758537, 58717.0, 58741.41258587359, 58919.70540147272, 1333.8599447057918, 1427.800107984883, 1458.8832893368506, 1505.127026324751, 1586.9285882135332, 29831.229740326482, 30353.69646303509, 30406.84796576003, 31136.377272454876, 31214.531782022834, 46905.53094469148, 47112.52887471081, 47449.28826067681, 47571.76214118907, 47639.52360476351, 273544.0, 275882.0, 275882.0, 277073.0, 278299.0, 35276.11809704778, 35292.47061294031, 36261.0, 36355.45466817947, 36421.817890911436, 45935.31097033614, 46672.766636166605, 47190.76404617955, 47652.52347476481, 47812.2828157571, 39249.215015700094, 40280.19439611133, 45497.772511137235, 46134.53865461436, 48351.75824120857, 44655.776721116184, 44998.550014500746, 46652.533474666176, 46670.29994550152, 47133.52866471291, 39983.400248995706, 40290.0, 40422.0, 40442.79778601088, 40572.0, 34088.48867266943, 34967.475487868214, 35006.64993350034, 35383.646163539066, 35604.82197588996, 26889.596656050566, 27772.30569235785, 27782.305442364104, 27798.305042374104, 27801.860990694917], "unit": "ms", "name": "ext.html", "value": 20385.77033645234}, {"lowerIsBetter": false, "replicates": [391.2039000633711, 395.98812035638923, 398.4043854437616, 400.8617027125641, 405.2705130764624, 15621.375144994186, 16107.758383624256, 17901.7314740279, 18264.269429222833, 18299.45101646951, 12408.0, 12545.1218414711, 12571.308578028205, 14025.36885840137, 17623.206955686994, 5094.872628184297, 5319.760610772524, 5472.480114389146, 5488.91766623499, 5543.307086614173, 4006.439098526194, 4115.732477388975, 5415.241866138744, 5433.945660543403, 5625.831225063234, 5719.714014299289, 5751.338596061465, 5773.191753154561, 5775.740091695884, 5776.075827867542, 5726.856828579277, 5817.8836423271505, 6195.783147589836, 6206.565540412173, 6212.87574248517, 5573.08044172711, 5581.246531718207, 5586.13414920688, 5589.469000444951, 5595.636283641591, 14679.119252844757, 14748.0, 18450.907745461187, 21693.67459488109, 22129.44676383087, 2302.643090321003, 2369.324742448411, 2391.043582566987, 2429.6841410616685, 2456.6192240202795, 10243.436610986393, 10290.948545257226, 10334.17326613869, 10493.790124197474, 10539.367637941748, 1612.3550579768187, 1886.9528261793428, 1890.2155605423732, 1914.15777058094, 1927.9325223617245, 66371.0, 67687.0, 68787.31212687859, 69618.30381696169, 70073.0, 11099.167562432849, 11328.71678208035, 11363.204575679623, 11369.374684392273, 11446.427678616035, 14493.420263189566, 15319.617009574627, 15320.463783767515, 15330.386784528493, 15335.539933802003, 7952.84094318122, 8031.357491400674, 8101.351891848638, 8180.304674102649, 8254.587270636444, 7555.244475552401, 7591.316781489582, 7598.962005189938, 7623.923760762433, 7646.923530764732, 4855.757212139379, 4901.632377571696, 4932.926006109911, 4961.454240033593, 4995.675281106716, 1736.106202197002, 1910.990445047766, 1934.7388102606249, 1941.9029048547516, 1993.6311782320026, 1024.1704219582014, 1038.4703801061512, 1045.3100953370738, 1066.3974854207504, 1095.5599417828025, 15223.467178648694, 15679.764803527956, 16138.838611613734, 16583.419580314632, 18046.097695115193, 960.519740129935, 1016.6390931219458, 1052.8578641883248, 1071.3625392891217, 1103.757173421846, 9859.30984831055, 10111.130534675254, 10154.441505717257, 10314.226433017553, 10641.361518308926, 667026.0, 672592.0, 673555.0, 687664.0, 703976.0, 82839.58580207061, 87436.0, 88975.55512222527, 89034.55482722675, 89541.0, 1168.0713832503181, 1182.3733421286731, 1189.3577468167093, 1191.1304747534348, 1192.2667559450874, 16092.597685057966, 16212.0, 16271.0, 16499.09254990939, 16633.002019878844, 36749.26501469902, 37621.81189094037, 37839.810800945816, 37893.43159852659, 38307.425388618634, 51003.23495147502, 51858.481415185364, 53396.46603533915, 53543.4645653554, 53914.46085539251, 10298.845517317097, 10378.584856605652, 10520.684379468628, 10521.894781052397, 10527.94736026315, 14879.628009299855, 18395.63208735791, 18401.90799045996, 18570.53573660615, 18922.14850331711, 13772.793408098687, 14321.64195895111, 15472.381104755683, 15588.376464941275, 15862.365505379656, 14434.0, 14740.262986850828, 14829.40682372693, 14971.77542336844, 15024.0, 15349.309281082154, 15452.381904723685, 15721.449749258722, 15722.292496837441, 16008.439704610282, 9819.558119884765, 10425.478726063819, 10541.262111652111, 10667.306625069346, 10677.14582833387, 13658.590242292747, 13912.165270083828, 13961.720765584834, 13987.720245594828, 14733.55799326022], "unit": "ms", "name": "jquery.html", "value": 9409.361477947026}, {"lowerIsBetter": false, "replicates": [1541.8843586730998, 1736.3054778088763, 1811.8369346758789, 1825.7261410788385, 1847.5104097414187, 7110.964445177767, 7237.4933754637195, 7686.192949740281, 8076.1923807619205, 8079.434439589224, 7599.354054905326, 7713.652885620147, 7773.844523109535, 7798.181190974951, 7798.5320880747195, 2358.2571489980646, 2378.5361854438393, 2380.452495925938, 2380.583397905368, 2381.6070348392495, 2042.6323261812868, 2078.615456140619, 2307.0, 2348.9295321140394, 2365.231299827563, 2294.541091781642, 2297.8965946532444, 2305.7578954209816, 2311.133325003124, 2312.4681323295654, 2340.3447034830187, 2370.2415227127326, 2370.3600027992434, 2371.0752806405517, 2372.074890792592, 2283.897224624896, 2316.9073237070497, 2322.2220556113552, 2322.7793359630978, 2323.6863023491783, 7633.236676332378, 7681.308682218571, 7685.193054729285, 7694.730684426018, 7694.769156925246, 4765.2375619900995, 4826.22780355145, 4861.513848615145, 4863.294822250754, 4865.245886887503, 3179.5071763876635, 3227.644959054502, 3282.3763484937786, 3302.752293577991, 3310.867565297385, 1031.2162756305263, 1035.7410647338165, 1043.768353343055, 1068.1027936533271, 1075.0861767497643, 10541.631042913537, 10549.156067514581, 10553.050225479743, 10561.894381056169, 10569.418681972566, 4289.892752681208, 4324.113556720865, 4364.869053928387, 4366.083122544238, 4375.081232941055, 9092.318076144316, 9098.727038188865, 9101.453912765255, 9102.90897091034, 9105.453672779655, 4855.198892182751, 4883.267509873547, 4883.780229889663, 4886.731229782325, 4887.144749668793, 4402.691811573159, 4442.311441726538, 4443.466783985942, 4445.0, 4445.110977804452, 3575.1955809942556, 3778.5843557208686, 3822.4839646647347, 3849.1339448624394, 3868.2263547290654, 1166.8833116688434, 1183.7632473505334, 1267.9112462127748, 1280.11032332528, 1298.2794549025382, 1134.7390100276982, 1163.313644949484, 1165.6036947437913, 1187.5368606243571, 1210.2375503432781, 7588.468807183554, 7655.234476552411, 7695.345895598937, 7697.538147711043, 7707.190744971809, 1087.16792754874, 1145.255583870491, 1215.1918973882268, 1221.6151912147823, 1232.8089146182356, 5870.559708021916, 5906.49794767441, 5908.113782932594, 5915.526757859361, 5929.970350148222, 9186.586603602855, 9498.572564234626, 9577.138057574852, 9631.855522167172, 9634.229261659051, 9512.09635084666, 9538.427694338223, 9540.141387275178, 9543.47510886894, 9569.28230382724, 7344.118705755237, 7652.464327497133, 7677.731279405306, 7680.923190768132, 7749.380049596019, 7414.110306763223, 7476.140243872024, 7496.25037496246, 7504.474686771873, 7514.699412023458, 8624.525651089, 8689.391742577958, 8779.429337093068, 8799.692010779592, 8822.779430514289, 8347.41568090252, 9003.279737621106, 9004.369694121611, 9007.054259302678, 9016.86474702893, 6937.340952609494, 7014.263502332182, 7020.543664661985, 7020.6489675514995, 7021.43828493709, 7282.308180722823, 7291.562506249642, 7333.596652184181, 7354.154272258545, 7539.698412063456, 7018.473614478832, 7078.681459334445, 7082.752103676553, 7110.146782386147, 7121.109861267341, 6878.759243426456, 6957.199922008831, 6967.09427774386, 7050.224475307815, 7068.363847253772, 6842.076319696777, 6896.862062758817, 6904.4131248844415, 6908.896366554405, 6911.205211400753, 6425.293217745951, 6614.603123812587, 6654.13496245485, 6660.467162627075, 6667.733290668319, 6655.767048153291, 6672.432843208382, 6680.064790929371, 6718.865622687616, 6723.831904202434], "unit": "ms", "name": "mootools.html", "value": 4600.881176391981}, {"lowerIsBetter": false, "replicates": [376.9886903392898, 377.92630437064764, 378.52941322960294, 378.78598591795634, 384.8960780589243, 6045.367750707306, 6048.032314829628, 6083.0875368694715, 6127.724252408641, 6131.693415329227, 5811.912821307673, 5910.34986151523, 6015.879682406349, 6063.514918806496, 6104.603200791946, 4753.548412900769, 4763.166445871976, 4773.90452190956, 4786.521347865203, 4796.928046079312, 4508.6393088553, 4777.355057067286, 4783.258594917794, 4788.257820037899, 4789.832355867546, 4541.886452838672, 4622.052479241765, 4686.250199968006, 4687.507811679776, 4711.340412342275, 4664.953350466486, 4692.272697731857, 4700.4359476862655, 4713.34013238147, 4727.621790256771, 4221.493420789525, 4231.61915427613, 4233.597808208216, 4236.2586547354085, 4238.025254191553, 5654.773809047633, 5766.682832444214, 5767.538596912237, 5778.133280007991, 5784.566157538202, 5453.672779633195, 5454.4545545445535, 5459.044667183227, 5459.290292262021, 5463.726813659341, 6431.935680643181, 6438.259600145996, 6440.1305823713665, 6442.516811239176, 6444.420002199825, 4565.315202719586, 4576.359309696645, 4578.267477203632, 4579.427571553556, 4596.49438561758, 6478.190226221723, 6603.108580341688, 6672.499562532829, 6679.398854103154, 6681.465482761368, 4669.486356500782, 4705.882352941136, 4712.269598212282, 4715.504871988461, 4721.15019296523, 4772.331873537708, 4774.9522504775205, 4778.283257511401, 4780.49804770501, 4781.258904869751, 5432.022235997559, 5433.592480563973, 5434.538064264581, 5446.183072539072, 5450.945490545123, 6285.151504546919, 6481.546291759531, 6495.577787443801, 6497.480201583862, 6498.512611554058, 1645.2020769926576, 1647.3163637090472, 1652.339064374236, 1658.2703610411381, 1661.2441339190639, 1139.2480962564832, 1143.108375467137, 1153.7058050197313, 1169.2808922512593, 1174.6945794093426, 6324.956382196886, 6326.810195694136, 6332.68336583169, 6346.9682651586445, 6358.554901156967, 6445.16212892321, 6687.699053542602, 6698.5980841149685, 6705.362990515893, 6706.295838936939, 6208.161898143693, 6241.96879015602, 6332.430081292706, 6391.744330226832, 6402.039694045838, 3605.7295702822394, 3631.3100510903373, 3633.4549817527054, 3637.1634524059614, 3644.2164934538673, 6864.176298844171, 7005.439564834801, 7016.087908571853, 7026.964865175743, 7027.789166325018, 6826.897596536056, 6827.590344579341, 6837.760678376233, 6843.3840954314355, 6844.178698556106, 6953.478489113337, 6957.547759395623, 6994.0907682002035, 7025.964870175719, 7042.718291268395, 6594.0, 6737.69680364375, 6741.932580674326, 6744.527883048336, 6745.2242992056545, 6611.140551728245, 6613.371729685672, 6617.272100069084, 6620.073189753534, 6624.90062649051, 6997.1253593300835, 7016.228214896255, 7025.121859767529, 7025.648717564203, 7033.050538177281, 4570.085982803386, 4668.719876807402, 4678.391809064799, 4681.040386720782, 4690.554397332248, 6711.3288671132495, 6722.899156512754, 6723.361280678328, 6726.260111387841, 6735.9663201685635, 6569.507286953402, 6569.605823650596, 6571.605703657605, 6579.407853293226, 6580.341965803573, 6418.0, 6553.082568440517, 6560.671966401756, 6567.211934567882, 6569.080328754074, 6417.2620148681635, 6443.291237963726, 6448.967755161382, 6452.322506136976, 6479.222493300834, 6531.706073226811, 6569.343065693392, 6573.342665733579, 6576.704048317742, 6579.17760279965, 6345.238571371465, 6409.359064093554, 6422.068800023877, 6438.3883531064475, 6439.259485159079], "unit": "ms", "name": "prototype.html", "value": 4945.699630342496}, {"lowerIsBetter": false, "replicates": [836.3267569606467, 880.4937161132347, 896.9147930946561, 924.4776701163846, 937.9249660027197, 13196.208227506344, 13424.261665608388, 13483.595492135251, 13503.257320847362, 13505.52730654426, 12412.503499860017, 12509.749805003894, 12510.0, 12511.186772859757, 12530.2481851089, 736.8857827036804, 748.0723902361087, 912.5118061836919, 925.7824411263348, 926.1849572376333, 912.4023764434273, 912.5802131019739, 915.9313051521129, 918.6600957645647, 919.7332773495679, 781.2656103262943, 789.4671097009524, 945.9763505912339, 955.4076472586971, 955.6320816485668, 941.2187884056217, 954.0507195340681, 955.6273053509137, 955.8996305387973, 955.904409559042, 704.4012589299106, 704.933031362025, 705.4779463197249, 705.5872314695857, 706.321930946287, 12494.687632809162, 12629.936850315782, 12644.304563249018, 12752.362381880868, 12780.169288996185, 12645.367731613474, 12699.492020319176, 12709.74580508394, 12990.935045324808, 13045.804312935314, 10272.178225741924, 10531.947340263327, 10628.521716522775, 10695.09091727204, 11887.583934562248, 3831.386978083521, 3896.2846604296883, 3916.608339166089, 3927.8625248116177, 3932.351162058257, 48600.0, 48638.27042594329, 48676.75661621705, 48685.513144868455, 48691.51308486941, 10442.582296708199, 10537.157027437786, 10572.259941804154, 10625.681229563126, 10673.359598423964, 18141.45575632707, 18153.7276940846, 18589.25642974293, 18597.7210341845, 18771.34300299483, 7751.573663448452, 7773.92226077732, 7789.182135875765, 7923.801904952422, 8073.273405393543, 3775.7356985011334, 3849.364854798927, 4409.889752756143, 4506.3465797459185, 4612.262038073892, 3237.708606225451, 3260.4457242268873, 3270.2478429961243, 3270.5748252726994, 3275.328557645677, 622.5953130465143, 627.1063734178776, 632.3707910628862, 634.4004915354946, 640.5964242527178, 586.7740919745928, 598.1267349669445, 603.8067818298102, 604.6644112517507, 610.5878531990888, 8583.18459746323, 8676.219140277279, 8685.218330350299, 8789.296856251485, 8976.192142707188, 500.4245118114125, 526.2185654303356, 583.3903570768557, 607.9483243924227, 635.8346829824186, 3928.64642182205, 3957.940630890539, 3992.9001774955277, 4027.1140349123148, 4055.3916912463364, 58952.70523647354, 59209.40790592125, 59531.0, 61559.38440615626, 61621.0, 56102.0, 56377.71811140918, 56855.0, 56934.0, 57217.713911430175, 49915.75042124766, 51952.48047519552, 52547.73726131345, 55644.72177639167, 55759.442405576236, 8556.914430855611, 8853.0, 8930.285577153682, 8943.329250306122, 9069.501177435304, 38337.4249386265, 38617.0, 38827.6117238824, 39030.2193956125, 39821.2035759289, 44171.77914110409, 47955.0, 48364.758176208896, 48534.75732621314, 48819.75590122027, 10431.269811113149, 10558.366498010144, 10913.563457461612, 11028.062614677843, 11059.059979901798, 12256.632301030982, 12358.62924112278, 12379.442925068213, 12753.872461275269, 12963.092583519063, 10936.50785714629, 11105.888941110808, 11223.88776112261, 11284.153688473232, 11298.661040168809, 10975.670729878117, 11091.833622495831, 11207.271527350696, 11229.623264574173, 11416.086713063101, 10188.592456301962, 10671.306365086244, 10723.0, 11078.279911805706, 11098.445077746243, 9712.5143742814, 9721.805563888824, 9893.258005649748, 10005.849912251177, 10039.548220330249, 9431.00558382162, 9613.159364775536, 9766.169875560372, 9889.06053924876, 10061.849072264069], "unit": "ms", "name": "yui.html", "value": 6510.415889688182}], "name": "dromaeo_css", "value": 7328.0646412180595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 102.0, 108.0, 109.0, 110.0, 97.0, 108.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [145.0, 122.0, 143.0, 160.0, 128.0, 146.0, 158.0, 124.0, 167.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 152.0, 71.0, 71.0, 73.0, 72.0, 157.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 137.0, 92.0, 93.0, 93.0, 133.0, 92.0, 93.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 57.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 64.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 79.0, 77.0, 77.0, 77.0, 78.0, 77.0, 80.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 118.0, 117.0, 121.0, 115.0, 121.0, 119.0, 109.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [130.0, 145.0, 143.0, 141.0, 141.0, 130.0, 140.0, 139.0, 143.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.1}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 64.0, 62.0, 63.0, 68.0, 68.0, 63.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1470.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.34391534391534], "unit": "score", "name": "Richards", "value": 213.506496}, {"lowerIsBetter": false, "replicates": [164.9620587264929], "unit": "score", "name": "DeltaBlue", "value": 400.8073159999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [540.8328826392644], "unit": "score", "name": "Earley", "value": 1232.290087}, {"lowerIsBetter": false, "replicates": [10557.894736842105], "unit": "score", "name": "Boyer", "value": 63.12461116650046}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [512.8205128205128], "unit": "score", "name": "Splay", "value": 158.90744999999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23393.22278564166}]} 04:35:17 INFO - RETURN: dromaeo_css: 7328.06 04:35:17 INFO - RETURN: kraken: 1470.10 04:35:17 INFO - RETURN: v8_7: 23393.22 04:35:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23393.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7328.06"}}} 04:35:17 INFO - Return code: 0 04:35:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:35:17 INFO - # TBPL SUCCESS # 04:35:17 INFO - Running post-action listener: _resource_record_post_action 04:35:17 INFO - Running post-run listener: _resource_record_post_run 04:35:18 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 323584; Write bytes: 510709760; Read time: 628; Write time: 601324 04:35:18 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 246464512; Read time: 224; Write time: 363208 04:35:18 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 319488; Write bytes: 263647232; Read time: 404; Write time: 238116 04:35:18 INFO - Running post-run listener: _upload_blobber_files 04:35:18 INFO - Blob upload gear active. 04:35:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:35:18 INFO - Copying logs to upload dir... 04:35:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.944975 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-24 04:35:17.923858) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:17.927670) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010038 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456307086/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-24 04:35:17.979190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:17.979535) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456313713.938808-2062322580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 04:35:18.028931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 04:35:18.029243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 04:35:18.029522) ========= ========= Total master_lag: 0.26 =========