builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1455909933.02 results: success (0) buildid: 20160219090437 builduid: b4fad0d5b31046ab88b309d166c875fe revision: b935e0100697 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.018658) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.019090) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.019372) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006791 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.041130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.041400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.077817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.078097) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.141396) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.141680) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.142053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.142339) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 11:25:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-02-19 11:25:34 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.312387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.312678) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021861 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:33.361320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 11:25:33.361644) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b935e0100697 --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 b935e0100697 --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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 11:25:34,732 Setting DEBUG logging. 2016-02-19 11:25:34,733 attempt 1/10 2016-02-19 11:25:34,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b935e0100697?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 11:25:36,025 unpacking tar archive at: mozilla-beta-b935e0100697/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 11:25:34.957902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:34.958251) ========= echo b935e0100697 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b935e0100697'] 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b935e0100697 program finished with exit code 0 elapsedTime=0.004648 script_repo_revision: 'b935e0100697' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:35.010318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:35.010756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 11:25:35.021235) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-19 11:25:35.021576) ========= /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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:36 INFO - MultiFileLogger online at 20160219 11:25:36 in /builds/slave/test-pgo 11:25:36 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 11:25:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:25:36 INFO - {'append_to_log': False, 11:25:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:25:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:25:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:25:36 INFO - 'branch': 'Mozilla-Beta', 11:25:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:36 INFO - 'config_files': ('talos/linux_config.py',), 11:25:36 INFO - 'default_actions': ('clobber', 11:25:36 INFO - 'read-buildbot-config', 11:25:36 INFO - 'download-and-extract', 11:25:36 INFO - 'populate-webroot', 11:25:36 INFO - 'create-virtualenv', 11:25:36 INFO - 'install', 11:25:36 INFO - 'run-tests'), 11:25:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:36 INFO - 'download_minidump_stackwalk': True, 11:25:36 INFO - 'download_symbols': 'ondemand', 11:25:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:36 INFO - 'installer_path': 'installer.exe', 11:25:36 INFO - 'log_level': 'info', 11:25:36 INFO - 'log_name': 'talos', 11:25:36 INFO - 'log_to_console': True, 11:25:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:36 INFO - 'opt_config_files': (), 11:25:36 INFO - 'pip_index': False, 11:25:36 INFO - 'sps_profile': False, 11:25:36 INFO - 'sps_profile_interval': 0, 11:25:36 INFO - 'suite': 'dromaeojs', 11:25:36 INFO - 'system_bits': '32', 11:25:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:36 INFO - 'title': 'talos-linux64-ix-023', 11:25:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:36 INFO - 'use_talos_json': True, 11:25:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:25:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:36 INFO - 'work_dir': 'build'} 11:25:36 INFO - ##### 11:25:36 INFO - ##### Running clobber step. 11:25:36 INFO - ##### 11:25:36 INFO - Running pre-action listener: _resource_record_pre_action 11:25:36 INFO - Running main action method: clobber 11:25:36 INFO - rmtree: /builds/slave/test-pgo/build 11:25:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:25:37 INFO - Running post-action listener: _resource_record_post_action 11:25:37 INFO - ##### 11:25:37 INFO - ##### Running read-buildbot-config step. 11:25:37 INFO - ##### 11:25:37 INFO - Running pre-action listener: _resource_record_pre_action 11:25:37 INFO - Running main action method: read_buildbot_config 11:25:37 INFO - Using buildbot properties: 11:25:37 INFO - { 11:25:37 INFO - "properties": { 11:25:37 INFO - "buildnumber": 118, 11:25:37 INFO - "product": "firefox", 11:25:37 INFO - "script_repo_revision": "production", 11:25:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:25:37 INFO - "repository": "", 11:25:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:25:37 INFO - "buildid": "20160219090437", 11:25:37 INFO - "slavename": "talos-linux64-ix-023", 11:25:37 INFO - "pgo_build": "True", 11:25:37 INFO - "basedir": "/builds/slave/test-pgo", 11:25:37 INFO - "project": "", 11:25:37 INFO - "platform": "ubuntu64_hw", 11:25:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:25:37 INFO - "slavebuilddir": "test", 11:25:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:25:37 INFO - "branch": "mozilla-beta", 11:25:37 INFO - "repo_path": "releases/mozilla-beta", 11:25:37 INFO - "stage_platform": "linux64-pgo", 11:25:37 INFO - "builduid": "b4fad0d5b31046ab88b309d166c875fe", 11:25:37 INFO - "revision": "b935e0100697" 11:25:37 INFO - }, 11:25:37 INFO - "sourcestamp": { 11:25:37 INFO - "repository": "", 11:25:37 INFO - "hasPatch": false, 11:25:37 INFO - "project": "", 11:25:37 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:25:37 INFO - "changes": [ 11:25:37 INFO - { 11:25:37 INFO - "category": null, 11:25:37 INFO - "files": [ 11:25:37 INFO - { 11:25:37 INFO - "url": null, 11:25:37 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2" 11:25:37 INFO - } 11:25:37 INFO - ], 11:25:37 INFO - "repository": "", 11:25:37 INFO - "rev": "b935e0100697", 11:25:37 INFO - "who": "sendchange", 11:25:37 INFO - "when": 1455909846, 11:25:37 INFO - "number": 7628861, 11:25:37 INFO - "comments": "Bug 1249551 - _Blank Hello panel in Firefox Beta 7_. r=mdeboer a=sylvestre", 11:25:37 INFO - "project": "", 11:25:37 INFO - "at": "Fri 19 Feb 2016 11:24:06", 11:25:37 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:25:37 INFO - "revlink": "", 11:25:37 INFO - "properties": [ 11:25:37 INFO - [ 11:25:37 INFO - "buildid", 11:25:37 INFO - "20160219090437", 11:25:37 INFO - "Change" 11:25:37 INFO - ], 11:25:37 INFO - [ 11:25:37 INFO - "builduid", 11:25:37 INFO - "b4fad0d5b31046ab88b309d166c875fe", 11:25:37 INFO - "Change" 11:25:37 INFO - ], 11:25:37 INFO - [ 11:25:37 INFO - "pgo_build", 11:25:37 INFO - "True", 11:25:37 INFO - "Change" 11:25:37 INFO - ] 11:25:37 INFO - ], 11:25:37 INFO - "revision": "b935e0100697" 11:25:37 INFO - } 11:25:37 INFO - ], 11:25:37 INFO - "revision": "b935e0100697" 11:25:37 INFO - } 11:25:37 INFO - } 11:25:37 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2. 11:25:37 INFO - Running post-action listener: _resource_record_post_action 11:25:37 INFO - ##### 11:25:37 INFO - ##### Running download-and-extract step. 11:25:37 INFO - ##### 11:25:37 INFO - Running pre-action listener: _resource_record_pre_action 11:25:37 INFO - Running main action method: download_and_extract 11:25:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/test_packages.json 11:25:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:25:37 INFO - Downloaded 1270 bytes. 11:25:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:25:37 INFO - Using the following test package requirements: 11:25:37 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:25:37 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:25:37 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'jsshell-linux-x86_64.zip'], 11:25:37 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:25:37 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:25:37 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 11:25:37 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 11:25:37 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:25:37 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:25:37 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:25:37 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:25:37 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:25:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:37 INFO - Downloaded 22255993 bytes. 11:25:37 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 11:25:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:25:37 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 11:25:39 INFO - Return code: 0 11:25:39 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 11:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:25:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:39 INFO - Downloaded 22255993 bytes. 11:25:39 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 11:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:25:39 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 11:25:40 INFO - Return code: 0 11:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 11:25:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:41 INFO - Downloaded 11132038 bytes. 11:25:41 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 11:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 11:25:41 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 11:25:41 INFO - Return code: 0 11:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:41 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:25:41 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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 11:25:42 INFO - Downloaded 58332558 bytes. 11:25:42 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:25:42 INFO - mkdir: /builds/slave/test-pgo/properties 11:25:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:25:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:25:42 INFO - Contents: 11:25:42 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - Running post-action listener: set_extra_try_arguments 11:25:42 INFO - ##### 11:25:42 INFO - ##### Running populate-webroot step. 11:25:42 INFO - ##### 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: populate_webroot 11:25:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:42 INFO - '--tppagecycles', 11:25:42 INFO - '7'], 11:25:42 INFO - 'tests': ['tsvgm']}}, 11:25:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:25:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:25:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:25:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['damp', 'tps']}, 11:25:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['damp', 'tps']}, 11:25:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:25:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:42 INFO - 'other': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other_l64': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'other_nol64': {'tests': ['a11yr', 11:25:42 INFO - 'ts_paint', 11:25:42 INFO - 'tpaint', 11:25:42 INFO - 'sessionrestore', 11:25:42 INFO - 'sessionrestore_no_auto_restore']}, 11:25:42 INFO - 'svgr': {'tests': ['tsvgx', 11:25:42 INFO - 'tsvgr_opacity', 11:25:42 INFO - 'tart', 11:25:42 INFO - 'tscrollx', 11:25:42 INFO - 'cart']}, 11:25:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tsvgx', 11:25:42 INFO - 'tsvgr_opacity', 11:25:42 INFO - 'tart', 11:25:42 INFO - 'tscrollx', 11:25:42 INFO - 'cart']}, 11:25:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'tests': ['tp5o']}, 11:25:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s'], 11:25:42 INFO - 'tests': ['tp5o']}, 11:25:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--xperf_path', 11:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:42 INFO - 'tests': ['tp5n']}, 11:25:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:42 INFO - 'talos_options': ['--e10s', 11:25:42 INFO - '--xperf_path', 11:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:42 INFO - 'tests': ['tp5n']}}, 11:25:42 INFO - 'talos.zip': {'path': '', 11:25:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:42 INFO - Running post-action listener: _resource_record_post_action 11:25:42 INFO - ##### 11:25:42 INFO - ##### Running create-virtualenv step. 11:25:42 INFO - ##### 11:25:42 INFO - Running pre-action listener: _resource_record_pre_action 11:25:42 INFO - Running main action method: create_virtualenv 11:25:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:25:42 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 11:25:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:25:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:42 INFO - Using real prefix '/usr' 11:25:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:25:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:45 INFO - Installing pip.................done. 11:25:45 INFO - Return code: 0 11:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:45 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25:45 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 11:25:45 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 11:25:45 INFO - Using env: {'DISPLAY': ':0', 11:25:45 INFO - 'HOME': '/home/cltbld', 11:25:45 INFO - 'LANG': 'en_US.UTF-8', 11:25:45 INFO - 'LANGUAGE': 'en_US:en', 11:25:45 INFO - 'LOGNAME': 'cltbld', 11:25:45 INFO - 'MAIL': '/var/mail/cltbld', 11:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:45 INFO - 'MOZ_NO_REMOTE': '1', 11:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:45 INFO - 'NO_EM_RESTART': '1', 11:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:45 INFO - 'SHELL': '/bin/bash', 11:25:45 INFO - 'SHLVL': '1', 11:25:45 INFO - 'TERM': 'linux', 11:25:45 INFO - 'TMOUT': '86400', 11:25:45 INFO - 'USER': 'cltbld', 11:25:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:45 INFO - '_': '/tools/buildbot/bin/python'} 11:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:25:45 INFO - Cleaning up... 11:25:45 INFO - Return code: 0 11:25:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:45 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25:45 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 11:25:45 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 11:25:45 INFO - Using env: {'DISPLAY': ':0', 11:25:45 INFO - 'HOME': '/home/cltbld', 11:25:45 INFO - 'LANG': 'en_US.UTF-8', 11:25:45 INFO - 'LANGUAGE': 'en_US:en', 11:25:45 INFO - 'LOGNAME': 'cltbld', 11:25:45 INFO - 'MAIL': '/var/mail/cltbld', 11:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:45 INFO - 'MOZ_NO_REMOTE': '1', 11:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:45 INFO - 'NO_EM_RESTART': '1', 11:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:45 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:45 INFO - 'SHELL': '/bin/bash', 11:25:45 INFO - 'SHLVL': '1', 11:25:45 INFO - 'TERM': 'linux', 11:25:45 INFO - 'TMOUT': '86400', 11:25:45 INFO - 'USER': 'cltbld', 11:25:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:45 INFO - '_': '/tools/buildbot/bin/python'} 11:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:45 INFO - Downloading/unpacking psutil>=0.7.1 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:47 INFO - Installing collected packages: psutil 11:25:47 INFO - Running setup.py install for psutil 11:25:47 INFO - building 'psutil._psutil_linux' extension 11:25:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:25:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:25:47 INFO - building 'psutil._psutil_posix' extension 11:25:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:25:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:47 INFO - Successfully installed psutil 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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', '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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:25: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 mozsystemmonitor==0.0.0 11:25:47 INFO - Using env: {'DISPLAY': ':0', 11:25:47 INFO - 'HOME': '/home/cltbld', 11:25:47 INFO - 'LANG': 'en_US.UTF-8', 11:25:47 INFO - 'LANGUAGE': 'en_US:en', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MAIL': '/var/mail/cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SHLVL': '1', 11:25:47 INFO - 'TERM': 'linux', 11:25:47 INFO - 'TMOUT': '86400', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - '_': '/tools/buildbot/bin/python'} 11:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:25:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:25:49 INFO - Installing collected packages: mozsystemmonitor 11:25:49 INFO - Running setup.py install for mozsystemmonitor 11:25:50 INFO - Successfully installed mozsystemmonitor 11:25:50 INFO - Cleaning up... 11:25:50 INFO - Return code: 0 11:25:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:50 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25:50 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 11:25:50 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 11:25:50 INFO - Using env: {'DISPLAY': ':0', 11:25:50 INFO - 'HOME': '/home/cltbld', 11:25:50 INFO - 'LANG': 'en_US.UTF-8', 11:25:50 INFO - 'LANGUAGE': 'en_US:en', 11:25:50 INFO - 'LOGNAME': 'cltbld', 11:25:50 INFO - 'MAIL': '/var/mail/cltbld', 11:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:50 INFO - 'MOZ_NO_REMOTE': '1', 11:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:50 INFO - 'NO_EM_RESTART': '1', 11:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:50 INFO - 'SHELL': '/bin/bash', 11:25:50 INFO - 'SHLVL': '1', 11:25:50 INFO - 'TERM': 'linux', 11:25:50 INFO - 'TMOUT': '86400', 11:25:50 INFO - 'USER': 'cltbld', 11:25:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:50 INFO - '_': '/tools/buildbot/bin/python'} 11:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:25:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Downloading docopt-0.6.1.tar.gz 11:25:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:52 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:52 INFO - Running setup.py install for blobuploader 11:25:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:25:52 INFO - Running setup.py install for requests 11:25:53 INFO - Running setup.py install for docopt 11:25:53 INFO - Successfully installed blobuploader requests docopt 11:25:53 INFO - Cleaning up... 11:25:53 INFO - Return code: 0 11:25:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:53 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25:53 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 11:25:53 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 11:25:53 INFO - Using env: {'DISPLAY': ':0', 11:25:53 INFO - 'HOME': '/home/cltbld', 11:25:53 INFO - 'LANG': 'en_US.UTF-8', 11:25:53 INFO - 'LANGUAGE': 'en_US:en', 11:25:53 INFO - 'LOGNAME': 'cltbld', 11:25:53 INFO - 'MAIL': '/var/mail/cltbld', 11:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:53 INFO - 'MOZ_NO_REMOTE': '1', 11:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:53 INFO - 'NO_EM_RESTART': '1', 11:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:53 INFO - 'SHELL': '/bin/bash', 11:25:53 INFO - 'SHLVL': '1', 11:25:53 INFO - 'TERM': 'linux', 11:25:53 INFO - 'TMOUT': '86400', 11:25:53 INFO - 'USER': 'cltbld', 11:25:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:53 INFO - '_': '/tools/buildbot/bin/python'} 11:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:25:53 INFO - Running setup.py (path:/tmp/pip-11J36E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:25:53 INFO - Running setup.py (path:/tmp/pip-g0Gtov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:25:53 INFO - Running setup.py (path:/tmp/pip-i6l1_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:25:53 INFO - Running setup.py (path:/tmp/pip-eMrecE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:25:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:25:53 INFO - Running setup.py (path:/tmp/pip-ALjA1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:25:54 INFO - Running setup.py (path:/tmp/pip-NL9W34-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:25:54 INFO - Running setup.py (path:/tmp/pip-ThbVJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:25:54 INFO - Running setup.py (path:/tmp/pip-VNDZBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:25:54 INFO - Running setup.py (path:/tmp/pip-EIbIHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:25:54 INFO - Running setup.py (path:/tmp/pip-Ftext4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:25:54 INFO - Running setup.py (path:/tmp/pip-Pi_KS1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:25:54 INFO - Running setup.py (path:/tmp/pip-U1mj21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:25:54 INFO - Running setup.py (path:/tmp/pip-KT2Rpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:25:54 INFO - Running setup.py (path:/tmp/pip-1HmvWx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:25:54 INFO - Running setup.py (path:/tmp/pip-krEegi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:25:54 INFO - Running setup.py (path:/tmp/pip-RiE3sR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:25:54 INFO - Running setup.py (path:/tmp/pip-bKCoIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:25:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:54 INFO - Running setup.py install for manifestparser 11:25:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for mozcrash 11:25:55 INFO - Running setup.py install for mozdebug 11:25:55 INFO - Running setup.py install for mozdevice 11:25:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for mozfile 11:25:55 INFO - Running setup.py install for mozhttpd 11:25:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for mozinfo 11:25:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for mozInstall 11:25:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for mozleak 11:25:55 INFO - Running setup.py install for mozlog 11:25:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:25:55 INFO - Running setup.py install for moznetwork 11:25:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Running setup.py install for mozprocess 11:25:56 INFO - Running setup.py install for mozprofile 11:25:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Running setup.py install for mozrunner 11:25:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Running setup.py install for mozscreenshot 11:25:56 INFO - Running setup.py install for moztest 11:25:56 INFO - Running setup.py install for mozversion 11:25:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:25:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:56 INFO - Cleaning up... 11:25:56 INFO - Return code: 0 11:25:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:56 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:25:56 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 11:25:56 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 11:25:56 INFO - Using env: {'DISPLAY': ':0', 11:25:56 INFO - 'HOME': '/home/cltbld', 11:25:56 INFO - 'LANG': 'en_US.UTF-8', 11:25:56 INFO - 'LANGUAGE': 'en_US:en', 11:25:56 INFO - 'LOGNAME': 'cltbld', 11:25:56 INFO - 'MAIL': '/var/mail/cltbld', 11:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:56 INFO - 'MOZ_NO_REMOTE': '1', 11:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:56 INFO - 'NO_EM_RESTART': '1', 11:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:25:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:25:56 INFO - 'SHELL': '/bin/bash', 11:25:56 INFO - 'SHLVL': '1', 11:25:56 INFO - 'TERM': 'linux', 11:25:56 INFO - 'TMOUT': '86400', 11:25:56 INFO - 'USER': 'cltbld', 11:25:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:56 INFO - '_': '/tools/buildbot/bin/python'} 11:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:25:56 INFO - Running setup.py (path:/tmp/pip-UDcXpd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:25:57 INFO - Running setup.py (path:/tmp/pip-yed5wl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:25:57 INFO - Running setup.py (path:/tmp/pip-AYxFzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:25:57 INFO - Running setup.py (path:/tmp/pip-Vc_rQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:25:57 INFO - Running setup.py (path:/tmp/pip-qGzsNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:25:57 INFO - Running setup.py (path:/tmp/pip-owCApH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:25:57 INFO - Running setup.py (path:/tmp/pip-pZlgPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:25:57 INFO - Running setup.py (path:/tmp/pip-sDUm2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:25:57 INFO - Running setup.py (path:/tmp/pip-0hQITR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:25:57 INFO - Running setup.py (path:/tmp/pip-zkrVuw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:25:57 INFO - Running setup.py (path:/tmp/pip-iRXuMY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:25:57 INFO - Running setup.py (path:/tmp/pip-UZvwRi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:25:57 INFO - Running setup.py (path:/tmp/pip-OGyoln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:25:57 INFO - Running setup.py (path:/tmp/pip-RJq155-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:25:57 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)) 11:25:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:25:57 INFO - Running setup.py (path:/tmp/pip-P2Aduw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:25:58 INFO - Running setup.py (path:/tmp/pip-VqAT37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:25:58 INFO - Running setup.py (path:/tmp/pip-HbAlW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 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)) 11:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:59 INFO - Downloading blessings-1.6.tar.gz 11:25:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:00 INFO - Installing collected packages: blessings 11:26:00 INFO - Running setup.py install for blessings 11:26:00 INFO - Successfully installed blessings 11:26:00 INFO - Cleaning up... 11:26:00 INFO - Return code: 0 11:26:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:26:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:26:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:26:00 INFO - Reading from file tmpfile_stdout 11:26:00 INFO - Current package versions: 11:26:00 INFO - argparse == 1.2.1 11:26:00 INFO - blessings == 1.6 11:26:00 INFO - blobuploader == 1.2.4 11:26:00 INFO - docopt == 0.6.1 11:26:00 INFO - manifestparser == 1.1 11:26:00 INFO - mozInstall == 1.12 11:26:00 INFO - mozcrash == 0.16 11:26:00 INFO - mozdebug == 0.1 11:26:00 INFO - mozdevice == 0.47 11:26:00 INFO - mozfile == 1.2 11:26:00 INFO - mozhttpd == 0.7 11:26:00 INFO - mozinfo == 0.9 11:26:00 INFO - mozleak == 0.1 11:26:00 INFO - mozlog == 3.1 11:26:00 INFO - moznetwork == 0.27 11:26:00 INFO - mozprocess == 0.22 11:26:00 INFO - mozprofile == 0.27 11:26:00 INFO - mozrunner == 6.11 11:26:00 INFO - mozscreenshot == 0.1 11:26:00 INFO - mozsystemmonitor == 0.0 11:26:00 INFO - moztest == 0.7 11:26:00 INFO - mozversion == 1.4 11:26:00 INFO - psutil == 3.1.1 11:26:00 INFO - requests == 1.2.3 11:26:00 INFO - wsgiref == 0.1.2 11:26:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:26:00 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 11:26:00 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 11:26:00 INFO - Using env: {'DISPLAY': ':0', 11:26:00 INFO - 'HOME': '/home/cltbld', 11:26:00 INFO - 'LANG': 'en_US.UTF-8', 11:26:00 INFO - 'LANGUAGE': 'en_US:en', 11:26:00 INFO - 'LOGNAME': 'cltbld', 11:26:00 INFO - 'MAIL': '/var/mail/cltbld', 11:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:00 INFO - 'MOZ_NO_REMOTE': '1', 11:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:00 INFO - 'NO_EM_RESTART': '1', 11:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:00 INFO - 'SHELL': '/bin/bash', 11:26:00 INFO - 'SHLVL': '1', 11:26:00 INFO - 'TERM': 'linux', 11:26:00 INFO - 'TMOUT': '86400', 11:26:00 INFO - 'USER': 'cltbld', 11:26:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:00 INFO - '_': '/tools/buildbot/bin/python'} 11:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 INFO - Cleaning up... 11:26:00 INFO - Return code: 0 11:26:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:26:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:26:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:26:00 INFO - Using env: {'DISPLAY': ':0', 11:26:00 INFO - 'HOME': '/home/cltbld', 11:26:00 INFO - 'LANG': 'en_US.UTF-8', 11:26:00 INFO - 'LANGUAGE': 'en_US:en', 11:26:00 INFO - 'LOGNAME': 'cltbld', 11:26:00 INFO - 'MAIL': '/var/mail/cltbld', 11:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:00 INFO - 'MOZ_NO_REMOTE': '1', 11:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:00 INFO - 'NO_EM_RESTART': '1', 11:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:00 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:00 INFO - 'SHELL': '/bin/bash', 11:26:00 INFO - 'SHLVL': '1', 11:26:00 INFO - 'TERM': 'linux', 11:26:00 INFO - 'TMOUT': '86400', 11:26:00 INFO - 'USER': 'cltbld', 11:26:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:00 INFO - '_': '/tools/buildbot/bin/python'} 11:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:00 INFO - Downloading/unpacking jsonschema 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:02 INFO - Downloading/unpacking functools32 (from jsonschema) 11:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:03 INFO - warning: no files found matching '*.txt' 11:26:03 INFO - no previously-included directories found matching 'build' 11:26:03 INFO - no previously-included directories found matching 'dist' 11:26:03 INFO - no previously-included directories found matching '.git*' 11:26:03 INFO - Installing collected packages: jsonschema, functools32 11:26:03 INFO - Running setup.py install for functools32 11:26:03 INFO - warning: no files found matching '*.txt' 11:26:03 INFO - no previously-included directories found matching 'build' 11:26:03 INFO - no previously-included directories found matching 'dist' 11:26:03 INFO - no previously-included directories found matching '.git*' 11:26:03 INFO - Successfully installed jsonschema functools32 11:26:03 INFO - Cleaning up... 11:26:03 INFO - Return code: 0 11:26:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:03 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 0x7fd8da1fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', '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 11:26:03 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 11:26:03 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 11:26:03 INFO - Using env: {'DISPLAY': ':0', 11:26:03 INFO - 'HOME': '/home/cltbld', 11:26:03 INFO - 'LANG': 'en_US.UTF-8', 11:26:03 INFO - 'LANGUAGE': 'en_US:en', 11:26:03 INFO - 'LOGNAME': 'cltbld', 11:26:03 INFO - 'MAIL': '/var/mail/cltbld', 11:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:03 INFO - 'MOZ_NO_REMOTE': '1', 11:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:03 INFO - 'NO_EM_RESTART': '1', 11:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:03 INFO - 'SHELL': '/bin/bash', 11:26:03 INFO - 'SHLVL': '1', 11:26:03 INFO - 'TERM': 'linux', 11:26:03 INFO - 'TMOUT': '86400', 11:26:03 INFO - 'USER': 'cltbld', 11:26:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:03 INFO - '_': '/tools/buildbot/bin/python'} 11:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:03 INFO - Downloading/unpacking flake8 11:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:26:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:26:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:05 INFO - no previously-included directories found matching 'docs/_build' 11:26:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:26:06 INFO - Running setup.py install for pep8 11:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:06 INFO - no previously-included directories found matching 'docs/_build' 11:26:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:26:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:26:06 INFO - Cleaning up... 11:26:06 INFO - Return code: 0 11:26:06 INFO - Running post-action listener: _resource_record_post_action 11:26:06 INFO - Running post-action listener: _start_resource_monitoring 11:26:06 INFO - Starting resource monitoring. 11:26:06 INFO - ##### 11:26:06 INFO - ##### Running install step. 11:26:06 INFO - ##### 11:26:06 INFO - Running pre-action listener: _resource_record_pre_action 11:26:06 INFO - Running main action method: install 11:26:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:26:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:26:06 INFO - Reading from file tmpfile_stdout 11:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:26:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:26:06 INFO - Reading from file tmpfile_stdout 11:26:06 INFO - Output received: 11:26:06 INFO - Usage: mozinstall [options] installer 11:26:06 INFO - Options: 11:26:06 INFO - -h, --help show this help message and exit 11:26:06 INFO - -d DEST, --destination=DEST 11:26:06 INFO - Directory to install application into. [default: 11:26:06 INFO - "/builds/slave/test-pgo"] 11:26:06 INFO - --app=APP Application being installed. [default: firefox] 11:26:06 INFO - mkdir: /builds/slave/test-pgo/build/application 11:26:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:26:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:26:21 INFO - Reading from file tmpfile_stdout 11:26:21 INFO - Output received: 11:26:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:26:21 INFO - Running post-action listener: _resource_record_post_action 11:26:21 INFO - ##### 11:26:21 INFO - ##### Running run-tests step. 11:26:21 INFO - ##### 11:26:21 INFO - Running pre-action listener: _resource_record_pre_action 11:26:21 INFO - Running main action method: run_tests 11:26:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:26:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:26:21 INFO - Python 2.7.3 11:26:21 INFO - Return code: 0 11:26:21 INFO - grabbing minidump binary from tooltool 11:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0350>, '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 0x1cb1250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb16e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:26:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:26:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:26:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:21 INFO - Return code: 0 11:26:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:26:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:26:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:26:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:26:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:26:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:26:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:26:22 INFO - Return code: 0 11:26:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:26:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 11:26:22 INFO - Using env: {'DISPLAY': ':0', 11:26:22 INFO - 'HOME': '/home/cltbld', 11:26:22 INFO - 'LANG': 'en_US.UTF-8', 11:26:22 INFO - 'LANGUAGE': 'en_US:en', 11:26:22 INFO - 'LOGNAME': 'cltbld', 11:26:22 INFO - 'MAIL': '/var/mail/cltbld', 11:26:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:26:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:22 INFO - 'MOZ_NO_REMOTE': '1', 11:26:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:22 INFO - 'NO_EM_RESTART': '1', 11:26:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:26:22 INFO - 'SHELL': '/bin/bash', 11:26:22 INFO - 'SHLVL': '1', 11:26:22 INFO - 'TERM': 'linux', 11:26:22 INFO - 'TMOUT': '86400', 11:26:22 INFO - 'USER': 'cltbld', 11:26:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245', 11:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:22 INFO - '_': '/tools/buildbot/bin/python'} 11:26:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 11:26:22 INFO - mozversion INFO | application_buildid: 20160219090437 11:26:22 INFO - mozversion INFO | application_changeset: b935e0100697bde8bfc19d56a7ae6beb8722dff5 11:26:22 INFO - mozversion INFO | application_display_name: Nightly 11:26:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:22 INFO - mozversion INFO | application_name: Firefox 11:26:22 INFO - mozversion INFO | application_remotingname: firefox 11:26:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:26:22 INFO - mozversion INFO | application_vendor: Mozilla 11:26:22 INFO - mozversion INFO | application_version: 45.0 11:26:22 INFO - mozversion INFO | platform_buildid: 20160219090437 11:26:22 INFO - mozversion INFO | platform_changeset: b935e0100697bde8bfc19d56a7ae6beb8722dff5 11:26:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:26:22 INFO - mozversion INFO | platform_version: 45.0 11:26:22 INFO - 2016-02-19 11:26:22,442 DEBUG : using testdate: 1455909982 11:26:22 INFO - 2016-02-19 11:26:22,442 DEBUG : actual date: 1455909982 11:26:22 INFO - 2016-02-19 11:26:22,519 INFO : starting webserver on 'localhost:45852' 11:26:22 INFO - 2016-02-19 11:26:22,520 INFO : Starting test suite talos-linux64-ix-023 11:26:22 INFO - 2016-02-19 11:26:22,520 INFO : Starting test dromaeo_css 11:26:22 INFO - 2016-02-19 11:26:22,520 DEBUG : operating with platform_type : linux_ 11:26:22 INFO - 2016-02-19 11:26:22,521 INFO : Initialising browser for dromaeo_css test... 11:26:22 INFO - 2016-02-19 11:26:22,536 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAkQocv/profile http://localhost:45852/getInfo.html 11:26:26 INFO - 2016-02-19 11:26:26,333 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:26:26 INFO - 2016-02-19 11:26:26,333 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:26:26 INFO - 2016-02-19 11:26:26,333 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:26:26 INFO - 2016-02-19 11:26:26,333 DEBUG : BROWSER_OUTPUT: __metrics 11:26:26 INFO - 2016-02-19 11:26:26,490 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] 11:26:27 INFO - 2016-02-19 11:26:27,372 INFO : Browser initialized. 11:26:27 INFO - 2016-02-19 11:26:27,372 INFO : Running cycle 1/1 for dromaeo_css test... 11:26:27 INFO - 2016-02-19 11:26:27,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAkQocv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:26:39 INFO - 2016-02-19 11:26:39,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 133124096 11:26:39 INFO - 2016-02-19 11:26:39,048 DEBUG : BROWSER_OUTPUT: 11:27:29 INFO - 2016-02-19 11:27:29,992 DEBUG : BROWSER_OUTPUT: 1455910049990 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:29:38 INFO - 2016-02-19 11:29:38,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45852/tests/dromaeo/cssquery-ext.html) 11:29:39 INFO - 2016-02-19 11:29:39,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 246853632 11:29:39 INFO - 2016-02-19 11:29:39,628 DEBUG : BROWSER_OUTPUT: 11:32:41 INFO - 2016-02-19 11:32:41,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-ext.html (next: http://localhost:45852/tests/dromaeo/cssquery-jquery.html) 11:32:42 INFO - 2016-02-19 11:32:42,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 218935296 11:32:42 INFO - 2016-02-19 11:32:42,337 DEBUG : BROWSER_OUTPUT: 11:35:44 INFO - 2016-02-19 11:35:44,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45852/tests/dromaeo/cssquery-mootools.html) 11:35:44 INFO - 2016-02-19 11:35:44,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 213131264 11:35:44 INFO - 2016-02-19 11:35:44,735 DEBUG : BROWSER_OUTPUT: 11:38:46 INFO - 2016-02-19 11:38:46,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45852/tests/dromaeo/cssquery-prototype.html) 11:38:46 INFO - 2016-02-19 11:38:46,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 196952064 11:38:46 INFO - 2016-02-19 11:38:46,972 DEBUG : BROWSER_OUTPUT: 11:41:49 INFO - 2016-02-19 11:41:49,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45852/tests/dromaeo/cssquery-yui.html) 11:41:49 INFO - 2016-02-19 11:41:49,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 197337088 11:41:49 INFO - 2016-02-19 11:41:49,877 DEBUG : BROWSER_OUTPUT: 11:44:51 INFO - 2016-02-19 11:44:51,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/dromaeo/cssquery-yui.html (next: http://localhost:45852/tests/dromaeo/cssquery-dojo.html) 11:44:52 INFO - 2016-02-19 11:44:52,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 234860544 11:44:52 INFO - 2016-02-19 11:44:52,229 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,230 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:44:52 INFO - 2016-02-19 11:44:52,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:44:52 INFO - 2016-02-19 11:44:52,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:44:52 INFO - 2016-02-19 11:44:52,231 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:44:52 INFO - 2016-02-19 11:44:52,232 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3300.900972970811;3365.915852103699;3385.898423047308;3388.932221355573;3418.0087774545377;5544.112941929292;5577.2191893135;5603.467670571295;5611.523020543248;5611.635243709156;5565.749541270642;5607.046802043652;5614.017546929292;5615.5507559395255;5628.26832511774;4907;4965.255211718235;5074.086664400415;5102.31118798963;5152.845414637548;5077;5123.948760512384;5136.255242989764;5142.151544995071;5153.484651534854;4982.103221420143;5071.898562028758;5119.846404607849;5170.612204084689;5180.11937970544;5004.699718016931;5083.212102124158;5103.362079740033;5104.3619547556555;5105.540501354896;5044.621653376012;5146.511081447256;5147.253648221024;5148.665336753099;5158.303629010074;5313.628046036779;5332.493413125747;5403.648762830443;5445.428230035868;5459.044667183227;5947.37552556984;5983.042713165916;5990.610610310316;6003.0695242237525;6005.549583781234;5940.435658612425;6025.879482410327;6026.758929642809;6029.125776762345;6032.758689652409;5472.808451704172;5543.390227075059;5604.747786349624;5643.153526970905;5682.829515114512;6076.088586712029;6190.969045154746;6192.380761923861;6193.504519638418;6202.658853763086;5734.62724922887;6011.789587364421;6019.759209631566;6022.57841951068;6024.548158888101;5875.294964604275;5887.705614719247;5966.552508561876;5967.701614919237;6004.819855404345;5986.161937328778;6022.126791615191;6054.51563874889;6067.332593414721;6069.969650151721;5865.970670146622;5920.674362909996;6060.818175454743;6065.423784740443;6065.666388348595;4577.588017078412;4583.060472603109;4583.495815460296;4583.610393116623;4584.358189853423;4086.427900093989;4133.379993001014;4134.069834287261;4154.397612346193;4184.372344148402;5716.342620598602;5768.826935191951;5772.826815195551;5783.103618939072;5785.103308987113;6078.392160783975;6129.049997250433;6152.784652537229;6153.476954458921;6156;5473.042217611902;5539.833804985777;5556.527695145877;5620.887582248414;5656.547476201894;5269.841904742864;5288.101022826128;5288.338957630296;5312.468753124656;5314.1497360422145;5954.493868021266;6214.4407003369915;6220.191375121296;6220.471259942956;6220.657863817443;6066.1204125402455;6077.908831367445;6180.845478863064;6185.505159587132;6185.84535386619;6112.908306375319;6157.96921015392;6186.597871138361;6194.5044396449075;6196.938030619816;5787.826365208882;5898.941010590011;5964.612300200473;5972.432618901197;6022.849428764316;5884.205632239593;5977.731002104829;5991.820245392645;5992.49063829562;6022.277326720821;5874.735636896265;5985.820425387245;6000.459958603747;6000.639961602318;6007.48936340416;5650.63270887391;5701.743421545957;5835.153902684172;5958.255218097738;5983.461488466059;5829.912551311819;5877.853053673693;5881.500072493886;5886.735096920564;5887.646741195542;5940.524758019262;5962.940370596412;5984.1921340618455;5993.041113422006;5994.460498555151;5553.08374118266;5676.290463692038;5757.251557297524;5860.794872179454;5909.763609455574 11:44:52 INFO - 2016-02-19 11:44:52,232 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.3416173344393;601.6811090122235;607.2136583124853;612.7334609444891;613.0528333724395;40646.593534064654;41426;41499.79250103745;41588.792056039754;41639.58360416395;47445.525544744625;48068.27897581539;48258.517414825845;48281;48356.51643483564;8112.756617301461;8231.42380033398;9059.773505662379;9236.26109911209;10181.440020798853;10189.745256368577;10220.540075696574;10318.793624127513;10328.483575821216;10337.483125843715;10470.895291047107;10579;10579.894201058007;10582.894171058306;10584.047435730783;10379.948100259488;10467.73830654236;10481.947590262076;10495.842562361571;10496.790064198749;10153.746156346077;10652.840207396895;10706.036456718934;10727.034566888939;10733;44216.3367549487;44366.77816610929;44590.33114503285;44602.33096503555;44614.77692611549;3597.5503062117236;3661.835217415223;3946.3291240488898;4158.584141585818;4160.83356665736;32623.51064734031;32879.83560082208;33021.33957320864;33058.33883322344;34701.65298347035;4211.886947227131;4223.472065991751;4285.1429714057;4292.441982542249;4345.196138714348;295707.99999999785;298497;298662;298839;298886.99999999785;63293.36706632875;63445.36554634394;63612.68193659002;63671;63720.68139659272;68095.65952170208;68414;68539;68618;68626;15919.840801591836;16187.190640468165;16209.918950405172;16264.268107935171;16324.75512867308;12228.327441990776;12249.326287054297;12261.080418968435;12270.938645306895;12283.324417157142;20452.181912723623;20976.79023209779;21005.36983890486;21053.47366315824;21086.683699744517;7875.724349647735;7899.210078992055;7924.683012679544;7959.3234575060615;8112.837743245102;1003.7039073473343;1011.6560369474414;1046.581367453025;1129.079799963044;1147.2294409002166;29536.704632953824;29696;29912.40175196484;30241.546376804366;30781.692183078332;1097.2154909239932;1105.3367979212408;1135.5401062569672;1175.2008634128874;1256.0454054918146;13512.882539650986;14546.854531454761;14745.11529308245;15137.523779327856;15594.29825657848;359566;361012;362338;362865;363881.1805940953;57767.42232577704;58077;58088.4191158083;58188.70905645445;58231;1432.7994080828691;1436.1670231265841;1439.3163247457373;1439.474591773995;1458.4166333466699;29879.850600746857;30725.385492290476;31104.22239444032;32442.675573243967;32814.34371312513;44741;44792.10415791601;45120.0975980472;45220.321695175255;45247.095058098;222938.65592016457;224638;225071;225724;226090;31058.68941310558;31369.686303136677;31940.20149496281;34051;34394.31211375808;43223.35164972591;44105.55894441014;44537.777311113234;45434.77282613566;46636.53363466322;37085.814570926974;37136.62863371332;37249.81375093107;37268.440973385965;40172.1965560693;36825.44761828521;37975.2404951905;38436.23127537378;38443.42334865035;38469.6153038466;37199.62800371962;37446.25107497889;37506;37557.62442375541;37787.81106094452;32952.34095318128;32954.670453296116;34351.82824085864;46261.30608040815;47276.52723472721;32122.19694507656;32431.351372971938;33073.007809764786;34255.657443426244;36685.63314366929 11:44:52 INFO - 2016-02-19 11:44:52,234 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.49256257770713;374.97375183737114;375.1465416178194;377.19845328676564;377.3038743518208;15325.616859578517;15412.69174616507;17517.29930802768;18990;19036.143373548188;15132.394704211845;17845.464636060908;18571.814281857176;18785.342513012012;18970.810291897076;5042.218456139304;5345.866353341159;5637.3517045539675;5755.39568345324;5761.971190144043;4324.589164029412;4487.708298960573;6172.105044768506;6361.141245931809;6361.650109244013;5322.414534401213;6243.469305109071;6270.153529273558;6274.027525733496;6286.874262514747;5382.811601593926;5384.488473595002;5392.811251606214;5404.864878378033;5415.566754659618;5205.9219111713355;5345.412004679482;5459.590530710173;5496.367917689477;5512.641678290938;12996.415161317764;13211.669708257274;14831.48089816862;20478.18087276507;20501.58996820055;2186.3331683836423;2221.1448592292086;2349.5183487385043;2352.470694093832;2408.6146216605257;8631.568421578959;9082.954585227099;10356;10427.530761115691;11382.71543211418;1714.6484970581;1778.6264884374298;1834.8623853211063;1912.6079153773444;1997.4307322413042;61334;62997.99999999954;63340.68329658322;63607;64453;10840.295380800222;11093.722656933642;11143.2199746017;11174.66476005721;11248.987591116675;14645.267736613127;14717.337719802634;14726.705465890836;14728.779068313985;14738;8125.187481251945;8154.592270386457;8170.591470426455;8195.344372450309;8210.343172546181;7701.730439434593;7709.614519274014;7728.343090837229;7738;7764.145943946161;4308.655307575386;4721;4797.520247975174;4802.471728109905;4842.854714358575;1742.5607696783036;1884.9434516964513;1977.3178253502806;2023.453667509764;2029.2998915374171;997.4264797741328;1015.3146626027402;1077.6120596585224;1078.784243151373;1108.855848739675;14071.85928140726;16537.255823487973;17057.061861597733;17263.56841078958;18327.541811454554;998.0967224661692;1005.9446730429751;1023.6007956896816;1031.9329243599143;1045.749020235138;9350.298727595458;9535.713928582014;9606.375585586915;9875.901240987498;10135.138513226311;625544;636851;647691;675809;681011;76464.61767691126;78098.21901781023;78960;82968.58515707383;87215;1200.9819852702217;1223.9840932026398;1226.693326668333;1227.858796238444;1233.4881024374963;15522.611934701723;16057.919710401373;16256.51230463088;16395.918020409823;16617.0860602668;35954;36915.63084369122;37145.071373215884;37850.810745946095;38725.61274387333;45018.77490612526;47075.52924470711;47397;47597.76201118972;49146.262806057224;8642.308615310885;10165.33925294883;10208.387496750218;10816.837747433638;10817.729556761144;18431.07844607791;18609.255629774656;18750.812491874905;19023.809761902205;19064.523386914883;15053.849461505244;15071.54785356441;15706.2932168055;15915;16093.436729714404;10839.837402438812;15186;15209;15706.057636541844;15861.206939653202;14357.353919073457;14829.851701482847;15459;15645.374185032471;15656.4520241791;9988.950055249968;10106.595736170471;10132.138768204784;10133.493325333851;10141.442220677638;14151.787723183954;14402.063865848686;14628.488002919847;14763.778543321643;15090.849091509384 11:44:52 INFO - 2016-02-19 11:44:52,235 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1543.9614009649758;1546.8607825295721;1631.7797097391851;1673.5899704572378;1701.4130125106833;7680.769576912695;7879.290863822248;7882.802929926755;7893.565853878034;7898.802529936755;6915.757948471804;7007;7525;7641.388688904888;7704.768856934301;2303.53929214157;2310.688057112285;2340.2862127051244;2342.6603142544323;2343.660169275454;2067.5348046689523;2340.3564019894493;2341.262502311775;2406.4104294447884;2406.9879650601724;2072.253988564116;2287.9885600571974;2337.123578658003;2337.649352597107;2339.988300058506;2286.2912497125944;2310.9653355199684;2315.78000089992;2327.7672232776586;2333.1134169015836;2284.5316710074394;2289.175896677195;2294.9196778112855;2303.6890019847274;2326.150954901466;7709.575973321521;7780.338671212954;7783.571903545303;7785.922140778576;7792.532448053078;4726.102040612307;4833.613310935117;4834.758262086917;4835.298881662175;4836;3021.214484234093;3076.2463196516997;3079.307155889929;3130.7025832545874;3237.1745204972817;1057.5399701130034;1072.9463526823706;1073.3720773347602;1089.9128069754402;1107.457345900511;10432.530536125892;10610.416427096583;10612.893871061267;10613.46932653372;10617.044465998097;4264.744115353089;4278.4010238566625;4405.867823965286;4413.492448368479;4414.359917811899;8701.825963480695;8746.781330466789;8754.430961987451;8758.036615972238;8782.473051616924;4801.591864691471;4811.398575178103;4835.661503694708;4843.128236917389;4844.079624871263;4402.845900393535;4482.8655140345845;4494.70784399013;4496.437945256843;4496.550344965477;3497.9300413991577;3499.562554680665;3506.0708912138302;3526.0479670488826;3541.1678255609913;1024.3802499487851;1032.9586816527406;1034.379372376568;1047.3925123428394;1051.232600201857;1162.7325715085578;1183.9230450020893;1200.8258802473592;1443.314425647809;1462.1154201708025;7325.890111648329;7358.96320518394;7435.962820185972;7477.887831682529;7515.586642734702;673.4376795375916;675.0414411535534;686.8729285082176;692.8129405060605;828.9419740618099;5850.707464626752;5994.100884867305;6003.879922401527;6004;6006.729697163638;8968.103189681111;9081.137291957253;9123.361364704408;9285;9289.489078100634;9145.725628231165;9207.355485115977;9281.489518076436;9289.628414863464;9294.44233345988;6984.965075174591;7096.858062838714;7171.103612048494;7380.372668323145;7435.925640743523;7402.703891844266;7474.439417043634;7479.70081196746;7480.102387713291;7480.4389670776;8131.715389961323;8325.875111873447;8326.542040187847;8335.249827515552;8349.540775257175;8222.465539739898;8246.83506329882;8283.751487455385;8401.95799021001;8423.073461919306;6846.5892046477375;7073.045138906182;7095.325944035309;7095.46783991213;7102.218755936739;7460.7015719372785;7528.360089392463;7544.396448284234;7545.207753185837;7563.394928405824;6022.488088512526;6937.202221744362;7113.893291600733;7157.391621712004;7245.927540724736;6886.10480637514;6938.167419909643;6983.790486285419;7012.789616311519;7033.366996970297;6998.895016574857;7066.505344625827;7128.607926564089;7137.536060156073;7138.428925686037;6500.609963402211;6522.630247647858;6551.050097735897;6567.113439685772;6568.6058836469965;6593.241777195492;6603.80188594343;6662.600243985376;6672.866542669217;6673.9666301668185 11:44:52 INFO - 2016-02-19 11:44:52,236 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.2069048082247;343.29966867590116;343.8435511842112;344.29247895574616;353.4239190120106;6168.907466388002;6193.597416167946;6214.440700336969;6221.471174950123;6227.688615569215;5889.85275368116;5922.141289513029;6087.239095113111;6168.074788781685;6181.165542651741;4650.6744527882975;4664.346991421204;4670.859874203779;4699.107169637775;4722.858314250578;4713.622910167195;4720.268358404453;4725.291206319045;4731.858044258661;4740.668153229275;4445.733256004634;4558.61251793598;4559.270516717326;4667.6265898728025;4713.245880659095;4662.230731929228;4681.0403867207315;4681.906361872743;4692.131955588227;4695.413073365829;4114.300568903293;4118.258713431581;4122.381642753581;4125.484314460692;4132.607402296777;5827.184194212814;5900.616459930134;5903.439173278532;5916.3787802281;5917.260342457193;5509.393966663663;5513.696746678931;5520.861978450531;5523.585731070146;5526.281583394133;6539.6403197824575;6543.411093001605;6545.967270163666;6549;6563.442107420875;4623.214053610861;4626.167289887819;4626.768661566908;4628.004978929513;4630.166570017395;6532.444742196919;6722.49581281401;6774.932250677529;6784.626845523544;6788.8302792430095;4597.885052873705;4640.048789998043;4642.605378542862;4646.697964632355;4652.232381657056;4694.061187762393;4707.176244157259;4707.882302942454;4708.411448568929;4715.905681886343;5455.727213639381;5456.236126942231;5461.2627295315415;5462.044142275086;5466.262054622654;6478.611283323015;6588.505862060365;6590.736370545221;6595.274519802818;6601.3068627794355;1625.7236269834157;1652.9586760330847;1653.4295667994763;1655.2303179021812;1657.6436066245574;1080.56777289085;1080.983785243222;1083.8265877459569;1084.4198353880636;1101.3116801998751;6360.586561873463;6366.77716279928;6368.872622547523;6370.681465926685;6375.71309291083;6776.593404395752;6834.453243740489;6841.589504629738;6843.623600702009;6848.6918088686125;6156.445919867234;6317.052442133717;6325.3674632537295;6416.230052393649;6425.871482570323;3682.613325600827;3697.8335974881193;3699.3341198584512;3707.7775333480076;3710.257948410329;6914.662130083918;6987.161540615159;7002.75490357835;7025.5784652919965;7026.683799229047;6978.720851165998;7028.824279392954;7033.050538177383;7033.683484243222;7037.261087585832;7014.684339204748;7016.824579385454;7019.859602808017;7020.613866237304;7023.648817559204;6662.600243985376;6857.348551887562;6859.794206173823;6860.382565569123;6869;6775.424088952297;6785.491088168308;6791.151106111736;6797.796066118024;6799.048133261446;6876.346747059021;6884.105066341343;6895.965520172367;6911.619860907497;7020.824479387852;4560;4585.656075794262;4629.86110416688;4635.7218566886095;4644.303354496852;6883.931160688329;6889.586624802528;6889.931100689129;6891.069705589882;6898.1377327834025;6673.9332606673315;6676.165479315086;6681.198256209286;6682.69927853238;6683.198016238082;6573.605583664996;6636.27001029896;6695.832604184934;6696.129503164558;6705.228898676714;6575.80272591823;6583.736650534117;6587.374199451045;6588.176477940257;6588.967055164885;6725.260221375743;6725.4619630430425;6728.764493242713;6732.124823772878;6742;6448.25845027809;6577.309382514767;6588.670566471753;6589.571677840925;6592.110065141144 11:44:52 INFO - 2016-02-19 11:44:52,236 DEBUG : BROWSER_OUTPUT: |5;yui.html;808.531051989846;880.0935036911978;929.5305870535378;938.1416004356015;940.0646356874909;14077.225752583603;14178.85821141787;14461.63845903853;15784.99999999997;15813.525594232162;14234.501792437266;14331.068480548756;14359.856401435982;14415.495457658984;14422.134671919692;906.2115959115579;914.1270087066869;914.3919293669702;914.4924566865387;915.0209276074603;760.5702777930479;772.1776308231744;899.2176806178634;919.1360121485816;919.8988111307751;970.8155450464425;974.1622204903813;975.7365511311941;979.0111986893254;979.211734553684;779.7309928074806;793.5119901260683;964.9758756031085;967.5017366056486;968.8207681578931;702.1784512120831;716.0905649824746;716.1120210938451;716.3660160757714;717.3042149115349;14907.254637268094;14931.70136597262;14945;14949.252537373197;14992.850071499255;13121.934390328082;13605.047646664738;13843.377048032862;13936.713709376467;13976.860231397759;10831.2959657622;10857.51141198648;10956.56173753049;11020.889791102147;11096.944515277453;3870.8838734838;3923.27419427404;3924.1955399143108;3924.2151569686175;3925.430812532167;48086.759566202294;48334.51665483371;49129.754351228374;49554.25668614974;49947.50052499465;10879.347239165676;10940.726481838017;10992.450377481095;11013.779724405627;11043.282186657842;19185.32851350196;19353.12910919012;19393.22427102928;19425.22299108048;19484.805151948298;8067.757967260992;8220.917790822135;8300.667973281123;8339.666413343519;8455.873161902577;4238.660907127484;4272.487301523837;4335.263005289045;4336;4365.825366985285;3345.8494367753024;3360.630330663674;3363.9495407568907;3368.2758206985613;3382.9830850845588;587.092941405521;599.3526990849872;599.4784537452445;604.8487878030493;610.3682688417466;618.8762247550508;639.0254861336406;691.2085661917076;702.8629417263585;705.6542294275871;8709.433886797338;8935.28517718581;8965.148310910454;9071.591778369857;9093;622.5082185073741;633.756003938487;689.3416786968434;703.0894990986684;715.1561157833806;3951.8419263229725;4119.814608342632;4210.347396153601;4272.4445822042935;4349.195398851222;62097.68951155306;62156.68921655363;62546.0618090729;62904;62989;53196.73401632967;53905.1914221287;53906.19140712892;53981;54370;47610.52389476061;48770;49002;49420.258696119585;49532.75233623809;9245.72262832116;9464.479453630116;9603.855942161013;9727.708168754949;9738.318317717692;36324.818375907955;36622.63377366299;37028.25943481169;37089.44365834461;37341.626583733814;43682.78158609186;46063;48198.27702584534;48304;48892.75553622209;10687.145028397554;11027.44862756875;11067.225294229327;11537.538498459968;11934.761304774029;13099.738005239651;13368.665783355495;13369.26469044212;13375.197488150741;13383.933080334536;11873.465694043616;12350.876491235333;12543.749125017632;12550.87449125497;12581.433835477243;10938.179636527133;11314.547418103513;11348.659540213806;11352.262102963281;11364.886351136383;11415.543378264776;11877.465514051715;11959.820602691141;12020.098492613264;12287.201331913397;9498.810023799624;9850.556724947251;10156;10214.846777298495;10263.12763415118;10011.242465814461;10070.579791051965;10087.046849483386;10254.897451025394;10365 11:44:52 INFO - 2016-02-19 11:44:52,236 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:44:52 INFO - 2016-02-19 11:44:52,236 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:44:52 INFO - 2016-02-19 11:44:52,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,860 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: __startTimestamp1455911092229__endTimestamp 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,237 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5587.78 Median:5829.91 stddev:625.56 (10.7%) stddev-sans-first:601.20 11:44:52 INFO - 2016-02-19 11:44:52,238 DEBUG : BROWSER_OUTPUT: Values: 3300.9 3365.9 3385.9 3388.9 3418.0 5544.1 5577.2 5603.5 5611.5 5611.6 5565.7 5607.0 5614.0 5615.6 5628.3 4907.0 4965.3 5074.1 5102.3 5152.8 5077.0 5123.9 5136.3 5142.2 5153.5 4982.1 5071.9 5119.8 5170.6 5180.1 5004.7 5083.2 5103.4 5104.4 5105.5 5044.6 5146.5 5147.3 5148.7 5158.3 5313.6 5332.5 5403.6 5445.4 5459.0 5947.4 5983.0 5990.6 6003.1 6005.5 5940.4 6025.9 6026.8 6029.1 6032.8 5472.8 5543.4 5604.7 5643.2 5682.8 6076.1 6191.0 6192.4 6193.5 6202.7 5734.6 6011.8 6019.8 6022.6 6024.5 5875.3 5887.7 5966.6 5967.7 6004.8 5986.2 6022.1 6054.5 6067.3 6070.0 5866.0 5920.7 6060.8 6065.4 6065.7 4577.6 4583.1 4583.5 4583.6 4584.4 4086.4 4133.4 4134.1 4154.4 4184.4 5716.3 5768.8 5772.8 5783.1 5785.1 6078.4 6129.0 6152.8 6153.5 6156.0 5473.0 5539.8 5556.5 5620.9 5656.5 5269.8 5288.1 5288.3 5312.5 5314.1 5954.5 6214.4 6220.2 6220.5 6220.7 6066.1 6077.9 6180.8 6185.5 6185.8 6112.9 6158.0 6186.6 6194.5 6196.9 5787.8 5898.9 5964.6 5972.4 6022.8 5884.2 5977.7 5991.8 5992.5 6022.3 5874.7 5985.8 6000.5 6000.6 6007.5 5650.6 5701.7 5835.2 5958.3 5983.5 5829.9 5877.9 5881.5 5886.7 5887.6 5940.5 5962.9 5984.2 5993.0 5994.5 5553.1 5676.3 5757.3 5860.8 5909.8 11:44:52 INFO - 2016-02-19 11:44:52,238 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,238 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48530.61 Median:34373.07 stddev:78482.24 (228.3%) stddev-sans-first:78619.76 11:44:52 INFO - 2016-02-19 11:44:52,239 DEBUG : BROWSER_OUTPUT: Values: 564.3 601.7 607.2 612.7 613.1 40646.6 41426.0 41499.8 41588.8 41639.6 47445.5 48068.3 48258.5 48281.0 48356.5 8112.8 8231.4 9059.8 9236.3 10181.4 10189.7 10220.5 10318.8 10328.5 10337.5 10470.9 10579.0 10579.9 10582.9 10584.0 10379.9 10467.7 10481.9 10495.8 10496.8 10153.7 10652.8 10706.0 10727.0 10733.0 44216.3 44366.8 44590.3 44602.3 44614.8 3597.6 3661.8 3946.3 4158.6 4160.8 32623.5 32879.8 33021.3 33058.3 34701.7 4211.9 4223.5 4285.1 4292.4 4345.2 295708.0 298497.0 298662.0 298839.0 298887.0 63293.4 63445.4 63612.7 63671.0 63720.7 68095.7 68414.0 68539.0 68618.0 68626.0 15919.8 16187.2 16209.9 16264.3 16324.8 12228.3 12249.3 12261.1 12270.9 12283.3 20452.2 20976.8 21005.4 21053.5 21086.7 7875.7 7899.2 7924.7 7959.3 8112.8 1003.7 1011.7 1046.6 1129.1 1147.2 29536.7 29696.0 29912.4 30241.5 30781.7 1097.2 1105.3 1135.5 1175.2 1256.0 13512.9 14546.9 14745.1 15137.5 15594.3 359566.0 361012.0 362338.0 362865.0 363881.2 57767.4 58077.0 58088.4 58188.7 58231.0 1432.8 1436.2 1439.3 1439.5 1458.4 29879.9 30725.4 31104.2 32442.7 32814.3 44741.0 44792.1 45120.1 45220.3 45247.1 222938.7 224638.0 225071.0 225724.0 226090.0 31058.7 31369.7 31940.2 34051.0 34394.3 43223.4 44105.6 44537.8 45434.8 46636.5 37085.8 37136.6 37249.8 37268.4 40172.2 36825.4 37975.2 38436.2 38443.4 38469.6 37199.6 37446.3 37506.0 37557.6 37787.8 32952.3 32954.7 34351.8 46261.3 47276.5 32122.2 32431.4 33073.0 34255.7 36685.6 11:44:52 INFO - 2016-02-19 11:44:52,239 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,239 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32468.86 Median:2010.44 stddev:106667.99 (5305.7%) stddev-sans-first:106940.00 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: Values: 374.5 375.0 375.1 377.2 377.3 15325.6 15412.7 17517.3 18990.0 19036.1 15132.4 17845.5 18571.8 18785.3 18970.8 5042.2 5345.9 5637.4 5755.4 5762.0 4324.6 4487.7 6172.1 6361.1 6361.7 5322.4 6243.5 6270.2 6274.0 6286.9 5382.8 5384.5 5392.8 5404.9 5415.6 5205.9 5345.4 5459.6 5496.4 5512.6 12996.4 13211.7 14831.5 20478.2 20501.6 2186.3 2221.1 2349.5 2352.5 2408.6 8631.6 9083.0 10356.0 10427.5 11382.7 1714.6 1778.6 1834.9 1912.6 1997.4 61334.0 62998.0 63340.7 63607.0 64453.0 10840.3 11093.7 11143.2 11174.7 11249.0 14645.3 14717.3 14726.7 14728.8 14738.0 8125.2 8154.6 8170.6 8195.3 8210.3 7701.7 7709.6 7728.3 7738.0 7764.1 4308.7 4721.0 4797.5 4802.5 4842.9 1742.6 1884.9 1977.3 2023.5 2029.3 997.4 1015.3 1077.6 1078.8 1108.9 14071.9 16537.3 17057.1 17263.6 18327.5 998.1 1005.9 1023.6 1031.9 1045.7 9350.3 9535.7 9606.4 9875.9 10135.1 625544.0 636851.0 647691.0 675809.0 681011.0 76464.6 78098.2 78960.0 82968.6 87215.0 1201.0 1224.0 1226.7 1227.9 1233.5 15522.6 16057.9 16256.5 16395.9 16617.1 35954.0 36915.6 37145.1 37850.8 38725.6 45018.8 47075.5 47397.0 47597.8 49146.3 8642.3 10165.3 10208.4 10816.8 10817.7 18431.1 18609.3 18750.8 19023.8 19064.5 15053.8 15071.5 15706.3 15915.0 16093.4 10839.8 15186.0 15209.0 15706.1 15861.2 14357.4 14829.9 15459.0 15645.4 15656.5 9989.0 10106.6 10132.1 10133.5 10141.4 14151.8 14402.1 14628.5 14763.8 15090.8 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5457.08 Median:6580.92 stddev:2793.07 (42.4%) stddev-sans-first:2785.42 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: Values: 1544.0 1546.9 1631.8 1673.6 1701.4 7680.8 7879.3 7882.8 7893.6 7898.8 6915.8 7007.0 7525.0 7641.4 7704.8 2303.5 2310.7 2340.3 2342.7 2343.7 2067.5 2340.4 2341.3 2406.4 2407.0 2072.3 2288.0 2337.1 2337.6 2340.0 2286.3 2311.0 2315.8 2327.8 2333.1 2284.5 2289.2 2294.9 2303.7 2326.2 7709.6 7780.3 7783.6 7785.9 7792.5 4726.1 4833.6 4834.8 4835.3 4836.0 3021.2 3076.2 3079.3 3130.7 3237.2 1057.5 1072.9 1073.4 1089.9 1107.5 10432.5 10610.4 10612.9 10613.5 10617.0 4264.7 4278.4 4405.9 4413.5 4414.4 8701.8 8746.8 8754.4 8758.0 8782.5 4801.6 4811.4 4835.7 4843.1 4844.1 4402.8 4482.9 4494.7 4496.4 4496.6 3497.9 3499.6 3506.1 3526.0 3541.2 1024.4 1033.0 1034.4 1047.4 1051.2 1162.7 1183.9 1200.8 1443.3 1462.1 7325.9 7359.0 7436.0 7477.9 7515.6 673.4 675.0 686.9 692.8 828.9 5850.7 5994.1 6003.9 6004.0 6006.7 8968.1 9081.1 9123.4 9285.0 9289.5 9145.7 9207.4 9281.5 9289.6 9294.4 6985.0 7096.9 7171.1 7380.4 7435.9 7402.7 7474.4 7479.7 7480.1 7480.4 8131.7 8325.9 8326.5 8335.2 8349.5 8222.5 8246.8 8283.8 8402.0 8423.1 6846.6 7073.0 7095.3 7095.5 7102.2 7460.7 7528.4 7544.4 7545.2 7563.4 6022.5 6937.2 7113.9 7157.4 7245.9 6886.1 6938.2 6983.8 7012.8 7033.4 6998.9 7066.5 7128.6 7137.5 7138.4 6500.6 6522.6 6551.1 6567.1 6568.6 6593.2 6603.8 6662.6 6672.9 6674.0 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5508.96 Median:6272.37 stddev:1675.01 (26.7%) stddev-sans-first:1634.13 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: Values: 338.2 343.3 343.8 344.3 353.4 6168.9 6193.6 6214.4 6221.5 6227.7 5889.9 5922.1 6087.2 6168.1 6181.2 4650.7 4664.3 4670.9 4699.1 4722.9 4713.6 4720.3 4725.3 4731.9 4740.7 4445.7 4558.6 4559.3 4667.6 4713.2 4662.2 4681.0 4681.9 4692.1 4695.4 4114.3 4118.3 4122.4 4125.5 4132.6 5827.2 5900.6 5903.4 5916.4 5917.3 5509.4 5513.7 5520.9 5523.6 5526.3 6539.6 6543.4 6546.0 6549.0 6563.4 4623.2 4626.2 4626.8 4628.0 4630.2 6532.4 6722.5 6774.9 6784.6 6788.8 4597.9 4640.0 4642.6 4646.7 4652.2 4694.1 4707.2 4707.9 4708.4 4715.9 5455.7 5456.2 5461.3 5462.0 5466.3 6478.6 6588.5 6590.7 6595.3 6601.3 1625.7 1653.0 1653.4 1655.2 1657.6 1080.6 1081.0 1083.8 1084.4 1101.3 6360.6 6366.8 6368.9 6370.7 6375.7 6776.6 6834.5 6841.6 6843.6 6848.7 6156.4 6317.1 6325.4 6416.2 6425.9 3682.6 3697.8 3699.3 3707.8 3710.3 6914.7 6987.2 7002.8 7025.6 7026.7 6978.7 7028.8 7033.1 7033.7 7037.3 7014.7 7016.8 7019.9 7020.6 7023.6 6662.6 6857.3 6859.8 6860.4 6869.0 6775.4 6785.5 6791.2 6797.8 6799.0 6876.3 6884.1 6896.0 6911.6 7020.8 4560.0 4585.7 4629.9 4635.7 4644.3 6883.9 6889.6 6889.9 6891.1 6898.1 6673.9 6676.2 6681.2 6682.7 6683.2 6573.6 6636.3 6695.8 6696.1 6705.2 6575.8 6583.7 6587.4 6588.2 6589.0 6725.3 6725.5 6728.8 6732.1 6742.0 6448.3 6577.3 6588.7 6589.6 6592.1 11:44:52 INFO - 2016-02-19 11:44:52,241 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,242 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14649.51 Median:4342.60 stddev:16835.41 (387.7%) stddev-sans-first:16850.55 11:44:52 INFO - 2016-02-19 11:44:52,242 DEBUG : BROWSER_OUTPUT: Values: 808.5 880.1 929.5 938.1 940.1 14077.2 14178.9 14461.6 15785.0 15813.5 14234.5 14331.1 14359.9 14415.5 14422.1 906.2 914.1 914.4 914.5 915.0 760.6 772.2 899.2 919.1 919.9 970.8 974.2 975.7 979.0 979.2 779.7 793.5 965.0 967.5 968.8 702.2 716.1 716.1 716.4 717.3 14907.3 14931.7 14945.0 14949.3 14992.9 13121.9 13605.0 13843.4 13936.7 13976.9 10831.3 10857.5 10956.6 11020.9 11096.9 3870.9 3923.3 3924.2 3924.2 3925.4 48086.8 48334.5 49129.8 49554.3 49947.5 10879.3 10940.7 10992.5 11013.8 11043.3 19185.3 19353.1 19393.2 19425.2 19484.8 8067.8 8220.9 8300.7 8339.7 8455.9 4238.7 4272.5 4335.3 4336.0 4365.8 3345.8 3360.6 3363.9 3368.3 3383.0 587.1 599.4 599.5 604.8 610.4 618.9 639.0 691.2 702.9 705.7 8709.4 8935.3 8965.1 9071.6 9093.0 622.5 633.8 689.3 703.1 715.2 3951.8 4119.8 4210.3 4272.4 4349.2 62097.7 62156.7 62546.1 62904.0 62989.0 53196.7 53905.2 53906.2 53981.0 54370.0 47610.5 48770.0 49002.0 49420.3 49532.8 9245.7 9464.5 9603.9 9727.7 9738.3 36324.8 36622.6 37028.3 37089.4 37341.6 43682.8 46063.0 48198.3 48304.0 48892.8 10687.1 11027.4 11067.2 11537.5 11934.8 13099.7 13368.7 13369.3 13375.2 13383.9 11873.5 12350.9 12543.7 12550.9 12581.4 10938.2 11314.5 11348.7 11352.3 11364.9 11415.5 11877.5 11959.8 12020.1 12287.2 9498.8 9850.6 10156.0 10214.8 10263.1 10011.2 10070.6 10087.0 10254.9 10365.0 11:44:52 INFO - 2016-02-19 11:44:52,242 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:44:52 INFO - 2016-02-19 11:44:52,242 DEBUG : BROWSER_OUTPUT: 11:44:52 INFO - 2016-02-19 11:44:52,804 INFO : Browser exited with error code: 0 11:44:52 INFO - 2016-02-19 11:44:52,824 INFO : Completed test dromaeo_css (00:18:30) 11:44:52 INFO - 2016-02-19 11:44:52,825 INFO : Starting test kraken 11:44:52 INFO - 2016-02-19 11:44:52,825 DEBUG : operating with platform_type : linux_ 11:44:52 INFO - 2016-02-19 11:44:52,825 INFO : Initialising browser for kraken test... 11:44:52 INFO - 2016-02-19 11:44:52,831 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdwzw3n/profile http://localhost:45852/getInfo.html 11:44:56 INFO - 2016-02-19 11:44:56,557 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:44:56 INFO - 2016-02-19 11:44:56,557 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:44:56 INFO - 2016-02-19 11:44:56,557 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:44:56 INFO - 2016-02-19 11:44:56,557 DEBUG : BROWSER_OUTPUT: __metrics 11:44:56 INFO - 2016-02-19 11:44:56,674 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] 11:44:57 INFO - 2016-02-19 11:44:57,488 INFO : Browser initialized. 11:44:57 INFO - 2016-02-19 11:44:57,488 INFO : Running cycle 1/1 for kraken test... 11:44:57 INFO - 2016-02-19 11:44:57,489 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdwzw3n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:45:09 INFO - 2016-02-19 11:45:09,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 132907008 11:45:09 INFO - 2016-02-19 11:45:09,134 DEBUG : BROWSER_OUTPUT: 11:45:11 INFO - 2016-02-19 11:45:11,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:12 INFO - 2016-02-19 11:45:12,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 164708352 11:45:12 INFO - 2016-02-19 11:45:12,156 DEBUG : BROWSER_OUTPUT: 11:45:14 INFO - 2016-02-19 11:45:14,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-dft) 11:45:15 INFO - 2016-02-19 11:45:15,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 161021952 11:45:15 INFO - 2016-02-19 11:45:15,292 DEBUG : BROWSER_OUTPUT: 11:45:18 INFO - 2016-02-19 11:45:18,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-fft) 11:45:18 INFO - 2016-02-19 11:45:18,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 159752192 11:45:18 INFO - 2016-02-19 11:45:18,745 DEBUG : BROWSER_OUTPUT: 11:45:20 INFO - 2016-02-19 11:45:20,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator) 11:45:21 INFO - 2016-02-19 11:45:21,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 157949952 11:45:21 INFO - 2016-02-19 11:45:21,279 DEBUG : BROWSER_OUTPUT: 11:45:23 INFO - 2016-02-19 11:45:23,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:24 INFO - 2016-02-19 11:45:24,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 158539776 11:45:24 INFO - 2016-02-19 11:45:24,019 DEBUG : BROWSER_OUTPUT: 11:45:26 INFO - 2016-02-19 11:45:26,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:27 INFO - 2016-02-19 11:45:27,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 159416320 11:45:27 INFO - 2016-02-19 11:45:27,423 DEBUG : BROWSER_OUTPUT: 11:45:30 INFO - 2016-02-19 11:45:30,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:31 INFO - 2016-02-19 11:45:31,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 159608832 11:45:31 INFO - 2016-02-19 11:45:31,326 DEBUG : BROWSER_OUTPUT: 11:45:34 INFO - 2016-02-19 11:45:34,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial) 11:45:34 INFO - 2016-02-19 11:45:34,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 158318592 11:45:34 INFO - 2016-02-19 11:45:34,618 DEBUG : BROWSER_OUTPUT: 11:45:36 INFO - 2016-02-19 11:45:36,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:36 INFO - 2016-02-19 11:45:36,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 163475456 11:45:36 INFO - 2016-02-19 11:45:36,748 DEBUG : BROWSER_OUTPUT: 11:45:38 INFO - 2016-02-19 11:45:38,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:39 INFO - 2016-02-19 11:45:39,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 161837056 11:45:39 INFO - 2016-02-19 11:45:39,088 DEBUG : BROWSER_OUTPUT: 11:45:41 INFO - 2016-02-19 11:45:41,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:41 INFO - 2016-02-19 11:45:41,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 166072320 11:45:41 INFO - 2016-02-19 11:45:41,645 DEBUG : BROWSER_OUTPUT: 11:45:44 INFO - 2016-02-19 11:45:43,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:44 INFO - 2016-02-19 11:45:44,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 172351488 11:45:44 INFO - 2016-02-19 11:45:44,581 DEBUG : BROWSER_OUTPUT: 11:45:47 INFO - 2016-02-19 11:45:47,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:47 INFO - 2016-02-19 11:45:47,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 167542784 11:45:47 INFO - 2016-02-19 11:45:47,632 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45852/tests/kraken/driver.html?testName=ai-astar) 11:45:49 INFO - 2016-02-19 11:45:49,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 226144256 11:45:49 INFO - 2016-02-19 11:45:49,528 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;109;111;114;101;112;109;109 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;126;150;155;123;151;147;129;163;122 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;172;171;172;172;173;170;171;171;175 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;71;152;71;71;70;71;152;73 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;92;93;92;136;92;93;134 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;108;110;109;108;109;109;111;109 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;145;145;145;146;145;145 11:45:49 INFO - 2016-02-19 11:45:49,532 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;95;95;95;95 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;55;56;56;57;59;60;55;55 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;62;63;63;64;64;63;64;64;65 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;77;86;79;78;78;79;86;79;78 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;109;118;113;115;118;121;110;120;113 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;141;140;145;144;143;142;141;141;132 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;65;64;65;65;62;63;63;64 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,878 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: __startTimestamp1455911149530__endTimestamp 11:45:49 INFO - 2016-02-19 11:45:49,533 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:45:49 INFO - 2016-02-19 11:45:49,534 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.77 (3.4%) stddev-sans-first:3.98 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 109.0 111.0 114.0 101.0 112.0 109.0 109.0 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:150.50 stddev:15.15 (10.1%) stddev-sans-first:15.61 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: Values: 152.0 126.0 150.0 155.0 123.0 151.0 147.0 129.0 163.0 122.0 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:171.90 Median:172.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: Values: 172.0 172.0 171.0 172.0 172.0 173.0 170.0 171.0 171.0 175.0 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.20 Median:71.00 stddev:34.16 (48.1%) stddev-sans-first:35.66 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 152.0 71.0 71.0 70.0 71.0 152.0 73.0 11:45:49 INFO - 2016-02-19 11:45:49,535 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.50 stddev:20.83 (22.5%) stddev-sans-first:21.60 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 92.0 93.0 92.0 136.0 92.0 93.0 134.0 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 108.0 110.0 109.0 108.0 109.0 109.0 111.0 109.0 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,536 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:1.71 (3.0%) stddev-sans-first:1.80 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 55.0 56.0 56.0 57.0 59.0 60.0 55.0 55.0 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 65.0 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:3.33 (4.2%) stddev-sans-first:3.46 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 86.0 79.0 78.0 78.0 79.0 86.0 79.0 78.0 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:117.00 stddev:4.06 (3.5%) stddev-sans-first:4.29 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 116.0 109.0 118.0 113.0 115.0 118.0 121.0 110.0 120.0 113.0 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:141.50 stddev:3.54 (2.5%) stddev-sans-first:3.74 11:45:49 INFO - 2016-02-19 11:45:49,537 DEBUG : BROWSER_OUTPUT: Values: 140.0 141.0 140.0 145.0 144.0 143.0 142.0 141.0 141.0 132.0 11:45:49 INFO - 2016-02-19 11:45:49,538 DEBUG : BROWSER_OUTPUT: 11:45:49 INFO - 2016-02-19 11:45:49,538 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 11:45:49 INFO - 2016-02-19 11:45:49,538 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 65.0 64.0 65.0 65.0 62.0 63.0 63.0 64.0 11:45:49 INFO - 2016-02-19 11:45:49,538 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:45:49 INFO - 2016-02-19 11:45:49,538 DEBUG : BROWSER_OUTPUT: 11:45:50 INFO - 2016-02-19 11:45:50,172 INFO : Browser exited with error code: 0 11:45:50 INFO - 2016-02-19 11:45:50,220 INFO : Completed test kraken (00:00:57) 11:45:50 INFO - 2016-02-19 11:45:50,220 INFO : Starting test v8_7 11:45:50 INFO - 2016-02-19 11:45:50,220 DEBUG : operating with platform_type : linux_ 11:45:50 INFO - 2016-02-19 11:45:50,221 INFO : Initialising browser for v8_7 test... 11:45:50 INFO - 2016-02-19 11:45:50,227 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplRH7vU/profile http://localhost:45852/getInfo.html 11:45:53 INFO - 2016-02-19 11:45:53,934 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:45:53 INFO - 2016-02-19 11:45:53,934 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:45:53 INFO - 2016-02-19 11:45:53,934 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:45:53 INFO - 2016-02-19 11:45:53,934 DEBUG : BROWSER_OUTPUT: __metrics 11:45:54 INFO - 2016-02-19 11:45:54,056 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] 11:45:54 INFO - 2016-02-19 11:45:54,943 INFO : Browser initialized. 11:45:54 INFO - 2016-02-19 11:45:54,944 INFO : Running cycle 1/1 for v8_7 test... 11:45:54 INFO - 2016-02-19 11:45:54,944 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplRH7vU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:46:06 INFO - 2016-02-19 11:46:06,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 133197824 11:46:06 INFO - 2016-02-19 11:46:06,628 DEBUG : BROWSER_OUTPUT: 11:46:27 INFO - 2016-02-19 11:46:27,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45852/tests/v8_7/run.html (next: http://localhost:45852/tests/v8_7/run.html) 11:46:28 INFO - 2016-02-19 11:46:28,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 424665088 11:46:28 INFO - 2016-02-19 11:46:28,210 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,211 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:46:28 INFO - 2016-02-19 11:46:28,211 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:46:28 INFO - 2016-02-19 11:46:28,211 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:46:28 INFO - 2016-02-19 11:46:28,211 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |0;Richards;167.1402306535183 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.05713308244952 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5102.040816326531 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 11:46:28 INFO - 2016-02-19 11:46:28,212 DEBUG : BROWSER_OUTPUT: |5;Earley;544.069640914037 11:46:28 INFO - 2016-02-19 11:46:28,213 DEBUG : BROWSER_OUTPUT: |6;Boyer;10568.421052631578 11:46:28 INFO - 2016-02-19 11:46:28,213 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 11:46:28 INFO - 2016-02-19 11:46:28,213 DEBUG : BROWSER_OUTPUT: |8;Splay;531.3496280552604 11:46:28 INFO - 2016-02-19 11:46:28,213 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 11:46:28 INFO - 2016-02-19 11:46:28,213 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: __startTimestamp1455911188210__endTimestamp 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,214 DEBUG : BROWSER_OUTPUT: Values: 167.1 11:46:28 INFO - 2016-02-19 11:46:28,215 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,215 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.06 Median:171.06 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,215 DEBUG : BROWSER_OUTPUT: Values: 171.1 11:46:28 INFO - 2016-02-19 11:46:28,215 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,215 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,216 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:46:28 INFO - 2016-02-19 11:46:28,216 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,217 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5102.04 Median:5102.04 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,217 DEBUG : BROWSER_OUTPUT: Values: 5102.0 11:46:28 INFO - 2016-02-19 11:46:28,217 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,218 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,218 DEBUG : BROWSER_OUTPUT: Values: 943.4 11:46:28 INFO - 2016-02-19 11:46:28,218 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,218 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.07 Median:544.07 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,218 DEBUG : BROWSER_OUTPUT: Values: 544.1 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10568.42 Median:10568.42 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: Values: 10568.4 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: Values: 24238.1 11:46:28 INFO - 2016-02-19 11:46:28,219 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:531.35 Median:531.35 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: Values: 531.3 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: Values: 4822.1 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:46:28 INFO - 2016-02-19 11:46:28,220 DEBUG : BROWSER_OUTPUT: 11:46:28 INFO - 2016-02-19 11:46:28,896 INFO : Browser exited with error code: 0 11:46:28 INFO - 2016-02-19 11:46:28,910 INFO : Completed test v8_7 (00:00:38) 11:46:29 INFO - 2016-02-19 11:46:29,286 INFO : Completed test suite (00:20:06) 11:46:29 INFO - 2016-02-19 11:46:29,286 DEBUG : Working with test: dromaeo_css 11:46:29 INFO - 2016-02-19 11:46:29,286 DEBUG : Generating results file: dromaeo_css 11:46:29 INFO - 2016-02-19 11:46:29,288 DEBUG : Working with test: kraken 11:46:29 INFO - 2016-02-19 11:46:29,288 DEBUG : Generating results file: kraken 11:46:29 INFO - 2016-02-19 11:46:29,288 INFO : javascript benchmark 11:46:29 INFO - 2016-02-19 11:46:29,288 DEBUG : Working with test: v8_7 11:46:29 INFO - 2016-02-19 11:46:29,288 DEBUG : Generating results file: v8_7 11:46:29 INFO - 2016-02-19 11:46:29,289 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:46:29 INFO - 2016-02-19 11:46:29,334 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 11:46:29 INFO - 2016-02-19 11:46:29,335 DEBUG : process_Request line: dromaeo_css 7328.50 graph.html#tests=[[72,53,35]] 11:46:29 INFO - 2016-02-19 11:46:29,335 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:46:29 INFO - 2016-02-19 11:46:29,364 DEBUG : process_Request line: kraken 1485.30 graph.html#tests=[[232,53,35]] 11:46:29 INFO - 2016-02-19 11:46:29,364 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:46:29 INFO - 2016-02-19 11:46:29,395 DEBUG : process_Request line: v8_7 23208.37 graph.html#tests=[[230,53,35]] 11:46:29 INFO - 2016-02-19 11:46:29,396 INFO : javascript benchmark 11:46:29 INFO - 2016-02-19 11:46:29,400 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.900972970811, 3365.915852103699, 3385.898423047308, 3388.932221355573, 3418.0087774545377, 5544.112941929292, 5577.2191893135, 5603.467670571295, 5611.523020543248, 5611.635243709156, 5565.749541270642, 5607.046802043652, 5614.017546929292, 5615.5507559395255, 5628.26832511774, 4907.0, 4965.255211718235, 5074.086664400415, 5102.31118798963, 5152.845414637548, 5077.0, 5123.948760512384, 5136.255242989764, 5142.151544995071, 5153.484651534854, 4982.103221420143, 5071.898562028758, 5119.846404607849, 5170.612204084689, 5180.11937970544, 5004.699718016931, 5083.212102124158, 5103.362079740033, 5104.3619547556555, 5105.540501354896, 5044.621653376012, 5146.511081447256, 5147.253648221024, 5148.665336753099, 5158.303629010074, 5313.628046036779, 5332.493413125747, 5403.648762830443, 5445.428230035868, 5459.044667183227, 5947.37552556984, 5983.042713165916, 5990.610610310316, 6003.0695242237525, 6005.549583781234, 5940.435658612425, 6025.879482410327, 6026.758929642809, 6029.125776762345, 6032.758689652409, 5472.808451704172, 5543.390227075059, 5604.747786349624, 5643.153526970905, 5682.829515114512, 6076.088586712029, 6190.969045154746, 6192.380761923861, 6193.504519638418, 6202.658853763086, 5734.62724922887, 6011.789587364421, 6019.759209631566, 6022.57841951068, 6024.548158888101, 5875.294964604275, 5887.705614719247, 5966.552508561876, 5967.701614919237, 6004.819855404345, 5986.161937328778, 6022.126791615191, 6054.51563874889, 6067.332593414721, 6069.969650151721, 5865.970670146622, 5920.674362909996, 6060.818175454743, 6065.423784740443, 6065.666388348595, 4577.588017078412, 4583.060472603109, 4583.495815460296, 4583.610393116623, 4584.358189853423, 4086.427900093989, 4133.379993001014, 4134.069834287261, 4154.397612346193, 4184.372344148402, 5716.342620598602, 5768.826935191951, 5772.826815195551, 5783.103618939072, 5785.103308987113, 6078.392160783975, 6129.049997250433, 6152.784652537229, 6153.476954458921, 6156.0, 5473.042217611902, 5539.833804985777, 5556.527695145877, 5620.887582248414, 5656.547476201894, 5269.841904742864, 5288.101022826128, 5288.338957630296, 5312.468753124656, 5314.1497360422145, 5954.493868021266, 6214.4407003369915, 6220.191375121296, 6220.471259942956, 6220.657863817443, 6066.1204125402455, 6077.908831367445, 6180.845478863064, 6185.505159587132, 6185.84535386619, 6112.908306375319, 6157.96921015392, 6186.597871138361, 6194.5044396449075, 6196.938030619816, 5787.826365208882, 5898.941010590011, 5964.612300200473, 5972.432618901197, 6022.849428764316, 5884.205632239593, 5977.731002104829, 5991.820245392645, 5992.49063829562, 6022.277326720821, 5874.735636896265, 5985.820425387245, 6000.459958603747, 6000.639961602318, 6007.48936340416, 5650.63270887391, 5701.743421545957, 5835.153902684172, 5958.255218097738, 5983.461488466059, 5829.912551311819, 5877.853053673693, 5881.500072493886, 5886.735096920564, 5887.646741195542, 5940.524758019262, 5962.940370596412, 5984.1921340618455, 5993.041113422006, 5994.460498555151, 5553.08374118266, 5676.290463692038, 5757.251557297524, 5860.794872179454, 5909.763609455574], "unit": "ms", "name": "dojo.html", "value": 5547.063524035121}, {"lowerIsBetter": false, "replicates": [564.3416173344393, 601.6811090122235, 607.2136583124853, 612.7334609444891, 613.0528333724395, 40646.593534064654, 41426.0, 41499.79250103745, 41588.792056039754, 41639.58360416395, 47445.525544744625, 48068.27897581539, 48258.517414825845, 48281.0, 48356.51643483564, 8112.756617301461, 8231.42380033398, 9059.773505662379, 9236.26109911209, 10181.440020798853, 10189.745256368577, 10220.540075696574, 10318.793624127513, 10328.483575821216, 10337.483125843715, 10470.895291047107, 10579.0, 10579.894201058007, 10582.894171058306, 10584.047435730783, 10379.948100259488, 10467.73830654236, 10481.947590262076, 10495.842562361571, 10496.790064198749, 10153.746156346077, 10652.840207396895, 10706.036456718934, 10727.034566888939, 10733.0, 44216.3367549487, 44366.77816610929, 44590.33114503285, 44602.33096503555, 44614.77692611549, 3597.5503062117236, 3661.835217415223, 3946.3291240488898, 4158.584141585818, 4160.83356665736, 32623.51064734031, 32879.83560082208, 33021.33957320864, 33058.33883322344, 34701.65298347035, 4211.886947227131, 4223.472065991751, 4285.1429714057, 4292.441982542249, 4345.196138714348, 295707.99999999785, 298497.0, 298662.0, 298839.0, 298886.99999999785, 63293.36706632875, 63445.36554634394, 63612.68193659002, 63671.0, 63720.68139659272, 68095.65952170208, 68414.0, 68539.0, 68618.0, 68626.0, 15919.840801591836, 16187.190640468165, 16209.918950405172, 16264.268107935171, 16324.75512867308, 12228.327441990776, 12249.326287054297, 12261.080418968435, 12270.938645306895, 12283.324417157142, 20452.181912723623, 20976.79023209779, 21005.36983890486, 21053.47366315824, 21086.683699744517, 7875.724349647735, 7899.210078992055, 7924.683012679544, 7959.3234575060615, 8112.837743245102, 1003.7039073473343, 1011.6560369474414, 1046.581367453025, 1129.079799963044, 1147.2294409002166, 29536.704632953824, 29696.0, 29912.40175196484, 30241.546376804366, 30781.692183078332, 1097.2154909239932, 1105.3367979212408, 1135.5401062569672, 1175.2008634128874, 1256.0454054918146, 13512.882539650986, 14546.854531454761, 14745.11529308245, 15137.523779327856, 15594.29825657848, 359566.0, 361012.0, 362338.0, 362865.0, 363881.1805940953, 57767.42232577704, 58077.0, 58088.4191158083, 58188.70905645445, 58231.0, 1432.7994080828691, 1436.1670231265841, 1439.3163247457373, 1439.474591773995, 1458.4166333466699, 29879.850600746857, 30725.385492290476, 31104.22239444032, 32442.675573243967, 32814.34371312513, 44741.0, 44792.10415791601, 45120.0975980472, 45220.321695175255, 45247.095058098, 222938.65592016457, 224638.0, 225071.0, 225724.0, 226090.0, 31058.68941310558, 31369.686303136677, 31940.20149496281, 34051.0, 34394.31211375808, 43223.35164972591, 44105.55894441014, 44537.777311113234, 45434.77282613566, 46636.53363466322, 37085.814570926974, 37136.62863371332, 37249.81375093107, 37268.440973385965, 40172.1965560693, 36825.44761828521, 37975.2404951905, 38436.23127537378, 38443.42334865035, 38469.6153038466, 37199.62800371962, 37446.25107497889, 37506.0, 37557.62442375541, 37787.81106094452, 32952.34095318128, 32954.670453296116, 34351.82824085864, 46261.30608040815, 47276.52723472721, 32122.19694507656, 32431.351372971938, 33073.007809764786, 34255.657443426244, 36685.63314366929], "unit": "ms", "name": "ext.html", "value": 20036.738965759767}, {"lowerIsBetter": false, "replicates": [374.49256257770713, 374.97375183737114, 375.1465416178194, 377.19845328676564, 377.3038743518208, 15325.616859578517, 15412.69174616507, 17517.29930802768, 18990.0, 19036.143373548188, 15132.394704211845, 17845.464636060908, 18571.814281857176, 18785.342513012012, 18970.810291897076, 5042.218456139304, 5345.866353341159, 5637.3517045539675, 5755.39568345324, 5761.971190144043, 4324.589164029412, 4487.708298960573, 6172.105044768506, 6361.141245931809, 6361.650109244013, 5322.414534401213, 6243.469305109071, 6270.153529273558, 6274.027525733496, 6286.874262514747, 5382.811601593926, 5384.488473595002, 5392.811251606214, 5404.864878378033, 5415.566754659618, 5205.9219111713355, 5345.412004679482, 5459.590530710173, 5496.367917689477, 5512.641678290938, 12996.415161317764, 13211.669708257274, 14831.48089816862, 20478.18087276507, 20501.58996820055, 2186.3331683836423, 2221.1448592292086, 2349.5183487385043, 2352.470694093832, 2408.6146216605257, 8631.568421578959, 9082.954585227099, 10356.0, 10427.530761115691, 11382.71543211418, 1714.6484970581, 1778.6264884374298, 1834.8623853211063, 1912.6079153773444, 1997.4307322413042, 61334.0, 62997.99999999954, 63340.68329658322, 63607.0, 64453.0, 10840.295380800222, 11093.722656933642, 11143.2199746017, 11174.66476005721, 11248.987591116675, 14645.267736613127, 14717.337719802634, 14726.705465890836, 14728.779068313985, 14738.0, 8125.187481251945, 8154.592270386457, 8170.591470426455, 8195.344372450309, 8210.343172546181, 7701.730439434593, 7709.614519274014, 7728.343090837229, 7738.0, 7764.145943946161, 4308.655307575386, 4721.0, 4797.520247975174, 4802.471728109905, 4842.854714358575, 1742.5607696783036, 1884.9434516964513, 1977.3178253502806, 2023.453667509764, 2029.2998915374171, 997.4264797741328, 1015.3146626027402, 1077.6120596585224, 1078.784243151373, 1108.855848739675, 14071.85928140726, 16537.255823487973, 17057.061861597733, 17263.56841078958, 18327.541811454554, 998.0967224661692, 1005.9446730429751, 1023.6007956896816, 1031.9329243599143, 1045.749020235138, 9350.298727595458, 9535.713928582014, 9606.375585586915, 9875.901240987498, 10135.138513226311, 625544.0, 636851.0, 647691.0, 675809.0, 681011.0, 76464.61767691126, 78098.21901781023, 78960.0, 82968.58515707383, 87215.0, 1200.9819852702217, 1223.9840932026398, 1226.693326668333, 1227.858796238444, 1233.4881024374963, 15522.611934701723, 16057.919710401373, 16256.51230463088, 16395.918020409823, 16617.0860602668, 35954.0, 36915.63084369122, 37145.071373215884, 37850.810745946095, 38725.61274387333, 45018.77490612526, 47075.52924470711, 47397.0, 47597.76201118972, 49146.262806057224, 8642.308615310885, 10165.33925294883, 10208.387496750218, 10816.837747433638, 10817.729556761144, 18431.07844607791, 18609.255629774656, 18750.812491874905, 19023.809761902205, 19064.523386914883, 15053.849461505244, 15071.54785356441, 15706.2932168055, 15915.0, 16093.436729714404, 10839.837402438812, 15186.0, 15209.0, 15706.057636541844, 15861.206939653202, 14357.353919073457, 14829.851701482847, 15459.0, 15645.374185032471, 15656.4520241791, 9988.950055249968, 10106.595736170471, 10132.138768204784, 10133.493325333851, 10141.442220677638, 14151.787723183954, 14402.063865848686, 14628.488002919847, 14763.778543321643, 15090.849091509384], "unit": "ms", "name": "jquery.html", "value": 9323.105707470391}, {"lowerIsBetter": false, "replicates": [1543.9614009649758, 1546.8607825295721, 1631.7797097391851, 1673.5899704572378, 1701.4130125106833, 7680.769576912695, 7879.290863822248, 7882.802929926755, 7893.565853878034, 7898.802529936755, 6915.757948471804, 7007.0, 7525.0, 7641.388688904888, 7704.768856934301, 2303.53929214157, 2310.688057112285, 2340.2862127051244, 2342.6603142544323, 2343.660169275454, 2067.5348046689523, 2340.3564019894493, 2341.262502311775, 2406.4104294447884, 2406.9879650601724, 2072.253988564116, 2287.9885600571974, 2337.123578658003, 2337.649352597107, 2339.988300058506, 2286.2912497125944, 2310.9653355199684, 2315.78000089992, 2327.7672232776586, 2333.1134169015836, 2284.5316710074394, 2289.175896677195, 2294.9196778112855, 2303.6890019847274, 2326.150954901466, 7709.575973321521, 7780.338671212954, 7783.571903545303, 7785.922140778576, 7792.532448053078, 4726.102040612307, 4833.613310935117, 4834.758262086917, 4835.298881662175, 4836.0, 3021.214484234093, 3076.2463196516997, 3079.307155889929, 3130.7025832545874, 3237.1745204972817, 1057.5399701130034, 1072.9463526823706, 1073.3720773347602, 1089.9128069754402, 1107.457345900511, 10432.530536125892, 10610.416427096583, 10612.893871061267, 10613.46932653372, 10617.044465998097, 4264.744115353089, 4278.4010238566625, 4405.867823965286, 4413.492448368479, 4414.359917811899, 8701.825963480695, 8746.781330466789, 8754.430961987451, 8758.036615972238, 8782.473051616924, 4801.591864691471, 4811.398575178103, 4835.661503694708, 4843.128236917389, 4844.079624871263, 4402.845900393535, 4482.8655140345845, 4494.70784399013, 4496.437945256843, 4496.550344965477, 3497.9300413991577, 3499.562554680665, 3506.0708912138302, 3526.0479670488826, 3541.1678255609913, 1024.3802499487851, 1032.9586816527406, 1034.379372376568, 1047.3925123428394, 1051.232600201857, 1162.7325715085578, 1183.9230450020893, 1200.8258802473592, 1443.314425647809, 1462.1154201708025, 7325.890111648329, 7358.96320518394, 7435.962820185972, 7477.887831682529, 7515.586642734702, 673.4376795375916, 675.0414411535534, 686.8729285082176, 692.8129405060605, 828.9419740618099, 5850.707464626752, 5994.100884867305, 6003.879922401527, 6004.0, 6006.729697163638, 8968.103189681111, 9081.137291957253, 9123.361364704408, 9285.0, 9289.489078100634, 9145.725628231165, 9207.355485115977, 9281.489518076436, 9289.628414863464, 9294.44233345988, 6984.965075174591, 7096.858062838714, 7171.103612048494, 7380.372668323145, 7435.925640743523, 7402.703891844266, 7474.439417043634, 7479.70081196746, 7480.102387713291, 7480.4389670776, 8131.715389961323, 8325.875111873447, 8326.542040187847, 8335.249827515552, 8349.540775257175, 8222.465539739898, 8246.83506329882, 8283.751487455385, 8401.95799021001, 8423.073461919306, 6846.5892046477375, 7073.045138906182, 7095.325944035309, 7095.46783991213, 7102.218755936739, 7460.7015719372785, 7528.360089392463, 7544.396448284234, 7545.207753185837, 7563.394928405824, 6022.488088512526, 6937.202221744362, 7113.893291600733, 7157.391621712004, 7245.927540724736, 6886.10480637514, 6938.167419909643, 6983.790486285419, 7012.789616311519, 7033.366996970297, 6998.895016574857, 7066.505344625827, 7128.607926564089, 7137.536060156073, 7138.428925686037, 6500.609963402211, 6522.630247647858, 6551.050097735897, 6567.113439685772, 6568.6058836469965, 6593.241777195492, 6603.80188594343, 6662.600243985376, 6672.866542669217, 6673.9666301668185], "unit": "ms", "name": "mootools.html", "value": 4463.691852294379}, {"lowerIsBetter": false, "replicates": [338.2069048082247, 343.29966867590116, 343.8435511842112, 344.29247895574616, 353.4239190120106, 6168.907466388002, 6193.597416167946, 6214.440700336969, 6221.471174950123, 6227.688615569215, 5889.85275368116, 5922.141289513029, 6087.239095113111, 6168.074788781685, 6181.165542651741, 4650.6744527882975, 4664.346991421204, 4670.859874203779, 4699.107169637775, 4722.858314250578, 4713.622910167195, 4720.268358404453, 4725.291206319045, 4731.858044258661, 4740.668153229275, 4445.733256004634, 4558.61251793598, 4559.270516717326, 4667.6265898728025, 4713.245880659095, 4662.230731929228, 4681.0403867207315, 4681.906361872743, 4692.131955588227, 4695.413073365829, 4114.300568903293, 4118.258713431581, 4122.381642753581, 4125.484314460692, 4132.607402296777, 5827.184194212814, 5900.616459930134, 5903.439173278532, 5916.3787802281, 5917.260342457193, 5509.393966663663, 5513.696746678931, 5520.861978450531, 5523.585731070146, 5526.281583394133, 6539.6403197824575, 6543.411093001605, 6545.967270163666, 6549.0, 6563.442107420875, 4623.214053610861, 4626.167289887819, 4626.768661566908, 4628.004978929513, 4630.166570017395, 6532.444742196919, 6722.49581281401, 6774.932250677529, 6784.626845523544, 6788.8302792430095, 4597.885052873705, 4640.048789998043, 4642.605378542862, 4646.697964632355, 4652.232381657056, 4694.061187762393, 4707.176244157259, 4707.882302942454, 4708.411448568929, 4715.905681886343, 5455.727213639381, 5456.236126942231, 5461.2627295315415, 5462.044142275086, 5466.262054622654, 6478.611283323015, 6588.505862060365, 6590.736370545221, 6595.274519802818, 6601.3068627794355, 1625.7236269834157, 1652.9586760330847, 1653.4295667994763, 1655.2303179021812, 1657.6436066245574, 1080.56777289085, 1080.983785243222, 1083.8265877459569, 1084.4198353880636, 1101.3116801998751, 6360.586561873463, 6366.77716279928, 6368.872622547523, 6370.681465926685, 6375.71309291083, 6776.593404395752, 6834.453243740489, 6841.589504629738, 6843.623600702009, 6848.6918088686125, 6156.445919867234, 6317.052442133717, 6325.3674632537295, 6416.230052393649, 6425.871482570323, 3682.613325600827, 3697.8335974881193, 3699.3341198584512, 3707.7775333480076, 3710.257948410329, 6914.662130083918, 6987.161540615159, 7002.75490357835, 7025.5784652919965, 7026.683799229047, 6978.720851165998, 7028.824279392954, 7033.050538177383, 7033.683484243222, 7037.261087585832, 7014.684339204748, 7016.824579385454, 7019.859602808017, 7020.613866237304, 7023.648817559204, 6662.600243985376, 6857.348551887562, 6859.794206173823, 6860.382565569123, 6869.0, 6775.424088952297, 6785.491088168308, 6791.151106111736, 6797.796066118024, 6799.048133261446, 6876.346747059021, 6884.105066341343, 6895.965520172367, 6911.619860907497, 7020.824479387852, 4560.0, 4585.656075794262, 4629.86110416688, 4635.7218566886095, 4644.303354496852, 6883.931160688329, 6889.586624802528, 6889.931100689129, 6891.069705589882, 6898.1377327834025, 6673.9332606673315, 6676.165479315086, 6681.198256209286, 6682.69927853238, 6683.198016238082, 6573.605583664996, 6636.27001029896, 6695.832604184934, 6696.129503164558, 6705.228898676714, 6575.80272591823, 6583.736650534117, 6587.374199451045, 6588.176477940257, 6588.967055164885, 6725.260221375743, 6725.4619630430425, 6728.764493242713, 6732.124823772878, 6742.0, 6448.25845027809, 6577.309382514767, 6588.670566471753, 6589.571677840925, 6592.110065141144], "unit": "ms", "name": "prototype.html", "value": 4960.1780687034625}, {"lowerIsBetter": false, "replicates": [808.531051989846, 880.0935036911978, 929.5305870535378, 938.1416004356015, 940.0646356874909, 14077.225752583603, 14178.85821141787, 14461.63845903853, 15784.99999999997, 15813.525594232162, 14234.501792437266, 14331.068480548756, 14359.856401435982, 14415.495457658984, 14422.134671919692, 906.2115959115579, 914.1270087066869, 914.3919293669702, 914.4924566865387, 915.0209276074603, 760.5702777930479, 772.1776308231744, 899.2176806178634, 919.1360121485816, 919.8988111307751, 970.8155450464425, 974.1622204903813, 975.7365511311941, 979.0111986893254, 979.211734553684, 779.7309928074806, 793.5119901260683, 964.9758756031085, 967.5017366056486, 968.8207681578931, 702.1784512120831, 716.0905649824746, 716.1120210938451, 716.3660160757714, 717.3042149115349, 14907.254637268094, 14931.70136597262, 14945.0, 14949.252537373197, 14992.850071499255, 13121.934390328082, 13605.047646664738, 13843.377048032862, 13936.713709376467, 13976.860231397759, 10831.2959657622, 10857.51141198648, 10956.56173753049, 11020.889791102147, 11096.944515277453, 3870.8838734838, 3923.27419427404, 3924.1955399143108, 3924.2151569686175, 3925.430812532167, 48086.759566202294, 48334.51665483371, 49129.754351228374, 49554.25668614974, 49947.50052499465, 10879.347239165676, 10940.726481838017, 10992.450377481095, 11013.779724405627, 11043.282186657842, 19185.32851350196, 19353.12910919012, 19393.22427102928, 19425.22299108048, 19484.805151948298, 8067.757967260992, 8220.917790822135, 8300.667973281123, 8339.666413343519, 8455.873161902577, 4238.660907127484, 4272.487301523837, 4335.263005289045, 4336.0, 4365.825366985285, 3345.8494367753024, 3360.630330663674, 3363.9495407568907, 3368.2758206985613, 3382.9830850845588, 587.092941405521, 599.3526990849872, 599.4784537452445, 604.8487878030493, 610.3682688417466, 618.8762247550508, 639.0254861336406, 691.2085661917076, 702.8629417263585, 705.6542294275871, 8709.433886797338, 8935.28517718581, 8965.148310910454, 9071.591778369857, 9093.0, 622.5082185073741, 633.756003938487, 689.3416786968434, 703.0894990986684, 715.1561157833806, 3951.8419263229725, 4119.814608342632, 4210.347396153601, 4272.4445822042935, 4349.195398851222, 62097.68951155306, 62156.68921655363, 62546.0618090729, 62904.0, 62989.0, 53196.73401632967, 53905.1914221287, 53906.19140712892, 53981.0, 54370.0, 47610.52389476061, 48770.0, 49002.0, 49420.258696119585, 49532.75233623809, 9245.72262832116, 9464.479453630116, 9603.855942161013, 9727.708168754949, 9738.318317717692, 36324.818375907955, 36622.63377366299, 37028.25943481169, 37089.44365834461, 37341.626583733814, 43682.78158609186, 46063.0, 48198.27702584534, 48304.0, 48892.75553622209, 10687.145028397554, 11027.44862756875, 11067.225294229327, 11537.538498459968, 11934.761304774029, 13099.738005239651, 13368.665783355495, 13369.26469044212, 13375.197488150741, 13383.933080334536, 11873.465694043616, 12350.876491235333, 12543.749125017632, 12550.87449125497, 12581.433835477243, 10938.179636527133, 11314.547418103513, 11348.659540213806, 11352.262102963281, 11364.886351136383, 11415.543378264776, 11877.465514051715, 11959.820602691141, 12020.098492613264, 12287.201331913397, 9498.810023799624, 9850.556724947251, 10156.0, 10214.846777298495, 10263.12763415118, 10011.242465814461, 10070.579791051965, 10087.046849483386, 10254.897451025394, 10365.0], "unit": "ms", "name": "yui.html", "value": 6751.641414838016}], "name": "dromaeo_css", "value": 7328.503448750944}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 109.0, 111.0, 114.0, 101.0, 112.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 150.0, 155.0, 123.0, 151.0, 147.0, 129.0, 163.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [172.0, 172.0, 171.0, 172.0, 172.0, 173.0, 170.0, 171.0, 171.0, 175.0], "unit": "ms", "name": "audio-dft", "value": 171.9}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 152.0, 71.0, 71.0, 70.0, 71.0, 152.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 92.0, 93.0, 92.0, 136.0, 92.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 108.0, 110.0, 109.0, 108.0, 109.0, 109.0, 111.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 56.0, 57.0, 59.0, 60.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 86.0, 79.0, 78.0, 78.0, 79.0, 86.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [116.0, 109.0, 118.0, 113.0, 115.0, 118.0, 121.0, 110.0, 120.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 140.0, 145.0, 144.0, 143.0, 142.0, 141.0, 141.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 64.0, 65.0, 65.0, 62.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1485.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [171.05713308244952], "unit": "score", "name": "DeltaBlue", "value": 386.5258280000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5102.040816326531], "unit": "score", "name": "Decrypt", "value": 52.17147600000001}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [544.069640914037], "unit": "score", "name": "Earley", "value": 1224.9589940000005}, {"lowerIsBetter": false, "replicates": [10568.421052631578], "unit": "score", "name": "Boyer", "value": 63.06173804780874}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [531.3496280552604], "unit": "score", "name": "Splay", "value": 153.36606199999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23208.368053432918}]} 11:46:29 INFO - RETURN: dromaeo_css: 7328.50 11:46:29 INFO - RETURN: kraken: 1485.30 11:46:29 INFO - RETURN: v8_7: 23208.37 11:46:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23208.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1485.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7328.50"}}} 11:46:29 INFO - Return code: 0 11:46:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:46:29 INFO - # TBPL SUCCESS # 11:46:29 INFO - Running post-action listener: _resource_record_post_action 11:46:29 INFO - Running post-run listener: _resource_record_post_run 11:46:30 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 315392; Write bytes: 521822208; Read time: 60; Write time: 520368 11:46:30 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 256077824; Read time: 0; Write time: 344476 11:46:30 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 315392; Write bytes: 265744384; Read time: 60; Write time: 175892 11:46:30 INFO - Running post-run listener: _upload_blobber_files 11:46:30 INFO - Blob upload gear active. 11:46:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:46:30 INFO - Copying logs to upload dir... 11:46:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.291758 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-19 11:46:29.321622) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-19 11:46:29.325311) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009868 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455901477/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-19 11:46:29.377034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:46:29.377399) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455909428.875293-287400245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 11:46:29.426957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 11:46:29.427321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 11:46:29.427702) ========= ========= Total master_lag: 0.27 =========