builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1454869814.5 results: success (0) buildid: 20160207080418 builduid: b7f155cc1d11482eb75bd9b1b87faa8e revision: ffb9c10f484b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.499018) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.499629) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.499910) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005771 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.547887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.548165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.572660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.572998) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.621834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.622102) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.622432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.622764) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-07 10:30:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.5M=0s 2016-02-07 10:30:14 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.207102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.842644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.842980) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.114983 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.966912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:14.967284) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ffb9c10f484b --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 ffb9c10f484b --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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-07 10:30:15,047 Setting DEBUG logging. 2016-02-07 10:30:15,047 attempt 1/10 2016-02-07 10:30:15,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ffb9c10f484b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-07 10:30:15,388 unpacking tar archive at: mozilla-beta-ffb9c10f484b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:15.607363) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:15.607673) ========= echo ffb9c10f484b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ffb9c10f484b'] 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ffb9c10f484b program finished with exit code 0 elapsedTime=0.003966 script_repo_revision: 'ffb9c10f484b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:15.657672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:15.657965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-07 10:30:15.667694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-07 10:30:15.667966) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:30:15 INFO - MultiFileLogger online at 20160207 10:30:15 in /builds/slave/test-pgo 10:30:15 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 10:30:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:30:15 INFO - {'append_to_log': False, 10:30:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:30:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:30:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:30:15 INFO - 'branch': 'Mozilla-Beta', 10:30:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:15 INFO - 'config_files': ('talos/linux_config.py',), 10:30:15 INFO - 'default_actions': ('clobber', 10:30:15 INFO - 'read-buildbot-config', 10:30:15 INFO - 'download-and-extract', 10:30:15 INFO - 'populate-webroot', 10:30:15 INFO - 'create-virtualenv', 10:30:15 INFO - 'install', 10:30:15 INFO - 'run-tests'), 10:30:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:15 INFO - 'download_minidump_stackwalk': True, 10:30:15 INFO - 'download_symbols': 'ondemand', 10:30:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:15 INFO - 'installer_path': 'installer.exe', 10:30:15 INFO - 'log_level': 'info', 10:30:15 INFO - 'log_name': 'talos', 10:30:15 INFO - 'log_to_console': True, 10:30:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:30:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:30:15 INFO - 'opt_config_files': (), 10:30:15 INFO - 'pip_index': False, 10:30:15 INFO - 'sps_profile': False, 10:30:15 INFO - 'sps_profile_interval': 0, 10:30:15 INFO - 'suite': 'dromaeojs', 10:30:15 INFO - 'system_bits': '32', 10:30:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:15 INFO - 'title': 'talos-linux64-ix-068', 10:30:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:15 INFO - 'use_talos_json': True, 10:30:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:30:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:15 INFO - 'work_dir': 'build'} 10:30:15 INFO - ##### 10:30:15 INFO - ##### Running clobber step. 10:30:15 INFO - ##### 10:30:15 INFO - Running pre-action listener: _resource_record_pre_action 10:30:15 INFO - Running main action method: clobber 10:30:15 INFO - rmtree: /builds/slave/test-pgo/build 10:30:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:30:21 INFO - Running post-action listener: _resource_record_post_action 10:30:21 INFO - ##### 10:30:21 INFO - ##### Running read-buildbot-config step. 10:30:21 INFO - ##### 10:30:21 INFO - Running pre-action listener: _resource_record_pre_action 10:30:21 INFO - Running main action method: read_buildbot_config 10:30:21 INFO - Using buildbot properties: 10:30:21 INFO - { 10:30:21 INFO - "properties": { 10:30:21 INFO - "buildnumber": 70, 10:30:21 INFO - "product": "firefox", 10:30:21 INFO - "script_repo_revision": "production", 10:30:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:30:21 INFO - "repository": "", 10:30:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:30:21 INFO - "buildid": "20160207080418", 10:30:21 INFO - "slavename": "talos-linux64-ix-068", 10:30:21 INFO - "pgo_build": "True", 10:30:21 INFO - "basedir": "/builds/slave/test-pgo", 10:30:21 INFO - "project": "", 10:30:21 INFO - "platform": "ubuntu64_hw", 10:30:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:30:21 INFO - "slavebuilddir": "test", 10:30:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:30:21 INFO - "branch": "mozilla-beta", 10:30:21 INFO - "repo_path": "releases/mozilla-beta", 10:30:21 INFO - "stage_platform": "linux64-pgo", 10:30:21 INFO - "builduid": "b7f155cc1d11482eb75bd9b1b87faa8e", 10:30:21 INFO - "revision": "ffb9c10f484b" 10:30:21 INFO - }, 10:30:21 INFO - "sourcestamp": { 10:30:21 INFO - "repository": "", 10:30:21 INFO - "hasPatch": false, 10:30:21 INFO - "project": "", 10:30:21 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:30:21 INFO - "changes": [ 10:30:21 INFO - { 10:30:21 INFO - "category": null, 10:30:21 INFO - "files": [ 10:30:21 INFO - { 10:30:21 INFO - "url": null, 10:30:21 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:30:21 INFO - } 10:30:21 INFO - ], 10:30:21 INFO - "repository": "", 10:30:21 INFO - "rev": "ffb9c10f484b", 10:30:21 INFO - "who": "sendchange", 10:30:21 INFO - "when": 1454869735, 10:30:21 INFO - "number": 7576317, 10:30:21 INFO - "comments": "Bug 1245033 - Build break in dom/system/gonk/GonkGPSGeolocationProvider.cpp:541:126: error: format __d_ expects argument of type _int_, but argument 5 has type _nsresult_. r=fabrice, a=sylvestre", 10:30:21 INFO - "project": "", 10:30:21 INFO - "at": "Sun 07 Feb 2016 10:28:55", 10:30:21 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:30:21 INFO - "revlink": "", 10:30:21 INFO - "properties": [ 10:30:21 INFO - [ 10:30:21 INFO - "buildid", 10:30:21 INFO - "20160207080418", 10:30:21 INFO - "Change" 10:30:21 INFO - ], 10:30:21 INFO - [ 10:30:21 INFO - "builduid", 10:30:21 INFO - "b7f155cc1d11482eb75bd9b1b87faa8e", 10:30:21 INFO - "Change" 10:30:21 INFO - ], 10:30:21 INFO - [ 10:30:21 INFO - "pgo_build", 10:30:21 INFO - "True", 10:30:21 INFO - "Change" 10:30:21 INFO - ] 10:30:21 INFO - ], 10:30:21 INFO - "revision": "ffb9c10f484b" 10:30:21 INFO - } 10:30:21 INFO - ], 10:30:21 INFO - "revision": "ffb9c10f484b" 10:30:21 INFO - } 10:30:21 INFO - } 10:30:21 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:30:21 INFO - Running post-action listener: _resource_record_post_action 10:30:21 INFO - ##### 10:30:21 INFO - ##### Running download-and-extract step. 10:30:21 INFO - ##### 10:30:21 INFO - Running pre-action listener: _resource_record_pre_action 10:30:21 INFO - Running main action method: download_and_extract 10:30:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/test_packages.json 10:30:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:30:21 INFO - Downloaded 1270 bytes. 10:30:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:30:21 INFO - Using the following test package requirements: 10:30:21 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:30:21 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:30:21 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'jsshell-linux-x86_64.zip'], 10:30:21 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:30:21 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:30:21 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:30:21 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:30:21 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:30:21 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:30:21 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:30:21 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:30:21 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:30:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:21 INFO - Downloaded 21580255 bytes. 10:30:21 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 10:30:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:30:21 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 10:30:23 INFO - Return code: 0 10:30:23 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 10:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:30:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:23 INFO - Downloaded 21580255 bytes. 10:30:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:30:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:30:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:30:25 INFO - Return code: 0 10:30:25 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')]} 10:30:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:30:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:26 INFO - Downloaded 11132038 bytes. 10:30:26 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 10:30:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:30:26 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 10:30:26 INFO - Return code: 0 10:30:26 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')]} 10:30:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:30:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/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 10:30:27 INFO - Downloaded 57947641 bytes. 10:30:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:30:27 INFO - mkdir: /builds/slave/test-pgo/properties 10:30:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:30:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:30:27 INFO - Contents: 10:30:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:30:27 INFO - Running post-action listener: _resource_record_post_action 10:30:27 INFO - Running post-action listener: set_extra_try_arguments 10:30:27 INFO - ##### 10:30:27 INFO - ##### Running populate-webroot step. 10:30:27 INFO - ##### 10:30:27 INFO - Running pre-action listener: _resource_record_pre_action 10:30:27 INFO - Running main action method: populate_webroot 10:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:30:27 INFO - '--tppagecycles', 10:30:27 INFO - '7'], 10:30:27 INFO - 'tests': ['tsvgm']}}, 10:30:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:30:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:30:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:30:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:30:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'tests': ['damp', 'tps']}, 10:30:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['damp', 'tps']}, 10:30:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:30:27 INFO - 'other': {'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'other_l64': {'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'other_nol64': {'tests': ['a11yr', 10:30:27 INFO - 'ts_paint', 10:30:27 INFO - 'tpaint', 10:30:27 INFO - 'sessionrestore', 10:30:27 INFO - 'sessionrestore_no_auto_restore']}, 10:30:27 INFO - 'svgr': {'tests': ['tsvgx', 10:30:27 INFO - 'tsvgr_opacity', 10:30:27 INFO - 'tart', 10:30:27 INFO - 'tscrollx', 10:30:27 INFO - 'cart']}, 10:30:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['tsvgx', 10:30:27 INFO - 'tsvgr_opacity', 10:30:27 INFO - 'tart', 10:30:27 INFO - 'tscrollx', 10:30:27 INFO - 'cart']}, 10:30:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'tests': ['tp5o']}, 10:30:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'talos_options': ['--e10s'], 10:30:27 INFO - 'tests': ['tp5o']}, 10:30:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'talos_options': ['--xperf_path', 10:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:27 INFO - 'tests': ['tp5n']}, 10:30:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:27 INFO - 'talos_options': ['--e10s', 10:30:27 INFO - '--xperf_path', 10:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:27 INFO - 'tests': ['tp5n']}}, 10:30:27 INFO - 'talos.zip': {'path': '', 10:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:30:27 INFO - Running post-action listener: _resource_record_post_action 10:30:27 INFO - ##### 10:30:27 INFO - ##### Running create-virtualenv step. 10:30:27 INFO - ##### 10:30:27 INFO - Running pre-action listener: _resource_record_pre_action 10:30:27 INFO - Running main action method: create_virtualenv 10:30:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:30:27 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 10:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:30:27 INFO - Using real prefix '/usr' 10:30:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:30:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:30:30 INFO - Installing pip.................done. 10:30:30 INFO - Return code: 0 10:30:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:30:30 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')]} 10:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:30 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')]} 10:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:30 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:30 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 10:30:30 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 10:30:30 INFO - Using env: {'DISPLAY': ':0', 10:30:30 INFO - 'HOME': '/home/cltbld', 10:30:30 INFO - 'LANG': 'en_US.UTF-8', 10:30:30 INFO - 'LANGUAGE': 'en_US:en', 10:30:30 INFO - 'LOGNAME': 'cltbld', 10:30:30 INFO - 'MAIL': '/var/mail/cltbld', 10:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:30 INFO - 'MOZ_NO_REMOTE': '1', 10:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:30 INFO - 'NO_EM_RESTART': '1', 10:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:30 INFO - 'SHELL': '/bin/bash', 10:30:30 INFO - 'SHLVL': '1', 10:30:30 INFO - 'TERM': 'linux', 10:30:30 INFO - 'TMOUT': '86400', 10:30:30 INFO - 'USER': 'cltbld', 10:30:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:30 INFO - '_': '/tools/buildbot/bin/python'} 10:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:30 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 10:30:30 INFO - Cleaning up... 10:30:30 INFO - Return code: 0 10:30:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:30:30 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')]} 10:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:30 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')]} 10:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:30 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:30 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 10:30:30 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 10:30:30 INFO - Using env: {'DISPLAY': ':0', 10:30:30 INFO - 'HOME': '/home/cltbld', 10:30:30 INFO - 'LANG': 'en_US.UTF-8', 10:30:30 INFO - 'LANGUAGE': 'en_US:en', 10:30:30 INFO - 'LOGNAME': 'cltbld', 10:30:30 INFO - 'MAIL': '/var/mail/cltbld', 10:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:30 INFO - 'MOZ_NO_REMOTE': '1', 10:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:30 INFO - 'NO_EM_RESTART': '1', 10:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:30 INFO - 'SHELL': '/bin/bash', 10:30:30 INFO - 'SHLVL': '1', 10:30:30 INFO - 'TERM': 'linux', 10:30:30 INFO - 'TMOUT': '86400', 10:30:30 INFO - 'USER': 'cltbld', 10:30:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:30 INFO - '_': '/tools/buildbot/bin/python'} 10:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:31 INFO - Downloading/unpacking psutil>=0.7.1 10:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:30:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:33 INFO - Installing collected packages: psutil 10:30:33 INFO - Running setup.py install for psutil 10:30:33 INFO - building 'psutil._psutil_linux' extension 10:30:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:30:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:30:34 INFO - building 'psutil._psutil_posix' extension 10:30:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:30:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:34 INFO - Successfully installed psutil 10:30:34 INFO - Cleaning up... 10:30:34 INFO - Return code: 0 10:30:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:30:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:30:34 INFO - Using env: {'DISPLAY': ':0', 10:30:34 INFO - 'HOME': '/home/cltbld', 10:30:34 INFO - 'LANG': 'en_US.UTF-8', 10:30:34 INFO - 'LANGUAGE': 'en_US:en', 10:30:34 INFO - 'LOGNAME': 'cltbld', 10:30:34 INFO - 'MAIL': '/var/mail/cltbld', 10:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:34 INFO - 'MOZ_NO_REMOTE': '1', 10:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:34 INFO - 'NO_EM_RESTART': '1', 10:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:34 INFO - 'SHELL': '/bin/bash', 10:30:34 INFO - 'SHLVL': '1', 10:30:34 INFO - 'TERM': 'linux', 10:30:34 INFO - 'TMOUT': '86400', 10:30:34 INFO - 'USER': 'cltbld', 10:30:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:34 INFO - '_': '/tools/buildbot/bin/python'} 10:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:30:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:30:36 INFO - Installing collected packages: mozsystemmonitor 10:30:36 INFO - Running setup.py install for mozsystemmonitor 10:30:36 INFO - Successfully installed mozsystemmonitor 10:30:36 INFO - Cleaning up... 10:30:37 INFO - Return code: 0 10:30:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:30: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')]} 10:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30: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')]} 10:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:37 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:37 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 10:30:37 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 10:30:37 INFO - Using env: {'DISPLAY': ':0', 10:30:37 INFO - 'HOME': '/home/cltbld', 10:30:37 INFO - 'LANG': 'en_US.UTF-8', 10:30:37 INFO - 'LANGUAGE': 'en_US:en', 10:30:37 INFO - 'LOGNAME': 'cltbld', 10:30:37 INFO - 'MAIL': '/var/mail/cltbld', 10:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:37 INFO - 'MOZ_NO_REMOTE': '1', 10:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:37 INFO - 'NO_EM_RESTART': '1', 10:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:37 INFO - 'SHELL': '/bin/bash', 10:30:37 INFO - 'SHLVL': '1', 10:30:37 INFO - 'TERM': 'linux', 10:30:37 INFO - 'TMOUT': '86400', 10:30:37 INFO - 'USER': 'cltbld', 10:30:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:37 INFO - '_': '/tools/buildbot/bin/python'} 10:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:30:37 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 10:30:37 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 10:30:37 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 10:30:37 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 10:30:37 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 10:30:37 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 10:30:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:30:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:30:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:30:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:30:40 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 10:30:40 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 10:30:40 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 10:30:40 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 10:30:40 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 10:30:40 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 10:30:40 INFO - Downloading docopt-0.6.1.tar.gz 10:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:30:40 INFO - Running setup.py install for blobuploader 10:30:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:30:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:30:40 INFO - Running setup.py install for requests 10:30:40 INFO - Running setup.py install for docopt 10:30:40 INFO - Successfully installed blobuploader requests docopt 10:30:40 INFO - Cleaning up... 10:30:40 INFO - Return code: 0 10:30:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:40 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:40 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 10:30:40 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 10:30:40 INFO - Using env: {'DISPLAY': ':0', 10:30:40 INFO - 'HOME': '/home/cltbld', 10:30:40 INFO - 'LANG': 'en_US.UTF-8', 10:30:40 INFO - 'LANGUAGE': 'en_US:en', 10:30:40 INFO - 'LOGNAME': 'cltbld', 10:30:40 INFO - 'MAIL': '/var/mail/cltbld', 10:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:40 INFO - 'MOZ_NO_REMOTE': '1', 10:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:40 INFO - 'NO_EM_RESTART': '1', 10:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:40 INFO - 'SHELL': '/bin/bash', 10:30:40 INFO - 'SHLVL': '1', 10:30:40 INFO - 'TERM': 'linux', 10:30:40 INFO - 'TMOUT': '86400', 10:30:40 INFO - 'USER': 'cltbld', 10:30:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:40 INFO - '_': '/tools/buildbot/bin/python'} 10:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:30:41 INFO - Running setup.py (path:/tmp/pip-QF6Tbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:30:41 INFO - Running setup.py (path:/tmp/pip-9b25nV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:30:41 INFO - Running setup.py (path:/tmp/pip-qLjZLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:30:41 INFO - Running setup.py (path:/tmp/pip-PH0Fl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:30:41 INFO - Running setup.py (path:/tmp/pip-doMHef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:30:41 INFO - Running setup.py (path:/tmp/pip-4D4jkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:30:41 INFO - Running setup.py (path:/tmp/pip-x7aQXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:30:41 INFO - Running setup.py (path:/tmp/pip-DUGD9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:30:41 INFO - Running setup.py (path:/tmp/pip-YnBH3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:30:41 INFO - Running setup.py (path:/tmp/pip-OfM0An-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:30:41 INFO - Running setup.py (path:/tmp/pip-qzQK_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:30:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:30:41 INFO - Running setup.py (path:/tmp/pip-5S6JUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:30:42 INFO - Running setup.py (path:/tmp/pip-cP506z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:30:42 INFO - Running setup.py (path:/tmp/pip-JyzJSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:30:42 INFO - Running setup.py (path:/tmp/pip-ajA2PZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:30:42 INFO - Running setup.py (path:/tmp/pip-nxc_pa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:30:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:30:42 INFO - Running setup.py (path:/tmp/pip-tyQun9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:30:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:30:42 INFO - Running setup.py install for manifestparser 10:30:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:30:42 INFO - Running setup.py install for mozcrash 10:30:42 INFO - Running setup.py install for mozdebug 10:30:42 INFO - Running setup.py install for mozdevice 10:30:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:30:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:30:42 INFO - Running setup.py install for mozfile 10:30:42 INFO - Running setup.py install for mozhttpd 10:30:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozinfo 10:30:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozInstall 10:30:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozleak 10:30:43 INFO - Running setup.py install for mozlog 10:30:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for moznetwork 10:30:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozprocess 10:30:43 INFO - Running setup.py install for mozprofile 10:30:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozrunner 10:30:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:30:43 INFO - Running setup.py install for mozscreenshot 10:30:43 INFO - Running setup.py install for moztest 10:30:44 INFO - Running setup.py install for mozversion 10:30:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:30:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:30:44 INFO - Cleaning up... 10:30:44 INFO - Return code: 0 10:30:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:30:44 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')]} 10:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:44 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')]} 10:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:44 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:44 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 10:30:44 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 10:30:44 INFO - Using env: {'DISPLAY': ':0', 10:30:44 INFO - 'HOME': '/home/cltbld', 10:30:44 INFO - 'LANG': 'en_US.UTF-8', 10:30:44 INFO - 'LANGUAGE': 'en_US:en', 10:30:44 INFO - 'LOGNAME': 'cltbld', 10:30:44 INFO - 'MAIL': '/var/mail/cltbld', 10:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:44 INFO - 'MOZ_NO_REMOTE': '1', 10:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:44 INFO - 'NO_EM_RESTART': '1', 10:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:44 INFO - 'SHELL': '/bin/bash', 10:30:44 INFO - 'SHLVL': '1', 10:30:44 INFO - 'TERM': 'linux', 10:30:44 INFO - 'TMOUT': '86400', 10:30:44 INFO - 'USER': 'cltbld', 10:30:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:44 INFO - '_': '/tools/buildbot/bin/python'} 10:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:30:44 INFO - Running setup.py (path:/tmp/pip-YUvUrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:30:44 INFO - Running setup.py (path:/tmp/pip-NrbO1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:30:44 INFO - Running setup.py (path:/tmp/pip-W9aFLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:30:44 INFO - Running setup.py (path:/tmp/pip-3x0Pbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:30:44 INFO - Running setup.py (path:/tmp/pip-n_WyYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:30:44 INFO - Running setup.py (path:/tmp/pip-rR0xsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:30:44 INFO - Running setup.py (path:/tmp/pip-DAmJUm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:30:44 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)) 10:30:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:30:44 INFO - Running setup.py (path:/tmp/pip-FKzz8H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:30:45 INFO - Running setup.py (path:/tmp/pip-ES7nyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:30:45 INFO - Running setup.py (path:/tmp/pip-4jEo5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:30:45 INFO - Running setup.py (path:/tmp/pip-I2Sp7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:30:45 INFO - Running setup.py (path:/tmp/pip-0d5PMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:30:45 INFO - Running setup.py (path:/tmp/pip-OfnIxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:30:45 INFO - Running setup.py (path:/tmp/pip-r_akty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:30:45 INFO - Running setup.py (path:/tmp/pip-orterb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:30:45 INFO - Running setup.py (path:/tmp/pip-TZIFtg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:30:45 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)) 10:30:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:30:45 INFO - Running setup.py (path:/tmp/pip-4fVqyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:30:45 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)) 10:30:45 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)) 10:30:45 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)) 10:30:45 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)) 10:30:45 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)) 10:30:45 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)) 10:30:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:47 INFO - Downloading blessings-1.6.tar.gz 10:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:30:47 INFO - Installing collected packages: blessings 10:30:47 INFO - Running setup.py install for blessings 10:30:47 INFO - Successfully installed blessings 10:30:47 INFO - Cleaning up... 10:30:47 INFO - Return code: 0 10:30:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:30:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:30:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:30:47 INFO - Reading from file tmpfile_stdout 10:30:47 INFO - Current package versions: 10:30:47 INFO - argparse == 1.2.1 10:30:47 INFO - blessings == 1.6 10:30:47 INFO - blobuploader == 1.2.4 10:30:47 INFO - docopt == 0.6.1 10:30:47 INFO - manifestparser == 1.1 10:30:47 INFO - mozInstall == 1.12 10:30:47 INFO - mozcrash == 0.16 10:30:47 INFO - mozdebug == 0.1 10:30:47 INFO - mozdevice == 0.47 10:30:47 INFO - mozfile == 1.2 10:30:47 INFO - mozhttpd == 0.7 10:30:47 INFO - mozinfo == 0.9 10:30:47 INFO - mozleak == 0.1 10:30:47 INFO - mozlog == 3.1 10:30:47 INFO - moznetwork == 0.27 10:30:47 INFO - mozprocess == 0.22 10:30:47 INFO - mozprofile == 0.27 10:30:47 INFO - mozrunner == 6.11 10:30:47 INFO - mozscreenshot == 0.1 10:30:47 INFO - mozsystemmonitor == 0.0 10:30:47 INFO - moztest == 0.7 10:30:47 INFO - mozversion == 1.4 10:30:47 INFO - psutil == 3.1.1 10:30:47 INFO - requests == 1.2.3 10:30:47 INFO - wsgiref == 0.1.2 10:30:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:47 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 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:47 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 10:30:47 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 10:30:47 INFO - Using env: {'DISPLAY': ':0', 10:30:47 INFO - 'HOME': '/home/cltbld', 10:30:47 INFO - 'LANG': 'en_US.UTF-8', 10:30:47 INFO - 'LANGUAGE': 'en_US:en', 10:30:47 INFO - 'LOGNAME': 'cltbld', 10:30:47 INFO - 'MAIL': '/var/mail/cltbld', 10:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:47 INFO - 'MOZ_NO_REMOTE': '1', 10:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:47 INFO - 'NO_EM_RESTART': '1', 10:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:47 INFO - 'SHELL': '/bin/bash', 10:30:47 INFO - 'SHLVL': '1', 10:30:47 INFO - 'TERM': 'linux', 10:30:47 INFO - 'TMOUT': '86400', 10:30:47 INFO - 'USER': 'cltbld', 10:30:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:47 INFO - '_': '/tools/buildbot/bin/python'} 10:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 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)) 10:30:48 INFO - Cleaning up... 10:30:48 INFO - Return code: 0 10:30:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:30:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:30:48 INFO - Using env: {'DISPLAY': ':0', 10:30:48 INFO - 'HOME': '/home/cltbld', 10:30:48 INFO - 'LANG': 'en_US.UTF-8', 10:30:48 INFO - 'LANGUAGE': 'en_US:en', 10:30:48 INFO - 'LOGNAME': 'cltbld', 10:30:48 INFO - 'MAIL': '/var/mail/cltbld', 10:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:48 INFO - 'MOZ_NO_REMOTE': '1', 10:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:48 INFO - 'NO_EM_RESTART': '1', 10:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:48 INFO - 'SHELL': '/bin/bash', 10:30:48 INFO - 'SHLVL': '1', 10:30:48 INFO - 'TERM': 'linux', 10:30:48 INFO - 'TMOUT': '86400', 10:30:48 INFO - 'USER': 'cltbld', 10:30:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:48 INFO - '_': '/tools/buildbot/bin/python'} 10:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:48 INFO - Downloading/unpacking jsonschema 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30: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 10:30:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:30:50 INFO - Downloading/unpacking functools32 (from jsonschema) 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:50 INFO - Downloading functools32-3.2.3-2.tar.gz 10:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:30:50 INFO - warning: no files found matching '*.txt' 10:30:50 INFO - no previously-included directories found matching 'build' 10:30:50 INFO - no previously-included directories found matching 'dist' 10:30:50 INFO - no previously-included directories found matching '.git*' 10:30:50 INFO - Installing collected packages: jsonschema, functools32 10:30:50 INFO - Running setup.py install for functools32 10:30:50 INFO - warning: no files found matching '*.txt' 10:30:50 INFO - no previously-included directories found matching 'build' 10:30:50 INFO - no previously-included directories found matching 'dist' 10:30:50 INFO - no previously-included directories found matching '.git*' 10:30:50 INFO - Successfully installed jsonschema functools32 10:30:50 INFO - Cleaning up... 10:30:50 INFO - Return code: 0 10:30:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5f2952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', '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 10:30:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:30:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:30:50 INFO - Using env: {'DISPLAY': ':0', 10:30:50 INFO - 'HOME': '/home/cltbld', 10:30:50 INFO - 'LANG': 'en_US.UTF-8', 10:30:50 INFO - 'LANGUAGE': 'en_US:en', 10:30:50 INFO - 'LOGNAME': 'cltbld', 10:30:50 INFO - 'MAIL': '/var/mail/cltbld', 10:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:50 INFO - 'MOZ_NO_REMOTE': '1', 10:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:50 INFO - 'NO_EM_RESTART': '1', 10:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:30:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:30:50 INFO - 'SHELL': '/bin/bash', 10:30:50 INFO - 'SHLVL': '1', 10:30:50 INFO - 'TERM': 'linux', 10:30:50 INFO - 'TMOUT': '86400', 10:30:50 INFO - 'USER': 'cltbld', 10:30:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:50 INFO - '_': '/tools/buildbot/bin/python'} 10:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:50 INFO - Downloading/unpacking flake8 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:30:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:30:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:30:53 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 10:30:53 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 10:30:53 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 10:30:53 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 10:30:53 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 10:30:53 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 10:30:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:30:53 INFO - no previously-included directories found matching 'docs/_build' 10:30:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:30:53 INFO - Running setup.py install for pep8 10:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:30:53 INFO - no previously-included directories found matching 'docs/_build' 10:30:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:30:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:30:53 INFO - Cleaning up... 10:30:53 INFO - Return code: 0 10:30:53 INFO - Running post-action listener: _resource_record_post_action 10:30:53 INFO - Running post-action listener: _start_resource_monitoring 10:30:53 INFO - Starting resource monitoring. 10:30:53 INFO - ##### 10:30:53 INFO - ##### Running install step. 10:30:53 INFO - ##### 10:30:53 INFO - Running pre-action listener: _resource_record_pre_action 10:30:53 INFO - Running main action method: install 10:30:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:30:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:30:53 INFO - Reading from file tmpfile_stdout 10:30:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:30:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:30:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:30:53 INFO - Reading from file tmpfile_stdout 10:30:53 INFO - Output received: 10:30:53 INFO - Usage: mozinstall [options] installer 10:30:53 INFO - Options: 10:30:53 INFO - -h, --help show this help message and exit 10:30:53 INFO - -d DEST, --destination=DEST 10:30:53 INFO - Directory to install application into. [default: 10:30:53 INFO - "/builds/slave/test-pgo"] 10:30:53 INFO - --app=APP Application being installed. [default: firefox] 10:30:53 INFO - mkdir: /builds/slave/test-pgo/build/application 10:30:53 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'] 10:30:53 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 10:31:08 INFO - Reading from file tmpfile_stdout 10:31:08 INFO - Output received: 10:31:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:31:08 INFO - Running post-action listener: _resource_record_post_action 10:31:08 INFO - ##### 10:31:08 INFO - ##### Running run-tests step. 10:31:08 INFO - ##### 10:31:08 INFO - Running pre-action listener: _resource_record_pre_action 10:31:08 INFO - Running main action method: run_tests 10:31:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:31:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:31:08 INFO - Python 2.7.3 10:31:08 INFO - Return code: 0 10:31:08 INFO - grabbing minidump binary from tooltool 10:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:31:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1fe30>, '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 0xe20d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:31:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:31:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:31:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:31:08 INFO - Return code: 0 10:31:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:31:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:31:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:31:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:31:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:31:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:31:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:31:09 INFO - Return code: 0 10:31:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:31:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 10:31:09 INFO - Using env: {'DISPLAY': ':0', 10:31:09 INFO - 'HOME': '/home/cltbld', 10:31:09 INFO - 'LANG': 'en_US.UTF-8', 10:31:09 INFO - 'LANGUAGE': 'en_US:en', 10:31:09 INFO - 'LOGNAME': 'cltbld', 10:31:09 INFO - 'MAIL': '/var/mail/cltbld', 10:31:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:31:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:09 INFO - 'MOZ_NO_REMOTE': '1', 10:31:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:09 INFO - 'NO_EM_RESTART': '1', 10:31:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:31:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:31:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:31:09 INFO - 'SHELL': '/bin/bash', 10:31:09 INFO - 'SHLVL': '1', 10:31:09 INFO - 'TERM': 'linux', 10:31:09 INFO - 'TMOUT': '86400', 10:31:09 INFO - 'USER': 'cltbld', 10:31:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628', 10:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:09 INFO - '_': '/tools/buildbot/bin/python'} 10:31:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 10:31:10 INFO - mozversion INFO | application_buildid: 20160207080418 10:31:10 INFO - mozversion INFO | application_changeset: ffb9c10f484b341940dd0de7111c7bbc9616267c 10:31:10 INFO - mozversion INFO | application_display_name: Nightly 10:31:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:31:10 INFO - mozversion INFO | application_name: Firefox 10:31:10 INFO - mozversion INFO | application_remotingname: firefox 10:31:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:31:10 INFO - mozversion INFO | application_vendor: Mozilla 10:31:10 INFO - mozversion INFO | application_version: 45.0 10:31:10 INFO - mozversion INFO | platform_buildid: 20160207080418 10:31:10 INFO - mozversion INFO | platform_changeset: ffb9c10f484b341940dd0de7111c7bbc9616267c 10:31:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:31:10 INFO - mozversion INFO | platform_version: 45.0 10:31:10 INFO - 2016-02-07 10:31:10,078 DEBUG : using testdate: 1454869870 10:31:10 INFO - 2016-02-07 10:31:10,078 DEBUG : actual date: 1454869870 10:31:10 INFO - 2016-02-07 10:31:10,086 INFO : starting webserver on 'localhost:55229' 10:31:10 INFO - 2016-02-07 10:31:10,087 INFO : Starting test suite talos-linux64-ix-068 10:31:10 INFO - 2016-02-07 10:31:10,087 INFO : Starting test dromaeo_css 10:31:10 INFO - 2016-02-07 10:31:10,087 DEBUG : operating with platform_type : linux_ 10:31:10 INFO - 2016-02-07 10:31:10,087 INFO : Initialising browser for dromaeo_css test... 10:31:10 INFO - 2016-02-07 10:31:10,119 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp46B80h/profile http://localhost:55229/getInfo.html 10:31:16 INFO - 2016-02-07 10:31:16,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:31:16 INFO - 2016-02-07 10:31:16,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:31:16 INFO - 2016-02-07 10:31:16,989 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:31:16 INFO - 2016-02-07 10:31:16,989 DEBUG : BROWSER_OUTPUT: __metrics 10:31:17 INFO - 2016-02-07 10:31:17,174 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] 10:31:18 INFO - 2016-02-07 10:31:18,639 INFO : Browser initialized. 10:31:18 INFO - 2016-02-07 10:31:18,640 INFO : Running cycle 1/1 for dromaeo_css test... 10:31:18 INFO - 2016-02-07 10:31:18,640 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp46B80h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:31:30 INFO - 2016-02-07 10:31:30,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 133791744 10:31:30 INFO - 2016-02-07 10:31:30,442 DEBUG : BROWSER_OUTPUT: 10:32:21 INFO - 2016-02-07 10:32:21,325 DEBUG : BROWSER_OUTPUT: 1454869941324 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] 10:34:29 INFO - 2016-02-07 10:34:29,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55229/tests/dromaeo/cssquery-ext.html) 10:34:30 INFO - 2016-02-07 10:34:30,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 217509888 10:34:30 INFO - 2016-02-07 10:34:30,738 DEBUG : BROWSER_OUTPUT: 10:37:32 INFO - 2016-02-07 10:37:32,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-ext.html (next: http://localhost:55229/tests/dromaeo/cssquery-jquery.html) 10:37:33 INFO - 2016-02-07 10:37:33,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 219611136 10:37:33 INFO - 2016-02-07 10:37:33,354 DEBUG : BROWSER_OUTPUT: 10:40:35 INFO - 2016-02-07 10:40:35,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55229/tests/dromaeo/cssquery-mootools.html) 10:40:35 INFO - 2016-02-07 10:40:35,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 222531584 10:40:35 INFO - 2016-02-07 10:40:35,560 DEBUG : BROWSER_OUTPUT: 10:43:37 INFO - 2016-02-07 10:43:37,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55229/tests/dromaeo/cssquery-prototype.html) 10:43:37 INFO - 2016-02-07 10:43:37,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 200019968 10:43:37 INFO - 2016-02-07 10:43:37,824 DEBUG : BROWSER_OUTPUT: 10:46:40 INFO - 2016-02-07 10:46:40,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55229/tests/dromaeo/cssquery-yui.html) 10:46:40 INFO - 2016-02-07 10:46:40,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 201687040 10:46:40 INFO - 2016-02-07 10:46:40,729 DEBUG : BROWSER_OUTPUT: 10:49:42 INFO - 2016-02-07 10:49:42,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/dromaeo/cssquery-yui.html (next: http://localhost:55229/tests/dromaeo/cssquery-dojo.html) 10:49:43 INFO - 2016-02-07 10:49:43,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 243789824 10:49:43 INFO - 2016-02-07 10:49:43,096 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:49:43 INFO - 2016-02-07 10:49:43,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:49:43 INFO - 2016-02-07 10:49:43,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:49:43 INFO - 2016-02-07 10:49:43,098 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:49:43 INFO - 2016-02-07 10:49:43,099 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3266.7876588021777;3313.1054615253897;3383.0527452313345;3383.1711230748456;3387.69510744033;5501.092319767238;5573.777048918038;5592.161175823623;5596.272484576999;5628.240187574676;5534.916976245359;5608.186812912136;5608.327000759904;5617.101263797793;5629.380768115514;4957.5786058185095;5036.697798132123;5068.873278168047;5085.593152547805;5170.896582068356;4967.0810899983435;5036.496350364971;5037.24441333801;5038.823641172559;5043.268726034723;4936.654434189608;5034.924476132861;5119.56483698886;5138.409082955471;5180.689158650474;4984.875378115558;5086.059079070384;5088.211327244283;5090.720010399426;5112.207607820775;5002.2246551784165;5082.440931497532;5091.1854103343285;5119.539241468286;5139.10065738498;5232.293640358541;5283.471652834724;5400.83797486076;5413.458654134555;5424.701641409721;5896.911546326808;5976;5982.760689572412;5989.670568118751;6005.429484198994;5985.4912332451795;6011.248593925759;6025.487833534155;6036.547258955552;6046.818595442144;5338.652987555835;5380.166074258457;5448.991936491761;5490.56075513958;5580.86047848807;5954.4045595440975;5996.310424301174;6003.519718422515;6013.819585412444;6015.308239552507;5839.854003649943;5841.970790146022;5843.152742852348;5848.210491583667;5853.882922341614;5684.914726279109;5804.042333015005;5812.680302583314;5894.440028197314;5925;5829.271341082364;5937.52499800015;5952.970235148883;5963.19496867926;5964.761409543657;5675.829725108253;5917.911231331534;5927.2590926134235;5943.673097979567;5944.554158438134;4498.3927169832305;4506.369108324837;4536.455625324982;4561.064981678748;4572.245579479415;4056.6551843093666;4059.69552283574;4066.6340029397497;4066.8169932353117;4098.159877225162;5356.384015838151;5505.862353441116;5579.4420557944695;5592.888142237132;5593.496585307261;5794.739236734357;5847.44449277318;5865.032269675541;5871.823845284648;5885.705714714247;5616.9157462638095;5641.266635337462;5648;5649.943500564942;5658.943410565924;5052.393712754493;5129.9230511542355;5147.845564633067;5186.611004174702;5191.32512773337;6055.1220073090035;6058.909116363258;6072.605280656743;6081.939180608226;6082.513398928075;5943.286805583185;5943.821685349447;5947.583669143119;5954.225950626391;5963.970180149072;5871.706414679335;5904.940950590611;5987.131865879336;5993.190919226023;6021.488173505301;5827.679477628772;5832.24180856486;5835.533157347487;5840.386759390203;5841.269841269841;5893.675847828411;5938.287405511193;5948.078047902582;5952;5966.612170208922;5622.578306626938;5688;5796.913046304393;5800.59395842287;5815;5793.94206057934;5851.239338885917;5853.560982926383;5863.912041319299;5868.295804503487;5563.193336966198;5771.163181338598;5772.307323121252;5776.220210271727;5783.132530120515;5710.2576665033275;5746.281714785652;5899.4985426239255;5900.11498275245;5929.495992840657;5713.9142912855505;5757.424257574209;5760.337561180518;5762;5765.596408251382 10:49:43 INFO - 2016-02-07 10:49:43,101 DEBUG : BROWSER_OUTPUT: |1;ext.html;616.5345164400877;621.3662064694013;634.112242859996;635.199648442962;635.5836926812933;41934.370984435256;42367.36448953268;42813;42852;42872.57127428725;47064.2940355895;47884.28173577399;48004;48053.279200812016;48104;7881.60591970402;8006.399520035991;8006.599670016505;9153.176214140743;9353.859692104625;10960.342379457219;11141.387223702694;11185.608503702371;11201.215914885961;11238.887611123906;10613;10803.351798892052;10832.78334433311;10844.915508449132;10890.455477226147;10791.784164316708;10913.890861091368;10923.39921304328;10927.890721092766;10959.726006849813;10567.735806604896;10806.081483073947;10807.243492955497;10812.29720068201;10821.513031913582;43552.12895742099;43580.346294805604;43780.3432948506;43951.560484395064;43981;3525.7708248963736;3565.144365352297;3859.4403811447464;4273.487181538236;4388.626966707834;34252.486212706826;34396.82801586001;34527.82736086329;34644.82677586596;34679.30641387183;4206.326987681956;4400.867973960754;4421.977890110561;4434.84478043267;4444.355568442557;309499;311020;311363;312393.43803281063;312893;59211.70394148002;59840.70079649661;59975.40024599698;66880.31837771309;67380.32619673839;72186.63906680433;72902.27097729061;73295.63352183312;73310;73367.63316183384;16361.918190408971;16739.832601674072;16759.916200419164;16764.413245536347;16795.496135115965;10841.512131954081;10873.945630271955;10886.183536234656;10890.727731806768;10966.835497467544;21630;22533.549329013327;22549.098036078372;22661.773382266296;22693.319200423684;7748.573828439377;7809.765707028798;7890.250426209501;7945.443818932619;7946;938.8873335199684;958.5255298627225;1040.6929955663097;1061.1139698351963;1068.6740544133959;26795.86602066977;26935.86532067327;27150.86424567904;27283.590746138823;27714.861425692743;1033.1734612310122;1118.9552417903192;1186.6084192216547;1210.291979192165;1228.6436933289247;13944.51194208198;14400.495982640767;14706.852931470763;16628.7242397433;17316.480505584852;349635;354443;358014;358634;358673;59006.40993590009;59107;59193;59284.70357648184;59332;1442.3076923076771;1449.6665766873468;1451.7749748788954;1457.6007033247988;1469.1846025455975;27430.725692742817;31155.37689246248;31211.687883120878;31558.526622101144;32023.679763202068;48542;49220.753896230286;49227.75386123046;49263.75368123136;49299.26051109308;214770;215493;216959;217055;217346;32318.35363292674;33208;33907;34900.301993959474;35099.473507897914;41405.79297103495;41724;41795.582044179166;42627.57372426236;42855.785721071195;35524.822375887954;36100.81949590235;37893.62106378901;38884;40117.398239027025;33510.832445837616;37985.2402951945;38906.61093389143;39330.803345983084;39816.40275395929;34374.484382733775;35061.47407788936;35903.820480897426;35923;36291.637083628826;31075;34696.13259668528;34870.476942846384;34988.30023399467;35634.82182589071;25901.48197036011;26562.203133906012;26633.866830665724;26645.8667706668;26801.195964121107 10:49:43 INFO - 2016-02-07 10:49:43,104 DEBUG : BROWSER_OUTPUT: |2;jquery.html;381.05498364057155;382.3690909998502;384.61538461538464;384.6211481690535;385.9864904728335;16734;16885.746713799304;17310.71394723584;17597.560060998465;17621.03084330363;13922;17722.20250088746;17866.553336166602;18703.625927481444;18725.438236852915;5449.4005659377435;5610.747516361774;5620.887582248352;6116.68491274377;6242.31334553201;5579.525740312058;5592.5805564582615;5595.300587426572;5599.048161812481;5602.831915042555;5505.559555235592;5538.335399752015;5540.141278101901;5543.916841247385;5545.223668686387;5515.365732940703;5532.474414930575;5541.0580201365465;5542.667439953575;5543.1408131739445;5407.270018547524;5536.861578460531;5557.221988921554;5560.138178582326;5567.721613919329;12769.48922043117;12831.486740530368;15571.532854014398;22632.773672263233;22679.773202268098;2185.9234926777644;2282.988585057081;2341.976580234193;2373.560891235127;2460.495598402323;13379.86620133796;13931.512397066155;14026.158430494203;14137;14179.858201417957;1731.980058394749;1817.155022914338;1817.8454831339352;1890.4990177602947;1912.1586501939241;66878.66560667215;68396.97404538936;69956.6502167491;69961;70584.6470767648;11107.611233606785;11116.610918617971;11212.719682007852;11219.66341009771;11256.268342557707;14980.250987450583;15003.399864005318;15010.849891501164;15040.849591503946;15063.322150503254;6879.415249703831;7031.542949708355;7801.297883190427;7822.178671239438;7822.318201586686;7509.211532789088;7615.048118985127;7620.885686714703;7637.121731000895;7665.463417560829;4497.955020449754;4624.745638989821;4644.744539050317;4855.295982082578;4875.171220892456;1732.7660765796456;1765.7263124215767;1779.2082523277277;1788.8640713147245;1806.467092207802;817.721974528663;928.2666693312208;950.6435086842434;968.9970880139023;1053.8629978102797;15818.52544423646;16242.10668413225;16470.83529164717;16664.91667541679;16671.333146674;896.6189369517929;900.9369344145978;909.5270459361095;999.8400255959011;1008.3647302199568;7883.448158628956;9607.039296070338;9655.758606034764;9703.223742100616;9725;555473;557861;559963;562530;577322;85106;85394;85496;85840.57079714687;86637.5668121668;1155.820847768597;1164.5283660117666;1189.120051162134;1189.2091758980182;1208.9697757556132;15528.611784705472;15812.288447019682;15849.207539623203;15914.920425397799;16079;33802.154946125556;33952.83023584866;34409.82795086008;35326.293474130885;35427.291454170256;50812.49187508078;51670.48329516657;51993.22010169775;52524.47475525349;53523.732381337846;9988.550515226978;10200.469929510633;10225.488725563544;10247.231457640855;10418.166546676399;12313.753724925273;12446.315452650191;12568.183068100545;16961.321547137977;18839.71740423922;15666.451674191349;15839.841601584298;16010.279537421076;16032.59918502;16060.036397816168;15037.248137593295;15173.924130379277;15571.37714491453;15902;16204.027758334538;14702.852971470149;14945.476908308157;14969;15467.613309666898;16348.10085445312;10270.435126068138;10301.639442619473;10338.276320657482;10355.378677279386;10410.427426491615;14234.288285585471;14343.856561434251;14816.333265002886;15536.456224032105;15546.9222653886 10:49:43 INFO - 2016-02-07 10:49:43,106 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1512.56135720641;1568.1453607783756;1591.037422359473;1744.3197153110289;1863.5993261448793;7337.523061001031;7484.513506622073;7489.513181643203;7494.925050749491;7495.100587929443;6415.037744338351;6561.015847622859;7143.464240181981;7418.962905185466;7476.700931962729;2316.5830150572892;2339.82451316152;2362.433016076138;2364.432536191319;2364.6098393765096;1993.4318719165042;2299.908003679859;2302.700648915647;2360.0323867214447;2360.386299562109;1993.6012797440496;2191.5835991161707;2247.820174386053;2249.9437514062197;2250.032486031006;2189.540196558725;2205.0628482894704;2236.9664455033108;2275.590393729128;2275.943101422461;2265.512914723326;2297.5634629420524;2316.2049411705893;2329.0683726509365;2335.019291897407;7460.664270107858;7520.962395188044;7537.736179233755;7540.057492813398;7542.43431742616;4534.750588717619;4616.39986801717;4645.9303110453375;4649.535046495357;4659.603933665642;2942.9117126486026;2984.4777163996214;2989.701029896993;3006.8045577037424;3171.0486853943953;1118.8713297970676;1118.9664310070712;1129.074159189465;1154.3824054131;1160.2168536238005;9780.315377923549;10006.699799005968;10011.699649010541;10021.799564008752;10021.949890250575;4109.239790638741;4152.314868046738;4186.979065104655;4210.621044106045;4215.620594146541;8375.288100511525;8379.203975622428;8380.916190838014;8384.916150838535;8395.664173432995;4620.630349572026;4638.489766125724;4671.159191345522;4681.485036645966;4681.836135735233;4311.525732169459;4335.7615331157085;4339.891502712458;4340.934885976713;4344.218040752632;3500.649935006479;3511.8068506232403;3525.4183059794846;3542.3977923753023;3548.0952357148763;960.9711708648751;985.8373368394278;1047.3244757131608;1105.90599799018;1106.756513567014;1074.9946250268856;1121.4000509727257;1131.852859128308;1334.5262431836752;1444.949426770058;7000.272364869864;7027.43780497559;7031.0859588254225;7035.6482175891;7105.396041336544;1155.1682788392345;1173.2432580985217;1175.1069187417625;1186.3297237061033;1205.8673545909942;5682.687452190169;5776.075827867605;5783.306003279633;5788.3343415506915;5797.449242321973;8601.655933762704;8715.477071375737;8839.51382673959;8856.468611883307;9011.504367259864;8830.514321712368;8831.161039701217;8831.205191532792;8832.470051796912;8836.293096552261;7156.391706704884;7160.10498687664;7193.568385896863;7195.280471952763;7316.487845850846;7239.710411583477;7353.889691654736;7354;7357.889631655637;7361.631918404166;7944.483608565656;8305.833883322179;8308.418410711434;8314.833703326021;8340.04089529712;8037.8392432152195;8080.232377924088;8190.099089100313;8200.507969521848;8213.917860821315;6672.399484046265;6937.375636192767;6941.47938904574;6960.199577048705;6962.1297337832775;7363.410927125924;7369.705211791468;7377.704891804482;7383.593902335423;7399.334059934632;5842.269716285465;6826.112605361272;7016.333448322402;7042.753503627553;7132.393746531603;6855.177378714387;6858.897116543156;6912;6978.127734033246;6980.650967451708;6630.46956243509;6720.529562930548;6741.494387920828;6743.898841517479;6751.054852320581;6472.093906852951;6509.641969691713;6514.283428822731;6519;6519.706613202512;6344.1118243445035;6398.744050238124;6409;6416.294207637249;6452.709628066842 10:49:43 INFO - 2016-02-07 10:49:43,107 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.2206791970948;335.10359787568257;338.61905356473966;343.8658923020022;347.4094040131775;6166.290876549198;6205.131281620576;6223.471004964572;6243.906341404882;6264.84337891553;5867.618604790686;6011.669358185298;6052;6109.450149486545;6116.724747386367;4730.810767569293;4741.881452963669;4751.097291514601;4751.5010923853015;4765.618750499952;4718.528147185289;4739.763011849411;4747.90504189916;4752.263399173116;4753.287006948951;4482;4583.12920545097;4590.885227869297;4671.252599584067;4679.672422930379;4672.696274742131;4672.883177920545;4682;4684.180268453041;4686.27362758773;4138.79306034697;4140.213359461693;4143.461350024508;4147.460830092099;4158.189153115144;5750.827475175752;5820.272465941757;5835.5915085944;5842.211301474332;5854.677992710442;5519.9448005519835;5529.502344788948;5531.640443371168;5537.972310138423;5542.0855558832745;6520.11978382917;6525.510586706016;6525.575837570543;6531.7387304507765;6532.248791389004;4615;4619.838305659319;4619.884502887421;4623.537646235383;4625.95374046262;6665.333466653345;6688.297728738461;6731.69707363165;6761.661916904135;6770.492213084039;4711.199096153662;4718.292256161534;4719.858404247878;4720.315554244616;4723.95276047242;4777.116233496814;4777.4505931818285;4778.1638213312535;4780.95219047805;4780.976095119572;5465.836024919259;5493.862653433696;5493.945060549423;5495.230667706524;5500;6454.903176452357;6588.604683718896;6594.07682924391;6609.537332386687;6612.702428390734;1676.3546034776698;1696.414736915762;1697.711389063862;1697.7198762204098;1698.2357938927532;1109.4785450838094;1141.5604992077945;1142.0463912633045;1158.80879654856;1167.6205233299042;6336.239651241881;6350.587211831216;6359.586626869239;6362.141110950055;6370.331115232834;6791.3548212919695;6793.966030169818;6794.898076528856;6796.35434633709;6810.489213309022;6202.883480973378;6294.370562943761;6322.841928951813;6423.582467139621;6444.677766111676;3681;3699.944500832436;3702.740808143458;3704.0924973381693;3705.5368078990127;6991.510594258455;6999.300069993062;7010.894836577456;7012.387150955309;7014.859702805916;6853.383195512328;7010.123734533184;7054.717811287491;7074.92925070753;7080.858382832314;7024.051753013277;7027.43780497559;7037.577745335297;7041.366277035091;7041.859162816715;6640.767573134917;6799.082123913208;6881.380675739208;6884.65576721172;6889.586624802528;6703.865922681616;6749.5612785168805;6787.117674702455;6787.592744435349;6799.116114905229;6982.895256571257;6986;7005.894911576433;7014.193367762568;7018.403435707818;4589.5639914208095;4641.698289611165;4668.11305851887;4675.0416164685475;4680.391549098732;6873.450123990169;6887.20797108339;6888.586684798928;6894.172699276119;6895.207051188977;6656.7337306509135;6684.665766711742;6692.564983276072;6701.430378417889;6701.966490167518;6549.508786841101;6664.8000559983275;6673.165854268216;6673.432758215412;6675.165604299463;6572.112764776694;6579.243387010555;6581.078648989241;6586.637734924433;6588.439982601532;6673.399394054559;6676.1988561371;6678.799636010927;6680.5991640501725;6683.899741503784;6361.014042823184;6508.284088750328;6521.119648847345;6522.739090436329;6567.802965910839 10:49:43 INFO - 2016-02-07 10:49:43,108 DEBUG : BROWSER_OUTPUT: |5;yui.html;842.5618678287294;858.4505916213624;874.4403581707707;874.5583480342426;892.611713904452;13156.407961641726;13361.93104551636;13372.799408008876;13390.330483475811;13407.329633518333;13211.801822972639;13219.933900330509;13257.668558286048;13292.401841917113;13306.201627902332;735.2096496266508;743.9404847612178;892.7500299916034;896.4442045931531;906.4923642760042;893.5710858787786;902.440486898124;906.1663269791808;907.4555266839909;909.9590518426687;779.7894568466539;899.4468401932829;921.9953900230489;924.5700749151644;927.8329900617886;773.443120952913;931.483026920059;943.4810854030256;944.9433034017912;946.7917058247175;691.6576294734089;697.4141720954423;700.4921431961837;700.9649517524155;700.9684564194623;13634.522791702242;13812.930935345259;13838.792418113737;13842.792358114637;13860.93069534656;13029.478820847155;13158.342082895913;13174.407151678197;13355.599332020054;13459;10816.567337306498;10820.350778953289;10833.133349332034;10869.945650271698;10943.616973405971;3795.8102094895144;3839.884803455901;3906.7655940643654;3908.882733517999;3920;46524.76737616324;46796.7660161697;47002.2949655752;47491.52508474905;47590;9036.909630903607;9421.340506164639;9454.43273403598;9467.715968520955;9534.141927226445;17313.39403120885;17327.65344693099;17353.132343382782;17367.65264694699;17380.739288910678;7705.383569314441;7827.178146294671;7845.0978137513775;7879.921200787919;7995.200479951958;4232.978835105805;4242.66058715302;4270.850520231777;4328.935065974013;4408.867733967986;3056.770742194344;3091.0108765195373;3094;3095.272610936428;3095.92260193497;515.2760371677799;528.426657077068;531.9920201196985;536.3215532351501;538.4507802041895;605.5670195809929;709.2163159708551;711.3420086420041;717.3866344275674;735.6910097758954;8011.399145064143;8733;8805.119488051143;8936.106389361012;9041.095890410907;517.9378474583074;614.0206370838505;618.11300783376;675.8546912413855;729.3581648149594;4081.0817566047403;4212.936805947913;4298.183345164409;4301.290287102655;4312.288472402019;58216;58675;58913.41086589079;61566;61929.69035154885;54551;54555.18167227495;55381.72309138429;56322.718386408626;56615.43384566184;50454.74772626187;50547.98904021899;50843;50903.49096509062;52564.73717631387;8670.219680228809;8685.174908383693;8709.520976346363;8933.731988040368;9037.367384283038;39521.80239098786;39552.40671389989;39805.60194398019;40705.79647101864;40892.386614200215;49097.50902491072;49169;49652.75173624109;49743.25385119153;49745.502544975534;11938.28370297785;12079.094067944763;12085.335306558223;12275.75448491043;12325.630231093082;12800.03999700045;12929.482820687443;13148.34258287101;13151.29785172806;13483.932580337429;11660.650180494598;11713.238639488405;11802.173847830913;11877.287362758263;12153.08851836098;12229.69425764363;12412.56556020535;12439.136973450948;12617.242965422103;12619.87380126187;11351.318920864775;11369.54521819118;11641.59254426125;11647.941760291144;11739.119566032752;10630.84053739179;10748.83876741865;10852.131829453783;10994.560217591206;11096.167787415814;10028.548715307683;10304;10324.328918620266;10347.896521034694;10351.120154786626 10:49:43 INFO - 2016-02-07 10:49:43,108 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:49:43 INFO - 2016-02-07 10:49:43,108 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:49:43 INFO - 2016-02-07 10:49:43,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,658 10:49:43 INFO - 2016-02-07 10:49:43,108 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: __startTimestamp1454870983096__endTimestamp 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5501.66 Median:5746.28 stddev:597.71 (10.4%) stddev-sans-first:573.26 10:49:43 INFO - 2016-02-07 10:49:43,109 DEBUG : BROWSER_OUTPUT: Values: 3266.8 3313.1 3383.1 3383.2 3387.7 5501.1 5573.8 5592.2 5596.3 5628.2 5534.9 5608.2 5608.3 5617.1 5629.4 4957.6 5036.7 5068.9 5085.6 5170.9 4967.1 5036.5 5037.2 5038.8 5043.3 4936.7 5034.9 5119.6 5138.4 5180.7 4984.9 5086.1 5088.2 5090.7 5112.2 5002.2 5082.4 5091.2 5119.5 5139.1 5232.3 5283.5 5400.8 5413.5 5424.7 5896.9 5976.0 5982.8 5989.7 6005.4 5985.5 6011.2 6025.5 6036.5 6046.8 5338.7 5380.2 5449.0 5490.6 5580.9 5954.4 5996.3 6003.5 6013.8 6015.3 5839.9 5842.0 5843.2 5848.2 5853.9 5684.9 5804.0 5812.7 5894.4 5925.0 5829.3 5937.5 5953.0 5963.2 5964.8 5675.8 5917.9 5927.3 5943.7 5944.6 4498.4 4506.4 4536.5 4561.1 4572.2 4056.7 4059.7 4066.6 4066.8 4098.2 5356.4 5505.9 5579.4 5592.9 5593.5 5794.7 5847.4 5865.0 5871.8 5885.7 5616.9 5641.3 5648.0 5649.9 5658.9 5052.4 5129.9 5147.8 5186.6 5191.3 6055.1 6058.9 6072.6 6081.9 6082.5 5943.3 5943.8 5947.6 5954.2 5964.0 5871.7 5904.9 5987.1 5993.2 6021.5 5827.7 5832.2 5835.5 5840.4 5841.3 5893.7 5938.3 5948.1 5952.0 5966.6 5622.6 5688.0 5796.9 5800.6 5815.0 5793.9 5851.2 5853.6 5863.9 5868.3 5563.2 5771.2 5772.3 5776.2 5783.1 5710.3 5746.3 5899.5 5900.1 5929.5 5713.9 5757.4 5760.3 5762.0 5765.6 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48329.78 Median:34885.39 stddev:78596.82 (225.3%) stddev-sans-first:78735.66 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: Values: 616.5 621.4 634.1 635.2 635.6 41934.4 42367.4 42813.0 42852.0 42872.6 47064.3 47884.3 48004.0 48053.3 48104.0 7881.6 8006.4 8006.6 9153.2 9353.9 10960.3 11141.4 11185.6 11201.2 11238.9 10613.0 10803.4 10832.8 10844.9 10890.5 10791.8 10913.9 10923.4 10927.9 10959.7 10567.7 10806.1 10807.2 10812.3 10821.5 43552.1 43580.3 43780.3 43951.6 43981.0 3525.8 3565.1 3859.4 4273.5 4388.6 34252.5 34396.8 34527.8 34644.8 34679.3 4206.3 4400.9 4422.0 4434.8 4444.4 309499.0 311020.0 311363.0 312393.4 312893.0 59211.7 59840.7 59975.4 66880.3 67380.3 72186.6 72902.3 73295.6 73310.0 73367.6 16361.9 16739.8 16759.9 16764.4 16795.5 10841.5 10873.9 10886.2 10890.7 10966.8 21630.0 22533.5 22549.1 22661.8 22693.3 7748.6 7809.8 7890.3 7945.4 7946.0 938.9 958.5 1040.7 1061.1 1068.7 26795.9 26935.9 27150.9 27283.6 27714.9 1033.2 1119.0 1186.6 1210.3 1228.6 13944.5 14400.5 14706.9 16628.7 17316.5 349635.0 354443.0 358014.0 358634.0 358673.0 59006.4 59107.0 59193.0 59284.7 59332.0 1442.3 1449.7 1451.8 1457.6 1469.2 27430.7 31155.4 31211.7 31558.5 32023.7 48542.0 49220.8 49227.8 49263.8 49299.3 214770.0 215493.0 216959.0 217055.0 217346.0 32318.4 33208.0 33907.0 34900.3 35099.5 41405.8 41724.0 41795.6 42627.6 42855.8 35524.8 36100.8 37893.6 38884.0 40117.4 33510.8 37985.2 38906.6 39330.8 39816.4 34374.5 35061.5 35903.8 35923.0 36291.6 31075.0 34696.1 34870.5 34988.3 35634.8 25901.5 26562.2 26633.9 26645.9 26801.2 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30326.90 Median:22656.27 stddev:92045.14 (406.3%) stddev-sans-first:92275.88 10:49:43 INFO - 2016-02-07 10:49:43,110 DEBUG : BROWSER_OUTPUT: Values: 381.1 382.4 384.6 384.6 386.0 16734.0 16885.7 17310.7 17597.6 17621.0 13922.0 17722.2 17866.6 18703.6 18725.4 5449.4 5610.7 5620.9 6116.7 6242.3 5579.5 5592.6 5595.3 5599.0 5602.8 5505.6 5538.3 5540.1 5543.9 5545.2 5515.4 5532.5 5541.1 5542.7 5543.1 5407.3 5536.9 5557.2 5560.1 5567.7 12769.5 12831.5 15571.5 22632.8 22679.8 2185.9 2283.0 2342.0 2373.6 2460.5 13379.9 13931.5 14026.2 14137.0 14179.9 1732.0 1817.2 1817.8 1890.5 1912.2 66878.7 68397.0 69956.7 69961.0 70584.6 11107.6 11116.6 11212.7 11219.7 11256.3 14980.3 15003.4 15010.8 15040.8 15063.3 6879.4 7031.5 7801.3 7822.2 7822.3 7509.2 7615.0 7620.9 7637.1 7665.5 4498.0 4624.7 4644.7 4855.3 4875.2 1732.8 1765.7 1779.2 1788.9 1806.5 817.7 928.3 950.6 969.0 1053.9 15818.5 16242.1 16470.8 16664.9 16671.3 896.6 900.9 909.5 999.8 1008.4 7883.4 9607.0 9655.8 9703.2 9725.0 555473.0 557861.0 559963.0 562530.0 577322.0 85106.0 85394.0 85496.0 85840.6 86637.6 1155.8 1164.5 1189.1 1189.2 1209.0 15528.6 15812.3 15849.2 15914.9 16079.0 33802.2 33952.8 34409.8 35326.3 35427.3 50812.5 51670.5 51993.2 52524.5 53523.7 9988.6 10200.5 10225.5 10247.2 10418.2 12313.8 12446.3 12568.2 16961.3 18839.7 15666.5 15839.8 16010.3 16032.6 16060.0 15037.2 15173.9 15571.4 15902.0 16204.0 14702.9 14945.5 14969.0 15467.6 16348.1 10270.4 10301.6 10338.3 10355.4 10410.4 14234.3 14343.9 14816.3 15536.5 15546.9 10:49:43 INFO - 2016-02-07 10:49:43,111 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,111 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5311.32 Median:6412.02 stddev:2658.24 (41.5%) stddev-sans-first:2650.37 10:49:43 INFO - 2016-02-07 10:49:43,112 DEBUG : BROWSER_OUTPUT: Values: 1512.6 1568.1 1591.0 1744.3 1863.6 7337.5 7484.5 7489.5 7494.9 7495.1 6415.0 6561.0 7143.5 7419.0 7476.7 2316.6 2339.8 2362.4 2364.4 2364.6 1993.4 2299.9 2302.7 2360.0 2360.4 1993.6 2191.6 2247.8 2249.9 2250.0 2189.5 2205.1 2237.0 2275.6 2275.9 2265.5 2297.6 2316.2 2329.1 2335.0 7460.7 7521.0 7537.7 7540.1 7542.4 4534.8 4616.4 4645.9 4649.5 4659.6 2942.9 2984.5 2989.7 3006.8 3171.0 1118.9 1119.0 1129.1 1154.4 1160.2 9780.3 10006.7 10011.7 10021.8 10021.9 4109.2 4152.3 4187.0 4210.6 4215.6 8375.3 8379.2 8380.9 8384.9 8395.7 4620.6 4638.5 4671.2 4681.5 4681.8 4311.5 4335.8 4339.9 4340.9 4344.2 3500.6 3511.8 3525.4 3542.4 3548.1 961.0 985.8 1047.3 1105.9 1106.8 1075.0 1121.4 1131.9 1334.5 1444.9 7000.3 7027.4 7031.1 7035.6 7105.4 1155.2 1173.2 1175.1 1186.3 1205.9 5682.7 5776.1 5783.3 5788.3 5797.4 8601.7 8715.5 8839.5 8856.5 9011.5 8830.5 8831.2 8831.2 8832.5 8836.3 7156.4 7160.1 7193.6 7195.3 7316.5 7239.7 7353.9 7354.0 7357.9 7361.6 7944.5 8305.8 8308.4 8314.8 8340.0 8037.8 8080.2 8190.1 8200.5 8213.9 6672.4 6937.4 6941.5 6960.2 6962.1 7363.4 7369.7 7377.7 7383.6 7399.3 5842.3 6826.1 7016.3 7042.8 7132.4 6855.2 6858.9 6912.0 6978.1 6980.7 6630.5 6720.5 6741.5 6743.9 6751.1 6472.1 6509.6 6514.3 6519.0 6519.7 6344.1 6398.7 6409.0 6416.3 6452.7 10:49:43 INFO - 2016-02-07 10:49:43,112 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,112 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5516.38 Median:6279.61 stddev:1662.20 (26.5%) stddev-sans-first:1620.64 10:49:43 INFO - 2016-02-07 10:49:43,112 DEBUG : BROWSER_OUTPUT: Values: 330.2 335.1 338.6 343.9 347.4 6166.3 6205.1 6223.5 6243.9 6264.8 5867.6 6011.7 6052.0 6109.5 6116.7 4730.8 4741.9 4751.1 4751.5 4765.6 4718.5 4739.8 4747.9 4752.3 4753.3 4482.0 4583.1 4590.9 4671.3 4679.7 4672.7 4672.9 4682.0 4684.2 4686.3 4138.8 4140.2 4143.5 4147.5 4158.2 5750.8 5820.3 5835.6 5842.2 5854.7 5519.9 5529.5 5531.6 5538.0 5542.1 6520.1 6525.5 6525.6 6531.7 6532.2 4615.0 4619.8 4619.9 4623.5 4626.0 6665.3 6688.3 6731.7 6761.7 6770.5 4711.2 4718.3 4719.9 4720.3 4724.0 4777.1 4777.5 4778.2 4781.0 4781.0 5465.8 5493.9 5493.9 5495.2 5500.0 6454.9 6588.6 6594.1 6609.5 6612.7 1676.4 1696.4 1697.7 1697.7 1698.2 1109.5 1141.6 1142.0 1158.8 1167.6 6336.2 6350.6 6359.6 6362.1 6370.3 6791.4 6794.0 6794.9 6796.4 6810.5 6202.9 6294.4 6322.8 6423.6 6444.7 3681.0 3699.9 3702.7 3704.1 3705.5 6991.5 6999.3 7010.9 7012.4 7014.9 6853.4 7010.1 7054.7 7074.9 7080.9 7024.1 7027.4 7037.6 7041.4 7041.9 6640.8 6799.1 6881.4 6884.7 6889.6 6703.9 6749.6 6787.1 6787.6 6799.1 6982.9 6986.0 7005.9 7014.2 7018.4 4589.6 4641.7 4668.1 4675.0 4680.4 6873.5 6887.2 6888.6 6894.2 6895.2 6656.7 6684.7 6692.6 6701.4 6702.0 6549.5 6664.8 6673.2 6673.4 6675.2 6572.1 6579.2 6581.1 6586.6 6588.4 6673.4 6676.2 6678.8 6680.6 6683.9 6361.0 6508.3 6521.1 6522.7 6567.8 10:49:43 INFO - 2016-02-07 10:49:43,112 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,113 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14565.02 Median:46660.77 stddev:17035.07 (36.5%) stddev-sans-first:17051.69 10:49:43 INFO - 2016-02-07 10:49:43,113 DEBUG : BROWSER_OUTPUT: Values: 842.6 858.5 874.4 874.6 892.6 13156.4 13361.9 13372.8 13390.3 13407.3 13211.8 13219.9 13257.7 13292.4 13306.2 735.2 743.9 892.8 896.4 906.5 893.6 902.4 906.2 907.5 910.0 779.8 899.4 922.0 924.6 927.8 773.4 931.5 943.5 944.9 946.8 691.7 697.4 700.5 701.0 701.0 13634.5 13812.9 13838.8 13842.8 13860.9 13029.5 13158.3 13174.4 13355.6 13459.0 10816.6 10820.4 10833.1 10869.9 10943.6 3795.8 3839.9 3906.8 3908.9 3920.0 46524.8 46796.8 47002.3 47491.5 47590.0 9036.9 9421.3 9454.4 9467.7 9534.1 17313.4 17327.7 17353.1 17367.7 17380.7 7705.4 7827.2 7845.1 7879.9 7995.2 4233.0 4242.7 4270.9 4328.9 4408.9 3056.8 3091.0 3094.0 3095.3 3095.9 515.3 528.4 532.0 536.3 538.5 605.6 709.2 711.3 717.4 735.7 8011.4 8733.0 8805.1 8936.1 9041.1 517.9 614.0 618.1 675.9 729.4 4081.1 4212.9 4298.2 4301.3 4312.3 58216.0 58675.0 58913.4 61566.0 61929.7 54551.0 54555.2 55381.7 56322.7 56615.4 50454.7 50548.0 50843.0 50903.5 52564.7 8670.2 8685.2 8709.5 8933.7 9037.4 39521.8 39552.4 39805.6 40705.8 40892.4 49097.5 49169.0 49652.8 49743.3 49745.5 11938.3 12079.1 12085.3 12275.8 12325.6 12800.0 12929.5 13148.3 13151.3 13483.9 11660.7 11713.2 11802.2 11877.3 12153.1 12229.7 12412.6 12439.1 12617.2 12619.9 11351.3 11369.5 11641.6 11647.9 11739.1 10630.8 10748.8 10852.1 10994.6 11096.2 10028.5 10304.0 10324.3 10347.9 10351.1 10:49:43 INFO - 2016-02-07 10:49:43,113 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:49:43 INFO - 2016-02-07 10:49:43,113 DEBUG : BROWSER_OUTPUT: 10:49:43 INFO - 2016-02-07 10:49:43,802 INFO : Browser exited with error code: 0 10:49:43 INFO - 2016-02-07 10:49:43,820 INFO : Completed test dromaeo_css (00:18:33) 10:49:43 INFO - 2016-02-07 10:49:43,821 INFO : Starting test kraken 10:49:43 INFO - 2016-02-07 10:49:43,821 DEBUG : operating with platform_type : linux_ 10:49:43 INFO - 2016-02-07 10:49:43,821 INFO : Initialising browser for kraken test... 10:49:43 INFO - 2016-02-07 10:49:43,827 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpD9e3/profile http://localhost:55229/getInfo.html 10:49:48 INFO - 2016-02-07 10:49:48,125 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:49:48 INFO - 2016-02-07 10:49:48,125 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:49:48 INFO - 2016-02-07 10:49:48,125 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:49:48 INFO - 2016-02-07 10:49:48,125 DEBUG : BROWSER_OUTPUT: __metrics 10:49:48 INFO - 2016-02-07 10:49:48,290 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] 10:49:49 INFO - 2016-02-07 10:49:49,147 INFO : Browser initialized. 10:49:49 INFO - 2016-02-07 10:49:49,147 INFO : Running cycle 1/1 for kraken test... 10:49:49 INFO - 2016-02-07 10:49:49,147 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphpD9e3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:50:00 INFO - 2016-02-07 10:50:00,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 134053888 10:50:00 INFO - 2016-02-07 10:50:00,933 DEBUG : BROWSER_OUTPUT: 10:50:03 INFO - 2016-02-07 10:50:03,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55229/tests/kraken/driver.html?testName=audio-beat-detection) 10:50:03 INFO - 2016-02-07 10:50:03,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 166490112 10:50:03 INFO - 2016-02-07 10:50:03,974 DEBUG : BROWSER_OUTPUT: 10:50:06 INFO - 2016-02-07 10:50:06,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55229/tests/kraken/driver.html?testName=audio-dft) 10:50:07 INFO - 2016-02-07 10:50:07,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 162873344 10:50:07 INFO - 2016-02-07 10:50:07,138 DEBUG : BROWSER_OUTPUT: 10:50:09 INFO - 2016-02-07 10:50:09,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55229/tests/kraken/driver.html?testName=audio-fft) 10:50:10 INFO - 2016-02-07 10:50:10,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 159944704 10:50:10 INFO - 2016-02-07 10:50:10,494 DEBUG : BROWSER_OUTPUT: 10:50:12 INFO - 2016-02-07 10:50:12,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55229/tests/kraken/driver.html?testName=audio-oscillator) 10:50:13 INFO - 2016-02-07 10:50:13,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 160673792 10:50:13 INFO - 2016-02-07 10:50:13,036 DEBUG : BROWSER_OUTPUT: 10:50:15 INFO - 2016-02-07 10:50:15,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:50:15 INFO - 2016-02-07 10:50:15,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 159559680 10:50:15 INFO - 2016-02-07 10:50:15,747 DEBUG : BROWSER_OUTPUT: 10:50:18 INFO - 2016-02-07 10:50:18,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55229/tests/kraken/driver.html?testName=imaging-darkroom) 10:50:19 INFO - 2016-02-07 10:50:19,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 158945280 10:50:19 INFO - 2016-02-07 10:50:19,164 DEBUG : BROWSER_OUTPUT: 10:50:22 INFO - 2016-02-07 10:50:22,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55229/tests/kraken/driver.html?testName=imaging-desaturate) 10:50:23 INFO - 2016-02-07 10:50:23,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 159506432 10:50:23 INFO - 2016-02-07 10:50:23,073 DEBUG : BROWSER_OUTPUT: 10:50:25 INFO - 2016-02-07 10:50:25,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55229/tests/kraken/driver.html?testName=json-parse-financial) 10:50:26 INFO - 2016-02-07 10:50:26,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 159301632 10:50:26 INFO - 2016-02-07 10:50:26,317 DEBUG : BROWSER_OUTPUT: 10:50:27 INFO - 2016-02-07 10:50:27,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:50:28 INFO - 2016-02-07 10:50:28,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 163418112 10:50:28 INFO - 2016-02-07 10:50:28,432 DEBUG : BROWSER_OUTPUT: 10:50:30 INFO - 2016-02-07 10:50:30,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:50:30 INFO - 2016-02-07 10:50:30,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 163262464 10:50:30 INFO - 2016-02-07 10:50:30,780 DEBUG : BROWSER_OUTPUT: 10:50:32 INFO - 2016-02-07 10:50:32,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:50:33 INFO - 2016-02-07 10:50:33,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 166641664 10:50:33 INFO - 2016-02-07 10:50:33,322 DEBUG : BROWSER_OUTPUT: 10:50:36 INFO - 2016-02-07 10:50:36,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:50:36 INFO - 2016-02-07 10:50:36,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 173944832 10:50:36 INFO - 2016-02-07 10:50:36,633 DEBUG : BROWSER_OUTPUT: 10:50:39 INFO - 2016-02-07 10:50:39,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:50:39 INFO - 2016-02-07 10:50:39,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 173273088 10:50:39 INFO - 2016-02-07 10:50:39,678 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55229/tests/kraken/driver.html?testName=ai-astar) 10:50:41 INFO - 2016-02-07 10:50:41,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 231903232 10:50:41 INFO - 2016-02-07 10:50:41,578 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,578 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;106;109;110;111;100;110;108;100 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;123;165;160;122;145;146;130;162;124 10:50:41 INFO - 2016-02-07 10:50:41,579 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;162;159;162;161;161;160;162;159;162 10:50:41 INFO - 2016-02-07 10:50:41,580 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;71;152;72;71;71;73;155;71 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;134;91;92;92;134;92;92;135 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;110;109;110;111;111 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;145;146;146;145;145;145 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;95;95;95;95;96 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;58;57;56;57;56;58;59;53;57 10:50:41 INFO - 2016-02-07 10:50:41,583 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;64;65;65;65;63;63;65 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;80;78;78;79;79;77;78;80;78 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;111;118;111;115;114;118;119;114;118 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;140;141;151;142;143;148;144;139;135 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;62;62;67;66;61;63;62;62 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,880 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: __startTimestamp1454871041577__endTimestamp 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:50:41 INFO - 2016-02-07 10:50:41,584 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.14 (3.8%) stddev-sans-first:4.38 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 106.0 109.0 110.0 111.0 100.0 110.0 108.0 100.0 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.00 stddev:16.80 (11.4%) stddev-sans-first:17.70 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: Values: 148.0 123.0 165.0 160.0 122.0 145.0 146.0 130.0 162.0 124.0 10:50:41 INFO - 2016-02-07 10:50:41,585 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,586 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.50 stddev:1.34 (0.8%) stddev-sans-first:1.27 10:50:41 INFO - 2016-02-07 10:50:41,586 DEBUG : BROWSER_OUTPUT: Values: 159.0 162.0 159.0 162.0 161.0 161.0 160.0 162.0 159.0 162.0 10:50:41 INFO - 2016-02-07 10:50:41,586 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,586 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:71.00 stddev:34.54 (48.6%) stddev-sans-first:36.08 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 152.0 72.0 71.0 71.0 73.0 155.0 71.0 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:92.00 stddev:20.39 (22.2%) stddev-sans-first:21.17 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 134.0 91.0 92.0 92.0 134.0 92.0 92.0 135.0 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 111.0 111.0 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,587 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.64 (2.9%) stddev-sans-first:1.72 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: Values: 56.0 58.0 57.0 56.0 57.0 56.0 58.0 59.0 53.0 57.0 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.93 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 65.0 65.0 65.0 63.0 63.0 65.0 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:1.07 (1.4%) stddev-sans-first:1.01 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 78.0 78.0 79.0 79.0 77.0 78.0 80.0 78.0 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:116.50 stddev:3.09 (2.7%) stddev-sans-first:3.08 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 118.0 111.0 115.0 114.0 118.0 119.0 114.0 118.0 10:50:41 INFO - 2016-02-07 10:50:41,588 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:142.50 stddev:5.80 (4.1%) stddev-sans-first:4.77 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: Values: 131.0 140.0 141.0 151.0 142.0 143.0 148.0 144.0 139.0 135.0 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:2.00 (3.2%) stddev-sans-first:2.12 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 62.0 62.0 67.0 66.0 61.0 63.0 62.0 62.0 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:50:41 INFO - 2016-02-07 10:50:41,589 DEBUG : BROWSER_OUTPUT: 10:50:42 INFO - 2016-02-07 10:50:42,294 INFO : Browser exited with error code: 0 10:50:42 INFO - 2016-02-07 10:50:42,343 INFO : Completed test kraken (00:00:58) 10:50:42 INFO - 2016-02-07 10:50:42,343 INFO : Starting test v8_7 10:50:42 INFO - 2016-02-07 10:50:42,343 DEBUG : operating with platform_type : linux_ 10:50:42 INFO - 2016-02-07 10:50:42,343 INFO : Initialising browser for v8_7 test... 10:50:42 INFO - 2016-02-07 10:50:42,349 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ_pbZ0/profile http://localhost:55229/getInfo.html 10:50:46 INFO - 2016-02-07 10:50:46,598 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:50:46 INFO - 2016-02-07 10:50:46,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:50:46 INFO - 2016-02-07 10:50:46,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:50:46 INFO - 2016-02-07 10:50:46,599 DEBUG : BROWSER_OUTPUT: __metrics 10:50:46 INFO - 2016-02-07 10:50:46,776 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] 10:50:47 INFO - 2016-02-07 10:50:47,518 INFO : Browser initialized. 10:50:47 INFO - 2016-02-07 10:50:47,519 INFO : Running cycle 1/1 for v8_7 test... 10:50:47 INFO - 2016-02-07 10:50:47,519 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ_pbZ0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:50:59 INFO - 2016-02-07 10:50:59,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 134328320 10:50:59 INFO - 2016-02-07 10:50:59,196 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55229/tests/v8_7/run.html (next: http://localhost:55229/tests/v8_7/run.html) 10:51:20 INFO - 2016-02-07 10:51:20,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 424132608 10:51:20 INFO - 2016-02-07 10:51:20,848 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,849 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:51:20 INFO - 2016-02-07 10:51:20,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:51:20 INFO - 2016-02-07 10:51:20,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:51:20 INFO - 2016-02-07 10:51:20,850 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:51:20 INFO - 2016-02-07 10:51:20,850 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 10:51:20 INFO - 2016-02-07 10:51:20,850 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.70158068438423 10:51:20 INFO - 2016-02-07 10:51:20,850 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 10:51:20 INFO - 2016-02-07 10:51:20,850 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 10:51:20 INFO - 2016-02-07 10:51:20,851 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 10:51:20 INFO - 2016-02-07 10:51:20,851 DEBUG : BROWSER_OUTPUT: |5;Earley;543.4782608695652 10:51:20 INFO - 2016-02-07 10:51:20,851 DEBUG : BROWSER_OUTPUT: |6;Boyer;10500 10:51:20 INFO - 2016-02-07 10:51:20,851 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 10:51:20 INFO - 2016-02-07 10:51:20,852 DEBUG : BROWSER_OUTPUT: |8;Splay;528.8207297726071 10:51:20 INFO - 2016-02-07 10:51:20,852 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:51:20 INFO - 2016-02-07 10:51:20,852 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:51:20 INFO - 2016-02-07 10:51:20,852 DEBUG : BROWSER_OUTPUT: __startTimestamp1454871080848__endTimestamp 10:51:20 INFO - 2016-02-07 10:51:20,853 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,853 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:51:20 INFO - 2016-02-07 10:51:20,853 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:51:20 INFO - 2016-02-07 10:51:20,853 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,854 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,854 DEBUG : BROWSER_OUTPUT: Values: 166.3 10:51:20 INFO - 2016-02-07 10:51:20,854 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,854 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.70 Median:173.70 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,855 DEBUG : BROWSER_OUTPUT: Values: 173.7 10:51:20 INFO - 2016-02-07 10:51:20,855 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,855 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,855 DEBUG : BROWSER_OUTPUT: Values: 278.1 10:51:20 INFO - 2016-02-07 10:51:20,856 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,856 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,856 DEBUG : BROWSER_OUTPUT: Values: 5175.3 10:51:20 INFO - 2016-02-07 10:51:20,856 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,857 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,857 DEBUG : BROWSER_OUTPUT: Values: 943.4 10:51:20 INFO - 2016-02-07 10:51:20,857 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,857 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.48 Median:543.48 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: Values: 543.5 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10500.00 Median:10500.00 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: Values: 10500.0 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: Values: 24261.9 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:528.82 Median:528.82 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,859 DEBUG : BROWSER_OUTPUT: Values: 528.8 10:51:20 INFO - 2016-02-07 10:51:20,860 DEBUG : BROWSER_OUTPUT: 10:51:20 INFO - 2016-02-07 10:51:20,860 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:51:20 INFO - 2016-02-07 10:51:20,860 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:51:20 INFO - 2016-02-07 10:51:20,860 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:51:20 INFO - 2016-02-07 10:51:20,860 DEBUG : BROWSER_OUTPUT: 10:51:21 INFO - 2016-02-07 10:51:21,562 INFO : Browser exited with error code: 0 10:51:21 INFO - 2016-02-07 10:51:21,579 INFO : Completed test v8_7 (00:00:39) 10:51:21 INFO - 2016-02-07 10:51:21,888 INFO : Completed test suite (00:20:11) 10:51:21 INFO - 2016-02-07 10:51:21,888 DEBUG : Working with test: dromaeo_css 10:51:21 INFO - 2016-02-07 10:51:21,888 DEBUG : Generating results file: dromaeo_css 10:51:21 INFO - 2016-02-07 10:51:21,889 DEBUG : Working with test: kraken 10:51:21 INFO - 2016-02-07 10:51:21,890 DEBUG : Generating results file: kraken 10:51:21 INFO - 2016-02-07 10:51:21,890 INFO : javascript benchmark 10:51:21 INFO - 2016-02-07 10:51:21,890 DEBUG : Working with test: v8_7 10:51:21 INFO - 2016-02-07 10:51:21,890 DEBUG : Generating results file: v8_7 10:51:21 INFO - 2016-02-07 10:51:21,891 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:51:21 INFO - 2016-02-07 10:51:21,951 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:51:21 INFO - 2016-02-07 10:51:21,951 DEBUG : process_Request line: dromaeo_css 7261.06 graph.html#tests=[[72,53,35]] 10:51:21 INFO - 2016-02-07 10:51:21,951 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:51:21 INFO - 2016-02-07 10:51:21,985 DEBUG : process_Request line: kraken 1472.80 graph.html#tests=[[232,53,35]] 10:51:21 INFO - 2016-02-07 10:51:21,985 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:51:22 INFO - 2016-02-07 10:51:22,017 DEBUG : process_Request line: v8_7 23185.41 graph.html#tests=[[230,53,35]] 10:51:22 INFO - 2016-02-07 10:51:22,018 INFO : javascript benchmark 10:51:22 INFO - 2016-02-07 10:51:22,022 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3266.7876588021777, 3313.1054615253897, 3383.0527452313345, 3383.1711230748456, 3387.69510744033, 5501.092319767238, 5573.777048918038, 5592.161175823623, 5596.272484576999, 5628.240187574676, 5534.916976245359, 5608.186812912136, 5608.327000759904, 5617.101263797793, 5629.380768115514, 4957.5786058185095, 5036.697798132123, 5068.873278168047, 5085.593152547805, 5170.896582068356, 4967.0810899983435, 5036.496350364971, 5037.24441333801, 5038.823641172559, 5043.268726034723, 4936.654434189608, 5034.924476132861, 5119.56483698886, 5138.409082955471, 5180.689158650474, 4984.875378115558, 5086.059079070384, 5088.211327244283, 5090.720010399426, 5112.207607820775, 5002.2246551784165, 5082.440931497532, 5091.1854103343285, 5119.539241468286, 5139.10065738498, 5232.293640358541, 5283.471652834724, 5400.83797486076, 5413.458654134555, 5424.701641409721, 5896.911546326808, 5976.0, 5982.760689572412, 5989.670568118751, 6005.429484198994, 5985.4912332451795, 6011.248593925759, 6025.487833534155, 6036.547258955552, 6046.818595442144, 5338.652987555835, 5380.166074258457, 5448.991936491761, 5490.56075513958, 5580.86047848807, 5954.4045595440975, 5996.310424301174, 6003.519718422515, 6013.819585412444, 6015.308239552507, 5839.854003649943, 5841.970790146022, 5843.152742852348, 5848.210491583667, 5853.882922341614, 5684.914726279109, 5804.042333015005, 5812.680302583314, 5894.440028197314, 5925.0, 5829.271341082364, 5937.52499800015, 5952.970235148883, 5963.19496867926, 5964.761409543657, 5675.829725108253, 5917.911231331534, 5927.2590926134235, 5943.673097979567, 5944.554158438134, 4498.3927169832305, 4506.369108324837, 4536.455625324982, 4561.064981678748, 4572.245579479415, 4056.6551843093666, 4059.69552283574, 4066.6340029397497, 4066.8169932353117, 4098.159877225162, 5356.384015838151, 5505.862353441116, 5579.4420557944695, 5592.888142237132, 5593.496585307261, 5794.739236734357, 5847.44449277318, 5865.032269675541, 5871.823845284648, 5885.705714714247, 5616.9157462638095, 5641.266635337462, 5648.0, 5649.943500564942, 5658.943410565924, 5052.393712754493, 5129.9230511542355, 5147.845564633067, 5186.611004174702, 5191.32512773337, 6055.1220073090035, 6058.909116363258, 6072.605280656743, 6081.939180608226, 6082.513398928075, 5943.286805583185, 5943.821685349447, 5947.583669143119, 5954.225950626391, 5963.970180149072, 5871.706414679335, 5904.940950590611, 5987.131865879336, 5993.190919226023, 6021.488173505301, 5827.679477628772, 5832.24180856486, 5835.533157347487, 5840.386759390203, 5841.269841269841, 5893.675847828411, 5938.287405511193, 5948.078047902582, 5952.0, 5966.612170208922, 5622.578306626938, 5688.0, 5796.913046304393, 5800.59395842287, 5815.0, 5793.94206057934, 5851.239338885917, 5853.560982926383, 5863.912041319299, 5868.295804503487, 5563.193336966198, 5771.163181338598, 5772.307323121252, 5776.220210271727, 5783.132530120515, 5710.2576665033275, 5746.281714785652, 5899.4985426239255, 5900.11498275245, 5929.495992840657, 5713.9142912855505, 5757.424257574209, 5760.337561180518, 5762.0, 5765.596408251382], "unit": "ms", "name": "dojo.html", "value": 5463.665278712586}, {"lowerIsBetter": false, "replicates": [616.5345164400877, 621.3662064694013, 634.112242859996, 635.199648442962, 635.5836926812933, 41934.370984435256, 42367.36448953268, 42813.0, 42852.0, 42872.57127428725, 47064.2940355895, 47884.28173577399, 48004.0, 48053.279200812016, 48104.0, 7881.60591970402, 8006.399520035991, 8006.599670016505, 9153.176214140743, 9353.859692104625, 10960.342379457219, 11141.387223702694, 11185.608503702371, 11201.215914885961, 11238.887611123906, 10613.0, 10803.351798892052, 10832.78334433311, 10844.915508449132, 10890.455477226147, 10791.784164316708, 10913.890861091368, 10923.39921304328, 10927.890721092766, 10959.726006849813, 10567.735806604896, 10806.081483073947, 10807.243492955497, 10812.29720068201, 10821.513031913582, 43552.12895742099, 43580.346294805604, 43780.3432948506, 43951.560484395064, 43981.0, 3525.7708248963736, 3565.144365352297, 3859.4403811447464, 4273.487181538236, 4388.626966707834, 34252.486212706826, 34396.82801586001, 34527.82736086329, 34644.82677586596, 34679.30641387183, 4206.326987681956, 4400.867973960754, 4421.977890110561, 4434.84478043267, 4444.355568442557, 309499.0, 311020.0, 311363.0, 312393.43803281063, 312893.0, 59211.70394148002, 59840.70079649661, 59975.40024599698, 66880.31837771309, 67380.32619673839, 72186.63906680433, 72902.27097729061, 73295.63352183312, 73310.0, 73367.63316183384, 16361.918190408971, 16739.832601674072, 16759.916200419164, 16764.413245536347, 16795.496135115965, 10841.512131954081, 10873.945630271955, 10886.183536234656, 10890.727731806768, 10966.835497467544, 21630.0, 22533.549329013327, 22549.098036078372, 22661.773382266296, 22693.319200423684, 7748.573828439377, 7809.765707028798, 7890.250426209501, 7945.443818932619, 7946.0, 938.8873335199684, 958.5255298627225, 1040.6929955663097, 1061.1139698351963, 1068.6740544133959, 26795.86602066977, 26935.86532067327, 27150.86424567904, 27283.590746138823, 27714.861425692743, 1033.1734612310122, 1118.9552417903192, 1186.6084192216547, 1210.291979192165, 1228.6436933289247, 13944.51194208198, 14400.495982640767, 14706.852931470763, 16628.7242397433, 17316.480505584852, 349635.0, 354443.0, 358014.0, 358634.0, 358673.0, 59006.40993590009, 59107.0, 59193.0, 59284.70357648184, 59332.0, 1442.3076923076771, 1449.6665766873468, 1451.7749748788954, 1457.6007033247988, 1469.1846025455975, 27430.725692742817, 31155.37689246248, 31211.687883120878, 31558.526622101144, 32023.679763202068, 48542.0, 49220.753896230286, 49227.75386123046, 49263.75368123136, 49299.26051109308, 214770.0, 215493.0, 216959.0, 217055.0, 217346.0, 32318.35363292674, 33208.0, 33907.0, 34900.301993959474, 35099.473507897914, 41405.79297103495, 41724.0, 41795.582044179166, 42627.57372426236, 42855.785721071195, 35524.822375887954, 36100.81949590235, 37893.62106378901, 38884.0, 40117.398239027025, 33510.832445837616, 37985.2402951945, 38906.61093389143, 39330.803345983084, 39816.40275395929, 34374.484382733775, 35061.47407788936, 35903.820480897426, 35923.0, 36291.637083628826, 31075.0, 34696.13259668528, 34870.476942846384, 34988.30023399467, 35634.82182589071, 25901.48197036011, 26562.203133906012, 26633.866830665724, 26645.8667706668, 26801.195964121107], "unit": "ms", "name": "ext.html", "value": 19911.95543146036}, {"lowerIsBetter": false, "replicates": [381.05498364057155, 382.3690909998502, 384.61538461538464, 384.6211481690535, 385.9864904728335, 16734.0, 16885.746713799304, 17310.71394723584, 17597.560060998465, 17621.03084330363, 13922.0, 17722.20250088746, 17866.553336166602, 18703.625927481444, 18725.438236852915, 5449.4005659377435, 5610.747516361774, 5620.887582248352, 6116.68491274377, 6242.31334553201, 5579.525740312058, 5592.5805564582615, 5595.300587426572, 5599.048161812481, 5602.831915042555, 5505.559555235592, 5538.335399752015, 5540.141278101901, 5543.916841247385, 5545.223668686387, 5515.365732940703, 5532.474414930575, 5541.0580201365465, 5542.667439953575, 5543.1408131739445, 5407.270018547524, 5536.861578460531, 5557.221988921554, 5560.138178582326, 5567.721613919329, 12769.48922043117, 12831.486740530368, 15571.532854014398, 22632.773672263233, 22679.773202268098, 2185.9234926777644, 2282.988585057081, 2341.976580234193, 2373.560891235127, 2460.495598402323, 13379.86620133796, 13931.512397066155, 14026.158430494203, 14137.0, 14179.858201417957, 1731.980058394749, 1817.155022914338, 1817.8454831339352, 1890.4990177602947, 1912.1586501939241, 66878.66560667215, 68396.97404538936, 69956.6502167491, 69961.0, 70584.6470767648, 11107.611233606785, 11116.610918617971, 11212.719682007852, 11219.66341009771, 11256.268342557707, 14980.250987450583, 15003.399864005318, 15010.849891501164, 15040.849591503946, 15063.322150503254, 6879.415249703831, 7031.542949708355, 7801.297883190427, 7822.178671239438, 7822.318201586686, 7509.211532789088, 7615.048118985127, 7620.885686714703, 7637.121731000895, 7665.463417560829, 4497.955020449754, 4624.745638989821, 4644.744539050317, 4855.295982082578, 4875.171220892456, 1732.7660765796456, 1765.7263124215767, 1779.2082523277277, 1788.8640713147245, 1806.467092207802, 817.721974528663, 928.2666693312208, 950.6435086842434, 968.9970880139023, 1053.8629978102797, 15818.52544423646, 16242.10668413225, 16470.83529164717, 16664.91667541679, 16671.333146674, 896.6189369517929, 900.9369344145978, 909.5270459361095, 999.8400255959011, 1008.3647302199568, 7883.448158628956, 9607.039296070338, 9655.758606034764, 9703.223742100616, 9725.0, 555473.0, 557861.0, 559963.0, 562530.0, 577322.0, 85106.0, 85394.0, 85496.0, 85840.57079714687, 86637.5668121668, 1155.820847768597, 1164.5283660117666, 1189.120051162134, 1189.2091758980182, 1208.9697757556132, 15528.611784705472, 15812.288447019682, 15849.207539623203, 15914.920425397799, 16079.0, 33802.154946125556, 33952.83023584866, 34409.82795086008, 35326.293474130885, 35427.291454170256, 50812.49187508078, 51670.48329516657, 51993.22010169775, 52524.47475525349, 53523.732381337846, 9988.550515226978, 10200.469929510633, 10225.488725563544, 10247.231457640855, 10418.166546676399, 12313.753724925273, 12446.315452650191, 12568.183068100545, 16961.321547137977, 18839.71740423922, 15666.451674191349, 15839.841601584298, 16010.279537421076, 16032.59918502, 16060.036397816168, 15037.248137593295, 15173.924130379277, 15571.37714491453, 15902.0, 16204.027758334538, 14702.852971470149, 14945.476908308157, 14969.0, 15467.613309666898, 16348.10085445312, 10270.435126068138, 10301.639442619473, 10338.276320657482, 10355.378677279386, 10410.427426491615, 14234.288285585471, 14343.856561434251, 14816.333265002886, 15536.456224032105, 15546.9222653886], "unit": "ms", "name": "jquery.html", "value": 9285.67523373936}, {"lowerIsBetter": false, "replicates": [1512.56135720641, 1568.1453607783756, 1591.037422359473, 1744.3197153110289, 1863.5993261448793, 7337.523061001031, 7484.513506622073, 7489.513181643203, 7494.925050749491, 7495.100587929443, 6415.037744338351, 6561.015847622859, 7143.464240181981, 7418.962905185466, 7476.700931962729, 2316.5830150572892, 2339.82451316152, 2362.433016076138, 2364.432536191319, 2364.6098393765096, 1993.4318719165042, 2299.908003679859, 2302.700648915647, 2360.0323867214447, 2360.386299562109, 1993.6012797440496, 2191.5835991161707, 2247.820174386053, 2249.9437514062197, 2250.032486031006, 2189.540196558725, 2205.0628482894704, 2236.9664455033108, 2275.590393729128, 2275.943101422461, 2265.512914723326, 2297.5634629420524, 2316.2049411705893, 2329.0683726509365, 2335.019291897407, 7460.664270107858, 7520.962395188044, 7537.736179233755, 7540.057492813398, 7542.43431742616, 4534.750588717619, 4616.39986801717, 4645.9303110453375, 4649.535046495357, 4659.603933665642, 2942.9117126486026, 2984.4777163996214, 2989.701029896993, 3006.8045577037424, 3171.0486853943953, 1118.8713297970676, 1118.9664310070712, 1129.074159189465, 1154.3824054131, 1160.2168536238005, 9780.315377923549, 10006.699799005968, 10011.699649010541, 10021.799564008752, 10021.949890250575, 4109.239790638741, 4152.314868046738, 4186.979065104655, 4210.621044106045, 4215.620594146541, 8375.288100511525, 8379.203975622428, 8380.916190838014, 8384.916150838535, 8395.664173432995, 4620.630349572026, 4638.489766125724, 4671.159191345522, 4681.485036645966, 4681.836135735233, 4311.525732169459, 4335.7615331157085, 4339.891502712458, 4340.934885976713, 4344.218040752632, 3500.649935006479, 3511.8068506232403, 3525.4183059794846, 3542.3977923753023, 3548.0952357148763, 960.9711708648751, 985.8373368394278, 1047.3244757131608, 1105.90599799018, 1106.756513567014, 1074.9946250268856, 1121.4000509727257, 1131.852859128308, 1334.5262431836752, 1444.949426770058, 7000.272364869864, 7027.43780497559, 7031.0859588254225, 7035.6482175891, 7105.396041336544, 1155.1682788392345, 1173.2432580985217, 1175.1069187417625, 1186.3297237061033, 1205.8673545909942, 5682.687452190169, 5776.075827867605, 5783.306003279633, 5788.3343415506915, 5797.449242321973, 8601.655933762704, 8715.477071375737, 8839.51382673959, 8856.468611883307, 9011.504367259864, 8830.514321712368, 8831.161039701217, 8831.205191532792, 8832.470051796912, 8836.293096552261, 7156.391706704884, 7160.10498687664, 7193.568385896863, 7195.280471952763, 7316.487845850846, 7239.710411583477, 7353.889691654736, 7354.0, 7357.889631655637, 7361.631918404166, 7944.483608565656, 8305.833883322179, 8308.418410711434, 8314.833703326021, 8340.04089529712, 8037.8392432152195, 8080.232377924088, 8190.099089100313, 8200.507969521848, 8213.917860821315, 6672.399484046265, 6937.375636192767, 6941.47938904574, 6960.199577048705, 6962.1297337832775, 7363.410927125924, 7369.705211791468, 7377.704891804482, 7383.593902335423, 7399.334059934632, 5842.269716285465, 6826.112605361272, 7016.333448322402, 7042.753503627553, 7132.393746531603, 6855.177378714387, 6858.897116543156, 6912.0, 6978.127734033246, 6980.650967451708, 6630.46956243509, 6720.529562930548, 6741.494387920828, 6743.898841517479, 6751.054852320581, 6472.093906852951, 6509.641969691713, 6514.283428822731, 6519.0, 6519.706613202512, 6344.1118243445035, 6398.744050238124, 6409.0, 6416.294207637249, 6452.709628066842], "unit": "ms", "name": "mootools.html", "value": 4420.6162786805935}, {"lowerIsBetter": false, "replicates": [330.2206791970948, 335.10359787568257, 338.61905356473966, 343.8658923020022, 347.4094040131775, 6166.290876549198, 6205.131281620576, 6223.471004964572, 6243.906341404882, 6264.84337891553, 5867.618604790686, 6011.669358185298, 6052.0, 6109.450149486545, 6116.724747386367, 4730.810767569293, 4741.881452963669, 4751.097291514601, 4751.5010923853015, 4765.618750499952, 4718.528147185289, 4739.763011849411, 4747.90504189916, 4752.263399173116, 4753.287006948951, 4482.0, 4583.12920545097, 4590.885227869297, 4671.252599584067, 4679.672422930379, 4672.696274742131, 4672.883177920545, 4682.0, 4684.180268453041, 4686.27362758773, 4138.79306034697, 4140.213359461693, 4143.461350024508, 4147.460830092099, 4158.189153115144, 5750.827475175752, 5820.272465941757, 5835.5915085944, 5842.211301474332, 5854.677992710442, 5519.9448005519835, 5529.502344788948, 5531.640443371168, 5537.972310138423, 5542.0855558832745, 6520.11978382917, 6525.510586706016, 6525.575837570543, 6531.7387304507765, 6532.248791389004, 4615.0, 4619.838305659319, 4619.884502887421, 4623.537646235383, 4625.95374046262, 6665.333466653345, 6688.297728738461, 6731.69707363165, 6761.661916904135, 6770.492213084039, 4711.199096153662, 4718.292256161534, 4719.858404247878, 4720.315554244616, 4723.95276047242, 4777.116233496814, 4777.4505931818285, 4778.1638213312535, 4780.95219047805, 4780.976095119572, 5465.836024919259, 5493.862653433696, 5493.945060549423, 5495.230667706524, 5500.0, 6454.903176452357, 6588.604683718896, 6594.07682924391, 6609.537332386687, 6612.702428390734, 1676.3546034776698, 1696.414736915762, 1697.711389063862, 1697.7198762204098, 1698.2357938927532, 1109.4785450838094, 1141.5604992077945, 1142.0463912633045, 1158.80879654856, 1167.6205233299042, 6336.239651241881, 6350.587211831216, 6359.586626869239, 6362.141110950055, 6370.331115232834, 6791.3548212919695, 6793.966030169818, 6794.898076528856, 6796.35434633709, 6810.489213309022, 6202.883480973378, 6294.370562943761, 6322.841928951813, 6423.582467139621, 6444.677766111676, 3681.0, 3699.944500832436, 3702.740808143458, 3704.0924973381693, 3705.5368078990127, 6991.510594258455, 6999.300069993062, 7010.894836577456, 7012.387150955309, 7014.859702805916, 6853.383195512328, 7010.123734533184, 7054.717811287491, 7074.92925070753, 7080.858382832314, 7024.051753013277, 7027.43780497559, 7037.577745335297, 7041.366277035091, 7041.859162816715, 6640.767573134917, 6799.082123913208, 6881.380675739208, 6884.65576721172, 6889.586624802528, 6703.865922681616, 6749.5612785168805, 6787.117674702455, 6787.592744435349, 6799.116114905229, 6982.895256571257, 6986.0, 7005.894911576433, 7014.193367762568, 7018.403435707818, 4589.5639914208095, 4641.698289611165, 4668.11305851887, 4675.0416164685475, 4680.391549098732, 6873.450123990169, 6887.20797108339, 6888.586684798928, 6894.172699276119, 6895.207051188977, 6656.7337306509135, 6684.665766711742, 6692.564983276072, 6701.430378417889, 6701.966490167518, 6549.508786841101, 6664.8000559983275, 6673.165854268216, 6673.432758215412, 6675.165604299463, 6572.112764776694, 6579.243387010555, 6581.078648989241, 6586.637734924433, 6588.439982601532, 6673.399394054559, 6676.1988561371, 6678.799636010927, 6680.5991640501725, 6683.899741503784, 6361.014042823184, 6508.284088750328, 6521.119648847345, 6522.739090436329, 6567.802965910839], "unit": "ms", "name": "prototype.html", "value": 4974.834187060944}, {"lowerIsBetter": false, "replicates": [842.5618678287294, 858.4505916213624, 874.4403581707707, 874.5583480342426, 892.611713904452, 13156.407961641726, 13361.93104551636, 13372.799408008876, 13390.330483475811, 13407.329633518333, 13211.801822972639, 13219.933900330509, 13257.668558286048, 13292.401841917113, 13306.201627902332, 735.2096496266508, 743.9404847612178, 892.7500299916034, 896.4442045931531, 906.4923642760042, 893.5710858787786, 902.440486898124, 906.1663269791808, 907.4555266839909, 909.9590518426687, 779.7894568466539, 899.4468401932829, 921.9953900230489, 924.5700749151644, 927.8329900617886, 773.443120952913, 931.483026920059, 943.4810854030256, 944.9433034017912, 946.7917058247175, 691.6576294734089, 697.4141720954423, 700.4921431961837, 700.9649517524155, 700.9684564194623, 13634.522791702242, 13812.930935345259, 13838.792418113737, 13842.792358114637, 13860.93069534656, 13029.478820847155, 13158.342082895913, 13174.407151678197, 13355.599332020054, 13459.0, 10816.567337306498, 10820.350778953289, 10833.133349332034, 10869.945650271698, 10943.616973405971, 3795.8102094895144, 3839.884803455901, 3906.7655940643654, 3908.882733517999, 3920.0, 46524.76737616324, 46796.7660161697, 47002.2949655752, 47491.52508474905, 47590.0, 9036.909630903607, 9421.340506164639, 9454.43273403598, 9467.715968520955, 9534.141927226445, 17313.39403120885, 17327.65344693099, 17353.132343382782, 17367.65264694699, 17380.739288910678, 7705.383569314441, 7827.178146294671, 7845.0978137513775, 7879.921200787919, 7995.200479951958, 4232.978835105805, 4242.66058715302, 4270.850520231777, 4328.935065974013, 4408.867733967986, 3056.770742194344, 3091.0108765195373, 3094.0, 3095.272610936428, 3095.92260193497, 515.2760371677799, 528.426657077068, 531.9920201196985, 536.3215532351501, 538.4507802041895, 605.5670195809929, 709.2163159708551, 711.3420086420041, 717.3866344275674, 735.6910097758954, 8011.399145064143, 8733.0, 8805.119488051143, 8936.106389361012, 9041.095890410907, 517.9378474583074, 614.0206370838505, 618.11300783376, 675.8546912413855, 729.3581648149594, 4081.0817566047403, 4212.936805947913, 4298.183345164409, 4301.290287102655, 4312.288472402019, 58216.0, 58675.0, 58913.41086589079, 61566.0, 61929.69035154885, 54551.0, 54555.18167227495, 55381.72309138429, 56322.718386408626, 56615.43384566184, 50454.74772626187, 50547.98904021899, 50843.0, 50903.49096509062, 52564.73717631387, 8670.219680228809, 8685.174908383693, 8709.520976346363, 8933.731988040368, 9037.367384283038, 39521.80239098786, 39552.40671389989, 39805.60194398019, 40705.79647101864, 40892.386614200215, 49097.50902491072, 49169.0, 49652.75173624109, 49743.25385119153, 49745.502544975534, 11938.28370297785, 12079.094067944763, 12085.335306558223, 12275.75448491043, 12325.630231093082, 12800.03999700045, 12929.482820687443, 13148.34258287101, 13151.29785172806, 13483.932580337429, 11660.650180494598, 11713.238639488405, 11802.173847830913, 11877.287362758263, 12153.08851836098, 12229.69425764363, 12412.56556020535, 12439.136973450948, 12617.242965422103, 12619.87380126187, 11351.318920864775, 11369.54521819118, 11641.59254426125, 11647.941760291144, 11739.119566032752, 10630.84053739179, 10748.83876741865, 10852.131829453783, 10994.560217591206, 11096.167787415814, 10028.548715307683, 10304.0, 10324.328918620266, 10347.896521034694, 10351.120154786626], "unit": "ms", "name": "yui.html", "value": 6596.0836856937985}], "name": "dromaeo_css", "value": 7261.058584617573}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 106.0, 109.0, 110.0, 111.0, 100.0, 110.0, 108.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 165.0, 160.0, 122.0, 145.0, 146.0, 130.0, 162.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [159.0, 162.0, 159.0, 162.0, 161.0, 161.0, 160.0, 162.0, 159.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 152.0, 72.0, 71.0, 71.0, 73.0, 155.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 91.0, 92.0, 92.0, 134.0, 92.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 56.0, 58.0, 59.0, 53.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 65.0, 65.0, 65.0, 63.0, 63.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 78.0, 78.0, 79.0, 79.0, 77.0, 78.0, 80.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 118.0, 111.0, 115.0, 114.0, 118.0, 119.0, 114.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [131.0, 140.0, 141.0, 151.0, 142.0, 143.0, 148.0, 144.0, 139.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 62.0, 62.0, 67.0, 66.0, 61.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1472.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [173.70158068438423], "unit": "score", "name": "DeltaBlue", "value": 380.64132600000005}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [543.4782608695652], "unit": "score", "name": "Earley", "value": 1226.2919200000001}, {"lowerIsBetter": false, "replicates": [10500.0], "unit": "score", "name": "Boyer", "value": 63.47266666666663}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [528.8207297726071], "unit": "score", "name": "Splay", "value": 154.099481}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23185.40871008941}]} 10:51:22 INFO - RETURN: dromaeo_css: 7261.06 10:51:22 INFO - RETURN: kraken: 1472.80 10:51:22 INFO - RETURN: v8_7: 23185.41 10:51:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23185.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7261.06"}}} 10:51:22 INFO - Return code: 0 10:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:51:22 INFO - # TBPL SUCCESS # 10:51:22 INFO - Running post-action listener: _resource_record_post_action 10:51:22 INFO - Running post-run listener: _resource_record_post_run 10:51:23 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 7884800; Write bytes: 399228928; Read time: 1244; Write time: 406248 10:51:23 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 3833856; Read time: 0; Write time: 476 10:51:23 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 7880704; Write bytes: 395395072; Read time: 1228; Write time: 405772 10:51:23 INFO - Running post-run listener: _upload_blobber_files 10:51:23 INFO - Blob upload gear active. 10:51:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:51:23 INFO - Copying logs to upload dir... 10:51:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.559722 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-07 10:51:23.227935) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-07 10:51:23.231802) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009913 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454861058/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-07 10:51:23.283795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:51:23.284175) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1454868842.13314-772798628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 10:51:23.334330) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-07 10:51:23.334685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-07 10:51:23.335026) ========= ========= Total master_lag: 0.26 =========