builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1454507086.44 results: success (0) buildid: 20160203031240 builduid: 8e3731ee94674f8da8af455ed9197d89 revision: db97361d5dda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.440729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.441135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.441519) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.468313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.468979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.483181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.483456) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.532245) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.532517) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.532946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.533498) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-03 05:44:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 212M=0s 2016-02-03 05:44:47 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.749087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.749530) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:46.799098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-03 05:44:46.799460) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev db97361d5dda --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 db97361d5dda --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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-03 05:44:47,295 Setting DEBUG logging. 2016-02-03 05:44:47,295 attempt 1/10 2016-02-03 05:44:47,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/db97361d5dda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 05:44:48,343 unpacking tar archive at: mozilla-beta-db97361d5dda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.406811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-03 05:44:48.219786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:48.220135) ========= echo db97361d5dda in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'db97361d5dda'] 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False db97361d5dda program finished with exit code 0 elapsedTime=0.004023 script_repo_revision: 'db97361d5dda' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:48.268647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:48.268961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 05:44:48.282814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-03 05:44:48.283074) ========= /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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:48 INFO - MultiFileLogger online at 20160203 05:44:48 in /builds/slave/test-pgo 05:44:48 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 05:44:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:44:48 INFO - {'append_to_log': False, 05:44:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:44:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:44:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:44:48 INFO - 'branch': 'Mozilla-Beta', 05:44:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:48 INFO - 'config_files': ('talos/linux_config.py',), 05:44:48 INFO - 'default_actions': ('clobber', 05:44:48 INFO - 'read-buildbot-config', 05:44:48 INFO - 'download-and-extract', 05:44:48 INFO - 'populate-webroot', 05:44:48 INFO - 'create-virtualenv', 05:44:48 INFO - 'install', 05:44:48 INFO - 'run-tests'), 05:44:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:48 INFO - 'download_minidump_stackwalk': True, 05:44:48 INFO - 'download_symbols': 'ondemand', 05:44:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:48 INFO - 'installer_path': 'installer.exe', 05:44:48 INFO - 'log_level': 'info', 05:44:48 INFO - 'log_name': 'talos', 05:44:48 INFO - 'log_to_console': True, 05:44:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:48 INFO - 'opt_config_files': (), 05:44:48 INFO - 'pip_index': False, 05:44:48 INFO - 'sps_profile': False, 05:44:48 INFO - 'sps_profile_interval': 0, 05:44:48 INFO - 'suite': 'dromaeojs', 05:44:48 INFO - 'system_bits': '32', 05:44:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:48 INFO - 'title': 'talos-linux64-ix-026', 05:44:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:48 INFO - 'use_talos_json': True, 05:44:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:44:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:48 INFO - 'work_dir': 'build'} 05:44:48 INFO - ##### 05:44:48 INFO - ##### Running clobber step. 05:44:48 INFO - ##### 05:44:48 INFO - Running pre-action listener: _resource_record_pre_action 05:44:48 INFO - Running main action method: clobber 05:44:48 INFO - rmtree: /builds/slave/test-pgo/build 05:44:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:44:49 INFO - Running post-action listener: _resource_record_post_action 05:44:49 INFO - ##### 05:44:49 INFO - ##### Running read-buildbot-config step. 05:44:49 INFO - ##### 05:44:49 INFO - Running pre-action listener: _resource_record_pre_action 05:44:49 INFO - Running main action method: read_buildbot_config 05:44:49 INFO - Using buildbot properties: 05:44:49 INFO - { 05:44:49 INFO - "properties": { 05:44:49 INFO - "buildnumber": 101, 05:44:49 INFO - "product": "firefox", 05:44:49 INFO - "script_repo_revision": "production", 05:44:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:44:49 INFO - "repository": "", 05:44:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:44:49 INFO - "buildid": "20160203031240", 05:44:49 INFO - "slavename": "talos-linux64-ix-026", 05:44:49 INFO - "pgo_build": "True", 05:44:49 INFO - "basedir": "/builds/slave/test-pgo", 05:44:49 INFO - "project": "", 05:44:49 INFO - "platform": "ubuntu64_hw", 05:44:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:49 INFO - "slavebuilddir": "test", 05:44:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:44:49 INFO - "branch": "mozilla-beta", 05:44:49 INFO - "repo_path": "releases/mozilla-beta", 05:44:49 INFO - "stage_platform": "linux64-pgo", 05:44:49 INFO - "builduid": "8e3731ee94674f8da8af455ed9197d89", 05:44:49 INFO - "revision": "db97361d5dda" 05:44:49 INFO - }, 05:44:49 INFO - "sourcestamp": { 05:44:49 INFO - "repository": "", 05:44:49 INFO - "hasPatch": false, 05:44:49 INFO - "project": "", 05:44:49 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:44:49 INFO - "changes": [ 05:44:49 INFO - { 05:44:49 INFO - "category": null, 05:44:49 INFO - "files": [ 05:44:49 INFO - { 05:44:49 INFO - "url": null, 05:44:49 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2" 05:44:49 INFO - } 05:44:49 INFO - ], 05:44:49 INFO - "repository": "", 05:44:49 INFO - "rev": "db97361d5dda", 05:44:49 INFO - "who": "sendchange", 05:44:49 INFO - "when": 1454507067, 05:44:49 INFO - "number": 7556538, 05:44:49 INFO - "comments": "Bug 1244258 - Back out bug 1201327 on Beta in order to fix bug 1227327 and friends. a=sylvestre", 05:44:49 INFO - "project": "", 05:44:49 INFO - "at": "Wed 03 Feb 2016 05:44:27", 05:44:49 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:44:49 INFO - "revlink": "", 05:44:49 INFO - "properties": [ 05:44:49 INFO - [ 05:44:49 INFO - "buildid", 05:44:49 INFO - "20160203031240", 05:44:49 INFO - "Change" 05:44:49 INFO - ], 05:44:49 INFO - [ 05:44:49 INFO - "builduid", 05:44:49 INFO - "8e3731ee94674f8da8af455ed9197d89", 05:44:49 INFO - "Change" 05:44:49 INFO - ], 05:44:49 INFO - [ 05:44:49 INFO - "pgo_build", 05:44:49 INFO - "True", 05:44:49 INFO - "Change" 05:44:49 INFO - ] 05:44:49 INFO - ], 05:44:49 INFO - "revision": "db97361d5dda" 05:44:49 INFO - } 05:44:49 INFO - ], 05:44:49 INFO - "revision": "db97361d5dda" 05:44:49 INFO - } 05:44:49 INFO - } 05:44:49 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2. 05:44:49 INFO - Running post-action listener: _resource_record_post_action 05:44:49 INFO - ##### 05:44:49 INFO - ##### Running download-and-extract step. 05:44:49 INFO - ##### 05:44:49 INFO - Running pre-action listener: _resource_record_pre_action 05:44:49 INFO - Running main action method: download_and_extract 05:44:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/test_packages.json 05:44:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:44:50 INFO - Downloaded 1270 bytes. 05:44:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:44:50 INFO - Using the following test package requirements: 05:44:50 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:44:50 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:50 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'jsshell-linux-x86_64.zip'], 05:44:50 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:50 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:44:50 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 05:44:50 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 05:44:50 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:50 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:44:50 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:44:50 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:50 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44: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')]} 05:44:50 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:44:50 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:54 INFO - Downloaded 21581832 bytes. 05:44:54 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 05:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:44:54 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 05:44:55 INFO - Return code: 0 05:44:55 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 05:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:44:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:56 INFO - Downloaded 21581832 bytes. 05:44:56 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 05:44:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:44:56 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 05:44:57 INFO - Return code: 0 05:44:57 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')]} 05:44:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:44:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:59 INFO - Downloaded 11132038 bytes. 05:44:59 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 05:44:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:44:59 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 05:44:59 INFO - Return code: 0 05:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:44:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/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 05:45:00 INFO - Downloaded 57951225 bytes. 05:45:00 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:45:00 INFO - mkdir: /builds/slave/test-pgo/properties 05:45:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:45:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:45:00 INFO - Contents: 05:45:00 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:45:00 INFO - Running post-action listener: _resource_record_post_action 05:45:00 INFO - Running post-action listener: set_extra_try_arguments 05:45:00 INFO - ##### 05:45:00 INFO - ##### Running populate-webroot step. 05:45:00 INFO - ##### 05:45:00 INFO - Running pre-action listener: _resource_record_pre_action 05:45:00 INFO - Running main action method: populate_webroot 05:45:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:00 INFO - '--tppagecycles', 05:45:00 INFO - '7'], 05:45:00 INFO - 'tests': ['tsvgm']}}, 05:45:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:45:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'tests': ['damp', 'tps']}, 05:45:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['damp', 'tps']}, 05:45:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:45:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:00 INFO - 'other': {'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'other_l64': {'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'other_nol64': {'tests': ['a11yr', 05:45:00 INFO - 'ts_paint', 05:45:00 INFO - 'tpaint', 05:45:00 INFO - 'sessionrestore', 05:45:00 INFO - 'sessionrestore_no_auto_restore']}, 05:45:00 INFO - 'svgr': {'tests': ['tsvgx', 05:45:00 INFO - 'tsvgr_opacity', 05:45:00 INFO - 'tart', 05:45:00 INFO - 'tscrollx', 05:45:00 INFO - 'cart']}, 05:45:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['tsvgx', 05:45:00 INFO - 'tsvgr_opacity', 05:45:00 INFO - 'tart', 05:45:00 INFO - 'tscrollx', 05:45:00 INFO - 'cart']}, 05:45:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'tests': ['tp5o']}, 05:45:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'talos_options': ['--e10s'], 05:45:00 INFO - 'tests': ['tp5o']}, 05:45:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'talos_options': ['--xperf_path', 05:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:00 INFO - 'tests': ['tp5n']}, 05:45:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:00 INFO - 'talos_options': ['--e10s', 05:45:00 INFO - '--xperf_path', 05:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:00 INFO - 'tests': ['tp5n']}}, 05:45:00 INFO - 'talos.zip': {'path': '', 05:45:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:00 INFO - Running post-action listener: _resource_record_post_action 05:45:00 INFO - ##### 05:45:00 INFO - ##### Running create-virtualenv step. 05:45:00 INFO - ##### 05:45:00 INFO - Running pre-action listener: _resource_record_pre_action 05:45:00 INFO - Running main action method: create_virtualenv 05:45:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:45:00 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 05:45:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:45:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:00 INFO - Using real prefix '/usr' 05:45:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:45:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:03 INFO - Installing pip.................done. 05:45:03 INFO - Return code: 0 05:45:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:45: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 pip>=1.5 05:45:03 INFO - Using env: {'DISPLAY': ':0', 05:45:03 INFO - 'HOME': '/home/cltbld', 05:45:03 INFO - 'LANG': 'en_US.UTF-8', 05:45:03 INFO - 'LANGUAGE': 'en_US:en', 05:45:03 INFO - 'LOGNAME': 'cltbld', 05:45:03 INFO - 'MAIL': '/var/mail/cltbld', 05:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:03 INFO - 'MOZ_NO_REMOTE': '1', 05:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:03 INFO - 'NO_EM_RESTART': '1', 05:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:03 INFO - 'SHELL': '/bin/bash', 05:45:03 INFO - 'SHLVL': '1', 05:45:03 INFO - 'TERM': 'linux', 05:45:03 INFO - 'TMOUT': '86400', 05:45:03 INFO - 'USER': 'cltbld', 05:45:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:03 INFO - '_': '/tools/buildbot/bin/python'} 05:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:03 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 05:45:03 INFO - Cleaning up... 05:45:03 INFO - Return code: 0 05:45:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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', '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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:45: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 psutil>=0.7.1 05:45:03 INFO - Using env: {'DISPLAY': ':0', 05:45:03 INFO - 'HOME': '/home/cltbld', 05:45:03 INFO - 'LANG': 'en_US.UTF-8', 05:45:03 INFO - 'LANGUAGE': 'en_US:en', 05:45:03 INFO - 'LOGNAME': 'cltbld', 05:45:03 INFO - 'MAIL': '/var/mail/cltbld', 05:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:03 INFO - 'MOZ_NO_REMOTE': '1', 05:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:03 INFO - 'NO_EM_RESTART': '1', 05:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:03 INFO - 'SHELL': '/bin/bash', 05:45:03 INFO - 'SHLVL': '1', 05:45:03 INFO - 'TERM': 'linux', 05:45:03 INFO - 'TMOUT': '86400', 05:45:03 INFO - 'USER': 'cltbld', 05:45:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:03 INFO - '_': '/tools/buildbot/bin/python'} 05:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:03 INFO - Downloading/unpacking psutil>=0.7.1 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:05 INFO - Installing collected packages: psutil 05:45:05 INFO - Running setup.py install for psutil 05:45:05 INFO - building 'psutil._psutil_linux' extension 05:45:05 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 05:45:06 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 05:45:06 INFO - building 'psutil._psutil_posix' extension 05:45:06 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 05:45:06 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 05:45:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:06 INFO - Successfully installed psutil 05:45:06 INFO - Cleaning up... 05:45:06 INFO - Return code: 0 05:45:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:06 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')]} 05:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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')]} 05:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:06 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:06 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 05:45:06 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 05:45:06 INFO - Using env: {'DISPLAY': ':0', 05:45:06 INFO - 'HOME': '/home/cltbld', 05:45:06 INFO - 'LANG': 'en_US.UTF-8', 05:45:06 INFO - 'LANGUAGE': 'en_US:en', 05:45:06 INFO - 'LOGNAME': 'cltbld', 05:45:06 INFO - 'MAIL': '/var/mail/cltbld', 05:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:06 INFO - 'MOZ_NO_REMOTE': '1', 05:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:06 INFO - 'NO_EM_RESTART': '1', 05:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:06 INFO - 'SHELL': '/bin/bash', 05:45:06 INFO - 'SHLVL': '1', 05:45:06 INFO - 'TERM': 'linux', 05:45:06 INFO - 'TMOUT': '86400', 05:45:06 INFO - 'USER': 'cltbld', 05:45:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:06 INFO - '_': '/tools/buildbot/bin/python'} 05:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:08 INFO - Installing collected packages: mozsystemmonitor 05:45:08 INFO - Running setup.py install for mozsystemmonitor 05:45:08 INFO - Successfully installed mozsystemmonitor 05:45:08 INFO - Cleaning up... 05:45:08 INFO - Return code: 0 05:45:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:08 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 05:45:08 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 05:45:08 INFO - Using env: {'DISPLAY': ':0', 05:45:08 INFO - 'HOME': '/home/cltbld', 05:45:08 INFO - 'LANG': 'en_US.UTF-8', 05:45:08 INFO - 'LANGUAGE': 'en_US:en', 05:45:08 INFO - 'LOGNAME': 'cltbld', 05:45:08 INFO - 'MAIL': '/var/mail/cltbld', 05:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:08 INFO - 'MOZ_NO_REMOTE': '1', 05:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:08 INFO - 'NO_EM_RESTART': '1', 05:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:08 INFO - 'SHELL': '/bin/bash', 05:45:08 INFO - 'SHLVL': '1', 05:45:08 INFO - 'TERM': 'linux', 05:45:08 INFO - 'TMOUT': '86400', 05:45:08 INFO - 'USER': 'cltbld', 05:45:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:08 INFO - '_': '/tools/buildbot/bin/python'} 05:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:10 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 05:45:11 INFO - Downloading docopt-0.6.1.tar.gz 05:45:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:11 INFO - Running setup.py install for blobuploader 05:45:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:11 INFO - Running setup.py install for requests 05:45:11 INFO - Running setup.py install for docopt 05:45:11 INFO - Successfully installed blobuploader requests docopt 05:45:11 INFO - Cleaning up... 05:45:11 INFO - Return code: 0 05:45:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:11 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:11 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 05:45:11 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 05:45:11 INFO - Using env: {'DISPLAY': ':0', 05:45:11 INFO - 'HOME': '/home/cltbld', 05:45:11 INFO - 'LANG': 'en_US.UTF-8', 05:45:11 INFO - 'LANGUAGE': 'en_US:en', 05:45:11 INFO - 'LOGNAME': 'cltbld', 05:45:11 INFO - 'MAIL': '/var/mail/cltbld', 05:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:11 INFO - 'MOZ_NO_REMOTE': '1', 05:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:11 INFO - 'NO_EM_RESTART': '1', 05:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:11 INFO - 'SHELL': '/bin/bash', 05:45:11 INFO - 'SHLVL': '1', 05:45:11 INFO - 'TERM': 'linux', 05:45:11 INFO - 'TMOUT': '86400', 05:45:11 INFO - 'USER': 'cltbld', 05:45:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:11 INFO - '_': '/tools/buildbot/bin/python'} 05:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:12 INFO - Running setup.py (path:/tmp/pip-8NALyG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:12 INFO - Running setup.py (path:/tmp/pip-W0v3jQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:12 INFO - Running setup.py (path:/tmp/pip-DDM_cN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:12 INFO - Running setup.py (path:/tmp/pip-V2Huky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:12 INFO - Running setup.py (path:/tmp/pip-SAGkuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:12 INFO - Running setup.py (path:/tmp/pip-jxwOij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:12 INFO - Running setup.py (path:/tmp/pip-dKA008-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:12 INFO - Running setup.py (path:/tmp/pip-Qt6Ua0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:12 INFO - Running setup.py (path:/tmp/pip-z0OjGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:12 INFO - Running setup.py (path:/tmp/pip-ebIuNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:12 INFO - Running setup.py (path:/tmp/pip-M8exv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:12 INFO - Running setup.py (path:/tmp/pip-VloCQ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:12 INFO - Running setup.py (path:/tmp/pip-iFgbuA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:12 INFO - Running setup.py (path:/tmp/pip-TM2ROB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:13 INFO - Running setup.py (path:/tmp/pip-Gai91s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:13 INFO - Running setup.py (path:/tmp/pip-_zYRxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:13 INFO - Running setup.py (path:/tmp/pip-FDpA6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:13 INFO - Running setup.py install for manifestparser 05:45:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Running setup.py install for mozcrash 05:45:13 INFO - Running setup.py install for mozdebug 05:45:13 INFO - Running setup.py install for mozdevice 05:45:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Running setup.py install for mozfile 05:45:13 INFO - Running setup.py install for mozhttpd 05:45:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Running setup.py install for mozinfo 05:45:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:13 INFO - Running setup.py install for mozInstall 05:45:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Running setup.py install for mozleak 05:45:14 INFO - Running setup.py install for mozlog 05:45:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Running setup.py install for moznetwork 05:45:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Running setup.py install for mozprocess 05:45:14 INFO - Running setup.py install for mozprofile 05:45:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Running setup.py install for mozrunner 05:45:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:14 INFO - Running setup.py install for mozscreenshot 05:45:14 INFO - Running setup.py install for moztest 05:45:14 INFO - Running setup.py install for mozversion 05:45:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:15 INFO - Cleaning up... 05:45:15 INFO - Return code: 0 05:45:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:15 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')]} 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 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')]} 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:15 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 05:45:15 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 05:45:15 INFO - Using env: {'DISPLAY': ':0', 05:45:15 INFO - 'HOME': '/home/cltbld', 05:45:15 INFO - 'LANG': 'en_US.UTF-8', 05:45:15 INFO - 'LANGUAGE': 'en_US:en', 05:45:15 INFO - 'LOGNAME': 'cltbld', 05:45:15 INFO - 'MAIL': '/var/mail/cltbld', 05:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:15 INFO - 'MOZ_NO_REMOTE': '1', 05:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:15 INFO - 'NO_EM_RESTART': '1', 05:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:15 INFO - 'SHELL': '/bin/bash', 05:45:15 INFO - 'SHLVL': '1', 05:45:15 INFO - 'TERM': 'linux', 05:45:15 INFO - 'TMOUT': '86400', 05:45:15 INFO - 'USER': 'cltbld', 05:45:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:15 INFO - '_': '/tools/buildbot/bin/python'} 05:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:15 INFO - Running setup.py (path:/tmp/pip-dp3YL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:15 INFO - Running setup.py (path:/tmp/pip-vYTPGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:15 INFO - Running setup.py (path:/tmp/pip-5T2Yxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:15 INFO - Running setup.py (path:/tmp/pip-kz4P8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:15 INFO - Running setup.py (path:/tmp/pip-lDIfCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:15 INFO - Running setup.py (path:/tmp/pip-wSWWS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:15 INFO - Running setup.py (path:/tmp/pip-rZTGhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:15 INFO - Running setup.py (path:/tmp/pip-wrbvdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:15 INFO - Running setup.py (path:/tmp/pip-G2bAZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:15 INFO - Running setup.py (path:/tmp/pip-LWZFBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:15 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)) 05:45:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:15 INFO - Running setup.py (path:/tmp/pip-R6SFsI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:16 INFO - Running setup.py (path:/tmp/pip-NjIXwT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:16 INFO - Running setup.py (path:/tmp/pip-ntSam0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:16 INFO - Running setup.py (path:/tmp/pip-djVLEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:16 INFO - Running setup.py (path:/tmp/pip-4TEFxI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:16 INFO - Running setup.py (path:/tmp/pip-PKXAn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:16 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)) 05:45:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:16 INFO - Running setup.py (path:/tmp/pip-795Awi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:16 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)) 05:45:16 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)) 05:45:16 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)) 05:45:16 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)) 05:45:16 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)) 05:45:16 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)) 05:45:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:18 INFO - Downloading blessings-1.6.tar.gz 05:45:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:18 INFO - Installing collected packages: blessings 05:45:18 INFO - Running setup.py install for blessings 05:45:18 INFO - Successfully installed blessings 05:45:18 INFO - Cleaning up... 05:45:18 INFO - Return code: 0 05:45:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:18 INFO - Reading from file tmpfile_stdout 05:45:18 INFO - Current package versions: 05:45:18 INFO - argparse == 1.2.1 05:45:18 INFO - blessings == 1.6 05:45:18 INFO - blobuploader == 1.2.4 05:45:18 INFO - docopt == 0.6.1 05:45:18 INFO - manifestparser == 1.1 05:45:18 INFO - mozInstall == 1.12 05:45:18 INFO - mozcrash == 0.16 05:45:18 INFO - mozdebug == 0.1 05:45:18 INFO - mozdevice == 0.47 05:45:18 INFO - mozfile == 1.2 05:45:18 INFO - mozhttpd == 0.7 05:45:18 INFO - mozinfo == 0.9 05:45:18 INFO - mozleak == 0.1 05:45:18 INFO - mozlog == 3.1 05:45:18 INFO - moznetwork == 0.27 05:45:18 INFO - mozprocess == 0.22 05:45:18 INFO - mozprofile == 0.27 05:45:18 INFO - mozrunner == 6.11 05:45:18 INFO - mozscreenshot == 0.1 05:45:18 INFO - mozsystemmonitor == 0.0 05:45:18 INFO - moztest == 0.7 05:45:18 INFO - mozversion == 1.4 05:45:18 INFO - psutil == 3.1.1 05:45:18 INFO - requests == 1.2.3 05:45:18 INFO - wsgiref == 0.1.2 05:45:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:18 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')]} 05:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:18 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')]} 05:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:18 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:18 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 05:45:18 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 05:45:18 INFO - Using env: {'DISPLAY': ':0', 05:45:18 INFO - 'HOME': '/home/cltbld', 05:45:18 INFO - 'LANG': 'en_US.UTF-8', 05:45:18 INFO - 'LANGUAGE': 'en_US:en', 05:45:18 INFO - 'LOGNAME': 'cltbld', 05:45:18 INFO - 'MAIL': '/var/mail/cltbld', 05:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:18 INFO - 'MOZ_NO_REMOTE': '1', 05:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:18 INFO - 'NO_EM_RESTART': '1', 05:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:18 INFO - 'SHELL': '/bin/bash', 05:45:18 INFO - 'SHLVL': '1', 05:45:18 INFO - 'TERM': 'linux', 05:45:18 INFO - 'TMOUT': '86400', 05:45:18 INFO - 'USER': 'cltbld', 05:45:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:18 INFO - '_': '/tools/buildbot/bin/python'} 05:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 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)) 05:45:19 INFO - Cleaning up... 05:45:19 INFO - Return code: 0 05:45:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:19 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')]} 05:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:19 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')]} 05:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:19 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:19 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 05:45:19 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 05:45:19 INFO - Using env: {'DISPLAY': ':0', 05:45:19 INFO - 'HOME': '/home/cltbld', 05:45:19 INFO - 'LANG': 'en_US.UTF-8', 05:45:19 INFO - 'LANGUAGE': 'en_US:en', 05:45:19 INFO - 'LOGNAME': 'cltbld', 05:45:19 INFO - 'MAIL': '/var/mail/cltbld', 05:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:19 INFO - 'MOZ_NO_REMOTE': '1', 05:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:19 INFO - 'NO_EM_RESTART': '1', 05:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:19 INFO - 'SHELL': '/bin/bash', 05:45:19 INFO - 'SHLVL': '1', 05:45:19 INFO - 'TERM': 'linux', 05:45:19 INFO - 'TMOUT': '86400', 05:45:19 INFO - 'USER': 'cltbld', 05:45:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:19 INFO - '_': '/tools/buildbot/bin/python'} 05:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:19 INFO - Downloading/unpacking jsonschema 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:21 INFO - warning: no files found matching '*.txt' 05:45:21 INFO - no previously-included directories found matching 'build' 05:45:21 INFO - no previously-included directories found matching 'dist' 05:45:21 INFO - no previously-included directories found matching '.git*' 05:45:21 INFO - Installing collected packages: jsonschema, functools32 05:45:21 INFO - Running setup.py install for functools32 05:45:21 INFO - warning: no files found matching '*.txt' 05:45:21 INFO - no previously-included directories found matching 'build' 05:45:21 INFO - no previously-included directories found matching 'dist' 05:45:21 INFO - no previously-included directories found matching '.git*' 05:45:21 INFO - Successfully installed jsonschema functools32 05:45:21 INFO - Cleaning up... 05:45:21 INFO - Return code: 0 05:45:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:21 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 0x7f2de929df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd6600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, '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': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', '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 05:45:21 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 05:45:21 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 05:45:21 INFO - Using env: {'DISPLAY': ':0', 05:45:21 INFO - 'HOME': '/home/cltbld', 05:45:21 INFO - 'LANG': 'en_US.UTF-8', 05:45:21 INFO - 'LANGUAGE': 'en_US:en', 05:45:21 INFO - 'LOGNAME': 'cltbld', 05:45:21 INFO - 'MAIL': '/var/mail/cltbld', 05:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:21 INFO - 'MOZ_NO_REMOTE': '1', 05:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:21 INFO - 'NO_EM_RESTART': '1', 05:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:21 INFO - 'SHELL': '/bin/bash', 05:45:21 INFO - 'SHLVL': '1', 05:45:21 INFO - 'TERM': 'linux', 05:45:21 INFO - 'TMOUT': '86400', 05:45:21 INFO - 'USER': 'cltbld', 05:45:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:21 INFO - '_': '/tools/buildbot/bin/python'} 05:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:21 INFO - Downloading/unpacking flake8 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:21 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 05:45:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:23 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 05:45:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:24 INFO - no previously-included directories found matching 'docs/_build' 05:45:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:24 INFO - Running setup.py install for pep8 05:45:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:24 INFO - no previously-included directories found matching 'docs/_build' 05:45:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:24 INFO - Cleaning up... 05:45:24 INFO - Return code: 0 05:45:24 INFO - Running post-action listener: _resource_record_post_action 05:45:24 INFO - Running post-action listener: _start_resource_monitoring 05:45:24 INFO - Starting resource monitoring. 05:45:24 INFO - ##### 05:45:24 INFO - ##### Running install step. 05:45:24 INFO - ##### 05:45:24 INFO - Running pre-action listener: _resource_record_pre_action 05:45:24 INFO - Running main action method: install 05:45:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:24 INFO - Reading from file tmpfile_stdout 05:45:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:24 INFO - Reading from file tmpfile_stdout 05:45:24 INFO - Output received: 05:45:24 INFO - Usage: mozinstall [options] installer 05:45:24 INFO - Options: 05:45:24 INFO - -h, --help show this help message and exit 05:45:24 INFO - -d DEST, --destination=DEST 05:45:24 INFO - Directory to install application into. [default: 05:45:24 INFO - "/builds/slave/test-pgo"] 05:45:24 INFO - --app=APP Application being installed. [default: firefox] 05:45:24 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:24 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'] 05:45:24 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 05:45:39 INFO - Reading from file tmpfile_stdout 05:45:39 INFO - Output received: 05:45:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:39 INFO - Running post-action listener: _resource_record_post_action 05:45:39 INFO - ##### 05:45:39 INFO - ##### Running run-tests step. 05:45:39 INFO - ##### 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: run_tests 05:45:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:39 INFO - Python 2.7.3 05:45:39 INFO - Return code: 0 05:45:39 INFO - grabbing minidump binary from tooltool 05:45: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')]} 05:45:39 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 0x2c65350>, '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 0x2c66250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c666e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:39 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 05:45:39 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 05:45:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:39 INFO - Return code: 0 05:45:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:45:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:45:40 INFO - Return code: 0 05:45:40 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/1454497960/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:45:40 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/1454497960/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost 05:45:40 INFO - Using env: {'DISPLAY': ':0', 05:45:40 INFO - 'HOME': '/home/cltbld', 05:45:40 INFO - 'LANG': 'en_US.UTF-8', 05:45:40 INFO - 'LANGUAGE': 'en_US:en', 05:45:40 INFO - 'LOGNAME': 'cltbld', 05:45:40 INFO - 'MAIL': '/var/mail/cltbld', 05:45:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:40 INFO - 'MOZ_NO_REMOTE': '1', 05:45:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:40 INFO - 'NO_EM_RESTART': '1', 05:45:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:45:40 INFO - 'SHELL': '/bin/bash', 05:45:40 INFO - 'SHLVL': '1', 05:45:40 INFO - 'TERM': 'linux', 05:45:40 INFO - 'TMOUT': '86400', 05:45:40 INFO - 'USER': 'cltbld', 05:45:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625', 05:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:40 INFO - '_': '/tools/buildbot/bin/python'} 05:45:40 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/1454497960/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost'] with output_timeout 3600 05:45:40 INFO - mozversion INFO | application_buildid: 20160203031240 05:45:40 INFO - mozversion INFO | application_changeset: db97361d5ddafac1463cb27c9aa638cc72c41c34 05:45:40 INFO - mozversion INFO | application_display_name: Nightly 05:45:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:40 INFO - mozversion INFO | application_name: Firefox 05:45:40 INFO - mozversion INFO | application_remotingname: firefox 05:45:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:45:40 INFO - mozversion INFO | application_vendor: Mozilla 05:45:40 INFO - mozversion INFO | application_version: 45.0 05:45:40 INFO - mozversion INFO | platform_buildid: 20160203031240 05:45:40 INFO - mozversion INFO | platform_changeset: db97361d5ddafac1463cb27c9aa638cc72c41c34 05:45:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:45:40 INFO - mozversion INFO | platform_version: 45.0 05:45:40 INFO - 2016-02-03 05:45:40,686 DEBUG : using testdate: 1454507140 05:45:40 INFO - 2016-02-03 05:45:40,686 DEBUG : actual date: 1454507140 05:45:40 INFO - 2016-02-03 05:45:40,703 INFO : starting webserver on 'localhost:47805' 05:45:40 INFO - 2016-02-03 05:45:40,704 INFO : Starting test suite talos-linux64-ix-026 05:45:40 INFO - 2016-02-03 05:45:40,704 INFO : Starting test dromaeo_css 05:45:40 INFO - 2016-02-03 05:45:40,704 DEBUG : operating with platform_type : linux_ 05:45:40 INFO - 2016-02-03 05:45:40,704 INFO : Initialising browser for dromaeo_css test... 05:45:40 INFO - 2016-02-03 05:45:40,719 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMMTfpo/profile http://localhost:47805/getInfo.html 05:45:44 INFO - 2016-02-03 05:45:44,352 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:45:44 INFO - 2016-02-03 05:45:44,352 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:45:44 INFO - 2016-02-03 05:45:44,352 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:45:44 INFO - 2016-02-03 05:45:44,352 DEBUG : BROWSER_OUTPUT: __metrics 05:45:44 INFO - 2016-02-03 05:45:44,456 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] 05:45:45 INFO - 2016-02-03 05:45:45,589 INFO : Browser initialized. 05:45:45 INFO - 2016-02-03 05:45:45,589 INFO : Running cycle 1/1 for dromaeo_css test... 05:45:45 INFO - 2016-02-03 05:45:45,590 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMMTfpo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:45:57 INFO - 2016-02-03 05:45:57,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 134295552 05:45:57 INFO - 2016-02-03 05:45:57,310 DEBUG : BROWSER_OUTPUT: 05:46:48 INFO - 2016-02-03 05:46:48,908 DEBUG : BROWSER_OUTPUT: 1454507208902 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] 05:48:55 INFO - 2016-02-03 05:48:55,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47805/tests/dromaeo/cssquery-ext.html) 05:48:56 INFO - 2016-02-03 05:48:56,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 222167040 05:48:56 INFO - 2016-02-03 05:48:56,901 DEBUG : BROWSER_OUTPUT: 05:51:58 INFO - 2016-02-03 05:51:58,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-ext.html (next: http://localhost:47805/tests/dromaeo/cssquery-jquery.html) 05:51:59 INFO - 2016-02-03 05:51:59,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 208592896 05:51:59 INFO - 2016-02-03 05:51:59,531 DEBUG : BROWSER_OUTPUT: 05:55:01 INFO - 2016-02-03 05:55:01,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47805/tests/dromaeo/cssquery-mootools.html) 05:55:01 INFO - 2016-02-03 05:55:01,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 216092672 05:55:01 INFO - 2016-02-03 05:55:01,902 DEBUG : BROWSER_OUTPUT: 05:58:03 INFO - 2016-02-03 05:58:03,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47805/tests/dromaeo/cssquery-prototype.html) 05:58:04 INFO - 2016-02-03 05:58:04,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 197050368 05:58:04 INFO - 2016-02-03 05:58:04,195 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2016-02-03 06:01:06,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47805/tests/dromaeo/cssquery-yui.html) 06:01:07 INFO - 2016-02-03 06:01:07,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 198483968 06:01:07 INFO - 2016-02-03 06:01:07,154 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/dromaeo/cssquery-yui.html (next: http://localhost:47805/tests/dromaeo/cssquery-dojo.html) 06:04:09 INFO - 2016-02-03 06:04:09,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 211828736 06:04:09 INFO - 2016-02-03 06:04:09,526 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,527 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:04:09 INFO - 2016-02-03 06:04:09,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:04:09 INFO - 2016-02-03 06:04:09,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:04:09 INFO - 2016-02-03 06:04:09,528 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:04:09 INFO - 2016-02-03 06:04:09,529 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3178.745700343972;3240.0765781752207;3277.88527401541;3283.4254005549024;3308.338332333534;5257;5295.31160949077;5301.814436494724;5307.097793375126;5349.91975120373;5375.193720941861;5396.1905714142895;5398.217258497525;5401.729913504329;5409.323834520685;4889.095517329288;4913.238448040542;4934.851954441364;4963.751812409383;4998.77505512251;4958.553730164284;5012.122878496267;5017.623678224129;5020.849374518771;5021.196608542634;4966.677165984218;4993.725345106018;5022.497750224967;5044.243363495469;5091.363579552556;5005.799768009275;5007.273945277914;5010.574101201384;5018.874528136789;5041.521055499722;4808.134535783557;4916.115099282128;4926.556609905126;4977.850664480072;4981.676191047571;5186.870328241824;5252.264682944391;5343.786248550054;5355.0896347621;5376.516113549799;5820.068788993783;5861.443162899518;5862.794802181903;5864.794732184353;5867.501262392701;5742.08126699726;5900.350961394243;5901.0558310670085;5911.349751527328;5924.140999555084;5468.64453810505;5488.643238189505;5573.996680597531;5578.079616863172;5602.075657516505;5924.881502369928;5951.404859514014;5959.106134079922;5959.404059594006;5962.522998160137;5572.4706152915405;5652.6325788824415;5731.656100633892;5779.566532510079;5795.33353664334;5798.043322851682;5885.087811389156;5890.970545147246;5892.764289428461;5925.34821169671;5779.075347944393;5894.528437725057;5912.497437717842;5937.376575459601;5939.703014849327;5658.321001479849;5742.598018138774;5744.798932037359;5886.264216972879;5908.291005079418;4507.211238033331;4526.388937493462;4527.162474942146;4543.295789152687;4559.179347717442;4058.452108965311;4061.939070913939;4067.2678917795083;4074.5110586729784;4086.7547947123267;5390.8921821563345;5495.862603434946;5500.614956953055;5586.24585680936;5598.58010649203;5853.590248682552;5905.881882362329;5923.200367950271;5932.406759324033;5936.376680448577;5582.385937546866;5587.1339942309005;5588.105903055492;5591.161325801081;5592.468715472024;4817.807287708522;4841.080194762983;4893;4950.727709975986;4961.627877909099;5954.434328738763;5974.462298393166;5985.221921150222;5986.191864098378;5991.370906054889;5861.443162899518;5891.1752354671235;5891.3224979127945;5897;5897.67562784051;5745.8563535911935;5861.238039054895;5933.643981361132;6003.699815009145;6028.8794224116145;5778.191053252632;5785.334686511105;5816.883662326814;5822.155787410887;5828.184054232326;5638.407967163553;5888.617239879394;5897.734601943009;5902.852428689145;5903.970480147572;5609.382967873612;5670.376258611632;5759.683217422914;5772.307323121252;5790;5754.51086657622;5771.595988280948;5780.104083867007;5786.218860453785;5787.450192231731;5449.1826226066405;5600.243967064394;5665.291838520185;5681.857953551194;5700.572457065654;5716.28546431696;5722.3991480895575;5746.13807928814;5758.798442054675;5759.942400576108;5589.720513974204;5609.775608975595;5613.74738136793;5633.464820842013;5633.971830140823 06:04:09 INFO - 2016-02-03 06:04:09,531 DEBUG : BROWSER_OUTPUT: |1;ext.html;586.9266341707287;627.9826680777142;632.7880160146351;642.1844257792607;642.1908395421768;31291.843540782294;32140.83929580352;39874.80062599687;40269;40449;43776.56223437765;43973.78013109938;44153;44254.55745442545;44263.77868110663;7941.16617755136;8842.425242359242;9000.639974401016;9005.369624126313;9012.098790120968;8182.509049457022;10599.735006624858;10793.514291856885;10809.189310801681;10811.18916081297;10465.215108866827;10579.20655950803;10600.204984626145;10652;10653.84019239712;10406.375617462976;10467.267291289612;10476.423796691179;10526.578936842518;10573;10401.427921464316;10509.527071281811;10527.263091583593;10530.47347632623;10531.368117912873;41283.380749288786;41751.7912410439;41817;41871.16257674829;41877.79061104706;3529.135361836341;3595.8741444049333;3955.4066889966734;4059.634632883025;4180.749155050707;31557.84221078903;32017.199570010704;32217.51673724896;33067.83466082678;33448;4115.670746340315;4177.644900183488;4179.414881916534;4270.6156445919705;4272.03879127197;483512;490222.5488872568;492004;492239;492594;51910.480895190565;60295.69852150711;61503;71294.2870571298;72993.63503182556;65474.345256546825;65807.67096164488;65995;66066.66966665136;66226.66886665535;16093.11487868155;16109.27508262131;16143.596410089842;16151.192440377934;16589.66820663604;12202.511899524097;12228.327441990597;12245.632631021084;12282.75434491323;12570.057245706608;21728.674069888963;21923.780762192175;21948.34154975353;22002.339929802132;22042;7992.880106798402;8135.308498777552;8135.7152499662225;8208.630611622491;8350.874736878952;983.6950545330827;1018.2464975917768;1034.3586976074882;1124.3254047571554;1163.2903928603546;29136.562951555745;29202;29844.253893652833;29945.401091978474;30011.899167058098;1142.126273400849;1160.6866146140665;1169.9356535390466;1197.802362610177;1269.8412698412699;13016.674583135497;15324.770128448083;15446.459373921858;15583.298751556207;15852.76220856688;265445;267960;269253;270359;270974;50914.74542627263;50992.49007509877;51149.23276150861;51304;51356.48643513592;1447.0232592999682;1451.397669966952;1455.89080818939;1462.9341679624442;1466.6773309871812;29030.12909612715;29860;30060;30844;30901.227469313446;49271.75364123157;49569.26507572218;49579;49701.50298496969;49721.502784971686;322970;324119;324832;326475;328000;30314.69685303207;30562.84718576393;34445.31109377849;34744;34975.65024349724;43102.31352213852;44267;44330.335044973704;44472;44533.55466445294;37424.812875935444;37694.434583480725;38277.42583861189;38514.229715406094;38788.6121138785;36979.44530832094;37152;37415.25169496649;37529.6247037537;37673.811630942764;37188.81405592955;37265;37565.43651845279;44363.33454998242;44974;33620.663793362735;34033.829830850686;34596.65403346035;34662.82668586641;35292.647073529966;26606.60090098611;27041.72958270392;27135.86432067827;28365.432691345646;29348 06:04:09 INFO - 2016-02-03 06:04:09,532 DEBUG : BROWSER_OUTPUT: |2;jquery.html;372.93473642112633;374.4645157424883;374.9906252343693;375.7069485801076;376.39024779856635;14954.850451495482;16532.586685332873;17163.399281025166;18455.63088738226;19133.043347832623;10561.471926403687;10572.101371383422;10757.946210268958;10801.027907488324;10821.6753497395;3935.3703407454814;4978.850634480962;5088.5929125670045;5094.108531007059;5096.108181068316;3995.7602543847315;5386.48828361305;5487.42382049885;5533.3083364579425;5542.0301447246575;5426.131818908975;5452.263944367499;5453.7818487260465;5911.852203694921;6074.179985701918;6100.755969761204;6102.511799056065;6121.357257487966;6126.17296664949;6131.816045518619;4855.5872750816225;4989.850304490871;4996.9500304996845;5415.10650742627;5415.756290966916;11956.222845515014;12136;12795.360231988456;16078.5980350491;16095.678086438324;2291.9770802291932;2393.581123303415;2426.987865060681;2444.132333021769;2516.018752686454;9379.953100234523;9454.4800035998;9581.466965285521;9582.329236953416;9830.803383932353;1898.2122419196016;1968.7834338222783;1979.3270288102115;1998.8700734452214;2018.777934427212;63976;64206.67896660534;64644.67677661629;66333;66463;10166.186705063577;10318.535665895053;10380.42907640072;10439.739006524898;10452.843207351896;13400.396982135828;13476.258805765778;13479.123856949267;13538.59384218475;13736.862631373559;8016.118226995026;8139.226773456512;8218.260356567818;8241.134680858544;8296.170382961776;8014.559199244098;8014.959925200336;8031.638576264082;8071.192880711999;8130.878036829452;4031.6169963853386;4251.06476575153;4380.518143004267;4402.7358358498595;4437.267850804646;1731.5584525945803;1752.9824701752818;1785.9821401786076;1798.9910050449664;1827.541956069085;389.29537537058013;396.8372967083482;397.4157987757991;402.5813154319533;979.7256768104942;9985.950070249748;10180.592776288866;10233.130183934449;10311.1235544978;10344.431056291976;407.8287119409855;412.43496409918606;423.84529646679357;437.23702139765675;442.04297695488907;5552.861178470571;5667.914981275284;5675.801346952837;5709.8287051388525;5715.742791574389;567616;608251;654520;661651;667213;88593;90569;90865;90892.54553727321;95227;1202.4408649977627;1206.3365149167923;1218.5004148299154;1229.225587879648;1240.993795031019;15450.150241736812;15676.294566744296;15969;16027.519174424786;16168.838311617204;38260.234795304495;38690.6130938687;38698;38730.4190437138;38995.41506877342;49651.75174124251;49898.25152622786;50167.73909695858;50517.242241365675;50638.2404263929;8918.37571369998;9474.715758527254;9754.707358779247;9876.35803672759;9883.604655813975;13795.517156899461;16036.599085022968;17832.91083544574;18013.279468821624;18222.81551699135;14597.12417254968;15154.393824246907;15268.541943741706;15328.156951367337;15408.229588520753;14375.137491750529;14842.851571484147;15033.849661503245;15223.847761522244;15359.846401535842;15212.695746085237;15666.37334506607;15882.523524294289;16375.59061023484;16448.671026579163;8960.596773145095;9026.277897768294;9046.321525885716;9580.856287155559;9940.801183976135;14482.565523034325;14768.77846832277;15095.924520377328;15319.846801531841;15360.23198840076 06:04:09 INFO - 2016-02-03 06:04:09,535 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1537.9999999999998;1601.5996000999753;1639.2049855819932;1798.649263393638;1898.800625934276;7160.928390716092;7312.049433573641;8369.330453563716;8557.957210213941;8568.871466927993;8092.635831387587;8235.217654322845;8344.374171937114;8346.499210047401;8362.790930226747;2404.230646193219;2435.2937648082034;2440.45089854783;2440.9023639054417;2443.425794938197;2110.9366718998376;2149.0973791007814;2385.415573184572;2436.8050555955483;2444.0712529238863;2364.775346342103;2372.644103384489;2374.845635033726;2379.892904819287;2380.2978121454125;2357.9292621221307;2379.6668466414717;2380.8928598213124;2382.1543352110098;2384.7972922301624;2348.635961425982;2385.0698227691214;2388.558116748407;2391.689080419552;2391.988040059806;8391.202835730595;8413.621387037598;8479.830403391898;8489.702860399857;8490.830183396298;4900.215965445512;4977.776000080005;5010.348654674905;5013.39839219296;5013.473585273567;3104.8447577621027;3199.6480387157394;3201.4557525220766;3220.710136087763;3228.2575007748114;1037.045917755659;1064.6220591689994;1087.8748943871399;1091.8744344400416;1125.2741981422018;11654.242474239232;11707.53169873204;11725.70685732855;11735.765284694258;11744.999999999915;4433.512313645497;4446.644268458515;4503.617192538605;4509.864704058883;4514.367988481616;10006.19950403966;10013.49932503372;10015.849762253572;10037.749056273651;10042.046005629454;5032.270320803463;5034.597232221414;5035.597152227813;5036.496350364934;5037.647364684437;4597.172508948422;4598.770061496912;4601.631869450436;4602.677812553089;4605.976970115128;3683.3369993401443;3928.744631598937;3954.426608141803;3965.980170099189;3998.100427403869;1192.2905871006737;1205.1744554979866;1229.6003798765437;1272.8727127287198;1286.5239861251398;1163.7672465506932;1188.7503624238834;1191.7020744813797;1193.2780667696093;1215.7933151364289;7765.805854853561;7829.060512738508;7867.685292588232;7886.132525422199;8074.757757267292;1183.083110589283;1211.1098342718094;1220.8901198891965;1230.5693007447321;1237.7029512916836;6130.846728831815;6191.721372538246;6225.439710425992;6231.657258850807;6241.531885108635;9634.807303854024;9924.553395097239;10020.098191162684;10039.899601003897;10069.244806639532;9528.761780955532;9882.901170988342;9888.060634239735;9892.109710126124;9900.158486528582;7946.761597151979;8024.919750802534;8032.076311224284;8048.476849004796;8050.798730031679;7492.400607951242;7571.205023472456;7617.809554761176;7618.428617853794;7630.542167469969;8921.420107692978;9094.090590940854;9217.815643686954;9232.723018309192;9258.444493330422;8270.83458330842;8644.178803013703;9395.107464790834;9431.104045115702;9432.905670943202;7596.088469383489;7688.11586667518;7697.807554811175;7698.191689872483;7699.076110866732;7194.89207661875;8208.384371172067;8229.79425514367;8360.707375241838;8368.41421100517;6874.072000279898;7263.164736055422;7521.360684341892;7597.126330471845;7616.9238307616215;7406.333429991327;7437.367823734827;7470.140933792683;7516.47384683067;7533;7327;7347.7795666130105;7377.26227377258;7381.298776616213;7392.22381649919;6683.966580167068;6760.222574404006;6766.120404347404;6769.221539523018;6786.59280443175;6894.896576551456;6920.58476491392;6930.099087118642;6933.3066693332285;6942.583444993316 06:04:09 INFO - 2016-02-03 06:04:09,537 DEBUG : BROWSER_OUTPUT: |4;prototype.html;365.10549154571305;367.6433859156618;367.92273622539267;369.2006805266599;374.6777771116839;6055.636661800284;6130.846728831782;6144.44699977002;6148.538859585532;6196.442320191182;5872.0898260769645;6013.188219590354;6044.516438684906;6086.421789929949;6091.360407157251;4750.263709125091;4758.072175925696;4760.3811504504365;4762.261849413347;4765.21373973294;4710.552497512731;4736.3369128322065;4751.524847515256;4765.952340476586;4772.403449568804;4472.932906006413;4593.632509399256;4596.35651008859;4621.237495813203;4668.089722504113;4573.931391029138;4598.425196850394;4601.539846015406;4602.976985115087;4610.216263235258;3894.9610503894883;3998.040470287139;4007.8196481158416;4012.1574469361467;4019.718619696622;5743.942560574383;5807.854803629901;5831.883362332772;5839.386864379221;5891.322497912752;5400.29796126505;5413.864653383657;5418.647787893774;5422.6475279106735;5430.8370748877205;6364.522660800412;6464.709088091;6464.93535064648;6469.191351081115;6474.546781725234;4529.184746745585;4536.818527258905;4539.568740969603;4540.8637740867825;4548.795304211319;6572.704228309737;6634.369734875179;6641.003849422577;6641.933580664228;6675.3324667533825;4649.232876575327;4655.37152484417;4658.34783130362;4658.627309815207;4661.021185551004;4614.97692511542;4677.134730074947;4697.248440249544;4704.529547045337;4705.106029854317;5412.215228791882;5420.159875219348;5420.864478387993;5422.674639521562;5424.755885985141;6505.056766768792;6507.446867016357;6511.348865113546;6516.413522782972;6520.021996700438;1641.8440248176405;1667.4080701351088;1667.9499615011568;1668.1242347767277;1668.5328108129743;1114.3536748685742;1122.0518661730825;1125.634168895096;1141.3095077478006;1148.6439203846835;6303.558750887486;6313;6315.747370105236;6316.05259211122;6321.715522801485;6717.193936727526;6717.5297729159465;6718.126643536309;6722.428593569602;6729.899051514231;6229.0967809667345;6248.625082495065;6308.968455157695;6309.652969086653;6311.400416960381;3654.488371627974;3684.5762737285017;3687;3694.07648087978;3694.2796154749567;6625.7680981166395;6766.7969960901255;6794.830129246809;6829.556078854858;6832.487563432763;6927.134108236471;6948.062011628365;6961.965190174118;6982.755603553851;6990.266022067712;6723.7646682365885;6933.445324374038;6935.826604334831;6936.786062439053;6951.0616066830335;6764.830879228059;6777.085093512313;6779.118714567075;6781.491388145811;6787.524873258824;6684.398404143651;6685.164354455693;6693.09643198162;6694.698738556874;6758.357955994173;6801.809683305501;6939.340762627542;6944.861102777815;6959.40845028158;6963.9303606963285;4686.133065382915;4715.575598196178;4716.622670186445;4730.716157030589;4731.952680473289;6772.322767723385;6784.151981002375;6793.592384456949;6794.558353706993;6794.93205067943;6524.119243902012;6606.372394622503;6615.834604134935;6637.2699003108655;6643.46852251809;6622.90065649006;6627.569208001464;6627.9337206627315;6634.137562117087;6635.734570617121;6514.055461958084;6523.347665233438;6525.2822189558165;6526.543141980016;6528.836779080561;6480.25477070143;6593.307702691149;6650.9667451662435;6652.368025037614;6668.766593169215;6461.386168314003;6462.063000864754;6480.351964803671;6480.384363485461;6481.060246264359 06:04:09 INFO - 2016-02-03 06:04:09,538 DEBUG : BROWSER_OUTPUT: |5;yui.html;905.9909400905993;915.9084091590837;917.687986084731;920.1350730313504;924.5700749151644;11970.82043769343;12164.635060948163;12184.51261949521;12185.634430967075;12277.324747138904;11861.881381186186;11890.346030968314;11914.582989595367;11935;11937.164398492108;716.0154787167645;727.3671905442272;727.5998200989461;728.8651599454118;830.0620299062051;870.1298701298701;878.6880657366638;882.5234373438335;883.3286702106413;883.4875772052227;843.2115971566574;919.3977944446399;931.8741969834088;932.2961164320928;933.351320832022;748.6331697468256;758.2531206761336;902.2376092202079;925.7084018534174;928.0580211085753;682.8019874236466;683.9213490448612;684.7569112964876;685.1777866560147;685.4927353758183;12158.452869620889;12161.270323780602;12257.019438444902;12257.387130643521;12264.81602775959;11629.360385178812;11756.823647645293;11818.17272790905;12150.270983741004;12518.12373133881;10160;10434.478276086242;10489.56629294182;10492.737681557946;10518.316309439862;3630.9273814523563;3686.668199862025;3692.5199724035974;3693.9445908311395;3696.9260614787554;46847.29729054067;46903;47208;47683.99999999965;47853;9710.271729620306;9782;9834.114929656365;9847.359921605073;9967;16925.492235232963;16944.966604007597;17001.659966800842;17056.573585660208;17059.232334544977;7462.589557574385;7567.432442566719;7756.767296981099;7983.2016798320865;8073.555954422446;4589.128065667513;4690.085433340534;4764.475907650156;4777.4505931818285;4805.471398146201;3118.3451475190463;3159.9684003160132;3163.6994485523837;3170.0489853043996;3170.2074481379655;555.977760889568;565.9575531835129;580.8025271407741;582.8397190772487;587.5505238492557;581.3575998521573;708.0865683268526;715.8675645005586;729.1104852080454;731.2066407947331;8389.370797190113;8687.869681954775;8705.434146780439;8746;8880.555972201364;616.1650962945234;657.6536423513137;695.6452209373256;729.5695539631643;734.0787311923502;3875.3218186817758;3953.5453422856162;3959.544652365015;3988.880333589997;3995.300822356076;58695.70652146712;59593.70203148956;60017.39982600205;60030.69984650049;60113.89601364019;52881.7355913218;53062;53365.1995220072;53523;53607.73196134072;47428.288575671395;48411.51588484141;48418;48608;49254.50745492499;8150.83698326042;8283.668653253802;8393;8502.659893604434;8578.65685372578;36027;36124;36640.63359366479;36872.44691329686;37381;43007;43656;47413.28880066733;47854.760726197535;48143.75928120477;9741.074597913186;9761.365511241747;10057.491376293321;10159.644412445825;10377.84433233487;10732.08777253911;10820.621278255223;10881.619143329945;10911.290766100496;12747.936260318638;11051.447427628747;11430.428478576205;11437.59968401102;11483.942580287045;11615.128865334964;10843.295185812896;10908.890911091104;11123.388213648326;11412.771744564896;11666.591669291534;10530.57877684884;10605.416702081151;10623.681289561016;10973.177011723992;11253.437328133725;8543.359248056546;8559.443636163629;9019.909800901907;9251.074892510695;9256.444613323221;8888;8998.86501702488;9223.907760922304;9261.583228754856;9399.624015039595 06:04:09 INFO - 2016-02-03 06:04:09,538 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:04:09 INFO - 2016-02-03 06:04:09,538 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:04:09 INFO - 2016-02-03 06:04:09,538 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 06:04:09 INFO - 2016-02-03 06:04:09,538 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: __startTimestamp1454508249526__endTimestamp 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5426.42 Median:5633.46 stddev:599.26 (10.6%) stddev-sans-first:574.58 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: Values: 3178.7 3240.1 3277.9 3283.4 3308.3 5257.0 5295.3 5301.8 5307.1 5349.9 5375.2 5396.2 5398.2 5401.7 5409.3 4889.1 4913.2 4934.9 4963.8 4998.8 4958.6 5012.1 5017.6 5020.8 5021.2 4966.7 4993.7 5022.5 5044.2 5091.4 5005.8 5007.3 5010.6 5018.9 5041.5 4808.1 4916.1 4926.6 4977.9 4981.7 5186.9 5252.3 5343.8 5355.1 5376.5 5820.1 5861.4 5862.8 5864.8 5867.5 5742.1 5900.4 5901.1 5911.3 5924.1 5468.6 5488.6 5574.0 5578.1 5602.1 5924.9 5951.4 5959.1 5959.4 5962.5 5572.5 5652.6 5731.7 5779.6 5795.3 5798.0 5885.1 5891.0 5892.8 5925.3 5779.1 5894.5 5912.5 5937.4 5939.7 5658.3 5742.6 5744.8 5886.3 5908.3 4507.2 4526.4 4527.2 4543.3 4559.2 4058.5 4061.9 4067.3 4074.5 4086.8 5390.9 5495.9 5500.6 5586.2 5598.6 5853.6 5905.9 5923.2 5932.4 5936.4 5582.4 5587.1 5588.1 5591.2 5592.5 4817.8 4841.1 4893.0 4950.7 4961.6 5954.4 5974.5 5985.2 5986.2 5991.4 5861.4 5891.2 5891.3 5897.0 5897.7 5745.9 5861.2 5933.6 6003.7 6028.9 5778.2 5785.3 5816.9 5822.2 5828.2 5638.4 5888.6 5897.7 5902.9 5904.0 5609.4 5670.4 5759.7 5772.3 5790.0 5754.5 5771.6 5780.1 5786.2 5787.5 5449.2 5600.2 5665.3 5681.9 5700.6 5716.3 5722.4 5746.1 5758.8 5759.9 5589.7 5609.8 5613.7 5633.5 5634.0 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53359.77 Median:34629.74 stddev:98654.66 (284.9%) stddev-sans-first:98851.84 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: Values: 586.9 628.0 632.8 642.2 642.2 31291.8 32140.8 39874.8 40269.0 40449.0 43776.6 43973.8 44153.0 44254.6 44263.8 7941.2 8842.4 9000.6 9005.4 9012.1 8182.5 10599.7 10793.5 10809.2 10811.2 10465.2 10579.2 10600.2 10652.0 10653.8 10406.4 10467.3 10476.4 10526.6 10573.0 10401.4 10509.5 10527.3 10530.5 10531.4 41283.4 41751.8 41817.0 41871.2 41877.8 3529.1 3595.9 3955.4 4059.6 4180.7 31557.8 32017.2 32217.5 33067.8 33448.0 4115.7 4177.6 4179.4 4270.6 4272.0 483512.0 490222.5 492004.0 492239.0 492594.0 51910.5 60295.7 61503.0 71294.3 72993.6 65474.3 65807.7 65995.0 66066.7 66226.7 16093.1 16109.3 16143.6 16151.2 16589.7 12202.5 12228.3 12245.6 12282.8 12570.1 21728.7 21923.8 21948.3 22002.3 22042.0 7992.9 8135.3 8135.7 8208.6 8350.9 983.7 1018.2 1034.4 1124.3 1163.3 29136.6 29202.0 29844.3 29945.4 30011.9 1142.1 1160.7 1169.9 1197.8 1269.8 13016.7 15324.8 15446.5 15583.3 15852.8 265445.0 267960.0 269253.0 270359.0 270974.0 50914.7 50992.5 51149.2 51304.0 51356.5 1447.0 1451.4 1455.9 1462.9 1466.7 29030.1 29860.0 30060.0 30844.0 30901.2 49271.8 49569.3 49579.0 49701.5 49721.5 322970.0 324119.0 324832.0 326475.0 328000.0 30314.7 30562.8 34445.3 34744.0 34975.7 43102.3 44267.0 44330.3 44472.0 44533.6 37424.8 37694.4 38277.4 38514.2 38788.6 36979.4 37152.0 37415.3 37529.6 37673.8 37188.8 37265.0 37565.4 44363.3 44974.0 33620.7 34033.8 34596.7 34662.8 35292.6 26606.6 27041.7 27135.9 28365.4 29348.0 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31580.14 Median:2166.10 stddev:103630.77 (4784.2%) stddev-sans-first:103894.98 06:04:09 INFO - 2016-02-03 06:04:09,539 DEBUG : BROWSER_OUTPUT: Values: 372.9 374.5 375.0 375.7 376.4 14954.9 16532.6 17163.4 18455.6 19133.0 10561.5 10572.1 10757.9 10801.0 10821.7 3935.4 4978.9 5088.6 5094.1 5096.1 3995.8 5386.5 5487.4 5533.3 5542.0 5426.1 5452.3 5453.8 5911.9 6074.2 6100.8 6102.5 6121.4 6126.2 6131.8 4855.6 4989.9 4997.0 5415.1 5415.8 11956.2 12136.0 12795.4 16078.6 16095.7 2292.0 2393.6 2427.0 2444.1 2516.0 9380.0 9454.5 9581.5 9582.3 9830.8 1898.2 1968.8 1979.3 1998.9 2018.8 63976.0 64206.7 64644.7 66333.0 66463.0 10166.2 10318.5 10380.4 10439.7 10452.8 13400.4 13476.3 13479.1 13538.6 13736.9 8016.1 8139.2 8218.3 8241.1 8296.2 8014.6 8015.0 8031.6 8071.2 8130.9 4031.6 4251.1 4380.5 4402.7 4437.3 1731.6 1753.0 1786.0 1799.0 1827.5 389.3 396.8 397.4 402.6 979.7 9986.0 10180.6 10233.1 10311.1 10344.4 407.8 412.4 423.8 437.2 442.0 5552.9 5667.9 5675.8 5709.8 5715.7 567616.0 608251.0 654520.0 661651.0 667213.0 88593.0 90569.0 90865.0 90892.5 95227.0 1202.4 1206.3 1218.5 1229.2 1241.0 15450.2 15676.3 15969.0 16027.5 16168.8 38260.2 38690.6 38698.0 38730.4 38995.4 49651.8 49898.3 50167.7 50517.2 50638.2 8918.4 9474.7 9754.7 9876.4 9883.6 13795.5 16036.6 17832.9 18013.3 18222.8 14597.1 15154.4 15268.5 15328.2 15408.2 14375.1 14842.9 15033.8 15223.8 15359.8 15212.7 15666.4 15882.5 16375.6 16448.7 8960.6 9026.3 9046.3 9580.9 9940.8 14482.6 14768.8 15095.9 15319.8 15360.2 06:04:09 INFO - 2016-02-03 06:04:09,540 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5839.44 Median:5036.05 stddev:3052.71 (60.6%) stddev-sans-first:3044.16 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: Values: 1538.0 1601.6 1639.2 1798.6 1898.8 7160.9 7312.0 8369.3 8558.0 8568.9 8092.6 8235.2 8344.4 8346.5 8362.8 2404.2 2435.3 2440.5 2440.9 2443.4 2110.9 2149.1 2385.4 2436.8 2444.1 2364.8 2372.6 2374.8 2379.9 2380.3 2357.9 2379.7 2380.9 2382.2 2384.8 2348.6 2385.1 2388.6 2391.7 2392.0 8391.2 8413.6 8479.8 8489.7 8490.8 4900.2 4977.8 5010.3 5013.4 5013.5 3104.8 3199.6 3201.5 3220.7 3228.3 1037.0 1064.6 1087.9 1091.9 1125.3 11654.2 11707.5 11725.7 11735.8 11745.0 4433.5 4446.6 4503.6 4509.9 4514.4 10006.2 10013.5 10015.8 10037.7 10042.0 5032.3 5034.6 5035.6 5036.5 5037.6 4597.2 4598.8 4601.6 4602.7 4606.0 3683.3 3928.7 3954.4 3966.0 3998.1 1192.3 1205.2 1229.6 1272.9 1286.5 1163.8 1188.8 1191.7 1193.3 1215.8 7765.8 7829.1 7867.7 7886.1 8074.8 1183.1 1211.1 1220.9 1230.6 1237.7 6130.8 6191.7 6225.4 6231.7 6241.5 9634.8 9924.6 10020.1 10039.9 10069.2 9528.8 9882.9 9888.1 9892.1 9900.2 7946.8 8024.9 8032.1 8048.5 8050.8 7492.4 7571.2 7617.8 7618.4 7630.5 8921.4 9094.1 9217.8 9232.7 9258.4 8270.8 8644.2 9395.1 9431.1 9432.9 7596.1 7688.1 7697.8 7698.2 7699.1 7194.9 8208.4 8229.8 8360.7 8368.4 6874.1 7263.2 7521.4 7597.1 7616.9 7406.3 7437.4 7470.1 7516.5 7533.0 7327.0 7347.8 7377.3 7381.3 7392.2 6684.0 6760.2 6766.1 6769.2 6786.6 6894.9 6920.6 6930.1 6933.3 6942.6 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5458.44 Median:6238.86 stddev:1640.54 (26.3%) stddev-sans-first:1599.98 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: Values: 365.1 367.6 367.9 369.2 374.7 6055.6 6130.8 6144.4 6148.5 6196.4 5872.1 6013.2 6044.5 6086.4 6091.4 4750.3 4758.1 4760.4 4762.3 4765.2 4710.6 4736.3 4751.5 4766.0 4772.4 4472.9 4593.6 4596.4 4621.2 4668.1 4573.9 4598.4 4601.5 4603.0 4610.2 3895.0 3998.0 4007.8 4012.2 4019.7 5743.9 5807.9 5831.9 5839.4 5891.3 5400.3 5413.9 5418.6 5422.6 5430.8 6364.5 6464.7 6464.9 6469.2 6474.5 4529.2 4536.8 4539.6 4540.9 4548.8 6572.7 6634.4 6641.0 6641.9 6675.3 4649.2 4655.4 4658.3 4658.6 4661.0 4615.0 4677.1 4697.2 4704.5 4705.1 5412.2 5420.2 5420.9 5422.7 5424.8 6505.1 6507.4 6511.3 6516.4 6520.0 1641.8 1667.4 1667.9 1668.1 1668.5 1114.4 1122.1 1125.6 1141.3 1148.6 6303.6 6313.0 6315.7 6316.1 6321.7 6717.2 6717.5 6718.1 6722.4 6729.9 6229.1 6248.6 6309.0 6309.7 6311.4 3654.5 3684.6 3687.0 3694.1 3694.3 6625.8 6766.8 6794.8 6829.6 6832.5 6927.1 6948.1 6962.0 6982.8 6990.3 6723.8 6933.4 6935.8 6936.8 6951.1 6764.8 6777.1 6779.1 6781.5 6787.5 6684.4 6685.2 6693.1 6694.7 6758.4 6801.8 6939.3 6944.9 6959.4 6963.9 4686.1 4715.6 4716.6 4730.7 4732.0 6772.3 6784.2 6793.6 6794.6 6794.9 6524.1 6606.4 6615.8 6637.3 6643.5 6622.9 6627.6 6627.9 6634.1 6635.7 6514.1 6523.3 6525.3 6526.5 6528.8 6480.3 6593.3 6651.0 6652.4 6668.8 6461.4 6462.1 6480.4 6480.4 6481.1 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13800.95 Median:48513.00 stddev:16463.60 (33.9%) stddev-sans-first:16481.31 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: Values: 906.0 915.9 917.7 920.1 924.6 11970.8 12164.6 12184.5 12185.6 12277.3 11861.9 11890.3 11914.6 11935.0 11937.2 716.0 727.4 727.6 728.9 830.1 870.1 878.7 882.5 883.3 883.5 843.2 919.4 931.9 932.3 933.4 748.6 758.3 902.2 925.7 928.1 682.8 683.9 684.8 685.2 685.5 12158.5 12161.3 12257.0 12257.4 12264.8 11629.4 11756.8 11818.2 12150.3 12518.1 10160.0 10434.5 10489.6 10492.7 10518.3 3630.9 3686.7 3692.5 3693.9 3696.9 46847.3 46903.0 47208.0 47684.0 47853.0 9710.3 9782.0 9834.1 9847.4 9967.0 16925.5 16945.0 17001.7 17056.6 17059.2 7462.6 7567.4 7756.8 7983.2 8073.6 4589.1 4690.1 4764.5 4777.5 4805.5 3118.3 3160.0 3163.7 3170.0 3170.2 556.0 566.0 580.8 582.8 587.6 581.4 708.1 715.9 729.1 731.2 8389.4 8687.9 8705.4 8746.0 8880.6 616.2 657.7 695.6 729.6 734.1 3875.3 3953.5 3959.5 3988.9 3995.3 58695.7 59593.7 60017.4 60030.7 60113.9 52881.7 53062.0 53365.2 53523.0 53607.7 47428.3 48411.5 48418.0 48608.0 49254.5 8150.8 8283.7 8393.0 8502.7 8578.7 36027.0 36124.0 36640.6 36872.4 37381.0 43007.0 43656.0 47413.3 47854.8 48143.8 9741.1 9761.4 10057.5 10159.6 10377.8 10732.1 10820.6 10881.6 10911.3 12747.9 11051.4 11430.4 11437.6 11483.9 11615.1 10843.3 10908.9 11123.4 11412.8 11666.6 10530.6 10605.4 10623.7 10973.2 11253.4 8543.4 8559.4 9019.9 9251.1 9256.4 8888.0 8998.9 9223.9 9261.6 9399.6 06:04:09 INFO - 2016-02-03 06:04:09,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:04:09 INFO - 2016-02-03 06:04:09,542 DEBUG : BROWSER_OUTPUT: 06:04:10 INFO - 2016-02-03 06:04:10,085 INFO : Browser exited with error code: 0 06:04:10 INFO - 2016-02-03 06:04:10,106 INFO : Completed test dromaeo_css (00:18:29) 06:04:10 INFO - 2016-02-03 06:04:10,106 INFO : Starting test kraken 06:04:10 INFO - 2016-02-03 06:04:10,106 DEBUG : operating with platform_type : linux_ 06:04:10 INFO - 2016-02-03 06:04:10,106 INFO : Initialising browser for kraken test... 06:04:10 INFO - 2016-02-03 06:04:10,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpswQUEw/profile http://localhost:47805/getInfo.html 06:04:13 INFO - 2016-02-03 06:04:13,788 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:04:13 INFO - 2016-02-03 06:04:13,789 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:04:13 INFO - 2016-02-03 06:04:13,789 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:04:13 INFO - 2016-02-03 06:04:13,789 DEBUG : BROWSER_OUTPUT: __metrics 06:04:13 INFO - 2016-02-03 06:04:13,925 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] 06:04:14 INFO - 2016-02-03 06:04:14,532 INFO : Browser initialized. 06:04:14 INFO - 2016-02-03 06:04:14,532 INFO : Running cycle 1/1 for kraken test... 06:04:14 INFO - 2016-02-03 06:04:14,533 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpswQUEw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:04:26 INFO - 2016-02-03 06:04:26,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 135143424 06:04:26 INFO - 2016-02-03 06:04:26,343 DEBUG : BROWSER_OUTPUT: 06:04:28 INFO - 2016-02-03 06:04:28,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47805/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:29 INFO - 2016-02-03 06:04:29,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 165326848 06:04:29 INFO - 2016-02-03 06:04:29,351 DEBUG : BROWSER_OUTPUT: 06:04:31 INFO - 2016-02-03 06:04:31,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47805/tests/kraken/driver.html?testName=audio-dft) 06:04:32 INFO - 2016-02-03 06:04:32,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 163557376 06:04:32 INFO - 2016-02-03 06:04:32,442 DEBUG : BROWSER_OUTPUT: 06:04:35 INFO - 2016-02-03 06:04:35,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47805/tests/kraken/driver.html?testName=audio-fft) 06:04:35 INFO - 2016-02-03 06:04:35,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 160600064 06:04:35 INFO - 2016-02-03 06:04:35,766 DEBUG : BROWSER_OUTPUT: 06:04:37 INFO - 2016-02-03 06:04:37,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47805/tests/kraken/driver.html?testName=audio-oscillator) 06:04:38 INFO - 2016-02-03 06:04:38,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 161390592 06:04:38 INFO - 2016-02-03 06:04:38,293 DEBUG : BROWSER_OUTPUT: 06:04:40 INFO - 2016-02-03 06:04:40,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:41 INFO - 2016-02-03 06:04:41,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 160034816 06:04:41 INFO - 2016-02-03 06:04:41,063 DEBUG : BROWSER_OUTPUT: 06:04:43 INFO - 2016-02-03 06:04:43,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47805/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:44 INFO - 2016-02-03 06:04:44,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 160657408 06:04:44 INFO - 2016-02-03 06:04:44,466 DEBUG : BROWSER_OUTPUT: 06:04:47 INFO - 2016-02-03 06:04:47,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47805/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:48 INFO - 2016-02-03 06:04:48,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 159977472 06:04:48 INFO - 2016-02-03 06:04:48,366 DEBUG : BROWSER_OUTPUT: 06:04:51 INFO - 2016-02-03 06:04:51,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47805/tests/kraken/driver.html?testName=json-parse-financial) 06:04:51 INFO - 2016-02-03 06:04:51,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 160342016 06:04:51 INFO - 2016-02-03 06:04:51,631 DEBUG : BROWSER_OUTPUT: 06:04:53 INFO - 2016-02-03 06:04:53,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:53 INFO - 2016-02-03 06:04:53,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 169263104 06:04:53 INFO - 2016-02-03 06:04:53,744 DEBUG : BROWSER_OUTPUT: 06:04:55 INFO - 2016-02-03 06:04:55,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:56 INFO - 2016-02-03 06:04:56,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 167215104 06:04:56 INFO - 2016-02-03 06:04:56,088 DEBUG : BROWSER_OUTPUT: 06:04:58 INFO - 2016-02-03 06:04:58,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:58 INFO - 2016-02-03 06:04:58,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 172646400 06:04:58 INFO - 2016-02-03 06:04:58,602 DEBUG : BROWSER_OUTPUT: 06:05:00 INFO - 2016-02-03 06:05:00,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:01 INFO - 2016-02-03 06:05:01,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 179298304 06:05:01 INFO - 2016-02-03 06:05:01,539 DEBUG : BROWSER_OUTPUT: 06:05:04 INFO - 2016-02-03 06:05:04,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:04 INFO - 2016-02-03 06:05:04,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 176435200 06:05:04 INFO - 2016-02-03 06:05:04,596 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47805/tests/kraken/driver.html?testName=ai-astar) 06:05:06 INFO - 2016-02-03 06:05:06,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 234115072 06:05:06 INFO - 2016-02-03 06:05:06,512 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,512 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:05:06 INFO - 2016-02-03 06:05:06,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:05:06 INFO - 2016-02-03 06:05:06,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:05:06 INFO - 2016-02-03 06:05:06,512 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:05:06 INFO - 2016-02-03 06:05:06,513 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;102;108;111;109;98;109;110;109 06:05:06 INFO - 2016-02-03 06:05:06,513 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;120;145;157;122;145;147;125;156;120 06:05:06 INFO - 2016-02-03 06:05:06,513 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;159;158;158;162;164;161;161 06:05:06 INFO - 2016-02-03 06:05:06,513 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;71;151;71;71;71;73;161;72 06:05:06 INFO - 2016-02-03 06:05:06,513 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;93;140;91;92;93;135;93;92;134 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;110;110 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;145;146;146;147;145;145;145 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;96;96;96;95;95 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;56;57;58;59;59;58;55 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;63;63;63;65;63;62;64;63 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;76;77;78;78;77;77;78;78 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;118;114;118;111;113;120;114;124;111 06:05:06 INFO - 2016-02-03 06:05:06,514 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;146;148;141;153;146;142;142;141;133 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;63;65;64;62;63;63;65;67;65 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:05:06 INFO - 2016-02-03 06:05:06,515 DEBUG : BROWSER_OUTPUT: __startTimestamp1454508306505__endTimestamp 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.50 stddev:4.12 (3.8%) stddev-sans-first:4.36 06:05:06 INFO - 2016-02-03 06:05:06,516 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 102.0 108.0 111.0 109.0 98.0 109.0 110.0 109.0 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.50 stddev:14.91 (10.2%) stddev-sans-first:15.55 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: Values: 146.0 120.0 145.0 157.0 122.0 145.0 147.0 125.0 156.0 120.0 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.87 (1.2%) stddev-sans-first:1.99 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 159.0 158.0 158.0 162.0 164.0 161.0 161.0 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,517 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.20 Median:71.00 stddev:35.82 (50.5%) stddev-sans-first:37.38 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 151.0 71.0 71.0 71.0 73.0 161.0 72.0 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:20.89 (22.7%) stddev-sans-first:22.07 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: Values: 101.0 93.0 140.0 91.0 92.0 93.0 135.0 93.0 92.0 134.0 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 06:05:06 INFO - 2016-02-03 06:05:06,519 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 145.0 146.0 146.0 147.0 145.0 145.0 145.0 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:1.25 (2.2%) stddev-sans-first:1.32 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 56.0 57.0 58.0 59.0 59.0 58.0 55.0 06:05:06 INFO - 2016-02-03 06:05:06,520 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.97 (1.5%) stddev-sans-first:0.87 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 63.0 63.0 63.0 65.0 63.0 62.0 64.0 63.0 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 76.0 77.0 78.0 78.0 77.0 77.0 78.0 78.0 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:4.33 (3.7%) stddev-sans-first:4.40 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: Values: 112.0 118.0 114.0 118.0 111.0 113.0 120.0 114.0 124.0 111.0 06:05:06 INFO - 2016-02-03 06:05:06,521 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:144.00 stddev:6.24 (4.3%) stddev-sans-first:5.59 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: Values: 133.0 146.0 148.0 141.0 153.0 146.0 142.0 142.0 141.0 133.0 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.49 (2.3%) stddev-sans-first:1.54 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 65.0 64.0 62.0 63.0 63.0 65.0 67.0 65.0 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:05:06 INFO - 2016-02-03 06:05:06,522 DEBUG : BROWSER_OUTPUT: 06:05:07 INFO - 2016-02-03 06:05:07,161 INFO : Browser exited with error code: 0 06:05:07 INFO - 2016-02-03 06:05:07,212 INFO : Completed test kraken (00:00:57) 06:05:07 INFO - 2016-02-03 06:05:07,212 INFO : Starting test v8_7 06:05:07 INFO - 2016-02-03 06:05:07,212 DEBUG : operating with platform_type : linux_ 06:05:07 INFO - 2016-02-03 06:05:07,213 INFO : Initialising browser for v8_7 test... 06:05:07 INFO - 2016-02-03 06:05:07,219 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9srnmW/profile http://localhost:47805/getInfo.html 06:05:10 INFO - 2016-02-03 06:05:10,697 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:05:10 INFO - 2016-02-03 06:05:10,697 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:05:10 INFO - 2016-02-03 06:05:10,697 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:05:10 INFO - 2016-02-03 06:05:10,697 DEBUG : BROWSER_OUTPUT: __metrics 06:05:10 INFO - 2016-02-03 06:05:10,842 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] 06:05:11 INFO - 2016-02-03 06:05:11,788 INFO : Browser initialized. 06:05:11 INFO - 2016-02-03 06:05:11,789 INFO : Running cycle 1/1 for v8_7 test... 06:05:11 INFO - 2016-02-03 06:05:11,789 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9srnmW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:05:23 INFO - 2016-02-03 06:05:23,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 134414336 06:05:23 INFO - 2016-02-03 06:05:23,537 DEBUG : BROWSER_OUTPUT: 06:05:44 INFO - 2016-02-03 06:05:44,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47805/tests/v8_7/run.html (next: http://localhost:47805/tests/v8_7/run.html) 06:05:45 INFO - 2016-02-03 06:05:45,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 423305216 06:05:45 INFO - 2016-02-03 06:05:45,107 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: |0;Richards;167.16817118020728 06:05:45 INFO - 2016-02-03 06:05:45,109 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.53550736633008 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |5;Earley;547.945205479452 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |6;Boyer;10568.421052631578 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 06:05:45 INFO - 2016-02-03 06:05:45,110 DEBUG : BROWSER_OUTPUT: |8;Splay;529.6610169491526 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: __startTimestamp1454508345108__endTimestamp 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:05:45 INFO - 2016-02-03 06:05:45,111 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:05:45 INFO - 2016-02-03 06:05:45,112 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,113 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,113 DEBUG : BROWSER_OUTPUT: Values: 167.2 06:05:45 INFO - 2016-02-03 06:05:45,113 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,113 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,113 DEBUG : BROWSER_OUTPUT: Values: 165.5 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: Values: 278.9 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: Values: 5181.3 06:05:45 INFO - 2016-02-03 06:05:45,114 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: Values: 941.6 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.95 Median:547.95 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: Values: 547.9 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10568.42 Median:10568.42 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,115 DEBUG : BROWSER_OUTPUT: Values: 10568.4 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: Values: 24047.6 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.66 Median:529.66 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: Values: 529.7 06:05:45 INFO - 2016-02-03 06:05:45,116 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,117 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 06:05:45 INFO - 2016-02-03 06:05:45,117 DEBUG : BROWSER_OUTPUT: Values: 4822.1 06:05:45 INFO - 2016-02-03 06:05:45,117 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:05:45 INFO - 2016-02-03 06:05:45,117 DEBUG : BROWSER_OUTPUT: 06:05:45 INFO - 2016-02-03 06:05:45,729 INFO : Browser exited with error code: 0 06:05:45 INFO - 2016-02-03 06:05:45,744 INFO : Completed test v8_7 (00:00:38) 06:05:46 INFO - 2016-02-03 06:05:46,182 INFO : Completed test suite (00:20:05) 06:05:46 INFO - 2016-02-03 06:05:46,182 DEBUG : Working with test: dromaeo_css 06:05:46 INFO - 2016-02-03 06:05:46,182 DEBUG : Generating results file: dromaeo_css 06:05:46 INFO - 2016-02-03 06:05:46,183 DEBUG : Working with test: kraken 06:05:46 INFO - 2016-02-03 06:05:46,183 DEBUG : Generating results file: kraken 06:05:46 INFO - 2016-02-03 06:05:46,184 INFO : javascript benchmark 06:05:46 INFO - 2016-02-03 06:05:46,184 DEBUG : Working with test: v8_7 06:05:46 INFO - 2016-02-03 06:05:46,184 DEBUG : Generating results file: v8_7 06:05:46 INFO - 2016-02-03 06:05:46,184 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:46 INFO - 2016-02-03 06:05:46,252 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 06:05:46 INFO - 2016-02-03 06:05:46,252 DEBUG : process_Request line: dromaeo_css 7165.26 graph.html#tests=[[72,53,35]] 06:05:46 INFO - 2016-02-03 06:05:46,252 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:46 INFO - 2016-02-03 06:05:46,288 DEBUG : process_Request line: kraken 1471.10 graph.html#tests=[[232,53,35]] 06:05:46 INFO - 2016-02-03 06:05:46,288 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:46 INFO - 2016-02-03 06:05:46,325 DEBUG : process_Request line: v8_7 23264.81 graph.html#tests=[[230,53,35]] 06:05:46 INFO - 2016-02-03 06:05:46,326 INFO : javascript benchmark 06:05:46 INFO - 2016-02-03 06:05:46,329 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.745700343972, 3240.0765781752207, 3277.88527401541, 3283.4254005549024, 3308.338332333534, 5257.0, 5295.31160949077, 5301.814436494724, 5307.097793375126, 5349.91975120373, 5375.193720941861, 5396.1905714142895, 5398.217258497525, 5401.729913504329, 5409.323834520685, 4889.095517329288, 4913.238448040542, 4934.851954441364, 4963.751812409383, 4998.77505512251, 4958.553730164284, 5012.122878496267, 5017.623678224129, 5020.849374518771, 5021.196608542634, 4966.677165984218, 4993.725345106018, 5022.497750224967, 5044.243363495469, 5091.363579552556, 5005.799768009275, 5007.273945277914, 5010.574101201384, 5018.874528136789, 5041.521055499722, 4808.134535783557, 4916.115099282128, 4926.556609905126, 4977.850664480072, 4981.676191047571, 5186.870328241824, 5252.264682944391, 5343.786248550054, 5355.0896347621, 5376.516113549799, 5820.068788993783, 5861.443162899518, 5862.794802181903, 5864.794732184353, 5867.501262392701, 5742.08126699726, 5900.350961394243, 5901.0558310670085, 5911.349751527328, 5924.140999555084, 5468.64453810505, 5488.643238189505, 5573.996680597531, 5578.079616863172, 5602.075657516505, 5924.881502369928, 5951.404859514014, 5959.106134079922, 5959.404059594006, 5962.522998160137, 5572.4706152915405, 5652.6325788824415, 5731.656100633892, 5779.566532510079, 5795.33353664334, 5798.043322851682, 5885.087811389156, 5890.970545147246, 5892.764289428461, 5925.34821169671, 5779.075347944393, 5894.528437725057, 5912.497437717842, 5937.376575459601, 5939.703014849327, 5658.321001479849, 5742.598018138774, 5744.798932037359, 5886.264216972879, 5908.291005079418, 4507.211238033331, 4526.388937493462, 4527.162474942146, 4543.295789152687, 4559.179347717442, 4058.452108965311, 4061.939070913939, 4067.2678917795083, 4074.5110586729784, 4086.7547947123267, 5390.8921821563345, 5495.862603434946, 5500.614956953055, 5586.24585680936, 5598.58010649203, 5853.590248682552, 5905.881882362329, 5923.200367950271, 5932.406759324033, 5936.376680448577, 5582.385937546866, 5587.1339942309005, 5588.105903055492, 5591.161325801081, 5592.468715472024, 4817.807287708522, 4841.080194762983, 4893.0, 4950.727709975986, 4961.627877909099, 5954.434328738763, 5974.462298393166, 5985.221921150222, 5986.191864098378, 5991.370906054889, 5861.443162899518, 5891.1752354671235, 5891.3224979127945, 5897.0, 5897.67562784051, 5745.8563535911935, 5861.238039054895, 5933.643981361132, 6003.699815009145, 6028.8794224116145, 5778.191053252632, 5785.334686511105, 5816.883662326814, 5822.155787410887, 5828.184054232326, 5638.407967163553, 5888.617239879394, 5897.734601943009, 5902.852428689145, 5903.970480147572, 5609.382967873612, 5670.376258611632, 5759.683217422914, 5772.307323121252, 5790.0, 5754.51086657622, 5771.595988280948, 5780.104083867007, 5786.218860453785, 5787.450192231731, 5449.1826226066405, 5600.243967064394, 5665.291838520185, 5681.857953551194, 5700.572457065654, 5716.28546431696, 5722.3991480895575, 5746.13807928814, 5758.798442054675, 5759.942400576108, 5589.720513974204, 5609.775608975595, 5613.74738136793, 5633.464820842013, 5633.971830140823], "unit": "ms", "name": "dojo.html", "value": 5387.748372493499}, {"lowerIsBetter": false, "replicates": [586.9266341707287, 627.9826680777142, 632.7880160146351, 642.1844257792607, 642.1908395421768, 31291.843540782294, 32140.83929580352, 39874.80062599687, 40269.0, 40449.0, 43776.56223437765, 43973.78013109938, 44153.0, 44254.55745442545, 44263.77868110663, 7941.16617755136, 8842.425242359242, 9000.639974401016, 9005.369624126313, 9012.098790120968, 8182.509049457022, 10599.735006624858, 10793.514291856885, 10809.189310801681, 10811.18916081297, 10465.215108866827, 10579.20655950803, 10600.204984626145, 10652.0, 10653.84019239712, 10406.375617462976, 10467.267291289612, 10476.423796691179, 10526.578936842518, 10573.0, 10401.427921464316, 10509.527071281811, 10527.263091583593, 10530.47347632623, 10531.368117912873, 41283.380749288786, 41751.7912410439, 41817.0, 41871.16257674829, 41877.79061104706, 3529.135361836341, 3595.8741444049333, 3955.4066889966734, 4059.634632883025, 4180.749155050707, 31557.84221078903, 32017.199570010704, 32217.51673724896, 33067.83466082678, 33448.0, 4115.670746340315, 4177.644900183488, 4179.414881916534, 4270.6156445919705, 4272.03879127197, 483512.0, 490222.5488872568, 492004.0, 492239.0, 492594.0, 51910.480895190565, 60295.69852150711, 61503.0, 71294.2870571298, 72993.63503182556, 65474.345256546825, 65807.67096164488, 65995.0, 66066.66966665136, 66226.66886665535, 16093.11487868155, 16109.27508262131, 16143.596410089842, 16151.192440377934, 16589.66820663604, 12202.511899524097, 12228.327441990597, 12245.632631021084, 12282.75434491323, 12570.057245706608, 21728.674069888963, 21923.780762192175, 21948.34154975353, 22002.339929802132, 22042.0, 7992.880106798402, 8135.308498777552, 8135.7152499662225, 8208.630611622491, 8350.874736878952, 983.6950545330827, 1018.2464975917768, 1034.3586976074882, 1124.3254047571554, 1163.2903928603546, 29136.562951555745, 29202.0, 29844.253893652833, 29945.401091978474, 30011.899167058098, 1142.126273400849, 1160.6866146140665, 1169.9356535390466, 1197.802362610177, 1269.8412698412699, 13016.674583135497, 15324.770128448083, 15446.459373921858, 15583.298751556207, 15852.76220856688, 265445.0, 267960.0, 269253.0, 270359.0, 270974.0, 50914.74542627263, 50992.49007509877, 51149.23276150861, 51304.0, 51356.48643513592, 1447.0232592999682, 1451.397669966952, 1455.89080818939, 1462.9341679624442, 1466.6773309871812, 29030.12909612715, 29860.0, 30060.0, 30844.0, 30901.227469313446, 49271.75364123157, 49569.26507572218, 49579.0, 49701.50298496969, 49721.502784971686, 322970.0, 324119.0, 324832.0, 326475.0, 328000.0, 30314.69685303207, 30562.84718576393, 34445.31109377849, 34744.0, 34975.65024349724, 43102.31352213852, 44267.0, 44330.335044973704, 44472.0, 44533.55466445294, 37424.812875935444, 37694.434583480725, 38277.42583861189, 38514.229715406094, 38788.6121138785, 36979.44530832094, 37152.0, 37415.25169496649, 37529.6247037537, 37673.811630942764, 37188.81405592955, 37265.0, 37565.43651845279, 44363.33454998242, 44974.0, 33620.663793362735, 34033.829830850686, 34596.65403346035, 34662.82668586641, 35292.647073529966, 26606.60090098611, 27041.72958270392, 27135.86432067827, 28365.432691345646, 29348.0], "unit": "ms", "name": "ext.html", "value": 20052.008623561596}, {"lowerIsBetter": false, "replicates": [372.93473642112633, 374.4645157424883, 374.9906252343693, 375.7069485801076, 376.39024779856635, 14954.850451495482, 16532.586685332873, 17163.399281025166, 18455.63088738226, 19133.043347832623, 10561.471926403687, 10572.101371383422, 10757.946210268958, 10801.027907488324, 10821.6753497395, 3935.3703407454814, 4978.850634480962, 5088.5929125670045, 5094.108531007059, 5096.108181068316, 3995.7602543847315, 5386.48828361305, 5487.42382049885, 5533.3083364579425, 5542.0301447246575, 5426.131818908975, 5452.263944367499, 5453.7818487260465, 5911.852203694921, 6074.179985701918, 6100.755969761204, 6102.511799056065, 6121.357257487966, 6126.17296664949, 6131.816045518619, 4855.5872750816225, 4989.850304490871, 4996.9500304996845, 5415.10650742627, 5415.756290966916, 11956.222845515014, 12136.0, 12795.360231988456, 16078.5980350491, 16095.678086438324, 2291.9770802291932, 2393.581123303415, 2426.987865060681, 2444.132333021769, 2516.018752686454, 9379.953100234523, 9454.4800035998, 9581.466965285521, 9582.329236953416, 9830.803383932353, 1898.2122419196016, 1968.7834338222783, 1979.3270288102115, 1998.8700734452214, 2018.777934427212, 63976.0, 64206.67896660534, 64644.67677661629, 66333.0, 66463.0, 10166.186705063577, 10318.535665895053, 10380.42907640072, 10439.739006524898, 10452.843207351896, 13400.396982135828, 13476.258805765778, 13479.123856949267, 13538.59384218475, 13736.862631373559, 8016.118226995026, 8139.226773456512, 8218.260356567818, 8241.134680858544, 8296.170382961776, 8014.559199244098, 8014.959925200336, 8031.638576264082, 8071.192880711999, 8130.878036829452, 4031.6169963853386, 4251.06476575153, 4380.518143004267, 4402.7358358498595, 4437.267850804646, 1731.5584525945803, 1752.9824701752818, 1785.9821401786076, 1798.9910050449664, 1827.541956069085, 389.29537537058013, 396.8372967083482, 397.4157987757991, 402.5813154319533, 979.7256768104942, 9985.950070249748, 10180.592776288866, 10233.130183934449, 10311.1235544978, 10344.431056291976, 407.8287119409855, 412.43496409918606, 423.84529646679357, 437.23702139765675, 442.04297695488907, 5552.861178470571, 5667.914981275284, 5675.801346952837, 5709.8287051388525, 5715.742791574389, 567616.0, 608251.0, 654520.0, 661651.0, 667213.0, 88593.0, 90569.0, 90865.0, 90892.54553727321, 95227.0, 1202.4408649977627, 1206.3365149167923, 1218.5004148299154, 1229.225587879648, 1240.993795031019, 15450.150241736812, 15676.294566744296, 15969.0, 16027.519174424786, 16168.838311617204, 38260.234795304495, 38690.6130938687, 38698.0, 38730.4190437138, 38995.41506877342, 49651.75174124251, 49898.25152622786, 50167.73909695858, 50517.242241365675, 50638.2404263929, 8918.37571369998, 9474.715758527254, 9754.707358779247, 9876.35803672759, 9883.604655813975, 13795.517156899461, 16036.599085022968, 17832.91083544574, 18013.279468821624, 18222.81551699135, 14597.12417254968, 15154.393824246907, 15268.541943741706, 15328.156951367337, 15408.229588520753, 14375.137491750529, 14842.851571484147, 15033.849661503245, 15223.847761522244, 15359.846401535842, 15212.695746085237, 15666.37334506607, 15882.523524294289, 16375.59061023484, 16448.671026579163, 8960.596773145095, 9026.277897768294, 9046.321525885716, 9580.856287155559, 9940.801183976135, 14482.565523034325, 14768.77846832277, 15095.924520377328, 15319.846801531841, 15360.23198840076], "unit": "ms", "name": "jquery.html", "value": 8413.683818616095}, {"lowerIsBetter": false, "replicates": [1537.9999999999998, 1601.5996000999753, 1639.2049855819932, 1798.649263393638, 1898.800625934276, 7160.928390716092, 7312.049433573641, 8369.330453563716, 8557.957210213941, 8568.871466927993, 8092.635831387587, 8235.217654322845, 8344.374171937114, 8346.499210047401, 8362.790930226747, 2404.230646193219, 2435.2937648082034, 2440.45089854783, 2440.9023639054417, 2443.425794938197, 2110.9366718998376, 2149.0973791007814, 2385.415573184572, 2436.8050555955483, 2444.0712529238863, 2364.775346342103, 2372.644103384489, 2374.845635033726, 2379.892904819287, 2380.2978121454125, 2357.9292621221307, 2379.6668466414717, 2380.8928598213124, 2382.1543352110098, 2384.7972922301624, 2348.635961425982, 2385.0698227691214, 2388.558116748407, 2391.689080419552, 2391.988040059806, 8391.202835730595, 8413.621387037598, 8479.830403391898, 8489.702860399857, 8490.830183396298, 4900.215965445512, 4977.776000080005, 5010.348654674905, 5013.39839219296, 5013.473585273567, 3104.8447577621027, 3199.6480387157394, 3201.4557525220766, 3220.710136087763, 3228.2575007748114, 1037.045917755659, 1064.6220591689994, 1087.8748943871399, 1091.8744344400416, 1125.2741981422018, 11654.242474239232, 11707.53169873204, 11725.70685732855, 11735.765284694258, 11744.999999999915, 4433.512313645497, 4446.644268458515, 4503.617192538605, 4509.864704058883, 4514.367988481616, 10006.19950403966, 10013.49932503372, 10015.849762253572, 10037.749056273651, 10042.046005629454, 5032.270320803463, 5034.597232221414, 5035.597152227813, 5036.496350364934, 5037.647364684437, 4597.172508948422, 4598.770061496912, 4601.631869450436, 4602.677812553089, 4605.976970115128, 3683.3369993401443, 3928.744631598937, 3954.426608141803, 3965.980170099189, 3998.100427403869, 1192.2905871006737, 1205.1744554979866, 1229.6003798765437, 1272.8727127287198, 1286.5239861251398, 1163.7672465506932, 1188.7503624238834, 1191.7020744813797, 1193.2780667696093, 1215.7933151364289, 7765.805854853561, 7829.060512738508, 7867.685292588232, 7886.132525422199, 8074.757757267292, 1183.083110589283, 1211.1098342718094, 1220.8901198891965, 1230.5693007447321, 1237.7029512916836, 6130.846728831815, 6191.721372538246, 6225.439710425992, 6231.657258850807, 6241.531885108635, 9634.807303854024, 9924.553395097239, 10020.098191162684, 10039.899601003897, 10069.244806639532, 9528.761780955532, 9882.901170988342, 9888.060634239735, 9892.109710126124, 9900.158486528582, 7946.761597151979, 8024.919750802534, 8032.076311224284, 8048.476849004796, 8050.798730031679, 7492.400607951242, 7571.205023472456, 7617.809554761176, 7618.428617853794, 7630.542167469969, 8921.420107692978, 9094.090590940854, 9217.815643686954, 9232.723018309192, 9258.444493330422, 8270.83458330842, 8644.178803013703, 9395.107464790834, 9431.104045115702, 9432.905670943202, 7596.088469383489, 7688.11586667518, 7697.807554811175, 7698.191689872483, 7699.076110866732, 7194.89207661875, 8208.384371172067, 8229.79425514367, 8360.707375241838, 8368.41421100517, 6874.072000279898, 7263.164736055422, 7521.360684341892, 7597.126330471845, 7616.9238307616215, 7406.333429991327, 7437.367823734827, 7470.140933792683, 7516.47384683067, 7533.0, 7327.0, 7347.7795666130105, 7377.26227377258, 7381.298776616213, 7392.22381649919, 6683.966580167068, 6760.222574404006, 6766.120404347404, 6769.221539523018, 6786.59280443175, 6894.896576551456, 6920.58476491392, 6930.099087118642, 6933.3066693332285, 6942.583444993316], "unit": "ms", "name": "mootools.html", "value": 4783.93346581799}, {"lowerIsBetter": false, "replicates": [365.10549154571305, 367.6433859156618, 367.92273622539267, 369.2006805266599, 374.6777771116839, 6055.636661800284, 6130.846728831782, 6144.44699977002, 6148.538859585532, 6196.442320191182, 5872.0898260769645, 6013.188219590354, 6044.516438684906, 6086.421789929949, 6091.360407157251, 4750.263709125091, 4758.072175925696, 4760.3811504504365, 4762.261849413347, 4765.21373973294, 4710.552497512731, 4736.3369128322065, 4751.524847515256, 4765.952340476586, 4772.403449568804, 4472.932906006413, 4593.632509399256, 4596.35651008859, 4621.237495813203, 4668.089722504113, 4573.931391029138, 4598.425196850394, 4601.539846015406, 4602.976985115087, 4610.216263235258, 3894.9610503894883, 3998.040470287139, 4007.8196481158416, 4012.1574469361467, 4019.718619696622, 5743.942560574383, 5807.854803629901, 5831.883362332772, 5839.386864379221, 5891.322497912752, 5400.29796126505, 5413.864653383657, 5418.647787893774, 5422.6475279106735, 5430.8370748877205, 6364.522660800412, 6464.709088091, 6464.93535064648, 6469.191351081115, 6474.546781725234, 4529.184746745585, 4536.818527258905, 4539.568740969603, 4540.8637740867825, 4548.795304211319, 6572.704228309737, 6634.369734875179, 6641.003849422577, 6641.933580664228, 6675.3324667533825, 4649.232876575327, 4655.37152484417, 4658.34783130362, 4658.627309815207, 4661.021185551004, 4614.97692511542, 4677.134730074947, 4697.248440249544, 4704.529547045337, 4705.106029854317, 5412.215228791882, 5420.159875219348, 5420.864478387993, 5422.674639521562, 5424.755885985141, 6505.056766768792, 6507.446867016357, 6511.348865113546, 6516.413522782972, 6520.021996700438, 1641.8440248176405, 1667.4080701351088, 1667.9499615011568, 1668.1242347767277, 1668.5328108129743, 1114.3536748685742, 1122.0518661730825, 1125.634168895096, 1141.3095077478006, 1148.6439203846835, 6303.558750887486, 6313.0, 6315.747370105236, 6316.05259211122, 6321.715522801485, 6717.193936727526, 6717.5297729159465, 6718.126643536309, 6722.428593569602, 6729.899051514231, 6229.0967809667345, 6248.625082495065, 6308.968455157695, 6309.652969086653, 6311.400416960381, 3654.488371627974, 3684.5762737285017, 3687.0, 3694.07648087978, 3694.2796154749567, 6625.7680981166395, 6766.7969960901255, 6794.830129246809, 6829.556078854858, 6832.487563432763, 6927.134108236471, 6948.062011628365, 6961.965190174118, 6982.755603553851, 6990.266022067712, 6723.7646682365885, 6933.445324374038, 6935.826604334831, 6936.786062439053, 6951.0616066830335, 6764.830879228059, 6777.085093512313, 6779.118714567075, 6781.491388145811, 6787.524873258824, 6684.398404143651, 6685.164354455693, 6693.09643198162, 6694.698738556874, 6758.357955994173, 6801.809683305501, 6939.340762627542, 6944.861102777815, 6959.40845028158, 6963.9303606963285, 4686.133065382915, 4715.575598196178, 4716.622670186445, 4730.716157030589, 4731.952680473289, 6772.322767723385, 6784.151981002375, 6793.592384456949, 6794.558353706993, 6794.93205067943, 6524.119243902012, 6606.372394622503, 6615.834604134935, 6637.2699003108655, 6643.46852251809, 6622.90065649006, 6627.569208001464, 6627.9337206627315, 6634.137562117087, 6635.734570617121, 6514.055461958084, 6523.347665233438, 6525.2822189558165, 6526.543141980016, 6528.836779080561, 6480.25477070143, 6593.307702691149, 6650.9667451662435, 6652.368025037614, 6668.766593169215, 6461.386168314003, 6462.063000864754, 6480.351964803671, 6480.384363485461, 6481.060246264359], "unit": "ms", "name": "prototype.html", "value": 4934.151921544485}, {"lowerIsBetter": false, "replicates": [905.9909400905993, 915.9084091590837, 917.687986084731, 920.1350730313504, 924.5700749151644, 11970.82043769343, 12164.635060948163, 12184.51261949521, 12185.634430967075, 12277.324747138904, 11861.881381186186, 11890.346030968314, 11914.582989595367, 11935.0, 11937.164398492108, 716.0154787167645, 727.3671905442272, 727.5998200989461, 728.8651599454118, 830.0620299062051, 870.1298701298701, 878.6880657366638, 882.5234373438335, 883.3286702106413, 883.4875772052227, 843.2115971566574, 919.3977944446399, 931.8741969834088, 932.2961164320928, 933.351320832022, 748.6331697468256, 758.2531206761336, 902.2376092202079, 925.7084018534174, 928.0580211085753, 682.8019874236466, 683.9213490448612, 684.7569112964876, 685.1777866560147, 685.4927353758183, 12158.452869620889, 12161.270323780602, 12257.019438444902, 12257.387130643521, 12264.81602775959, 11629.360385178812, 11756.823647645293, 11818.17272790905, 12150.270983741004, 12518.12373133881, 10160.0, 10434.478276086242, 10489.56629294182, 10492.737681557946, 10518.316309439862, 3630.9273814523563, 3686.668199862025, 3692.5199724035974, 3693.9445908311395, 3696.9260614787554, 46847.29729054067, 46903.0, 47208.0, 47683.99999999965, 47853.0, 9710.271729620306, 9782.0, 9834.114929656365, 9847.359921605073, 9967.0, 16925.492235232963, 16944.966604007597, 17001.659966800842, 17056.573585660208, 17059.232334544977, 7462.589557574385, 7567.432442566719, 7756.767296981099, 7983.2016798320865, 8073.555954422446, 4589.128065667513, 4690.085433340534, 4764.475907650156, 4777.4505931818285, 4805.471398146201, 3118.3451475190463, 3159.9684003160132, 3163.6994485523837, 3170.0489853043996, 3170.2074481379655, 555.977760889568, 565.9575531835129, 580.8025271407741, 582.8397190772487, 587.5505238492557, 581.3575998521573, 708.0865683268526, 715.8675645005586, 729.1104852080454, 731.2066407947331, 8389.370797190113, 8687.869681954775, 8705.434146780439, 8746.0, 8880.555972201364, 616.1650962945234, 657.6536423513137, 695.6452209373256, 729.5695539631643, 734.0787311923502, 3875.3218186817758, 3953.5453422856162, 3959.544652365015, 3988.880333589997, 3995.300822356076, 58695.70652146712, 59593.70203148956, 60017.39982600205, 60030.69984650049, 60113.89601364019, 52881.7355913218, 53062.0, 53365.1995220072, 53523.0, 53607.73196134072, 47428.288575671395, 48411.51588484141, 48418.0, 48608.0, 49254.50745492499, 8150.83698326042, 8283.668653253802, 8393.0, 8502.659893604434, 8578.65685372578, 36027.0, 36124.0, 36640.63359366479, 36872.44691329686, 37381.0, 43007.0, 43656.0, 47413.28880066733, 47854.760726197535, 48143.75928120477, 9741.074597913186, 9761.365511241747, 10057.491376293321, 10159.644412445825, 10377.84433233487, 10732.08777253911, 10820.621278255223, 10881.619143329945, 10911.290766100496, 12747.936260318638, 11051.447427628747, 11430.428478576205, 11437.59968401102, 11483.942580287045, 11615.128865334964, 10843.295185812896, 10908.890911091104, 11123.388213648326, 11412.771744564896, 11666.591669291534, 10530.57877684884, 10605.416702081151, 10623.681289561016, 10973.177011723992, 11253.437328133725, 8543.359248056546, 8559.443636163629, 9019.909800901907, 9251.074892510695, 9256.444613323221, 8888.0, 8998.86501702488, 9223.907760922304, 9261.583228754856, 9399.624015039595], "unit": "ms", "name": "yui.html", "value": 6306.758025175201}], "name": "dromaeo_css", "value": 7165.263676685152}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 102.0, 108.0, 111.0, 109.0, 98.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [146.0, 120.0, 145.0, 157.0, 122.0, 145.0, 147.0, 125.0, 156.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 159.0, 158.0, 158.0, 162.0, 164.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 151.0, 71.0, 71.0, 71.0, 73.0, 161.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [101.0, 93.0, 140.0, 91.0, 92.0, 93.0, 135.0, 93.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 58.0, 59.0, 59.0, 58.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 76.0, 77.0, 78.0, 78.0, 77.0, 77.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.3}, {"lowerIsBetter": true, "replicates": [112.0, 118.0, 114.0, 118.0, 111.0, 113.0, 120.0, 114.0, 124.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [133.0, 146.0, 148.0, 141.0, 153.0, 146.0, 142.0, 142.0, 141.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 64.0, 62.0, 63.0, 63.0, 65.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1471.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "DeltaBlue", "value": 399.41883800000005}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [547.945205479452], "unit": "score", "name": "Earley", "value": 1216.2949749999998}, {"lowerIsBetter": false, "replicates": [10568.421052631578], "unit": "score", "name": "Boyer", "value": 63.06173804780874}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [529.6610169491526], "unit": "score", "name": "Splay", "value": 153.85500800000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23264.80521238307}]} 06:05:46 INFO - RETURN: dromaeo_css: 7165.26 06:05:46 INFO - RETURN: kraken: 1471.10 06:05:46 INFO - RETURN: v8_7: 23264.81 06:05:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23264.81"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1471.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7165.26"}}} 06:05:46 INFO - Return code: 0 06:05:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:05:46 INFO - # TBPL SUCCESS # 06:05:46 INFO - Running post-action listener: _resource_record_post_action 06:05:46 INFO - Running post-run listener: _resource_record_post_run 06:05:47 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 510111744; Read time: 0; Write time: 354128 06:05:47 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244445184; Read time: 0; Write time: 206292 06:05:47 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 0; Write bytes: 265666560; Read time: 0; Write time: 147836 06:05:47 INFO - Running post-run listener: _upload_blobber_files 06:05:47 INFO - Blob upload gear active. 06:05:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:05:47 INFO - Copying logs to upload dir... 06:05:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.821585 ========= master_lag: 16.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-02-03 06:06:03.311896) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-03 06:06:03.315844) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010094 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454497960/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.14 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-03 06:06:03.466796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 06:06:03.467095) ========= 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=41bf3e9aed84707956354da8000001c5-1454506797.130690-636184625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 06:06:03.760011) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 06:06:03.760346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 06:06:03.764943) ========= ========= Total master_lag: 16.80 =========