builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1453800391.83 results: success (0) buildid: 20160125070233 builduid: eb2ea0af6ac2494ca810680a4890723f revision: 3bc504ea394f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.827407) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.827882) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.828165) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004911 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.849133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.849427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.865673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.866067) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.914962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.915263) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.918655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:31.918941) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 01:26:32-- 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% 226M=0s 2016-01-26 01:26:32 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177847 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.108702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.109010) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016441 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.161953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.162400) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3bc504ea394f --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 3bc504ea394f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 01:26:32,558 Setting DEBUG logging. 2016-01-26 01:26:32,558 attempt 1/10 2016-01-26 01:26:32,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3bc504ea394f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-26 01:26:32,808 unpacking tar archive at: mozilla-beta-3bc504ea394f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.742167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.744562) ========= echo 3bc504ea394f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bc504ea394f'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bc504ea394f program finished with exit code 0 elapsedTime=0.004659 script_repo_revision: '3bc504ea394f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.796879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.797194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 01:26:32.807902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-01-26 01:26:32.808207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:26:33 INFO - MultiFileLogger online at 20160126 01:26:33 in /builds/slave/test-pgo 01:26:33 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 01:26:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:26:33 INFO - {'append_to_log': False, 01:26:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:26:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:26:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:26:33 INFO - 'branch': 'Mozilla-Beta', 01:26:33 INFO - 'buildbot_json_path': 'buildprops.json', 01:26:33 INFO - 'config_files': ('talos/linux_config.py',), 01:26:33 INFO - 'default_actions': ('clobber', 01:26:33 INFO - 'read-buildbot-config', 01:26:33 INFO - 'download-and-extract', 01:26:33 INFO - 'populate-webroot', 01:26:33 INFO - 'create-virtualenv', 01:26:33 INFO - 'install', 01:26:33 INFO - 'run-tests'), 01:26:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:26:33 INFO - 'download_minidump_stackwalk': True, 01:26:33 INFO - 'download_symbols': 'ondemand', 01:26:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:26:33 INFO - 'tooltool.py': '/tools/tooltool.py', 01:26:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:26:33 INFO - '/tools/misc-python/virtualenv.py')}, 01:26:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:26:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:26:33 INFO - 'installer_path': 'installer.exe', 01:26:33 INFO - 'log_level': 'info', 01:26:33 INFO - 'log_name': 'talos', 01:26:33 INFO - 'log_to_console': True, 01:26:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:26:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:26:33 INFO - 'opt_config_files': (), 01:26:33 INFO - 'pip_index': False, 01:26:33 INFO - 'sps_profile': False, 01:26:33 INFO - 'sps_profile_interval': 0, 01:26:33 INFO - 'suite': 'dromaeojs', 01:26:33 INFO - 'system_bits': '32', 01:26:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:26:33 INFO - 'title': 'talos-linux64-ix-023', 01:26:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:26:33 INFO - 'use_talos_json': True, 01:26:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:26:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:26:33 INFO - 'work_dir': 'build'} 01:26:33 INFO - ##### 01:26:33 INFO - ##### Running clobber step. 01:26:33 INFO - ##### 01:26:33 INFO - Running pre-action listener: _resource_record_pre_action 01:26:33 INFO - Running main action method: clobber 01:26:33 INFO - rmtree: /builds/slave/test-pgo/build 01:26:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:26:33 INFO - Running post-action listener: _resource_record_post_action 01:26:33 INFO - ##### 01:26:33 INFO - ##### Running read-buildbot-config step. 01:26:33 INFO - ##### 01:26:33 INFO - Running pre-action listener: _resource_record_pre_action 01:26:33 INFO - Running main action method: read_buildbot_config 01:26:33 INFO - Using buildbot properties: 01:26:33 INFO - { 01:26:33 INFO - "properties": { 01:26:33 INFO - "buildnumber": 86, 01:26:33 INFO - "product": "firefox", 01:26:33 INFO - "script_repo_revision": "production", 01:26:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:26:33 INFO - "repository": "", 01:26:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:26:33 INFO - "buildid": "20160125070233", 01:26:33 INFO - "slavename": "talos-linux64-ix-023", 01:26:33 INFO - "pgo_build": "True", 01:26:33 INFO - "basedir": "/builds/slave/test-pgo", 01:26:33 INFO - "project": "", 01:26:33 INFO - "platform": "ubuntu64_hw", 01:26:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:26:33 INFO - "slavebuilddir": "test", 01:26:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:26:33 INFO - "branch": "mozilla-beta", 01:26:33 INFO - "repo_path": "releases/mozilla-beta", 01:26:33 INFO - "stage_platform": "linux64-pgo", 01:26:33 INFO - "builduid": "eb2ea0af6ac2494ca810680a4890723f", 01:26:33 INFO - "revision": "3bc504ea394f" 01:26:33 INFO - }, 01:26:33 INFO - "sourcestamp": { 01:26:33 INFO - "repository": "", 01:26:33 INFO - "hasPatch": false, 01:26:33 INFO - "project": "", 01:26:33 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:26:33 INFO - "changes": [ 01:26:33 INFO - { 01:26:33 INFO - "category": null, 01:26:33 INFO - "files": [ 01:26:33 INFO - { 01:26:33 INFO - "url": null, 01:26:33 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2" 01:26:33 INFO - } 01:26:33 INFO - ], 01:26:33 INFO - "repository": "", 01:26:33 INFO - "rev": "3bc504ea394f", 01:26:33 INFO - "who": "sendchange", 01:26:33 INFO - "when": 1453769833, 01:26:33 INFO - "number": 7514634, 01:26:33 INFO - "comments": "Bug 1241916 - Adds gn locale to browser/locales/shipped-locales. r=delphine a=sylvestre", 01:26:33 INFO - "project": "", 01:26:33 INFO - "at": "Mon 25 Jan 2016 16:57:13", 01:26:33 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:26:33 INFO - "revlink": "", 01:26:33 INFO - "properties": [ 01:26:33 INFO - [ 01:26:33 INFO - "buildid", 01:26:33 INFO - "20160125070233", 01:26:33 INFO - "Change" 01:26:33 INFO - ], 01:26:33 INFO - [ 01:26:33 INFO - "builduid", 01:26:33 INFO - "eb2ea0af6ac2494ca810680a4890723f", 01:26:33 INFO - "Change" 01:26:33 INFO - ], 01:26:33 INFO - [ 01:26:33 INFO - "pgo_build", 01:26:33 INFO - "True", 01:26:33 INFO - "Change" 01:26:33 INFO - ] 01:26:33 INFO - ], 01:26:33 INFO - "revision": "3bc504ea394f" 01:26:33 INFO - } 01:26:33 INFO - ], 01:26:33 INFO - "revision": "3bc504ea394f" 01:26:33 INFO - } 01:26:33 INFO - } 01:26:33 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2. 01:26:33 INFO - Running post-action listener: _resource_record_post_action 01:26:33 INFO - ##### 01:26:33 INFO - ##### Running download-and-extract step. 01:26:33 INFO - ##### 01:26:33 INFO - Running pre-action listener: _resource_record_pre_action 01:26:33 INFO - Running main action method: download_and_extract 01:26:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:26:33 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')]} 01:26:33 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json 01:26:33 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:26:33 INFO - Downloaded 1270 bytes. 01:26:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:26:33 INFO - Using the following test package requirements: 01:26:33 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:26:33 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:26:33 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'jsshell-linux-x86_64.zip'], 01:26:33 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:26:33 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:26:33 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 01:26:33 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 01:26:33 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:26:33 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:26:33 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:26:33 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:26:33 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:26:33 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')]} 01:26:33 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:26:33 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:34 INFO - Downloaded 21580477 bytes. 01:26:34 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 01:26:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:26:34 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 01:26:35 INFO - Return code: 0 01:26:35 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 01:26:35 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')]} 01:26:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:26:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:35 INFO - Downloaded 21580477 bytes. 01:26:35 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 01:26:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:26:35 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 01:26:36 INFO - Return code: 0 01:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:26:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:37 INFO - Downloaded 11132038 bytes. 01:26:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 01:26:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:26:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 01:26:37 INFO - Return code: 0 01:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:26:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:26:38 INFO - Downloaded 57947831 bytes. 01:26:38 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:26:38 INFO - mkdir: /builds/slave/test-pgo/properties 01:26:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:26:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:26:38 INFO - Contents: 01:26:38 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:26:38 INFO - Running post-action listener: _resource_record_post_action 01:26:38 INFO - Running post-action listener: set_extra_try_arguments 01:26:38 INFO - ##### 01:26:38 INFO - ##### Running populate-webroot step. 01:26:38 INFO - ##### 01:26:38 INFO - Running pre-action listener: _resource_record_pre_action 01:26:38 INFO - Running main action method: populate_webroot 01:26:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:26:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:26:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:26:38 INFO - '--tppagecycles', 01:26:38 INFO - '7'], 01:26:38 INFO - 'tests': ['tsvgm']}}, 01:26:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:26:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:26:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:26:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:26:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:26:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'tests': ['damp', 'tps']}, 01:26:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['damp', 'tps']}, 01:26:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:26:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:26:38 INFO - 'other': {'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'other_l64': {'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'other_nol64': {'tests': ['a11yr', 01:26:38 INFO - 'ts_paint', 01:26:38 INFO - 'tpaint', 01:26:38 INFO - 'sessionrestore', 01:26:38 INFO - 'sessionrestore_no_auto_restore']}, 01:26:38 INFO - 'svgr': {'tests': ['tsvgx', 01:26:38 INFO - 'tsvgr_opacity', 01:26:38 INFO - 'tart', 01:26:38 INFO - 'tscrollx', 01:26:38 INFO - 'cart']}, 01:26:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['tsvgx', 01:26:38 INFO - 'tsvgr_opacity', 01:26:38 INFO - 'tart', 01:26:38 INFO - 'tscrollx', 01:26:38 INFO - 'cart']}, 01:26:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'tests': ['tp5o']}, 01:26:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'talos_options': ['--e10s'], 01:26:38 INFO - 'tests': ['tp5o']}, 01:26:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'talos_options': ['--xperf_path', 01:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:38 INFO - 'tests': ['tp5n']}, 01:26:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:26:38 INFO - 'talos_options': ['--e10s', 01:26:38 INFO - '--xperf_path', 01:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:26:38 INFO - 'tests': ['tp5n']}}, 01:26:38 INFO - 'talos.zip': {'path': '', 01:26:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:26:38 INFO - Running post-action listener: _resource_record_post_action 01:26:38 INFO - ##### 01:26:38 INFO - ##### Running create-virtualenv step. 01:26:38 INFO - ##### 01:26:38 INFO - Running pre-action listener: _resource_record_pre_action 01:26:38 INFO - Running main action method: create_virtualenv 01:26:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:26:38 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 01:26:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:26:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:26:38 INFO - Using real prefix '/usr' 01:26:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:26:39 INFO - Installing distribute.............................................................................................................................................................................................done. 01:26:41 INFO - Installing pip.................done. 01:26:41 INFO - Return code: 0 01:26:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:41 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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:41 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 01:26:41 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 01:26:41 INFO - Using env: {'DISPLAY': ':0', 01:26:41 INFO - 'HOME': '/home/cltbld', 01:26:41 INFO - 'LANG': 'en_US.UTF-8', 01:26:41 INFO - 'LANGUAGE': 'en_US:en', 01:26:41 INFO - 'LOGNAME': 'cltbld', 01:26:41 INFO - 'MAIL': '/var/mail/cltbld', 01:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:41 INFO - 'MOZ_NO_REMOTE': '1', 01:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:41 INFO - 'NO_EM_RESTART': '1', 01:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:41 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:41 INFO - 'SHELL': '/bin/bash', 01:26:41 INFO - 'SHLVL': '1', 01:26:41 INFO - 'TERM': 'linux', 01:26:41 INFO - 'TMOUT': '86400', 01:26:41 INFO - 'USER': 'cltbld', 01:26:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:41 INFO - '_': '/tools/buildbot/bin/python'} 01:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:41 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 01:26:41 INFO - Cleaning up... 01:26:41 INFO - Return code: 0 01:26:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:41 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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:41 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 01:26:41 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 01:26:41 INFO - Using env: {'DISPLAY': ':0', 01:26:41 INFO - 'HOME': '/home/cltbld', 01:26:41 INFO - 'LANG': 'en_US.UTF-8', 01:26:41 INFO - 'LANGUAGE': 'en_US:en', 01:26:41 INFO - 'LOGNAME': 'cltbld', 01:26:41 INFO - 'MAIL': '/var/mail/cltbld', 01:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:41 INFO - 'MOZ_NO_REMOTE': '1', 01:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:41 INFO - 'NO_EM_RESTART': '1', 01:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:41 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:41 INFO - 'SHELL': '/bin/bash', 01:26:41 INFO - 'SHLVL': '1', 01:26:41 INFO - 'TERM': 'linux', 01:26:41 INFO - 'TMOUT': '86400', 01:26:41 INFO - 'USER': 'cltbld', 01:26:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:41 INFO - '_': '/tools/buildbot/bin/python'} 01:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:41 INFO - Downloading/unpacking psutil>=0.7.1 01:26:41 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 01:26:41 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 01:26:41 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 01:26:41 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 01:26:41 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 01:26:41 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 01:26:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:43 INFO - Installing collected packages: psutil 01:26:43 INFO - Running setup.py install for psutil 01:26:43 INFO - building 'psutil._psutil_linux' extension 01:26:43 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 01:26:43 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 01:26:43 INFO - building 'psutil._psutil_posix' extension 01:26:43 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 01:26:43 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 01:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:26:43 INFO - Successfully installed psutil 01:26:43 INFO - Cleaning up... 01:26:43 INFO - Return code: 0 01:26:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:26:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:26:43 INFO - Using env: {'DISPLAY': ':0', 01:26:43 INFO - 'HOME': '/home/cltbld', 01:26:43 INFO - 'LANG': 'en_US.UTF-8', 01:26:43 INFO - 'LANGUAGE': 'en_US:en', 01:26:43 INFO - 'LOGNAME': 'cltbld', 01:26:43 INFO - 'MAIL': '/var/mail/cltbld', 01:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:43 INFO - 'MOZ_NO_REMOTE': '1', 01:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:43 INFO - 'NO_EM_RESTART': '1', 01:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:43 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:43 INFO - 'SHELL': '/bin/bash', 01:26:43 INFO - 'SHLVL': '1', 01:26:43 INFO - 'TERM': 'linux', 01:26:43 INFO - 'TMOUT': '86400', 01:26:43 INFO - 'USER': 'cltbld', 01:26:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:43 INFO - '_': '/tools/buildbot/bin/python'} 01:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:26:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:26:45 INFO - Installing collected packages: mozsystemmonitor 01:26:45 INFO - Running setup.py install for mozsystemmonitor 01:26:46 INFO - Successfully installed mozsystemmonitor 01:26:46 INFO - Cleaning up... 01:26:46 INFO - Return code: 0 01:26:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:26:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:26:46 INFO - Using env: {'DISPLAY': ':0', 01:26:46 INFO - 'HOME': '/home/cltbld', 01:26:46 INFO - 'LANG': 'en_US.UTF-8', 01:26:46 INFO - 'LANGUAGE': 'en_US:en', 01:26:46 INFO - 'LOGNAME': 'cltbld', 01:26:46 INFO - 'MAIL': '/var/mail/cltbld', 01:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:46 INFO - 'MOZ_NO_REMOTE': '1', 01:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:46 INFO - 'NO_EM_RESTART': '1', 01:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:46 INFO - 'SHELL': '/bin/bash', 01:26:46 INFO - 'SHLVL': '1', 01:26:46 INFO - 'TERM': 'linux', 01:26:46 INFO - 'TMOUT': '86400', 01:26:46 INFO - 'USER': 'cltbld', 01:26:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:46 INFO - '_': '/tools/buildbot/bin/python'} 01:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:46 INFO - Downloading/unpacking blobuploader==1.2.4 01:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:48 INFO - Downloading blobuploader-1.2.4.tar.gz 01:26:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:26:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:26:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:48 INFO - Downloading docopt-0.6.1.tar.gz 01:26:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:26:48 INFO - Installing collected packages: blobuploader, requests, docopt 01:26:48 INFO - Running setup.py install for blobuploader 01:26:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:26:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:26:48 INFO - Running setup.py install for requests 01:26:49 INFO - Running setup.py install for docopt 01:26:49 INFO - Successfully installed blobuploader requests docopt 01:26:49 INFO - Cleaning up... 01:26:49 INFO - Return code: 0 01:26:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:26: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')]} 01:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:49 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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:49 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 01:26:49 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 01:26:49 INFO - Using env: {'DISPLAY': ':0', 01:26:49 INFO - 'HOME': '/home/cltbld', 01:26:49 INFO - 'LANG': 'en_US.UTF-8', 01:26:49 INFO - 'LANGUAGE': 'en_US:en', 01:26:49 INFO - 'LOGNAME': 'cltbld', 01:26:49 INFO - 'MAIL': '/var/mail/cltbld', 01:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:49 INFO - 'MOZ_NO_REMOTE': '1', 01:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:49 INFO - 'NO_EM_RESTART': '1', 01:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:49 INFO - 'SHELL': '/bin/bash', 01:26:49 INFO - 'SHLVL': '1', 01:26:49 INFO - 'TERM': 'linux', 01:26:49 INFO - 'TMOUT': '86400', 01:26:49 INFO - 'USER': 'cltbld', 01:26:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:49 INFO - '_': '/tools/buildbot/bin/python'} 01:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:26:49 INFO - Running setup.py (path:/tmp/pip-aP_PLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:26:49 INFO - Running setup.py (path:/tmp/pip-aZJMw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:26:49 INFO - Running setup.py (path:/tmp/pip-f1gkXg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:26:49 INFO - Running setup.py (path:/tmp/pip-igy_SK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:26:49 INFO - Running setup.py (path:/tmp/pip-110zLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:26:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:26:49 INFO - Running setup.py (path:/tmp/pip-nVaA7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:26:50 INFO - Running setup.py (path:/tmp/pip-Q3Xa4G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:26:50 INFO - Running setup.py (path:/tmp/pip-IoYRp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:26:50 INFO - Running setup.py (path:/tmp/pip-Kdsf0I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:26:50 INFO - Running setup.py (path:/tmp/pip-wlpu3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:26:50 INFO - Running setup.py (path:/tmp/pip-JTjUgs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:26:50 INFO - Running setup.py (path:/tmp/pip-5OB4l8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:26:50 INFO - Running setup.py (path:/tmp/pip-AgY97g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:26:50 INFO - Running setup.py (path:/tmp/pip-y5R36_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:26:50 INFO - Running setup.py (path:/tmp/pip-wY5uGG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:26:50 INFO - Running setup.py (path:/tmp/pip-pGfkJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:26:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:26:50 INFO - Running setup.py (path:/tmp/pip-MzZn7u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:26:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:26:50 INFO - Running setup.py install for manifestparser 01:26:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:26:50 INFO - Running setup.py install for mozcrash 01:26:51 INFO - Running setup.py install for mozdebug 01:26:51 INFO - Running setup.py install for mozdevice 01:26:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for mozfile 01:26:51 INFO - Running setup.py install for mozhttpd 01:26:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for mozinfo 01:26:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for mozInstall 01:26:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for mozleak 01:26:51 INFO - Running setup.py install for mozlog 01:26:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for moznetwork 01:26:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:26:51 INFO - Running setup.py install for mozprocess 01:26:52 INFO - Running setup.py install for mozprofile 01:26:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:26:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:26:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:26:52 INFO - Running setup.py install for mozrunner 01:26:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:26:52 INFO - Running setup.py install for mozscreenshot 01:26:52 INFO - Running setup.py install for moztest 01:26:52 INFO - Running setup.py install for mozversion 01:26:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:26:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:26:52 INFO - Cleaning up... 01:26:52 INFO - Return code: 0 01:26:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:52 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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:52 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 01:26:52 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 01:26:52 INFO - Using env: {'DISPLAY': ':0', 01:26:52 INFO - 'HOME': '/home/cltbld', 01:26:52 INFO - 'LANG': 'en_US.UTF-8', 01:26:52 INFO - 'LANGUAGE': 'en_US:en', 01:26:52 INFO - 'LOGNAME': 'cltbld', 01:26:52 INFO - 'MAIL': '/var/mail/cltbld', 01:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:52 INFO - 'MOZ_NO_REMOTE': '1', 01:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:52 INFO - 'NO_EM_RESTART': '1', 01:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:52 INFO - 'SHELL': '/bin/bash', 01:26:52 INFO - 'SHLVL': '1', 01:26:52 INFO - 'TERM': 'linux', 01:26:52 INFO - 'TMOUT': '86400', 01:26:52 INFO - 'USER': 'cltbld', 01:26:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:52 INFO - '_': '/tools/buildbot/bin/python'} 01:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:26:52 INFO - Running setup.py (path:/tmp/pip-MnztkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:26:52 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)) 01:26:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:26:52 INFO - Running setup.py (path:/tmp/pip-IkB8yA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:26:52 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)) 01:26:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:26:52 INFO - Running setup.py (path:/tmp/pip-kwEjln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:26:53 INFO - Running setup.py (path:/tmp/pip-yliKc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:26:53 INFO - Running setup.py (path:/tmp/pip-r_yGPq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:26:53 INFO - Running setup.py (path:/tmp/pip-Z6pNAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:26:53 INFO - Running setup.py (path:/tmp/pip-GibQg7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:26:53 INFO - Running setup.py (path:/tmp/pip-2mDrB4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:26:53 INFO - Running setup.py (path:/tmp/pip-vmP_Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:26:53 INFO - Running setup.py (path:/tmp/pip-iIMaUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:26:53 INFO - Running setup.py (path:/tmp/pip-QNLwUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:26:53 INFO - Running setup.py (path:/tmp/pip-BtRbnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:26:53 INFO - Running setup.py (path:/tmp/pip-gqsmVX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:26:53 INFO - Running setup.py (path:/tmp/pip-0dT1H_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:26:53 INFO - Running setup.py (path:/tmp/pip-tH6EYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:26:53 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)) 01:26:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:26:53 INFO - Running setup.py (path:/tmp/pip-W_8KYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:26:54 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)) 01:26:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:26:54 INFO - Running setup.py (path:/tmp/pip-FMS5ZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:26:54 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)) 01:26:54 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)) 01:26:54 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)) 01:26:54 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)) 01:26:54 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)) 01:26:54 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)) 01:26:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:54 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 01:26:55 INFO - Downloading blessings-1.6.tar.gz 01:26:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:26:55 INFO - Installing collected packages: blessings 01:26:55 INFO - Running setup.py install for blessings 01:26:56 INFO - Successfully installed blessings 01:26:56 INFO - Cleaning up... 01:26:56 INFO - Return code: 0 01:26:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:26:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:26:56 INFO - Reading from file tmpfile_stdout 01:26:56 INFO - Current package versions: 01:26:56 INFO - argparse == 1.2.1 01:26:56 INFO - blessings == 1.6 01:26:56 INFO - blobuploader == 1.2.4 01:26:56 INFO - docopt == 0.6.1 01:26:56 INFO - manifestparser == 1.1 01:26:56 INFO - mozInstall == 1.12 01:26:56 INFO - mozcrash == 0.16 01:26:56 INFO - mozdebug == 0.1 01:26:56 INFO - mozdevice == 0.47 01:26:56 INFO - mozfile == 1.2 01:26:56 INFO - mozhttpd == 0.7 01:26:56 INFO - mozinfo == 0.9 01:26:56 INFO - mozleak == 0.1 01:26:56 INFO - mozlog == 3.1 01:26:56 INFO - moznetwork == 0.27 01:26:56 INFO - mozprocess == 0.22 01:26:56 INFO - mozprofile == 0.27 01:26:56 INFO - mozrunner == 6.11 01:26:56 INFO - mozscreenshot == 0.1 01:26:56 INFO - mozsystemmonitor == 0.0 01:26:56 INFO - moztest == 0.7 01:26:56 INFO - mozversion == 1.4 01:26:56 INFO - psutil == 3.1.1 01:26:56 INFO - requests == 1.2.3 01:26:56 INFO - wsgiref == 0.1.2 01:26:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:56 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 01:26:56 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 01:26:56 INFO - Using env: {'DISPLAY': ':0', 01:26:56 INFO - 'HOME': '/home/cltbld', 01:26:56 INFO - 'LANG': 'en_US.UTF-8', 01:26:56 INFO - 'LANGUAGE': 'en_US:en', 01:26:56 INFO - 'LOGNAME': 'cltbld', 01:26:56 INFO - 'MAIL': '/var/mail/cltbld', 01:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:56 INFO - 'MOZ_NO_REMOTE': '1', 01:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:56 INFO - 'NO_EM_RESTART': '1', 01:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:56 INFO - 'SHELL': '/bin/bash', 01:26:56 INFO - 'SHLVL': '1', 01:26:56 INFO - 'TERM': 'linux', 01:26:56 INFO - 'TMOUT': '86400', 01:26:56 INFO - 'USER': 'cltbld', 01:26:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:56 INFO - '_': '/tools/buildbot/bin/python'} 01:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 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)) 01:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:26:56 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)) 01:26:56 INFO - Cleaning up... 01:26:56 INFO - Return code: 0 01:26:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:56 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 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:56 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 01:26:56 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 01:26:56 INFO - Using env: {'DISPLAY': ':0', 01:26:56 INFO - 'HOME': '/home/cltbld', 01:26:56 INFO - 'LANG': 'en_US.UTF-8', 01:26:56 INFO - 'LANGUAGE': 'en_US:en', 01:26:56 INFO - 'LOGNAME': 'cltbld', 01:26:56 INFO - 'MAIL': '/var/mail/cltbld', 01:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:56 INFO - 'MOZ_NO_REMOTE': '1', 01:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:56 INFO - 'NO_EM_RESTART': '1', 01:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:56 INFO - 'SHELL': '/bin/bash', 01:26:56 INFO - 'SHLVL': '1', 01:26:56 INFO - 'TERM': 'linux', 01:26:56 INFO - 'TMOUT': '86400', 01:26:56 INFO - 'USER': 'cltbld', 01:26:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:56 INFO - '_': '/tools/buildbot/bin/python'} 01:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:56 INFO - Downloading/unpacking jsonschema 01:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:26:58 INFO - Downloading/unpacking functools32 (from jsonschema) 01:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 01:26:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:26:58 INFO - warning: no files found matching '*.txt' 01:26:58 INFO - no previously-included directories found matching 'build' 01:26:58 INFO - no previously-included directories found matching 'dist' 01:26:58 INFO - no previously-included directories found matching '.git*' 01:26:58 INFO - Installing collected packages: jsonschema, functools32 01:26:58 INFO - Running setup.py install for functools32 01:26:58 INFO - warning: no files found matching '*.txt' 01:26:58 INFO - no previously-included directories found matching 'build' 01:26:58 INFO - no previously-included directories found matching 'dist' 01:26:58 INFO - no previously-included directories found matching '.git*' 01:26:58 INFO - Successfully installed jsonschema functools32 01:26:58 INFO - Cleaning up... 01:26:59 INFO - Return code: 0 01:26:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:26: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')]} 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26: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')]} 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4a1864f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x292e600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', '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 01:26:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:26:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:26:59 INFO - Using env: {'DISPLAY': ':0', 01:26:59 INFO - 'HOME': '/home/cltbld', 01:26:59 INFO - 'LANG': 'en_US.UTF-8', 01:26:59 INFO - 'LANGUAGE': 'en_US:en', 01:26:59 INFO - 'LOGNAME': 'cltbld', 01:26:59 INFO - 'MAIL': '/var/mail/cltbld', 01:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:26:59 INFO - 'MOZ_NO_REMOTE': '1', 01:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:26:59 INFO - 'NO_EM_RESTART': '1', 01:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:26:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:26:59 INFO - 'SHELL': '/bin/bash', 01:26:59 INFO - 'SHLVL': '1', 01:26:59 INFO - 'TERM': 'linux', 01:26:59 INFO - 'TMOUT': '86400', 01:26:59 INFO - 'USER': 'cltbld', 01:26:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:26:59 INFO - '_': '/tools/buildbot/bin/python'} 01:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:26:59 INFO - Downloading/unpacking flake8 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:27:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:27:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:01 INFO - no previously-included directories found matching 'docs/_build' 01:27:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:27:01 INFO - Running setup.py install for pep8 01:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:01 INFO - no previously-included directories found matching 'docs/_build' 01:27:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:27:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:27:01 INFO - Cleaning up... 01:27:01 INFO - Return code: 0 01:27:01 INFO - Running post-action listener: _resource_record_post_action 01:27:01 INFO - Running post-action listener: _start_resource_monitoring 01:27:01 INFO - Starting resource monitoring. 01:27:01 INFO - ##### 01:27:01 INFO - ##### Running install step. 01:27:01 INFO - ##### 01:27:01 INFO - Running pre-action listener: _resource_record_pre_action 01:27:01 INFO - Running main action method: install 01:27:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:27:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:27:02 INFO - Reading from file tmpfile_stdout 01:27:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:27:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:27:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:27:02 INFO - Reading from file tmpfile_stdout 01:27:02 INFO - Output received: 01:27:02 INFO - Usage: mozinstall [options] installer 01:27:02 INFO - Options: 01:27:02 INFO - -h, --help show this help message and exit 01:27:02 INFO - -d DEST, --destination=DEST 01:27:02 INFO - Directory to install application into. [default: 01:27:02 INFO - "/builds/slave/test-pgo"] 01:27:02 INFO - --app=APP Application being installed. [default: firefox] 01:27:02 INFO - mkdir: /builds/slave/test-pgo/build/application 01:27:02 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'] 01:27:02 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 01:27:16 INFO - Reading from file tmpfile_stdout 01:27:16 INFO - Output received: 01:27:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:27:16 INFO - Running post-action listener: _resource_record_post_action 01:27:16 INFO - ##### 01:27:16 INFO - ##### Running run-tests step. 01:27:16 INFO - ##### 01:27:16 INFO - Running pre-action listener: _resource_record_pre_action 01:27:16 INFO - Running main action method: run_tests 01:27:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:27:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:27:16 INFO - Python 2.7.3 01:27:16 INFO - Return code: 0 01:27:16 INFO - grabbing minidump binary from tooltool 01:27:16 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')]} 01:27:16 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 0x29bd350>, '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 0x29be250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29be6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:27:16 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 01:27:16 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 01:27:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:16 INFO - Return code: 0 01:27:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:27:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:27:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:27:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:27:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:27:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:27:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:27:17 INFO - Return code: 0 01:27:17 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:27:17 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 01:27:17 INFO - Using env: {'DISPLAY': ':0', 01:27:17 INFO - 'HOME': '/home/cltbld', 01:27:17 INFO - 'LANG': 'en_US.UTF-8', 01:27:17 INFO - 'LANGUAGE': 'en_US:en', 01:27:17 INFO - 'LOGNAME': 'cltbld', 01:27:17 INFO - 'MAIL': '/var/mail/cltbld', 01:27:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:27:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:17 INFO - 'MOZ_NO_REMOTE': '1', 01:27:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:17 INFO - 'NO_EM_RESTART': '1', 01:27:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:27:17 INFO - 'SHELL': '/bin/bash', 01:27:17 INFO - 'SHLVL': '1', 01:27:17 INFO - 'TERM': 'linux', 01:27:17 INFO - 'TMOUT': '86400', 01:27:17 INFO - 'USER': 'cltbld', 01:27:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132', 01:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:17 INFO - '_': '/tools/buildbot/bin/python'} 01:27:17 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 01:27:18 INFO - mozversion INFO | application_buildid: 20160125070233 01:27:18 INFO - mozversion INFO | application_changeset: 3bc504ea394fe54d1dbb3afc86534b25c36432bd 01:27:18 INFO - mozversion INFO | application_display_name: Nightly 01:27:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:18 INFO - mozversion INFO | application_name: Firefox 01:27:18 INFO - mozversion INFO | application_remotingname: firefox 01:27:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:18 INFO - mozversion INFO | application_vendor: Mozilla 01:27:18 INFO - mozversion INFO | application_version: 45.0 01:27:18 INFO - mozversion INFO | platform_buildid: 20160125070233 01:27:18 INFO - mozversion INFO | platform_changeset: 3bc504ea394fe54d1dbb3afc86534b25c36432bd 01:27:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:18 INFO - mozversion INFO | platform_version: 45.0 01:27:18 INFO - 2016-01-26 01:27:18,093 DEBUG : using testdate: 1453800438 01:27:18 INFO - 2016-01-26 01:27:18,093 DEBUG : actual date: 1453800438 01:27:18 INFO - 2016-01-26 01:27:18,148 INFO : starting webserver on 'localhost:56102' 01:27:18 INFO - 2016-01-26 01:27:18,149 INFO : Starting test suite talos-linux64-ix-023 01:27:18 INFO - 2016-01-26 01:27:18,149 INFO : Starting test dromaeo_css 01:27:18 INFO - 2016-01-26 01:27:18,149 DEBUG : operating with platform_type : linux_ 01:27:18 INFO - 2016-01-26 01:27:18,150 INFO : Initialising browser for dromaeo_css test... 01:27:18 INFO - 2016-01-26 01:27:18,166 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3ou6F/profile http://localhost:56102/getInfo.html 01:27:22 INFO - 2016-01-26 01:27:22,022 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:27:22 INFO - 2016-01-26 01:27:22,022 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:27:22 INFO - 2016-01-26 01:27:22,022 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:27:22 INFO - 2016-01-26 01:27:22,022 DEBUG : BROWSER_OUTPUT: __metrics 01:27:22 INFO - 2016-01-26 01:27:22,171 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] 01:27:22 INFO - 2016-01-26 01:27:22,986 INFO : Browser initialized. 01:27:22 INFO - 2016-01-26 01:27:22,986 INFO : Running cycle 1/1 for dromaeo_css test... 01:27:22 INFO - 2016-01-26 01:27:22,987 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl3ou6F/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:27:34 INFO - 2016-01-26 01:27:34,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 134168576 01:27:34 INFO - 2016-01-26 01:27:34,743 DEBUG : BROWSER_OUTPUT: 01:28:25 INFO - 2016-01-26 01:28:25,488 DEBUG : BROWSER_OUTPUT: 1453800505487 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] 01:30:33 INFO - 2016-01-26 01:30:33,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56102/tests/dromaeo/cssquery-ext.html) 01:30:34 INFO - 2016-01-26 01:30:34,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 244400128 01:30:34 INFO - 2016-01-26 01:30:34,811 DEBUG : BROWSER_OUTPUT: 01:33:36 INFO - 2016-01-26 01:33:36,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-ext.html (next: http://localhost:56102/tests/dromaeo/cssquery-jquery.html) 01:33:37 INFO - 2016-01-26 01:33:37,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 218845184 01:33:37 INFO - 2016-01-26 01:33:37,447 DEBUG : BROWSER_OUTPUT: 01:36:39 INFO - 2016-01-26 01:36:39,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56102/tests/dromaeo/cssquery-mootools.html) 01:36:39 INFO - 2016-01-26 01:36:39,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 206868480 01:36:39 INFO - 2016-01-26 01:36:39,756 DEBUG : BROWSER_OUTPUT: 01:39:41 INFO - 2016-01-26 01:39:41,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56102/tests/dromaeo/cssquery-prototype.html) 01:39:42 INFO - 2016-01-26 01:39:42,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 202719232 01:39:42 INFO - 2016-01-26 01:39:42,065 DEBUG : BROWSER_OUTPUT: 01:42:44 INFO - 2016-01-26 01:42:44,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56102/tests/dromaeo/cssquery-yui.html) 01:42:45 INFO - 2016-01-26 01:42:45,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 198557696 01:42:45 INFO - 2016-01-26 01:42:45,074 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-yui.html (next: http://localhost:56102/tests/dromaeo/cssquery-dojo.html) 01:45:47 INFO - 2016-01-26 01:45:47,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 225501184 01:45:47 INFO - 2016-01-26 01:45:47,463 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,465 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:45:47 INFO - 2016-01-26 01:45:47,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:45:47 INFO - 2016-01-26 01:45:47,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:45:47 INFO - 2016-01-26 01:45:47,465 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:45:47 INFO - 2016-01-26 01:45:47,466 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3300.2904375559256;3330.417176994027;3331.600207975042;3347.046091863819;3351.2627222011156;5536.667799932007;5556.305461817273;5560.332760068793;5566.860828479285;5598.048331783596;5565.860853478665;5583.190437386576;5584.6090773645865;5585.162225666152;5612.045952188128;4975.776090075937;5042.697438153723;5078.13671675816;5091.618128640348;5186.273921650972;4969.180085285923;5039.874003149914;5062.291279220912;5086.593072554206;5111.284420181178;5102.872428189306;5139.511746384088;5149.948500515003;5158.045761534109;5159.406668233164;5131.153359695683;5149.84550463483;5205.349331333565;5210.03614331348;5222.112240919015;4866.172750632401;4956.355673762388;4968.801247950078;5082.415522214956;5106.591472682177;5421.620486565942;5430.3755068167275;5433.510984011418;5440.401555828856;5452.345718513764;5789.884202315972;6026.879462410771;6041.214642096544;6043.6675982820925;6044.214252147237;5979.910301345483;5990.9101363479585;6068.362821903725;6070.271567411939;6082.391760823926;5606.159076138611;5609.831705048855;5612.803551875665;5615.101583746581;5631.436856314377;5896.115582662635;6060.818175454655;6063.696815159225;6068.180795592627;6072.848178795565;5782.421757824268;5831.271091113611;5853.765849365977;5891.675957822275;5955.880882382415;6013.819585412444;6052.485538729257;6062.727177277033;6064.666443345658;6073.331933487313;5800.129980502874;5849.268841394825;6020.518358531307;6030.487408570233;6032.487238584682;5841.386654401312;5890.352061273256;5919.615225010447;5927;5950.553708471882;4577.450705915311;4592.816287348469;4601.907961840744;4602;4626.560476754703;4027.979860100739;4078.7756673382655;4100.118474527991;4123.340265557496;4160.521540022936;5771.30744310677;5785.479306862402;5799.159121927381;5803.564732645069;5811.244538210006;6090.208272924491;6097.024476083805;6100.908486372708;6102.511799056065;6105.053716673922;5482.424345443751;5617.606767526316;5631.71841407928;5740.712964351766;5781.88436231273;5160.225966105114;5178.6116041297055;5184.662996905189;5187.948120518822;5188.403333616607;6057.3639767824625;6058.757649693963;6058.818235452944;6072.666003369857;6073.058675905153;5828.854278642898;5834.38738932406;5874.823755287348;5991.820245392645;6011.248593925759;6199.380061993945;6238.126662267377;6240.251169859464;6241.21984751906;6257.624542527463;5794.565407594363;6017.759289628541;6027.969860150672;6046.97201475759;6051.364606716232;5856.853578660568;5922.851928701644;5934.554908381975;5944.5838791284195;5950.375210602824;5842.1820945068575;5873.148393483007;5877.911831322619;5881.794137205177;5891.1457838612305;5661.2923384576925;5702.942970570407;5858.209141765807;5873.530117590668;5874.001419758737;5649.802256920988;5689.032864413142;5694.629849059798;5699.601027928005;5727.7422515986045;5854.092615644582;5865.208196893364;5880.882382352243;5905.970470147794;5910.468057874812;5583.553315734813;5583.609147359808;5677.063284558001;5757.769689212385;5762.222100016612 01:45:47 INFO - 2016-01-26 01:45:47,467 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.8843875444287;638.409471239104;639.8784230996107;644.761438267841;654.0679531667374;32949.17627059325;40138.598614013885;40295;40490.39264411036;40497.59502404975;45248.09503809922;45914.31128533067;45955.08089838201;45976.3103553447;45990.7700461498;7616.923830761704;7692.4615276930635;8968.82062358754;9149.725508234764;10347.844782328271;10653.733656658567;10749.301295415811;10750.462476876164;10786.892131078706;10800.189985751062;10695.518701658444;10712.732181695443;10749.83875241872;10790.946045269762;10807.621733239339;10704.839427408595;10753.085987691056;10808.72978175544;10817.459127043616;10824.134069274478;10515.684529464052;10544.525496352606;10573.577056917715;10660.147188224923;10660.307080039773;41963.370549441475;42362.576374236174;42378;42455.36316955248;42469;3471.3057388522398;3544.167120726627;4019.678425725935;4189.455370801777;4224.619784219435;31633.20916977094;31936;32115.678843211503;32173.356532869213;32595.18512037194;4002.2795896738576;4181.435506206653;4206;4217.662586993033;4246.87259382216;309542;311841;312078;312268.43865780754;312275;56488.43511564832;57476;57515;62378.68810656008;62824.68587657032;64983.35016649773;66607.66696166585;66687.66656166688;66712.66643666847;66717;17735.556611084827;18058;18096.9095154526;18113.637727245383;18145.81854181468;13780.655483612789;13915;13920;13922.651933701536;13931;19659.41021769349;20059;20119.698204526943;20252.797472025384;20269.189232430537;7689.577073260913;7787.649555770004;7790.571518566533;7828.217178282126;7938.722144724907;1029.0018681878566;1096.1340540972542;1103.933763974164;1109.778044391125;1163.9243449175776;30161.698383016326;30194.24514387114;30195.69804301973;30620.234494137825;31322.530162047588;1091.1161958813386;1094.8303013032992;1131.8924702153283;1148.4831825678477;1177.1348059176498;13762.311884405739;13938.442462301395;14152.504662336769;15975.041497509954;16351.100689461955;355664;360051;360686;361727;362316;57271.14093288604;57802.42197578055;57856.421435785946;57865.421345786;57996.4200357991;1323.1730168644597;1378.8621137886132;1425.62933637253;1454.8326942401548;1459.7883306920437;26902.192934212006;27258.863705681346;27628.447431051667;27686.446271074063;27724.86137569299;41186.588134118276;41628.58371416247;41638.791806040776;41651.583484164774;41685.37471937984;204133;205169;205171;205473;205571;32858;32968.34063318768;33443.66556334405;34518.65481345155;35092.64907350996;41112;41587.58412415837;41995.7900210497;42008.369874451295;42556.574434255264;34826;34859.65140348564;35239.647603523634;35959.1010224736;36236.63763362333;35063.47404788981;35542.822285888404;36040.27919441649;36833.44749828701;38013.23973520459;37181.6281837189;37239.44140837944;37910.62089379181;37955.43066853944;37997.620023799405;31903.680963190072;33790.49314260337;34089.48865766966;34345.48481772726;34549.13627159341;25791.613125803502;26098.217053488424;26501.204963851116;26595.867020664773;26637.866810665822 01:45:47 INFO - 2016-01-26 01:45:47,468 DEBUG : BROWSER_OUTPUT: |2;jquery.html;378.2812655953688;378.97726136431817;381.7156218617131;387.93211188042085;399.9000249937516;14896.851031489681;15099.396024159048;16708.415205467812;18025.54936126596;18032.729509057357;13720.108192967475;14140.292985350743;14275.072120312198;16503.09232992185;17805.7329140063;5241.764120614582;5645.435456454353;5745.942540574603;5778.942210577903;5788.305403351604;5735.512481439083;5778.6243894146955;5780.653160810365;5790.073588225885;5790.36306006339;5635.380108188096;5690.212774413417;5712.65724056558;5728.513076388512;5741.712914354286;5645.745941432625;5672.574556908248;5678.403767604384;5681.091025435951;5682.431756824326;5002.7248501332415;5112.18205087188;5115.386153661547;5157.587393008588;5158.716270605115;16423.42518011864;20132.09405576738;20736.896315518476;21885.67171492429;22025.779742202692;2251.5159240763314;2319.8028167605776;2324.070371851256;2331.067572970808;2362.6928499295154;10193.23550733698;10698.625548105856;11847.11146663995;13471.259080750555;13747.793783093262;1827.5065732252217;1833.9913047823643;1913.1677720191622;1952.531392465798;1955.4720225539024;48864.75567622139;49801;58360.4163958355;66121.338786612;69109.65445172793;9889.109980101824;10658.946705266424;10753.946230268799;10800.351978881292;10807.513661885234;14229.28853557318;14276.42894284217;14351.282435878373;14357.138571685733;14366.353514091681;8124.512529248264;8148.144444833326;8324.084350721416;8332.958335208285;8412.663493460315;8080.111187769341;8136.1863813618165;8165.1426600207315;8207.097219305871;8218.958905205436;4882.26765985098;4920.286558449076;4926.630502712311;4927.802887884516;4950.158473059589;1911.9044047797554;1927.6433859735714;1960.451073699338;1964.960700786005;1975.6292449061184;937.1331518345503;954.5036580977992;992.3153024413132;1061.2677252695614;1065.3767545985531;17262.395816146374;17300.567485812957;17494.912525437547;17542.91228543849;18191.272349105886;904.615538396179;993.3146129170849;997.7976538271365;1001.6644424117857;1050.1388861133796;9513.14381705636;9680.806383872425;9755.658551950648;9757.365771224848;9912.959139290271;452699;455221;456251;472798;688872;83643.16356836475;87640.5617971906;88255.55872220726;89232;89308.5534572323;1139.2139423797553;1167.0721776187781;1168.2464810197375;1186.104491109207;1202.1284568687631;15521.767173492632;15845.762313565076;16174.838251617804;16488.83511164873;16582.75125873137;33940.321193575495;34115.48826767551;34137;34781.826090869385;35362.823185883906;46568.30147547857;46674.76662616801;47487.287690683974;47993.28010079782;48875.51124488852;10330.586776528855;10545.261831671709;10632.202584806326;10724.51739671701;10892.509837057192;11583.76832463329;12224.633261002184;12370.44333004999;12385.876141238832;12499.500019999097;10466.37201767866;11079.113670906469;11181.888181118085;11293.604723834625;11294.209405341548;10839.078678312431;10867.836982445428;10926;10956.616518421817;11185.608503702331;11201.159913006393;11216.83174752363;11298.943505282421;11537.192396532162;11550.306981581132;12571.308578028296;13393.531226407029;15364.77081833473;15453.5363939082;15467.922660386626;16757.491825735742;16824.07467589294;16901.154942252593;17147.914260428617;17381.652366952338 01:45:47 INFO - 2016-01-26 01:45:47,469 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1442.9855701442987;1520.6426489774901;1635.6565121324522;1690.41680620186;1865.3098353609166;8056.194380561941;8224.83550328993;8225.50646961182;8228.218319259668;8233.752987410388;7235.204127545966;7353.0441042664515;7358.926410735891;7770.4560680752365;8063.6371363288645;2284.9885750571225;2295.1737374545232;2309.572729045132;2321.1527792355755;2321.3964369264027;2355.0697474497565;2377.3937645900273;2400.7959323457526;2402.567537843196;2406.03758496601;2011.6077364913774;2052.0970772859896;2246.0903334149616;2285.645724912641;2287.1194590082773;2227.7772222777676;2251.5159240763314;2285.4400671835506;2290.6105961986505;2291.415688999303;2321.292005938188;2325.8720770357622;2341.7189937207645;2346.1084787780705;2346.5424242272766;8047;8127.065387480457;8127.106018337978;8131.06492753335;8142.715004974857;4787.13831510328;4833.371661683994;4877.219644856841;4898.142825005645;4899.044686286175;3042.6957304269395;3057.159281197666;3070.1710538154575;3079.6612372638992;3178.9682103179134;1011.9342242754198;1014.2089170447063;1047.5862034496408;1060.1042119409087;1063.1972860490357;10868.782624347548;11043.779124417548;11048.281861678965;11049.779004419866;11066.557337706483;4220.683448741357;4255.702100852973;4346.500152482505;4369.934450983238;4373.562643735665;9110.49892255919;9115.589798459085;9155.862662060075;9158.129977652112;9161.267098632094;4902.852914412573;4920.803167873245;4926.729029903389;4928.581070608967;4939.629527785359;4473.4408198975125;4493.932591011137;4531;4545.909081818411;4546.340780586796;3662.230931504414;3667.578228503703;3683.834227459771;3698.6116457771545;3728.3102626014274;1081.4592703648175;1097.983530247047;1104.2160066352978;1141.537677240719;1143.5768765556797;998.0717932323009;1193.3555879824971;1233.9819648789605;1366.4261010375667;1449.4564538298139;7503.287187717158;7629.8855517167285;7669;7671.232876712284;7675.884861727079;598.60791181776;617.5368473644767;661.9106420633249;663.1445435388391;754.4153281207108;6058.939410605925;6074.605150665193;6189.473894718909;6197.659128747962;6198.690065496798;9200.953995230115;9334.066593340747;9447.433154010781;9483.383580067273;9488.905110948803;9389.38968967015;9638.325317227867;9653.90346096544;9670.661526846527;9676.516174191262;7412.777616671508;7505.549667019996;7512.624368781649;7560.395168386516;7572.356349710226;7823.452358335089;7866.9213307866185;7880.408969327438;7884.132745398117;7886.645100970585;8653.437526560754;8700.173483519056;8818.955905220433;8856.202941735275;8894.021657617528;8657.437266577652;9009.279257659502;9016.053314401894;9136.588853501475;9183.357164998386;7142.142942846892;7159.57042577447;7346.045014148341;7352.191258961403;7358.22738612438;7804.84390312202;7854.607269636381;7855.489393189653;7861.1745766693675;7874.763757087297;6449.129367535323;7398.371138453292;7556.773296801105;7621.1997740236475;7658.502197357154;6740.831479213059;7018.508704390848;7399.704011839466;7470.589117598584;7492.62536873165;7356.485046046725;7384.667689953858;7400.111986561647;7422.925770742439;7442.330190282901;6867.450603951772;6899.103116594811;6909.136357955255;6912.101426814482;6913.688884000333;6901.206361268519;6928.307169283032;6947.027416161843;6961.79114626562;6974.68613912365 01:45:47 INFO - 2016-01-26 01:45:47,470 DEBUG : BROWSER_OUTPUT: |4;prototype.html;356.2021072796935;361.40909612783094;364.22238520758174;364.3841907176871;367.5222211125538;6143.04782758672;6150.723217455214;6221.160143380654;6237.53218508612;6245.718942647581;5888.735006924688;5911.586188966774;6029.547783916202;6139.478144357724;6148.446639802417;4743.1225223333795;4763.404574428197;4766.976165119169;4783.784729687155;4790.880227994302;4570.13167498176;4777.880552986168;4783.306420569015;4786.401699787527;4795.952040479586;4602.286645569925;4611.077784443108;4656.627469802408;4665.440147182343;4725.645576581753;4694.906101877978;4715.1748444022505;4717.575418212343;4719.126961512114;4722.76386180693;4178.603032711888;4178.895527611804;4185.372194170868;4189.308764053927;4190.413342132104;5639.8590035249445;5806.680632565207;5832.650040997553;5836.416358364172;5837.211976383219;5532.5020748132865;5540.695261760601;5540.722963851791;5548.55611551075;5551.361593416768;6410.519211059142;6430.61416315018;6431.163948686641;6436.93563064368;6471.6764161791725;4667.533246675339;4670.486246512881;4674.602658774008;4678.625709943196;4682.765861706901;6513.1532900722605;6658.733650653968;6668.599884006975;6672.899906501358;6674.466042716571;4763.404574428197;4798.304245884327;4799.784009719571;4800.615950723934;4801.351817504592;4870.4155501339355;4870.659053866196;4871.853844384674;4872.756362181876;4875.512448755097;5409.377921538995;5513.2005859151;5522.972385138129;5528.502434780889;5535.806246781343;6520.18497687789;6537.411632952962;6537.5096867734155;6540.738370465128;6544.869102617921;1702.0553592755891;1722.276643809603;1729.8702597305;1730.3078768492453;1731.9826801732074;1151.694800877768;1175.9412029398668;1188.3761025461702;1199.154596009811;1209.909256805743;6344.49244060474;6391.840203994937;6392.169018027626;6396.648184349812;6396.9360306397275;6538.215414150332;6754.358335958076;6758.155230596176;6764.627945462948;6765.42493888025;6262.342454042351;6344.809655710336;6431.356864313531;6448.484121270287;6451.709673064724;3637.890863274106;3680.5031320771886;3686.64976827201;3691.557013158438;3692.058525076142;6919.965400172967;6986.580805151605;7046.401055910203;7050.083489146378;7058.400035996998;7016.158061032606;7018.1929078155645;7021.754238601727;7024.894626580605;7025.227225005246;7060.682269297894;7067.293270672892;7068.929310706827;7071.328223818729;7080.2919708028785;6610.9669451652435;6786.796396108125;6808.285130061272;6840.555363901331;6844.110265665432;6713.63075030878;6725.596464212163;6736.865262694817;6738.46092312604;6746.561473504206;7058.082449281561;7074.929250707427;7077.398421134056;7082.079329687108;7083.82290442743;4600.493945666041;4701.106789709944;4744.905101898012;4745.311929770095;4749.4063242094735;6717.429018533479;6761.594304341558;6764.425023872829;6767.864642707217;6768.830779230559;6571.277159512545;6584.275729669828;6589;6589.439897608757;6590.934090659032;6414.550981431255;6552.049952756728;6559.7376104955265;6563.343665633399;6568.441682456853;6431.196100487439;6452.741890324334;6465.3857883501;6466.321036291121;6467.579607325509;6581.835454113685;6595.505337099833;6598.868022639424;6603.273639899703;6604.933950660624;6255.78104766331;6341.175647165839;6417.935820641734;6425.06836508713;6438.227412710505 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: |5;yui.html;791.6279348706108;824.0893812337363;835.8411901738665;850.022474154722;850.6257246811402;15513.534593962186;15849.603759906007;15866.365345386184;15872.52382428529;15876.52370428886;15406.07563546188;15445.691086178269;15458.07251564907;15503.457378991738;15584.68830623387;767.9808004799896;778.2256654628652;912.37958188432;927.0729270729271;939.7133874168376;926.7219834049791;931.2177770672633;935.2190920581323;939.2673714502699;940.3558562384754;969.0358093696782;972.7130496503548;972.7568107973007;974.7075877236836;978.9363691360074;815.1237419773737;817.3175398542224;952.7570469530294;965.6620182935916;972.5186032913682;716.2407847681475;718.335539625844;719.8092505486051;720.1178556268582;720.1286443403488;14884.776728349083;15124.243787810565;15220.238988050553;15249.237538123049;15259.542213733606;12381.938090309492;12396.380180990915;12425.130240883142;12607.180533265308;13089.34553272342;9884.752881178028;11299.661010169708;11475.713107172303;11610.18728688992;11723.4138293085;3810.5427348718054;3853.5183102112237;3873.9225215495812;3883.359245724452;3975.2248311579256;50639.99999999963;50905;51559.48440515585;51650.483495164946;51769.74115129438;9920.801583968425;10054.64808731691;10128.59485620567;10210.744731381626;10625.5218515167;19326.226950922086;19472.90263548673;19477.80522194788;19478.707819382722;19480.415587532396;7986.960065199637;8132.390070744599;8257.8348433031;8419.452735572168;8527.573621318908;4322.37325587788;4395.472543294825;4539.954600454019;4601.217792975202;4636.258198688193;3157;3181;3182.6976437238427;3187.059817353886;3188.7927284726884;565.3131445293988;575.8128608202351;576.7692922830901;577.8208755285875;594.7234535940809;679.4530403025514;693.6531734132933;707.9185893622197;709.6522703875064;720.1106633307861;7973.561454120079;8539.74380768578;8558.229759321566;8602.397832151815;8830;514.3570536828964;651.9934800651932;700.5691499727631;703.1772825793731;723.8154270661053;3738.831752571141;4164.43780089684;4176.331786914079;4193.517745459311;4277.871663850089;60306.39693603096;60858.08712869311;61451.692741536004;62259;62269.688651556455;54616.180757288676;55367.446325537036;55808.441915581134;55821.44178558162;57103.71448142733;50026;50167.49832501701;50773.74613126984;51453.228201577;51946.22080668793;8271.255586996958;8422.410431269753;8430.15698430152;8572.78568035779;8636.78408039804;35520.28959420849;35787.28425431529;36121.63878361288;36452.45321320129;36716.26567468689;43936.12127757491;45852.31221531746;49307;49322.26016609682;50393.244101337776;10937.179711521509;11009.889901100887;11653.76692466129;11749.765004699688;12379.442925068213;12051.879481205426;12108.757824843278;12208.511659533875;12569.371531423576;12850.485980560672;10443.634472793416;10614.946925265323;10996.670099897015;11461.942690286829;12064.819027714766;10667.94666026696;10728.034476897117;10787;10962.177836662122;11139.33164010162;10321.690349289533;10366.792664146826;10430.791384172426;10491.527881245514;11082.05802506796;9649.43766451312;9757.268204884804;10277.794444111225;10690.893091069302;10704.839427408438;9580.13778759915;9703.272254580794;9714.125728684452;9807.313488055768;9824.950875245579 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,795 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801547463__endTimestamp 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,472 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5553.55 Median:5781.88 stddev:615.69 (10.6%) stddev-sans-first:591.66 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: Values: 3300.3 3330.4 3331.6 3347.0 3351.3 5536.7 5556.3 5560.3 5566.9 5598.0 5565.9 5583.2 5584.6 5585.2 5612.0 4975.8 5042.7 5078.1 5091.6 5186.3 4969.2 5039.9 5062.3 5086.6 5111.3 5102.9 5139.5 5149.9 5158.0 5159.4 5131.2 5149.8 5205.3 5210.0 5222.1 4866.2 4956.4 4968.8 5082.4 5106.6 5421.6 5430.4 5433.5 5440.4 5452.3 5789.9 6026.9 6041.2 6043.7 6044.2 5979.9 5990.9 6068.4 6070.3 6082.4 5606.2 5609.8 5612.8 5615.1 5631.4 5896.1 6060.8 6063.7 6068.2 6072.8 5782.4 5831.3 5853.8 5891.7 5955.9 6013.8 6052.5 6062.7 6064.7 6073.3 5800.1 5849.3 6020.5 6030.5 6032.5 5841.4 5890.4 5919.6 5927.0 5950.6 4577.5 4592.8 4601.9 4602.0 4626.6 4028.0 4078.8 4100.1 4123.3 4160.5 5771.3 5785.5 5799.2 5803.6 5811.2 6090.2 6097.0 6100.9 6102.5 6105.1 5482.4 5617.6 5631.7 5740.7 5781.9 5160.2 5178.6 5184.7 5187.9 5188.4 6057.4 6058.8 6058.8 6072.7 6073.1 5828.9 5834.4 5874.8 5991.8 6011.2 6199.4 6238.1 6240.3 6241.2 6257.6 5794.6 6017.8 6028.0 6047.0 6051.4 5856.9 5922.9 5934.6 5944.6 5950.4 5842.2 5873.1 5877.9 5881.8 5891.1 5661.3 5702.9 5858.2 5873.5 5874.0 5649.8 5689.0 5694.6 5699.6 5727.7 5854.1 5865.2 5880.9 5906.0 5910.5 5583.6 5583.6 5677.1 5757.8 5762.2 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47291.70 Median:33617.08 stddev:78379.52 (233.2%) stddev-sans-first:78520.97 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: Values: 592.9 638.4 639.9 644.8 654.1 32949.2 40138.6 40295.0 40490.4 40497.6 45248.1 45914.3 45955.1 45976.3 45990.8 7616.9 7692.5 8968.8 9149.7 10347.8 10653.7 10749.3 10750.5 10786.9 10800.2 10695.5 10712.7 10749.8 10790.9 10807.6 10704.8 10753.1 10808.7 10817.5 10824.1 10515.7 10544.5 10573.6 10660.1 10660.3 41963.4 42362.6 42378.0 42455.4 42469.0 3471.3 3544.2 4019.7 4189.5 4224.6 31633.2 31936.0 32115.7 32173.4 32595.2 4002.3 4181.4 4206.0 4217.7 4246.9 309542.0 311841.0 312078.0 312268.4 312275.0 56488.4 57476.0 57515.0 62378.7 62824.7 64983.4 66607.7 66687.7 66712.7 66717.0 17735.6 18058.0 18096.9 18113.6 18145.8 13780.7 13915.0 13920.0 13922.7 13931.0 19659.4 20059.0 20119.7 20252.8 20269.2 7689.6 7787.6 7790.6 7828.2 7938.7 1029.0 1096.1 1103.9 1109.8 1163.9 30161.7 30194.2 30195.7 30620.2 31322.5 1091.1 1094.8 1131.9 1148.5 1177.1 13762.3 13938.4 14152.5 15975.0 16351.1 355664.0 360051.0 360686.0 361727.0 362316.0 57271.1 57802.4 57856.4 57865.4 57996.4 1323.2 1378.9 1425.6 1454.8 1459.8 26902.2 27258.9 27628.4 27686.4 27724.9 41186.6 41628.6 41638.8 41651.6 41685.4 204133.0 205169.0 205171.0 205473.0 205571.0 32858.0 32968.3 33443.7 34518.7 35092.6 41112.0 41587.6 41995.8 42008.4 42556.6 34826.0 34859.7 35239.6 35959.1 36236.6 35063.5 35542.8 36040.3 36833.4 38013.2 37181.6 37239.4 37910.6 37955.4 37997.6 31903.7 33790.5 34089.5 34345.5 34549.1 25791.6 26098.2 26501.2 26595.9 26637.9 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28117.53 Median:21311.28 stddev:84123.76 (394.7%) stddev-sans-first:84333.96 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: Values: 378.3 379.0 381.7 387.9 399.9 14896.9 15099.4 16708.4 18025.5 18032.7 13720.1 14140.3 14275.1 16503.1 17805.7 5241.8 5645.4 5745.9 5778.9 5788.3 5735.5 5778.6 5780.7 5790.1 5790.4 5635.4 5690.2 5712.7 5728.5 5741.7 5645.7 5672.6 5678.4 5681.1 5682.4 5002.7 5112.2 5115.4 5157.6 5158.7 16423.4 20132.1 20736.9 21885.7 22025.8 2251.5 2319.8 2324.1 2331.1 2362.7 10193.2 10698.6 11847.1 13471.3 13747.8 1827.5 1834.0 1913.2 1952.5 1955.5 48864.8 49801.0 58360.4 66121.3 69109.7 9889.1 10658.9 10753.9 10800.4 10807.5 14229.3 14276.4 14351.3 14357.1 14366.4 8124.5 8148.1 8324.1 8333.0 8412.7 8080.1 8136.2 8165.1 8207.1 8219.0 4882.3 4920.3 4926.6 4927.8 4950.2 1911.9 1927.6 1960.5 1965.0 1975.6 937.1 954.5 992.3 1061.3 1065.4 17262.4 17300.6 17494.9 17542.9 18191.3 904.6 993.3 997.8 1001.7 1050.1 9513.1 9680.8 9755.7 9757.4 9913.0 452699.0 455221.0 456251.0 472798.0 688872.0 83643.2 87640.6 88255.6 89232.0 89308.6 1139.2 1167.1 1168.2 1186.1 1202.1 15521.8 15845.8 16174.8 16488.8 16582.8 33940.3 34115.5 34137.0 34781.8 35362.8 46568.3 46674.8 47487.3 47993.3 48875.5 10330.6 10545.3 10632.2 10724.5 10892.5 11583.8 12224.6 12370.4 12385.9 12499.5 10466.4 11079.1 11181.9 11293.6 11294.2 10839.1 10867.8 10926.0 10956.6 11185.6 11201.2 11216.8 11298.9 11537.2 11550.3 12571.3 13393.5 15364.8 15453.5 15467.9 16757.5 16824.1 16901.2 17147.9 17381.7 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,473 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5651.14 Median:6883.28 stddev:2958.14 (43.0%) stddev-sans-first:2949.53 01:45:47 INFO - 2016-01-26 01:45:47,474 DEBUG : BROWSER_OUTPUT: Values: 1443.0 1520.6 1635.7 1690.4 1865.3 8056.2 8224.8 8225.5 8228.2 8233.8 7235.2 7353.0 7358.9 7770.5 8063.6 2285.0 2295.2 2309.6 2321.2 2321.4 2355.1 2377.4 2400.8 2402.6 2406.0 2011.6 2052.1 2246.1 2285.6 2287.1 2227.8 2251.5 2285.4 2290.6 2291.4 2321.3 2325.9 2341.7 2346.1 2346.5 8047.0 8127.1 8127.1 8131.1 8142.7 4787.1 4833.4 4877.2 4898.1 4899.0 3042.7 3057.2 3070.2 3079.7 3179.0 1011.9 1014.2 1047.6 1060.1 1063.2 10868.8 11043.8 11048.3 11049.8 11066.6 4220.7 4255.7 4346.5 4369.9 4373.6 9110.5 9115.6 9155.9 9158.1 9161.3 4902.9 4920.8 4926.7 4928.6 4939.6 4473.4 4493.9 4531.0 4545.9 4546.3 3662.2 3667.6 3683.8 3698.6 3728.3 1081.5 1098.0 1104.2 1141.5 1143.6 998.1 1193.4 1234.0 1366.4 1449.5 7503.3 7629.9 7669.0 7671.2 7675.9 598.6 617.5 661.9 663.1 754.4 6058.9 6074.6 6189.5 6197.7 6198.7 9201.0 9334.1 9447.4 9483.4 9488.9 9389.4 9638.3 9653.9 9670.7 9676.5 7412.8 7505.5 7512.6 7560.4 7572.4 7823.5 7866.9 7880.4 7884.1 7886.6 8653.4 8700.2 8819.0 8856.2 8894.0 8657.4 9009.3 9016.1 9136.6 9183.4 7142.1 7159.6 7346.0 7352.2 7358.2 7804.8 7854.6 7855.5 7861.2 7874.8 6449.1 7398.4 7556.8 7621.2 7658.5 6740.8 7018.5 7399.7 7470.6 7492.6 7356.5 7384.7 7400.1 7422.9 7442.3 6867.5 6899.1 6909.1 6912.1 6913.7 6901.2 6928.3 6947.0 6961.8 6974.7 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5505.75 Median:6259.06 stddev:1634.04 (26.1%) stddev-sans-first:1592.26 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: Values: 356.2 361.4 364.2 364.4 367.5 6143.0 6150.7 6221.2 6237.5 6245.7 5888.7 5911.6 6029.5 6139.5 6148.4 4743.1 4763.4 4767.0 4783.8 4790.9 4570.1 4777.9 4783.3 4786.4 4796.0 4602.3 4611.1 4656.6 4665.4 4725.6 4694.9 4715.2 4717.6 4719.1 4722.8 4178.6 4178.9 4185.4 4189.3 4190.4 5639.9 5806.7 5832.7 5836.4 5837.2 5532.5 5540.7 5540.7 5548.6 5551.4 6410.5 6430.6 6431.2 6436.9 6471.7 4667.5 4670.5 4674.6 4678.6 4682.8 6513.2 6658.7 6668.6 6672.9 6674.5 4763.4 4798.3 4799.8 4800.6 4801.4 4870.4 4870.7 4871.9 4872.8 4875.5 5409.4 5513.2 5523.0 5528.5 5535.8 6520.2 6537.4 6537.5 6540.7 6544.9 1702.1 1722.3 1729.9 1730.3 1732.0 1151.7 1175.9 1188.4 1199.2 1209.9 6344.5 6391.8 6392.2 6396.6 6396.9 6538.2 6754.4 6758.2 6764.6 6765.4 6262.3 6344.8 6431.4 6448.5 6451.7 3637.9 3680.5 3686.6 3691.6 3692.1 6920.0 6986.6 7046.4 7050.1 7058.4 7016.2 7018.2 7021.8 7024.9 7025.2 7060.7 7067.3 7068.9 7071.3 7080.3 6611.0 6786.8 6808.3 6840.6 6844.1 6713.6 6725.6 6736.9 6738.5 6746.6 7058.1 7074.9 7077.4 7082.1 7083.8 4600.5 4701.1 4744.9 4745.3 4749.4 6717.4 6761.6 6764.4 6767.9 6768.8 6571.3 6584.3 6589.0 6589.4 6590.9 6414.6 6552.0 6559.7 6563.3 6568.4 6431.2 6452.7 6465.4 6466.3 6467.6 6581.8 6595.5 6598.9 6603.3 6604.9 6255.8 6341.2 6417.9 6425.1 6438.2 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14652.60 Median:50096.75 stddev:17182.90 (34.3%) stddev-sans-first:17199.58 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: Values: 791.6 824.1 835.8 850.0 850.6 15513.5 15849.6 15866.4 15872.5 15876.5 15406.1 15445.7 15458.1 15503.5 15584.7 768.0 778.2 912.4 927.1 939.7 926.7 931.2 935.2 939.3 940.4 969.0 972.7 972.8 974.7 978.9 815.1 817.3 952.8 965.7 972.5 716.2 718.3 719.8 720.1 720.1 14884.8 15124.2 15220.2 15249.2 15259.5 12381.9 12396.4 12425.1 12607.2 13089.3 9884.8 11299.7 11475.7 11610.2 11723.4 3810.5 3853.5 3873.9 3883.4 3975.2 50640.0 50905.0 51559.5 51650.5 51769.7 9920.8 10054.6 10128.6 10210.7 10625.5 19326.2 19472.9 19477.8 19478.7 19480.4 7987.0 8132.4 8257.8 8419.5 8527.6 4322.4 4395.5 4540.0 4601.2 4636.3 3157.0 3181.0 3182.7 3187.1 3188.8 565.3 575.8 576.8 577.8 594.7 679.5 693.7 707.9 709.7 720.1 7973.6 8539.7 8558.2 8602.4 8830.0 514.4 652.0 700.6 703.2 723.8 3738.8 4164.4 4176.3 4193.5 4277.9 60306.4 60858.1 61451.7 62259.0 62269.7 54616.2 55367.4 55808.4 55821.4 57103.7 50026.0 50167.5 50773.7 51453.2 51946.2 8271.3 8422.4 8430.2 8572.8 8636.8 35520.3 35787.3 36121.6 36452.5 36716.3 43936.1 45852.3 49307.0 49322.3 50393.2 10937.2 11009.9 11653.8 11749.8 12379.4 12051.9 12108.8 12208.5 12569.4 12850.5 10443.6 10614.9 10996.7 11461.9 12064.8 10667.9 10728.0 10787.0 10962.2 11139.3 10321.7 10366.8 10430.8 10491.5 11082.1 9649.4 9757.3 10277.8 10690.9 10704.8 9580.1 9703.3 9714.1 9807.3 9825.0 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:45:47 INFO - 2016-01-26 01:45:47,475 DEBUG : BROWSER_OUTPUT: 01:45:48 INFO - 2016-01-26 01:45:48,070 INFO : Browser exited with error code: 0 01:45:48 INFO - 2016-01-26 01:45:48,086 INFO : Completed test dromaeo_css (00:18:29) 01:45:48 INFO - 2016-01-26 01:45:48,086 INFO : Starting test kraken 01:45:48 INFO - 2016-01-26 01:45:48,086 DEBUG : operating with platform_type : linux_ 01:45:48 INFO - 2016-01-26 01:45:48,086 INFO : Initialising browser for kraken test... 01:45:48 INFO - 2016-01-26 01:45:48,092 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpewRW_8/profile http://localhost:56102/getInfo.html 01:45:51 INFO - 2016-01-26 01:45:51,699 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:45:51 INFO - 2016-01-26 01:45:51,699 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:45:51 INFO - 2016-01-26 01:45:51,699 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:45:51 INFO - 2016-01-26 01:45:51,700 DEBUG : BROWSER_OUTPUT: __metrics 01:45:51 INFO - 2016-01-26 01:45:51,978 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] 01:45:52 INFO - 2016-01-26 01:45:52,734 INFO : Browser initialized. 01:45:52 INFO - 2016-01-26 01:45:52,734 INFO : Running cycle 1/1 for kraken test... 01:45:52 INFO - 2016-01-26 01:45:52,734 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpewRW_8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:46:04 INFO - 2016-01-26 01:46:04,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 134307840 01:46:04 INFO - 2016-01-26 01:46:04,486 DEBUG : BROWSER_OUTPUT: 01:46:06 INFO - 2016-01-26 01:46:06,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:07 INFO - 2016-01-26 01:46:07,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 166535168 01:46:07 INFO - 2016-01-26 01:46:07,468 DEBUG : BROWSER_OUTPUT: 01:46:10 INFO - 2016-01-26 01:46:10,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-dft) 01:46:10 INFO - 2016-01-26 01:46:10,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 163008512 01:46:10 INFO - 2016-01-26 01:46:10,587 DEBUG : BROWSER_OUTPUT: 01:46:13 INFO - 2016-01-26 01:46:13,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-fft) 01:46:13 INFO - 2016-01-26 01:46:13,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 161132544 01:46:13 INFO - 2016-01-26 01:46:13,948 DEBUG : BROWSER_OUTPUT: 01:46:15 INFO - 2016-01-26 01:46:15,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator) 01:46:16 INFO - 2016-01-26 01:46:16,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 159907840 01:46:16 INFO - 2016-01-26 01:46:16,482 DEBUG : BROWSER_OUTPUT: 01:46:18 INFO - 2016-01-26 01:46:18,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:19 INFO - 2016-01-26 01:46:19,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 158969856 01:46:19 INFO - 2016-01-26 01:46:19,205 DEBUG : BROWSER_OUTPUT: 01:46:22 INFO - 2016-01-26 01:46:22,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:22 INFO - 2016-01-26 01:46:22,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 159272960 01:46:22 INFO - 2016-01-26 01:46:22,680 DEBUG : BROWSER_OUTPUT: 01:46:26 INFO - 2016-01-26 01:46:26,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:26 INFO - 2016-01-26 01:46:26,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 161214464 01:46:26 INFO - 2016-01-26 01:46:26,617 DEBUG : BROWSER_OUTPUT: 01:46:29 INFO - 2016-01-26 01:46:29,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial) 01:46:29 INFO - 2016-01-26 01:46:29,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 159502336 01:46:29 INFO - 2016-01-26 01:46:29,898 DEBUG : BROWSER_OUTPUT: 01:46:31 INFO - 2016-01-26 01:46:31,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:46:32 INFO - 2016-01-26 01:46:32,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 165199872 01:46:32 INFO - 2016-01-26 01:46:32,013 DEBUG : BROWSER_OUTPUT: 01:46:33 INFO - 2016-01-26 01:46:33,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:46:34 INFO - 2016-01-26 01:46:34,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 162418688 01:46:34 INFO - 2016-01-26 01:46:34,345 DEBUG : BROWSER_OUTPUT: 01:46:36 INFO - 2016-01-26 01:46:36,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:46:36 INFO - 2016-01-26 01:46:36,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 169287680 01:46:36 INFO - 2016-01-26 01:46:36,915 DEBUG : BROWSER_OUTPUT: 01:46:39 INFO - 2016-01-26 01:46:39,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:46:39 INFO - 2016-01-26 01:46:39,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 173682688 01:46:39 INFO - 2016-01-26 01:46:39,844 DEBUG : BROWSER_OUTPUT: 01:46:42 INFO - 2016-01-26 01:46:42,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:46:42 INFO - 2016-01-26 01:46:42,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 172683264 01:46:42 INFO - 2016-01-26 01:46:42,892 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56102/tests/kraken/driver.html?testName=ai-astar) 01:46:44 INFO - 2016-01-26 01:46:44,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 230408192 01:46:44 INFO - 2016-01-26 01:46:44,800 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:46:44 INFO - 2016-01-26 01:46:44,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:46:44 INFO - 2016-01-26 01:46:44,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;102;107;109;109;100;108;108;108 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;121;144;156;123;152;152;123;158;127 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;160;161;160;166;161;160;162;161 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;73;149;71;73;73;72;153;72 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;99;140;92;92;94;136;91;93;136 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;110;108;110;109;110 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;145;145;146;145;145;146;146 01:46:44 INFO - 2016-01-26 01:46:44,801 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;55;55;56;55;57;54;54;55 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;64;64;64;64;64;64 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;80;87;81;80;81;80;81;88 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;121;111;120;114;117;110;113;123 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;145;144;132;150;134;149;147;147;138 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;70;65;64;62;64;64;65;65 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:46:44 INFO - 2016-01-26 01:46:44,802 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,865 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801604794__endTimestamp 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:108.00 stddev:3.37 (3.1%) stddev-sans-first:3.55 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 102.0 107.0 109.0 109.0 100.0 108.0 108.0 108.0 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,803 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.60 Median:151.00 stddev:15.23 (10.1%) stddev-sans-first:15.77 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: Values: 150.0 121.0 144.0 156.0 123.0 152.0 152.0 123.0 158.0 127.0 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.91 (1.2%) stddev-sans-first:1.87 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 160.0 161.0 160.0 166.0 161.0 160.0 162.0 161.0 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:72.00 stddev:33.39 (46.4%) stddev-sans-first:34.80 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 73.0 149.0 71.0 73.0 73.0 72.0 153.0 72.0 01:46:44 INFO - 2016-01-26 01:46:44,804 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,805 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:21.50 (23.4%) stddev-sans-first:22.06 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: Values: 91.0 99.0 140.0 92.0 92.0 94.0 136.0 91.0 93.0 136.0 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 110.0 108.0 110.0 109.0 110.0 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,806 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 55.0 55.0 56.0 55.0 57.0 54.0 54.0 55.0 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:3.00 (3.7%) stddev-sans-first:3.10 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 80.0 87.0 81.0 80.0 81.0 80.0 81.0 88.0 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:116.50 stddev:4.29 (3.7%) stddev-sans-first:4.56 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 121.0 111.0 120.0 114.0 117.0 110.0 113.0 123.0 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:146.00 stddev:6.50 (4.5%) stddev-sans-first:6.60 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 137.0 145.0 144.0 132.0 150.0 134.0 149.0 147.0 147.0 138.0 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:2.04 (3.1%) stddev-sans-first:2.15 01:46:44 INFO - 2016-01-26 01:46:44,807 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 70.0 65.0 64.0 62.0 64.0 64.0 65.0 65.0 01:46:44 INFO - 2016-01-26 01:46:44,808 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:46:44 INFO - 2016-01-26 01:46:44,808 DEBUG : BROWSER_OUTPUT: 01:46:45 INFO - 2016-01-26 01:46:45,430 INFO : Browser exited with error code: 0 01:46:45 INFO - 2016-01-26 01:46:45,485 INFO : Completed test kraken (00:00:57) 01:46:45 INFO - 2016-01-26 01:46:45,485 INFO : Starting test v8_7 01:46:45 INFO - 2016-01-26 01:46:45,485 DEBUG : operating with platform_type : linux_ 01:46:45 INFO - 2016-01-26 01:46:45,485 INFO : Initialising browser for v8_7 test... 01:46:45 INFO - 2016-01-26 01:46:45,491 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCMuqGF/profile http://localhost:56102/getInfo.html 01:46:49 INFO - 2016-01-26 01:46:49,398 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:46:49 INFO - 2016-01-26 01:46:49,399 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:46:49 INFO - 2016-01-26 01:46:49,399 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:46:49 INFO - 2016-01-26 01:46:49,399 DEBUG : BROWSER_OUTPUT: __metrics 01:46:49 INFO - 2016-01-26 01:46:49,543 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] 01:46:50 INFO - 2016-01-26 01:46:50,261 INFO : Browser initialized. 01:46:50 INFO - 2016-01-26 01:46:50,262 INFO : Running cycle 1/1 for v8_7 test... 01:46:50 INFO - 2016-01-26 01:46:50,262 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCMuqGF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:47:02 INFO - 2016-01-26 01:47:02,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 134578176 01:47:02 INFO - 2016-01-26 01:47:02,008 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56102/tests/v8_7/run.html (next: http://localhost:56102/tests/v8_7/run.html) 01:47:23 INFO - 2016-01-26 01:47:23,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 424923136 01:47:23 INFO - 2016-01-26 01:47:23,590 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: |0;Richards;166.9449081803005 01:47:23 INFO - 2016-01-26 01:47:23,591 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.8697330871244 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |5;Earley;542.8881650380022 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |6;Boyer;10547.368421052632 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |7;RegExp;24609.756097560974 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |8;Splay;514.0953357252691 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:47:23 INFO - 2016-01-26 01:47:23,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801643590__endTimestamp 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: Values: 166.9 01:47:23 INFO - 2016-01-26 01:47:23,593 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,594 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,594 DEBUG : BROWSER_OUTPUT: Values: 167.9 01:47:23 INFO - 2016-01-26 01:47:23,594 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,594 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,595 DEBUG : BROWSER_OUTPUT: Values: 279.4 01:47:23 INFO - 2016-01-26 01:47:23,595 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,595 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,595 DEBUG : BROWSER_OUTPUT: Values: 5170.1 01:47:23 INFO - 2016-01-26 01:47:23,595 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: Values: 941.6 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.89 Median:542.89 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: Values: 542.9 01:47:23 INFO - 2016-01-26 01:47:23,596 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10547.37 Median:10547.37 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: Values: 10547.4 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24609.76 Median:24609.76 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: Values: 24609.8 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,597 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:514.10 Median:514.10 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: Values: 514.1 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: Values: 4835.7 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:47:23 INFO - 2016-01-26 01:47:23,599 DEBUG : BROWSER_OUTPUT: 01:47:24 INFO - 2016-01-26 01:47:24,206 INFO : Browser exited with error code: 0 01:47:24 INFO - 2016-01-26 01:47:24,222 INFO : Completed test v8_7 (00:00:38) 01:47:24 INFO - 2016-01-26 01:47:24,658 INFO : Completed test suite (00:20:06) 01:47:24 INFO - 2016-01-26 01:47:24,658 DEBUG : Working with test: dromaeo_css 01:47:24 INFO - 2016-01-26 01:47:24,659 DEBUG : Generating results file: dromaeo_css 01:47:24 INFO - 2016-01-26 01:47:24,660 DEBUG : Working with test: kraken 01:47:24 INFO - 2016-01-26 01:47:24,660 DEBUG : Generating results file: kraken 01:47:24 INFO - 2016-01-26 01:47:24,660 INFO : javascript benchmark 01:47:24 INFO - 2016-01-26 01:47:24,660 DEBUG : Working with test: v8_7 01:47:24 INFO - 2016-01-26 01:47:24,660 DEBUG : Generating results file: v8_7 01:47:24 INFO - 2016-01-26 01:47:24,661 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:24 INFO - 2016-01-26 01:47:24,721 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 01:47:24 INFO - 2016-01-26 01:47:24,721 DEBUG : process_Request line: dromaeo_css 7281.41 graph.html#tests=[[72,53,35]] 01:47:24 INFO - 2016-01-26 01:47:24,721 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:24 INFO - 2016-01-26 01:47:24,750 DEBUG : process_Request line: kraken 1476.80 graph.html#tests=[[232,53,35]] 01:47:24 INFO - 2016-01-26 01:47:24,751 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:24 INFO - 2016-01-26 01:47:24,778 DEBUG : process_Request line: v8_7 23272.67 graph.html#tests=[[230,53,35]] 01:47:24 INFO - 2016-01-26 01:47:24,779 INFO : javascript benchmark 01:47:24 INFO - 2016-01-26 01:47:24,783 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.2904375559256, 3330.417176994027, 3331.600207975042, 3347.046091863819, 3351.2627222011156, 5536.667799932007, 5556.305461817273, 5560.332760068793, 5566.860828479285, 5598.048331783596, 5565.860853478665, 5583.190437386576, 5584.6090773645865, 5585.162225666152, 5612.045952188128, 4975.776090075937, 5042.697438153723, 5078.13671675816, 5091.618128640348, 5186.273921650972, 4969.180085285923, 5039.874003149914, 5062.291279220912, 5086.593072554206, 5111.284420181178, 5102.872428189306, 5139.511746384088, 5149.948500515003, 5158.045761534109, 5159.406668233164, 5131.153359695683, 5149.84550463483, 5205.349331333565, 5210.03614331348, 5222.112240919015, 4866.172750632401, 4956.355673762388, 4968.801247950078, 5082.415522214956, 5106.591472682177, 5421.620486565942, 5430.3755068167275, 5433.510984011418, 5440.401555828856, 5452.345718513764, 5789.884202315972, 6026.879462410771, 6041.214642096544, 6043.6675982820925, 6044.214252147237, 5979.910301345483, 5990.9101363479585, 6068.362821903725, 6070.271567411939, 6082.391760823926, 5606.159076138611, 5609.831705048855, 5612.803551875665, 5615.101583746581, 5631.436856314377, 5896.115582662635, 6060.818175454655, 6063.696815159225, 6068.180795592627, 6072.848178795565, 5782.421757824268, 5831.271091113611, 5853.765849365977, 5891.675957822275, 5955.880882382415, 6013.819585412444, 6052.485538729257, 6062.727177277033, 6064.666443345658, 6073.331933487313, 5800.129980502874, 5849.268841394825, 6020.518358531307, 6030.487408570233, 6032.487238584682, 5841.386654401312, 5890.352061273256, 5919.615225010447, 5927.0, 5950.553708471882, 4577.450705915311, 4592.816287348469, 4601.907961840744, 4602.0, 4626.560476754703, 4027.979860100739, 4078.7756673382655, 4100.118474527991, 4123.340265557496, 4160.521540022936, 5771.30744310677, 5785.479306862402, 5799.159121927381, 5803.564732645069, 5811.244538210006, 6090.208272924491, 6097.024476083805, 6100.908486372708, 6102.511799056065, 6105.053716673922, 5482.424345443751, 5617.606767526316, 5631.71841407928, 5740.712964351766, 5781.88436231273, 5160.225966105114, 5178.6116041297055, 5184.662996905189, 5187.948120518822, 5188.403333616607, 6057.3639767824625, 6058.757649693963, 6058.818235452944, 6072.666003369857, 6073.058675905153, 5828.854278642898, 5834.38738932406, 5874.823755287348, 5991.820245392645, 6011.248593925759, 6199.380061993945, 6238.126662267377, 6240.251169859464, 6241.21984751906, 6257.624542527463, 5794.565407594363, 6017.759289628541, 6027.969860150672, 6046.97201475759, 6051.364606716232, 5856.853578660568, 5922.851928701644, 5934.554908381975, 5944.5838791284195, 5950.375210602824, 5842.1820945068575, 5873.148393483007, 5877.911831322619, 5881.794137205177, 5891.1457838612305, 5661.2923384576925, 5702.942970570407, 5858.209141765807, 5873.530117590668, 5874.001419758737, 5649.802256920988, 5689.032864413142, 5694.629849059798, 5699.601027928005, 5727.7422515986045, 5854.092615644582, 5865.208196893364, 5880.882382352243, 5905.970470147794, 5910.468057874812, 5583.553315734813, 5583.609147359808, 5677.063284558001, 5757.769689212385, 5762.222100016612], "unit": "ms", "name": "dojo.html", "value": 5513.508866055805}, {"lowerIsBetter": false, "replicates": [592.8843875444287, 638.409471239104, 639.8784230996107, 644.761438267841, 654.0679531667374, 32949.17627059325, 40138.598614013885, 40295.0, 40490.39264411036, 40497.59502404975, 45248.09503809922, 45914.31128533067, 45955.08089838201, 45976.3103553447, 45990.7700461498, 7616.923830761704, 7692.4615276930635, 8968.82062358754, 9149.725508234764, 10347.844782328271, 10653.733656658567, 10749.301295415811, 10750.462476876164, 10786.892131078706, 10800.189985751062, 10695.518701658444, 10712.732181695443, 10749.83875241872, 10790.946045269762, 10807.621733239339, 10704.839427408595, 10753.085987691056, 10808.72978175544, 10817.459127043616, 10824.134069274478, 10515.684529464052, 10544.525496352606, 10573.577056917715, 10660.147188224923, 10660.307080039773, 41963.370549441475, 42362.576374236174, 42378.0, 42455.36316955248, 42469.0, 3471.3057388522398, 3544.167120726627, 4019.678425725935, 4189.455370801777, 4224.619784219435, 31633.20916977094, 31936.0, 32115.678843211503, 32173.356532869213, 32595.18512037194, 4002.2795896738576, 4181.435506206653, 4206.0, 4217.662586993033, 4246.87259382216, 309542.0, 311841.0, 312078.0, 312268.43865780754, 312275.0, 56488.43511564832, 57476.0, 57515.0, 62378.68810656008, 62824.68587657032, 64983.35016649773, 66607.66696166585, 66687.66656166688, 66712.66643666847, 66717.0, 17735.556611084827, 18058.0, 18096.9095154526, 18113.637727245383, 18145.81854181468, 13780.655483612789, 13915.0, 13920.0, 13922.651933701536, 13931.0, 19659.41021769349, 20059.0, 20119.698204526943, 20252.797472025384, 20269.189232430537, 7689.577073260913, 7787.649555770004, 7790.571518566533, 7828.217178282126, 7938.722144724907, 1029.0018681878566, 1096.1340540972542, 1103.933763974164, 1109.778044391125, 1163.9243449175776, 30161.698383016326, 30194.24514387114, 30195.69804301973, 30620.234494137825, 31322.530162047588, 1091.1161958813386, 1094.8303013032992, 1131.8924702153283, 1148.4831825678477, 1177.1348059176498, 13762.311884405739, 13938.442462301395, 14152.504662336769, 15975.041497509954, 16351.100689461955, 355664.0, 360051.0, 360686.0, 361727.0, 362316.0, 57271.14093288604, 57802.42197578055, 57856.421435785946, 57865.421345786, 57996.4200357991, 1323.1730168644597, 1378.8621137886132, 1425.62933637253, 1454.8326942401548, 1459.7883306920437, 26902.192934212006, 27258.863705681346, 27628.447431051667, 27686.446271074063, 27724.86137569299, 41186.588134118276, 41628.58371416247, 41638.791806040776, 41651.583484164774, 41685.37471937984, 204133.0, 205169.0, 205171.0, 205473.0, 205571.0, 32858.0, 32968.34063318768, 33443.66556334405, 34518.65481345155, 35092.64907350996, 41112.0, 41587.58412415837, 41995.7900210497, 42008.369874451295, 42556.574434255264, 34826.0, 34859.65140348564, 35239.647603523634, 35959.1010224736, 36236.63763362333, 35063.47404788981, 35542.822285888404, 36040.27919441649, 36833.44749828701, 38013.23973520459, 37181.6281837189, 37239.44140837944, 37910.62089379181, 37955.43066853944, 37997.620023799405, 31903.680963190072, 33790.49314260337, 34089.48865766966, 34345.48481772726, 34549.13627159341, 25791.613125803502, 26098.217053488424, 26501.204963851116, 26595.867020664773, 26637.866810665822], "unit": "ms", "name": "ext.html", "value": 19588.872717168604}, {"lowerIsBetter": false, "replicates": [378.2812655953688, 378.97726136431817, 381.7156218617131, 387.93211188042085, 399.9000249937516, 14896.851031489681, 15099.396024159048, 16708.415205467812, 18025.54936126596, 18032.729509057357, 13720.108192967475, 14140.292985350743, 14275.072120312198, 16503.09232992185, 17805.7329140063, 5241.764120614582, 5645.435456454353, 5745.942540574603, 5778.942210577903, 5788.305403351604, 5735.512481439083, 5778.6243894146955, 5780.653160810365, 5790.073588225885, 5790.36306006339, 5635.380108188096, 5690.212774413417, 5712.65724056558, 5728.513076388512, 5741.712914354286, 5645.745941432625, 5672.574556908248, 5678.403767604384, 5681.091025435951, 5682.431756824326, 5002.7248501332415, 5112.18205087188, 5115.386153661547, 5157.587393008588, 5158.716270605115, 16423.42518011864, 20132.09405576738, 20736.896315518476, 21885.67171492429, 22025.779742202692, 2251.5159240763314, 2319.8028167605776, 2324.070371851256, 2331.067572970808, 2362.6928499295154, 10193.23550733698, 10698.625548105856, 11847.11146663995, 13471.259080750555, 13747.793783093262, 1827.5065732252217, 1833.9913047823643, 1913.1677720191622, 1952.531392465798, 1955.4720225539024, 48864.75567622139, 49801.0, 58360.4163958355, 66121.338786612, 69109.65445172793, 9889.109980101824, 10658.946705266424, 10753.946230268799, 10800.351978881292, 10807.513661885234, 14229.28853557318, 14276.42894284217, 14351.282435878373, 14357.138571685733, 14366.353514091681, 8124.512529248264, 8148.144444833326, 8324.084350721416, 8332.958335208285, 8412.663493460315, 8080.111187769341, 8136.1863813618165, 8165.1426600207315, 8207.097219305871, 8218.958905205436, 4882.26765985098, 4920.286558449076, 4926.630502712311, 4927.802887884516, 4950.158473059589, 1911.9044047797554, 1927.6433859735714, 1960.451073699338, 1964.960700786005, 1975.6292449061184, 937.1331518345503, 954.5036580977992, 992.3153024413132, 1061.2677252695614, 1065.3767545985531, 17262.395816146374, 17300.567485812957, 17494.912525437547, 17542.91228543849, 18191.272349105886, 904.615538396179, 993.3146129170849, 997.7976538271365, 1001.6644424117857, 1050.1388861133796, 9513.14381705636, 9680.806383872425, 9755.658551950648, 9757.365771224848, 9912.959139290271, 452699.0, 455221.0, 456251.0, 472798.0, 688872.0, 83643.16356836475, 87640.5617971906, 88255.55872220726, 89232.0, 89308.5534572323, 1139.2139423797553, 1167.0721776187781, 1168.2464810197375, 1186.104491109207, 1202.1284568687631, 15521.767173492632, 15845.762313565076, 16174.838251617804, 16488.83511164873, 16582.75125873137, 33940.321193575495, 34115.48826767551, 34137.0, 34781.826090869385, 35362.823185883906, 46568.30147547857, 46674.76662616801, 47487.287690683974, 47993.28010079782, 48875.51124488852, 10330.586776528855, 10545.261831671709, 10632.202584806326, 10724.51739671701, 10892.509837057192, 11583.76832463329, 12224.633261002184, 12370.44333004999, 12385.876141238832, 12499.500019999097, 10466.37201767866, 11079.113670906469, 11181.888181118085, 11293.604723834625, 11294.209405341548, 10839.078678312431, 10867.836982445428, 10926.0, 10956.616518421817, 11185.608503702331, 11201.159913006393, 11216.83174752363, 11298.943505282421, 11537.192396532162, 11550.306981581132, 12571.308578028296, 13393.531226407029, 15364.77081833473, 15453.5363939082, 15467.922660386626, 16757.491825735742, 16824.07467589294, 16901.154942252593, 17147.914260428617, 17381.652366952338], "unit": "ms", "name": "jquery.html", "value": 9094.887421884887}, {"lowerIsBetter": false, "replicates": [1442.9855701442987, 1520.6426489774901, 1635.6565121324522, 1690.41680620186, 1865.3098353609166, 8056.194380561941, 8224.83550328993, 8225.50646961182, 8228.218319259668, 8233.752987410388, 7235.204127545966, 7353.0441042664515, 7358.926410735891, 7770.4560680752365, 8063.6371363288645, 2284.9885750571225, 2295.1737374545232, 2309.572729045132, 2321.1527792355755, 2321.3964369264027, 2355.0697474497565, 2377.3937645900273, 2400.7959323457526, 2402.567537843196, 2406.03758496601, 2011.6077364913774, 2052.0970772859896, 2246.0903334149616, 2285.645724912641, 2287.1194590082773, 2227.7772222777676, 2251.5159240763314, 2285.4400671835506, 2290.6105961986505, 2291.415688999303, 2321.292005938188, 2325.8720770357622, 2341.7189937207645, 2346.1084787780705, 2346.5424242272766, 8047.0, 8127.065387480457, 8127.106018337978, 8131.06492753335, 8142.715004974857, 4787.13831510328, 4833.371661683994, 4877.219644856841, 4898.142825005645, 4899.044686286175, 3042.6957304269395, 3057.159281197666, 3070.1710538154575, 3079.6612372638992, 3178.9682103179134, 1011.9342242754198, 1014.2089170447063, 1047.5862034496408, 1060.1042119409087, 1063.1972860490357, 10868.782624347548, 11043.779124417548, 11048.281861678965, 11049.779004419866, 11066.557337706483, 4220.683448741357, 4255.702100852973, 4346.500152482505, 4369.934450983238, 4373.562643735665, 9110.49892255919, 9115.589798459085, 9155.862662060075, 9158.129977652112, 9161.267098632094, 4902.852914412573, 4920.803167873245, 4926.729029903389, 4928.581070608967, 4939.629527785359, 4473.4408198975125, 4493.932591011137, 4531.0, 4545.909081818411, 4546.340780586796, 3662.230931504414, 3667.578228503703, 3683.834227459771, 3698.6116457771545, 3728.3102626014274, 1081.4592703648175, 1097.983530247047, 1104.2160066352978, 1141.537677240719, 1143.5768765556797, 998.0717932323009, 1193.3555879824971, 1233.9819648789605, 1366.4261010375667, 1449.4564538298139, 7503.287187717158, 7629.8855517167285, 7669.0, 7671.232876712284, 7675.884861727079, 598.60791181776, 617.5368473644767, 661.9106420633249, 663.1445435388391, 754.4153281207108, 6058.939410605925, 6074.605150665193, 6189.473894718909, 6197.659128747962, 6198.690065496798, 9200.953995230115, 9334.066593340747, 9447.433154010781, 9483.383580067273, 9488.905110948803, 9389.38968967015, 9638.325317227867, 9653.90346096544, 9670.661526846527, 9676.516174191262, 7412.777616671508, 7505.549667019996, 7512.624368781649, 7560.395168386516, 7572.356349710226, 7823.452358335089, 7866.9213307866185, 7880.408969327438, 7884.132745398117, 7886.645100970585, 8653.437526560754, 8700.173483519056, 8818.955905220433, 8856.202941735275, 8894.021657617528, 8657.437266577652, 9009.279257659502, 9016.053314401894, 9136.588853501475, 9183.357164998386, 7142.142942846892, 7159.57042577447, 7346.045014148341, 7352.191258961403, 7358.22738612438, 7804.84390312202, 7854.607269636381, 7855.489393189653, 7861.1745766693675, 7874.763757087297, 6449.129367535323, 7398.371138453292, 7556.773296801105, 7621.1997740236475, 7658.502197357154, 6740.831479213059, 7018.508704390848, 7399.704011839466, 7470.589117598584, 7492.62536873165, 7356.485046046725, 7384.667689953858, 7400.111986561647, 7422.925770742439, 7442.330190282901, 6867.450603951772, 6899.103116594811, 6909.136357955255, 6912.101426814482, 6913.688884000333, 6901.206361268519, 6928.307169283032, 6947.027416161843, 6961.79114626562, 6974.68613912365], "unit": "ms", "name": "mootools.html", "value": 4568.271471368049}, {"lowerIsBetter": false, "replicates": [356.2021072796935, 361.40909612783094, 364.22238520758174, 364.3841907176871, 367.5222211125538, 6143.04782758672, 6150.723217455214, 6221.160143380654, 6237.53218508612, 6245.718942647581, 5888.735006924688, 5911.586188966774, 6029.547783916202, 6139.478144357724, 6148.446639802417, 4743.1225223333795, 4763.404574428197, 4766.976165119169, 4783.784729687155, 4790.880227994302, 4570.13167498176, 4777.880552986168, 4783.306420569015, 4786.401699787527, 4795.952040479586, 4602.286645569925, 4611.077784443108, 4656.627469802408, 4665.440147182343, 4725.645576581753, 4694.906101877978, 4715.1748444022505, 4717.575418212343, 4719.126961512114, 4722.76386180693, 4178.603032711888, 4178.895527611804, 4185.372194170868, 4189.308764053927, 4190.413342132104, 5639.8590035249445, 5806.680632565207, 5832.650040997553, 5836.416358364172, 5837.211976383219, 5532.5020748132865, 5540.695261760601, 5540.722963851791, 5548.55611551075, 5551.361593416768, 6410.519211059142, 6430.61416315018, 6431.163948686641, 6436.93563064368, 6471.6764161791725, 4667.533246675339, 4670.486246512881, 4674.602658774008, 4678.625709943196, 4682.765861706901, 6513.1532900722605, 6658.733650653968, 6668.599884006975, 6672.899906501358, 6674.466042716571, 4763.404574428197, 4798.304245884327, 4799.784009719571, 4800.615950723934, 4801.351817504592, 4870.4155501339355, 4870.659053866196, 4871.853844384674, 4872.756362181876, 4875.512448755097, 5409.377921538995, 5513.2005859151, 5522.972385138129, 5528.502434780889, 5535.806246781343, 6520.18497687789, 6537.411632952962, 6537.5096867734155, 6540.738370465128, 6544.869102617921, 1702.0553592755891, 1722.276643809603, 1729.8702597305, 1730.3078768492453, 1731.9826801732074, 1151.694800877768, 1175.9412029398668, 1188.3761025461702, 1199.154596009811, 1209.909256805743, 6344.49244060474, 6391.840203994937, 6392.169018027626, 6396.648184349812, 6396.9360306397275, 6538.215414150332, 6754.358335958076, 6758.155230596176, 6764.627945462948, 6765.42493888025, 6262.342454042351, 6344.809655710336, 6431.356864313531, 6448.484121270287, 6451.709673064724, 3637.890863274106, 3680.5031320771886, 3686.64976827201, 3691.557013158438, 3692.058525076142, 6919.965400172967, 6986.580805151605, 7046.401055910203, 7050.083489146378, 7058.400035996998, 7016.158061032606, 7018.1929078155645, 7021.754238601727, 7024.894626580605, 7025.227225005246, 7060.682269297894, 7067.293270672892, 7068.929310706827, 7071.328223818729, 7080.2919708028785, 6610.9669451652435, 6786.796396108125, 6808.285130061272, 6840.555363901331, 6844.110265665432, 6713.63075030878, 6725.596464212163, 6736.865262694817, 6738.46092312604, 6746.561473504206, 7058.082449281561, 7074.929250707427, 7077.398421134056, 7082.079329687108, 7083.82290442743, 4600.493945666041, 4701.106789709944, 4744.905101898012, 4745.311929770095, 4749.4063242094735, 6717.429018533479, 6761.594304341558, 6764.425023872829, 6767.864642707217, 6768.830779230559, 6571.277159512545, 6584.275729669828, 6589.0, 6589.439897608757, 6590.934090659032, 6414.550981431255, 6552.049952756728, 6559.7376104955265, 6563.343665633399, 6568.441682456853, 6431.196100487439, 6452.741890324334, 6465.3857883501, 6466.321036291121, 6467.579607325509, 6581.835454113685, 6595.505337099833, 6598.868022639424, 6603.273639899703, 6604.933950660624, 6255.78104766331, 6341.175647165839, 6417.935820641734, 6425.06836508713, 6438.227412710505], "unit": "ms", "name": "prototype.html", "value": 4984.742297946203}, {"lowerIsBetter": false, "replicates": [791.6279348706108, 824.0893812337363, 835.8411901738665, 850.022474154722, 850.6257246811402, 15513.534593962186, 15849.603759906007, 15866.365345386184, 15872.52382428529, 15876.52370428886, 15406.07563546188, 15445.691086178269, 15458.07251564907, 15503.457378991738, 15584.68830623387, 767.9808004799896, 778.2256654628652, 912.37958188432, 927.0729270729271, 939.7133874168376, 926.7219834049791, 931.2177770672633, 935.2190920581323, 939.2673714502699, 940.3558562384754, 969.0358093696782, 972.7130496503548, 972.7568107973007, 974.7075877236836, 978.9363691360074, 815.1237419773737, 817.3175398542224, 952.7570469530294, 965.6620182935916, 972.5186032913682, 716.2407847681475, 718.335539625844, 719.8092505486051, 720.1178556268582, 720.1286443403488, 14884.776728349083, 15124.243787810565, 15220.238988050553, 15249.237538123049, 15259.542213733606, 12381.938090309492, 12396.380180990915, 12425.130240883142, 12607.180533265308, 13089.34553272342, 9884.752881178028, 11299.661010169708, 11475.713107172303, 11610.18728688992, 11723.4138293085, 3810.5427348718054, 3853.5183102112237, 3873.9225215495812, 3883.359245724452, 3975.2248311579256, 50639.99999999963, 50905.0, 51559.48440515585, 51650.483495164946, 51769.74115129438, 9920.801583968425, 10054.64808731691, 10128.59485620567, 10210.744731381626, 10625.5218515167, 19326.226950922086, 19472.90263548673, 19477.80522194788, 19478.707819382722, 19480.415587532396, 7986.960065199637, 8132.390070744599, 8257.8348433031, 8419.452735572168, 8527.573621318908, 4322.37325587788, 4395.472543294825, 4539.954600454019, 4601.217792975202, 4636.258198688193, 3157.0, 3181.0, 3182.6976437238427, 3187.059817353886, 3188.7927284726884, 565.3131445293988, 575.8128608202351, 576.7692922830901, 577.8208755285875, 594.7234535940809, 679.4530403025514, 693.6531734132933, 707.9185893622197, 709.6522703875064, 720.1106633307861, 7973.561454120079, 8539.74380768578, 8558.229759321566, 8602.397832151815, 8830.0, 514.3570536828964, 651.9934800651932, 700.5691499727631, 703.1772825793731, 723.8154270661053, 3738.831752571141, 4164.43780089684, 4176.331786914079, 4193.517745459311, 4277.871663850089, 60306.39693603096, 60858.08712869311, 61451.692741536004, 62259.0, 62269.688651556455, 54616.180757288676, 55367.446325537036, 55808.441915581134, 55821.44178558162, 57103.71448142733, 50026.0, 50167.49832501701, 50773.74613126984, 51453.228201577, 51946.22080668793, 8271.255586996958, 8422.410431269753, 8430.15698430152, 8572.78568035779, 8636.78408039804, 35520.28959420849, 35787.28425431529, 36121.63878361288, 36452.45321320129, 36716.26567468689, 43936.12127757491, 45852.31221531746, 49307.0, 49322.26016609682, 50393.244101337776, 10937.179711521509, 11009.889901100887, 11653.76692466129, 11749.765004699688, 12379.442925068213, 12051.879481205426, 12108.757824843278, 12208.511659533875, 12569.371531423576, 12850.485980560672, 10443.634472793416, 10614.946925265323, 10996.670099897015, 11461.942690286829, 12064.819027714766, 10667.94666026696, 10728.034476897117, 10787.0, 10962.177836662122, 11139.33164010162, 10321.690349289533, 10366.792664146826, 10430.791384172426, 10491.527881245514, 11082.05802506796, 9649.43766451312, 9757.268204884804, 10277.794444111225, 10690.893091069302, 10704.839427408438, 9580.13778759915, 9703.272254580794, 9714.125728684452, 9807.313488055768, 9824.950875245579], "unit": "ms", "name": "yui.html", "value": 6662.344057597116}], "name": "dromaeo_css", "value": 7281.415031198769}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 102.0, 107.0, 109.0, 109.0, 100.0, 108.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 144.0, 156.0, 123.0, 152.0, 152.0, 123.0, 158.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.6}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 161.0, 160.0, 166.0, 161.0, 160.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 73.0, 149.0, 71.0, 73.0, 73.0, 72.0, 153.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [91.0, 99.0, 140.0, 92.0, 92.0, 94.0, 136.0, 91.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 108.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 57.0, 54.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 80.0, 87.0, 81.0, 80.0, 81.0, 80.0, 81.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 121.0, 111.0, 120.0, 114.0, 117.0, 110.0, 113.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 144.0, 132.0, 150.0, 134.0, 149.0, 147.0, 147.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 70.0, 65.0, 64.0, 62.0, 64.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1476.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "Richards", "value": 211.45897999999997}, {"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "DeltaBlue", "value": 393.86492599999997}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [542.8881650380022], "unit": "score", "name": "Earley", "value": 1227.624846}, {"lowerIsBetter": false, "replicates": [10547.368421052632], "unit": "score", "name": "Boyer", "value": 63.187609780439146}, {"lowerIsBetter": false, "replicates": [24609.756097560974], "unit": "score", "name": "RegExp", "value": 37.01722993062436}, {"lowerIsBetter": false, "replicates": [514.0953357252691], "unit": "score", "name": "Splay", "value": 158.5134007976071}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23272.672205284412}]} 01:47:24 INFO - RETURN: dromaeo_css: 7281.41 01:47:24 INFO - RETURN: kraken: 1476.80 01:47:24 INFO - RETURN: v8_7: 23272.67 01:47:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23272.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1476.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7281.41"}}} 01:47:24 INFO - Return code: 0 01:47:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:47:24 INFO - # TBPL SUCCESS # 01:47:24 INFO - Running post-action listener: _resource_record_post_action 01:47:24 INFO - Running post-run listener: _resource_record_post_run 01:47:25 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 511868928; Read time: 0; Write time: 468888 01:47:25 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 250118144; Read time: 0; Write time: 295120 01:47:25 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 261386240; Read time: 0; Write time: 173732 01:47:25 INFO - Running post-run listener: _upload_blobber_files 01:47:25 INFO - Blob upload gear active. 01:47:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:47:25 INFO - Copying logs to upload dir... 01:47:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.859936 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-01-26 01:47:25.679827) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:25.682912) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010022 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:25.733377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:25.733716) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453800391.442122-1233679132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:25.783687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 01:47:25.783993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 01:47:25.784287) ========= ========= Total master_lag: 0.27 =========