builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1455587725.42 results: success (0) buildid: 20160215152751 builduid: bd16ff65c1b540cfb79f517459908730 revision: 638572acfc9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.417621) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.422867) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.423240) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004394 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.483908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.484382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.532376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.532987) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037584 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.587033) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.587482) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.590567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.591029) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 17:55:25-- 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-15 17:55:26 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.798962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.799348) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047401 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.856668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:25.857043) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 638572acfc9e --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 638572acfc9e --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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 17:55:26,146 Setting DEBUG logging. 2016-02-15 17:55:26,146 attempt 1/10 2016-02-15 17:55:26,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/638572acfc9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 17:55:26,548 unpacking tar archive at: mozilla-beta-638572acfc9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.864068 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:26.737698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:26.738107) ========= echo 638572acfc9e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'638572acfc9e'] 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 638572acfc9e program finished with exit code 0 elapsedTime=0.004591 script_repo_revision: '638572acfc9e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:26.790067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:26.790495) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 17:55:26.800740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-15 17:55:26.801098) ========= /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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:27 INFO - MultiFileLogger online at 20160215 17:55:27 in /builds/slave/test-pgo 17:55:27 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 17:55:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:55:27 INFO - {'append_to_log': False, 17:55:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:55:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:55:27 INFO - 'branch': 'Mozilla-Beta', 17:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:27 INFO - 'config_files': ('talos/linux_config.py',), 17:55:27 INFO - 'default_actions': ('clobber', 17:55:27 INFO - 'read-buildbot-config', 17:55:27 INFO - 'download-and-extract', 17:55:27 INFO - 'populate-webroot', 17:55:27 INFO - 'create-virtualenv', 17:55:27 INFO - 'install', 17:55:27 INFO - 'run-tests'), 17:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:27 INFO - 'download_minidump_stackwalk': True, 17:55:27 INFO - 'download_symbols': 'ondemand', 17:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:27 INFO - 'installer_path': 'installer.exe', 17:55:27 INFO - 'log_level': 'info', 17:55:27 INFO - 'log_name': 'talos', 17:55:27 INFO - 'log_to_console': True, 17:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:27 INFO - 'opt_config_files': (), 17:55:27 INFO - 'pip_index': False, 17:55:27 INFO - 'sps_profile': False, 17:55:27 INFO - 'sps_profile_interval': 0, 17:55:27 INFO - 'suite': 'dromaeojs', 17:55:27 INFO - 'system_bits': '32', 17:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:27 INFO - 'title': 'talos-linux64-ix-060', 17:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:27 INFO - 'use_talos_json': True, 17:55:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:27 INFO - 'work_dir': 'build'} 17:55:27 INFO - ##### 17:55:27 INFO - ##### Running clobber step. 17:55:27 INFO - ##### 17:55:27 INFO - Running pre-action listener: _resource_record_pre_action 17:55:27 INFO - Running main action method: clobber 17:55:27 INFO - rmtree: /builds/slave/test-pgo/build 17:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:55:28 INFO - Running post-action listener: _resource_record_post_action 17:55:28 INFO - ##### 17:55:28 INFO - ##### Running read-buildbot-config step. 17:55:28 INFO - ##### 17:55:28 INFO - Running pre-action listener: _resource_record_pre_action 17:55:28 INFO - Running main action method: read_buildbot_config 17:55:28 INFO - Using buildbot properties: 17:55:28 INFO - { 17:55:28 INFO - "properties": { 17:55:28 INFO - "buildnumber": 124, 17:55:28 INFO - "product": "firefox", 17:55:28 INFO - "script_repo_revision": "production", 17:55:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:55:28 INFO - "repository": "", 17:55:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:55:28 INFO - "buildid": "20160215152751", 17:55:28 INFO - "slavename": "talos-linux64-ix-060", 17:55:28 INFO - "pgo_build": "True", 17:55:28 INFO - "basedir": "/builds/slave/test-pgo", 17:55:28 INFO - "project": "", 17:55:28 INFO - "platform": "ubuntu64_hw", 17:55:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:55:28 INFO - "slavebuilddir": "test", 17:55:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:55:28 INFO - "branch": "mozilla-beta", 17:55:28 INFO - "repo_path": "releases/mozilla-beta", 17:55:28 INFO - "stage_platform": "linux64-pgo", 17:55:28 INFO - "builduid": "bd16ff65c1b540cfb79f517459908730", 17:55:28 INFO - "revision": "638572acfc9e" 17:55:28 INFO - }, 17:55:28 INFO - "sourcestamp": { 17:55:28 INFO - "repository": "", 17:55:28 INFO - "hasPatch": false, 17:55:28 INFO - "project": "", 17:55:28 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 17:55:28 INFO - "changes": [ 17:55:28 INFO - { 17:55:28 INFO - "category": null, 17:55:28 INFO - "files": [ 17:55:28 INFO - { 17:55:28 INFO - "url": null, 17:55:28 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2" 17:55:28 INFO - } 17:55:28 INFO - ], 17:55:28 INFO - "repository": "", 17:55:28 INFO - "rev": "638572acfc9e", 17:55:28 INFO - "who": "sendchange", 17:55:28 INFO - "when": 1455587689, 17:55:28 INFO - "number": 7607669, 17:55:28 INFO - "comments": "Packaging bustage fix following bug 1239828 - package only the loop add-on and not the whole features directory. rs=glandium CLOSED TREE", 17:55:28 INFO - "project": "", 17:55:28 INFO - "at": "Mon 15 Feb 2016 17:54:49", 17:55:28 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 17:55:28 INFO - "revlink": "", 17:55:28 INFO - "properties": [ 17:55:28 INFO - [ 17:55:28 INFO - "buildid", 17:55:28 INFO - "20160215152751", 17:55:28 INFO - "Change" 17:55:28 INFO - ], 17:55:28 INFO - [ 17:55:28 INFO - "builduid", 17:55:28 INFO - "bd16ff65c1b540cfb79f517459908730", 17:55:28 INFO - "Change" 17:55:28 INFO - ], 17:55:28 INFO - [ 17:55:28 INFO - "pgo_build", 17:55:28 INFO - "True", 17:55:28 INFO - "Change" 17:55:28 INFO - ] 17:55:28 INFO - ], 17:55:28 INFO - "revision": "638572acfc9e" 17:55:28 INFO - } 17:55:28 INFO - ], 17:55:28 INFO - "revision": "638572acfc9e" 17:55:28 INFO - } 17:55:28 INFO - } 17:55:28 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2. 17:55:28 INFO - Running post-action listener: _resource_record_post_action 17:55:28 INFO - ##### 17:55:28 INFO - ##### Running download-and-extract step. 17:55:28 INFO - ##### 17:55:28 INFO - Running pre-action listener: _resource_record_pre_action 17:55:28 INFO - Running main action method: download_and_extract 17:55:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:55:28 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')]} 17:55:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/test_packages.json 17:55:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:55:28 INFO - Downloaded 1270 bytes. 17:55:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:55:28 INFO - Using the following test package requirements: 17:55:28 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:55:28 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:55:28 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'jsshell-linux-x86_64.zip'], 17:55:28 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:55:28 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:55:28 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 17:55:28 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 17:55:28 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:55:28 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 17:55:28 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 17:55:28 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:55:28 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:55:28 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')]} 17:55:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:55:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:30 INFO - Downloaded 22211717 bytes. 17:55:30 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 17:55:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:55:30 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 17:55:31 INFO - Return code: 0 17:55:31 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 17:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:55:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:31 INFO - Downloaded 22211717 bytes. 17:55:31 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 17:55:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 17:55:31 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 17:55:32 INFO - Return code: 0 17:55:32 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')]} 17:55:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 17:55:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:35 INFO - Downloaded 11132038 bytes. 17:55:35 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 17:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 17:55:35 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 17:55:35 INFO - Return code: 0 17:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:55:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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 17:55:40 INFO - Downloaded 58301096 bytes. 17:55:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:55:40 INFO - mkdir: /builds/slave/test-pgo/properties 17:55:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:55:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:55:40 INFO - Contents: 17:55:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2 17:55:40 INFO - Running post-action listener: _resource_record_post_action 17:55:40 INFO - Running post-action listener: set_extra_try_arguments 17:55:40 INFO - ##### 17:55:40 INFO - ##### Running populate-webroot step. 17:55:40 INFO - ##### 17:55:40 INFO - Running pre-action listener: _resource_record_pre_action 17:55:40 INFO - Running main action method: populate_webroot 17:55:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:55:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:55:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:55:40 INFO - '--tppagecycles', 17:55:40 INFO - '7'], 17:55:40 INFO - 'tests': ['tsvgm']}}, 17:55:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:55:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:55:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:55:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:55:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'tests': ['damp', 'tps']}, 17:55:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['damp', 'tps']}, 17:55:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:55:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:40 INFO - 'other': {'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'other_l64': {'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'other_nol64': {'tests': ['a11yr', 17:55:40 INFO - 'ts_paint', 17:55:40 INFO - 'tpaint', 17:55:40 INFO - 'sessionrestore', 17:55:40 INFO - 'sessionrestore_no_auto_restore']}, 17:55:40 INFO - 'svgr': {'tests': ['tsvgx', 17:55:40 INFO - 'tsvgr_opacity', 17:55:40 INFO - 'tart', 17:55:40 INFO - 'tscrollx', 17:55:40 INFO - 'cart']}, 17:55:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['tsvgx', 17:55:40 INFO - 'tsvgr_opacity', 17:55:40 INFO - 'tart', 17:55:40 INFO - 'tscrollx', 17:55:40 INFO - 'cart']}, 17:55:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'tests': ['tp5o']}, 17:55:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'talos_options': ['--e10s'], 17:55:40 INFO - 'tests': ['tp5o']}, 17:55:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'talos_options': ['--xperf_path', 17:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:40 INFO - 'tests': ['tp5n']}, 17:55:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:55:40 INFO - 'talos_options': ['--e10s', 17:55:40 INFO - '--xperf_path', 17:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:40 INFO - 'tests': ['tp5n']}}, 17:55:40 INFO - 'talos.zip': {'path': '', 17:55:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:55:40 INFO - Running post-action listener: _resource_record_post_action 17:55:40 INFO - ##### 17:55:40 INFO - ##### Running create-virtualenv step. 17:55:40 INFO - ##### 17:55:40 INFO - Running pre-action listener: _resource_record_pre_action 17:55:40 INFO - Running main action method: create_virtualenv 17:55:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:55:40 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 17:55:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:55:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:40 INFO - Using real prefix '/usr' 17:55:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:55:41 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:43 INFO - Installing pip.................done. 17:55:43 INFO - Return code: 0 17:55:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:55:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:55:43 INFO - Using env: {'DISPLAY': ':0', 17:55:43 INFO - 'HOME': '/home/cltbld', 17:55:43 INFO - 'LANG': 'en_US.UTF-8', 17:55:43 INFO - 'LANGUAGE': 'en_US:en', 17:55:43 INFO - 'LOGNAME': 'cltbld', 17:55:43 INFO - 'MAIL': '/var/mail/cltbld', 17:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:43 INFO - 'MOZ_NO_REMOTE': '1', 17:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:43 INFO - 'NO_EM_RESTART': '1', 17:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:43 INFO - 'SHELL': '/bin/bash', 17:55:43 INFO - 'SHLVL': '1', 17:55:43 INFO - 'TERM': 'linux', 17:55:43 INFO - 'TMOUT': '86400', 17:55:43 INFO - 'USER': 'cltbld', 17:55:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:43 INFO - '_': '/tools/buildbot/bin/python'} 17:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:43 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 17:55:43 INFO - Cleaning up... 17:55:43 INFO - Return code: 0 17:55:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:55:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:55:43 INFO - Using env: {'DISPLAY': ':0', 17:55:43 INFO - 'HOME': '/home/cltbld', 17:55:43 INFO - 'LANG': 'en_US.UTF-8', 17:55:43 INFO - 'LANGUAGE': 'en_US:en', 17:55:43 INFO - 'LOGNAME': 'cltbld', 17:55:43 INFO - 'MAIL': '/var/mail/cltbld', 17:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:43 INFO - 'MOZ_NO_REMOTE': '1', 17:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:43 INFO - 'NO_EM_RESTART': '1', 17:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:43 INFO - 'SHELL': '/bin/bash', 17:55:43 INFO - 'SHLVL': '1', 17:55:43 INFO - 'TERM': 'linux', 17:55:43 INFO - 'TMOUT': '86400', 17:55:43 INFO - 'USER': 'cltbld', 17:55:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:43 INFO - '_': '/tools/buildbot/bin/python'} 17:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:43 INFO - Downloading/unpacking psutil>=0.7.1 17:55:43 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 17:55:43 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 17:55:43 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 17:55:43 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 17:55:43 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 17:55:43 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 17:55:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:45 INFO - Installing collected packages: psutil 17:55:45 INFO - Running setup.py install for psutil 17:55:45 INFO - building 'psutil._psutil_linux' extension 17:55:45 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 17:55:46 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 17:55:46 INFO - building 'psutil._psutil_posix' extension 17:55:46 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 17:55:46 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 17:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:46 INFO - Successfully installed psutil 17:55:46 INFO - Cleaning up... 17:55:46 INFO - Return code: 0 17:55:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:55:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:55:46 INFO - Using env: {'DISPLAY': ':0', 17:55:46 INFO - 'HOME': '/home/cltbld', 17:55:46 INFO - 'LANG': 'en_US.UTF-8', 17:55:46 INFO - 'LANGUAGE': 'en_US:en', 17:55:46 INFO - 'LOGNAME': 'cltbld', 17:55:46 INFO - 'MAIL': '/var/mail/cltbld', 17:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:46 INFO - 'MOZ_NO_REMOTE': '1', 17:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:46 INFO - 'NO_EM_RESTART': '1', 17:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:46 INFO - 'SHELL': '/bin/bash', 17:55:46 INFO - 'SHLVL': '1', 17:55:46 INFO - 'TERM': 'linux', 17:55:46 INFO - 'TMOUT': '86400', 17:55:46 INFO - 'USER': 'cltbld', 17:55:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:46 INFO - '_': '/tools/buildbot/bin/python'} 17:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:55:48 INFO - Installing collected packages: mozsystemmonitor 17:55:48 INFO - Running setup.py install for mozsystemmonitor 17:55:49 INFO - Successfully installed mozsystemmonitor 17:55:49 INFO - Cleaning up... 17:55:49 INFO - Return code: 0 17:55:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:55:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:55:49 INFO - Using env: {'DISPLAY': ':0', 17:55:49 INFO - 'HOME': '/home/cltbld', 17:55:49 INFO - 'LANG': 'en_US.UTF-8', 17:55:49 INFO - 'LANGUAGE': 'en_US:en', 17:55:49 INFO - 'LOGNAME': 'cltbld', 17:55:49 INFO - 'MAIL': '/var/mail/cltbld', 17:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:49 INFO - 'MOZ_NO_REMOTE': '1', 17:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:49 INFO - 'NO_EM_RESTART': '1', 17:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:49 INFO - 'SHELL': '/bin/bash', 17:55:49 INFO - 'SHLVL': '1', 17:55:49 INFO - 'TERM': 'linux', 17:55:49 INFO - 'TMOUT': '86400', 17:55:49 INFO - 'USER': 'cltbld', 17:55:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:49 INFO - '_': '/tools/buildbot/bin/python'} 17:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:55:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:51 INFO - Downloading docopt-0.6.1.tar.gz 17:55:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:51 INFO - Running setup.py install for blobuploader 17:55:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:55:51 INFO - Running setup.py install for requests 17:55:52 INFO - Running setup.py install for docopt 17:55:52 INFO - Successfully installed blobuploader requests docopt 17:55:52 INFO - Cleaning up... 17:55:52 INFO - Return code: 0 17:55:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:52 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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:52 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 17:55:52 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 17:55:52 INFO - Using env: {'DISPLAY': ':0', 17:55:52 INFO - 'HOME': '/home/cltbld', 17:55:52 INFO - 'LANG': 'en_US.UTF-8', 17:55:52 INFO - 'LANGUAGE': 'en_US:en', 17:55:52 INFO - 'LOGNAME': 'cltbld', 17:55:52 INFO - 'MAIL': '/var/mail/cltbld', 17:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:52 INFO - 'MOZ_NO_REMOTE': '1', 17:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:52 INFO - 'NO_EM_RESTART': '1', 17:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:52 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:52 INFO - 'SHELL': '/bin/bash', 17:55:52 INFO - 'SHLVL': '1', 17:55:52 INFO - 'TERM': 'linux', 17:55:52 INFO - 'TMOUT': '86400', 17:55:52 INFO - 'USER': 'cltbld', 17:55:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:52 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:55:52 INFO - Running setup.py (path:/tmp/pip-wRVTbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:55:52 INFO - Running setup.py (path:/tmp/pip-UMdOc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:55:52 INFO - Running setup.py (path:/tmp/pip-K4aTBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:55:52 INFO - Running setup.py (path:/tmp/pip-6Tv6tW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:55:52 INFO - Running setup.py (path:/tmp/pip-VuDGYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:55:52 INFO - Running setup.py (path:/tmp/pip-9aVFlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:55:53 INFO - Running setup.py (path:/tmp/pip-nfZGXn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:55:53 INFO - Running setup.py (path:/tmp/pip-RH16Xv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:55:53 INFO - Running setup.py (path:/tmp/pip-k5wX0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:55:53 INFO - Running setup.py (path:/tmp/pip-46vzjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:55:53 INFO - Running setup.py (path:/tmp/pip-WOBC9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:55:53 INFO - Running setup.py (path:/tmp/pip-Q72xI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:55:53 INFO - Running setup.py (path:/tmp/pip-8ogtu0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:55:53 INFO - Running setup.py (path:/tmp/pip-fuDZt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:55:53 INFO - Running setup.py (path:/tmp/pip-IZbuKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:55:53 INFO - Running setup.py (path:/tmp/pip-PAu_b9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:55:53 INFO - Running setup.py (path:/tmp/pip-49EuzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:55:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:53 INFO - Running setup.py install for manifestparser 17:55:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:55:53 INFO - Running setup.py install for mozcrash 17:55:54 INFO - Running setup.py install for mozdebug 17:55:54 INFO - Running setup.py install for mozdevice 17:55:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for mozfile 17:55:54 INFO - Running setup.py install for mozhttpd 17:55:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for mozinfo 17:55:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for mozInstall 17:55:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for mozleak 17:55:54 INFO - Running setup.py install for mozlog 17:55:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for moznetwork 17:55:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:55:54 INFO - Running setup.py install for mozprocess 17:55:55 INFO - Running setup.py install for mozprofile 17:55:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:55:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:55:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:55:55 INFO - Running setup.py install for mozrunner 17:55:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:55:55 INFO - Running setup.py install for mozscreenshot 17:55:55 INFO - Running setup.py install for moztest 17:55:55 INFO - Running setup.py install for mozversion 17:55:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:55:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:55 INFO - Cleaning up... 17:55:55 INFO - Return code: 0 17:55:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:55 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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:55 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 17:55:55 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 17:55:55 INFO - Using env: {'DISPLAY': ':0', 17:55:55 INFO - 'HOME': '/home/cltbld', 17:55:55 INFO - 'LANG': 'en_US.UTF-8', 17:55:55 INFO - 'LANGUAGE': 'en_US:en', 17:55:55 INFO - 'LOGNAME': 'cltbld', 17:55:55 INFO - 'MAIL': '/var/mail/cltbld', 17:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:55 INFO - 'MOZ_NO_REMOTE': '1', 17:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:55 INFO - 'NO_EM_RESTART': '1', 17:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:55 INFO - 'SHELL': '/bin/bash', 17:55:55 INFO - 'SHLVL': '1', 17:55:55 INFO - 'TERM': 'linux', 17:55:55 INFO - 'TMOUT': '86400', 17:55:55 INFO - 'USER': 'cltbld', 17:55:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:55 INFO - '_': '/tools/buildbot/bin/python'} 17:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:55:55 INFO - Running setup.py (path:/tmp/pip-4CAQTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:55:55 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)) 17:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:55:55 INFO - Running setup.py (path:/tmp/pip-oDqjG9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:55:55 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)) 17:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:55:55 INFO - Running setup.py (path:/tmp/pip-cxx3Wc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:55:56 INFO - Running setup.py (path:/tmp/pip-HMQgwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:55:56 INFO - Running setup.py (path:/tmp/pip-w6vXPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:55:56 INFO - Running setup.py (path:/tmp/pip-cNSOVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:55:56 INFO - Running setup.py (path:/tmp/pip-qmUxjy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:55:56 INFO - Running setup.py (path:/tmp/pip-iAC75q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:55:56 INFO - Running setup.py (path:/tmp/pip-Y2hmdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:55:56 INFO - Running setup.py (path:/tmp/pip-wYdkSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:55:56 INFO - Running setup.py (path:/tmp/pip-dzXNYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:55:56 INFO - Running setup.py (path:/tmp/pip-G1MzXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:55:56 INFO - Running setup.py (path:/tmp/pip-ZC4svY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:55:56 INFO - Running setup.py (path:/tmp/pip-MrwnTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:55:56 INFO - Running setup.py (path:/tmp/pip-wyBTRk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:55:56 INFO - Running setup.py (path:/tmp/pip-mu6Aly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:55:56 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)) 17:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:55:56 INFO - Running setup.py (path:/tmp/pip-vnHh32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:55:57 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)) 17:55:57 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)) 17:55:57 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)) 17:55:57 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)) 17:55:57 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)) 17:55:57 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)) 17:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:57 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 17:55:57 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 17:55:57 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 17:55:57 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 17:55:57 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 17:55:57 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 17:55:58 INFO - Downloading blessings-1.6.tar.gz 17:55:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:58 INFO - Installing collected packages: blessings 17:55:58 INFO - Running setup.py install for blessings 17:55:58 INFO - Successfully installed blessings 17:55:58 INFO - Cleaning up... 17:55:59 INFO - Return code: 0 17:55:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:55:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:55:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:55:59 INFO - Reading from file tmpfile_stdout 17:55:59 INFO - Current package versions: 17:55:59 INFO - argparse == 1.2.1 17:55:59 INFO - blessings == 1.6 17:55:59 INFO - blobuploader == 1.2.4 17:55:59 INFO - docopt == 0.6.1 17:55:59 INFO - manifestparser == 1.1 17:55:59 INFO - mozInstall == 1.12 17:55:59 INFO - mozcrash == 0.16 17:55:59 INFO - mozdebug == 0.1 17:55:59 INFO - mozdevice == 0.47 17:55:59 INFO - mozfile == 1.2 17:55:59 INFO - mozhttpd == 0.7 17:55:59 INFO - mozinfo == 0.9 17:55:59 INFO - mozleak == 0.1 17:55:59 INFO - mozlog == 3.1 17:55:59 INFO - moznetwork == 0.27 17:55:59 INFO - mozprocess == 0.22 17:55:59 INFO - mozprofile == 0.27 17:55:59 INFO - mozrunner == 6.11 17:55:59 INFO - mozscreenshot == 0.1 17:55:59 INFO - mozsystemmonitor == 0.0 17:55:59 INFO - moztest == 0.7 17:55:59 INFO - mozversion == 1.4 17:55:59 INFO - psutil == 3.1.1 17:55:59 INFO - requests == 1.2.3 17:55:59 INFO - wsgiref == 0.1.2 17:55:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:59 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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:59 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 17:55:59 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 17:55:59 INFO - Using env: {'DISPLAY': ':0', 17:55:59 INFO - 'HOME': '/home/cltbld', 17:55:59 INFO - 'LANG': 'en_US.UTF-8', 17:55:59 INFO - 'LANGUAGE': 'en_US:en', 17:55:59 INFO - 'LOGNAME': 'cltbld', 17:55:59 INFO - 'MAIL': '/var/mail/cltbld', 17:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:59 INFO - 'MOZ_NO_REMOTE': '1', 17:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:59 INFO - 'NO_EM_RESTART': '1', 17:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:59 INFO - 'SHELL': '/bin/bash', 17:55:59 INFO - 'SHLVL': '1', 17:55:59 INFO - 'TERM': 'linux', 17:55:59 INFO - 'TMOUT': '86400', 17:55:59 INFO - 'USER': 'cltbld', 17:55:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:59 INFO - '_': '/tools/buildbot/bin/python'} 17:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 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)) 17:55:59 INFO - Cleaning up... 17:55:59 INFO - Return code: 0 17:55:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:55:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:55:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:55:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:55:59 INFO - Using env: {'DISPLAY': ':0', 17:55:59 INFO - 'HOME': '/home/cltbld', 17:55:59 INFO - 'LANG': 'en_US.UTF-8', 17:55:59 INFO - 'LANGUAGE': 'en_US:en', 17:55:59 INFO - 'LOGNAME': 'cltbld', 17:55:59 INFO - 'MAIL': '/var/mail/cltbld', 17:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:59 INFO - 'MOZ_NO_REMOTE': '1', 17:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:59 INFO - 'NO_EM_RESTART': '1', 17:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:55:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:55:59 INFO - 'SHELL': '/bin/bash', 17:55:59 INFO - 'SHLVL': '1', 17:55:59 INFO - 'TERM': 'linux', 17:55:59 INFO - 'TMOUT': '86400', 17:55:59 INFO - 'USER': 'cltbld', 17:55:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:59 INFO - '_': '/tools/buildbot/bin/python'} 17:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:59 INFO - Downloading/unpacking jsonschema 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:01 INFO - Downloading/unpacking functools32 (from jsonschema) 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:01 INFO - warning: no files found matching '*.txt' 17:56:01 INFO - no previously-included directories found matching 'build' 17:56:01 INFO - no previously-included directories found matching 'dist' 17:56:01 INFO - no previously-included directories found matching '.git*' 17:56:01 INFO - Installing collected packages: jsonschema, functools32 17:56:01 INFO - Running setup.py install for functools32 17:56:01 INFO - warning: no files found matching '*.txt' 17:56:01 INFO - no previously-included directories found matching 'build' 17:56:01 INFO - no previously-included directories found matching 'dist' 17:56:01 INFO - no previously-included directories found matching '.git*' 17:56:01 INFO - Successfully installed jsonschema functools32 17:56:01 INFO - Cleaning up... 17:56:02 INFO - Return code: 0 17:56:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:56:02 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')]} 17:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:02 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')]} 17:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:56:02 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 0x7f416bf6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', '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 17:56:02 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 17:56:02 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 17:56:02 INFO - Using env: {'DISPLAY': ':0', 17:56:02 INFO - 'HOME': '/home/cltbld', 17:56:02 INFO - 'LANG': 'en_US.UTF-8', 17:56:02 INFO - 'LANGUAGE': 'en_US:en', 17:56:02 INFO - 'LOGNAME': 'cltbld', 17:56:02 INFO - 'MAIL': '/var/mail/cltbld', 17:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:02 INFO - 'MOZ_NO_REMOTE': '1', 17:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:02 INFO - 'NO_EM_RESTART': '1', 17:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:56:02 INFO - 'PWD': '/builds/slave/test-pgo', 17:56:02 INFO - 'SHELL': '/bin/bash', 17:56:02 INFO - 'SHLVL': '1', 17:56:02 INFO - 'TERM': 'linux', 17:56:02 INFO - 'TMOUT': '86400', 17:56:02 INFO - 'USER': 'cltbld', 17:56:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:02 INFO - '_': '/tools/buildbot/bin/python'} 17:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:02 INFO - Downloading/unpacking flake8 17:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:56:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:56:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 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 17:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:56:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:56:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:56:04 INFO - no previously-included directories found matching 'docs/_build' 17:56:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:56:04 INFO - Running setup.py install for pep8 17:56:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:56:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:56:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:56:04 INFO - no previously-included directories found matching 'docs/_build' 17:56:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:56:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:56:04 INFO - Cleaning up... 17:56:04 INFO - Return code: 0 17:56:04 INFO - Running post-action listener: _resource_record_post_action 17:56:04 INFO - Running post-action listener: _start_resource_monitoring 17:56:04 INFO - Starting resource monitoring. 17:56:04 INFO - ##### 17:56:04 INFO - ##### Running install step. 17:56:04 INFO - ##### 17:56:04 INFO - Running pre-action listener: _resource_record_pre_action 17:56:04 INFO - Running main action method: install 17:56:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:56:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:56:05 INFO - Reading from file tmpfile_stdout 17:56:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:56:05 INFO - Reading from file tmpfile_stdout 17:56:05 INFO - Output received: 17:56:05 INFO - Usage: mozinstall [options] installer 17:56:05 INFO - Options: 17:56:05 INFO - -h, --help show this help message and exit 17:56:05 INFO - -d DEST, --destination=DEST 17:56:05 INFO - Directory to install application into. [default: 17:56:05 INFO - "/builds/slave/test-pgo"] 17:56:05 INFO - --app=APP Application being installed. [default: firefox] 17:56:05 INFO - mkdir: /builds/slave/test-pgo/build/application 17:56:05 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'] 17:56:05 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 17:56:19 INFO - Reading from file tmpfile_stdout 17:56:19 INFO - Output received: 17:56:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:56:19 INFO - Running post-action listener: _resource_record_post_action 17:56:19 INFO - ##### 17:56:19 INFO - ##### Running run-tests step. 17:56:19 INFO - ##### 17:56:19 INFO - Running pre-action listener: _resource_record_pre_action 17:56:19 INFO - Running main action method: run_tests 17:56:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:56:19 INFO - Python 2.7.3 17:56:19 INFO - Return code: 0 17:56:19 INFO - grabbing minidump binary from tooltool 17:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:56:19 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 0x18d6350>, '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 0x18d7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:56:19 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 17:56:20 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 17:56:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:56:20 INFO - Return code: 0 17:56:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:56:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:56:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:56:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:56:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:56:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:56:21 INFO - Return code: 0 17:56:21 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/1455578871/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:56:21 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/1455578871/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 17:56:21 INFO - Using env: {'DISPLAY': ':0', 17:56:21 INFO - 'HOME': '/home/cltbld', 17:56:21 INFO - 'LANG': 'en_US.UTF-8', 17:56:21 INFO - 'LANGUAGE': 'en_US:en', 17:56:21 INFO - 'LOGNAME': 'cltbld', 17:56:21 INFO - 'MAIL': '/var/mail/cltbld', 17:56:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:56:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:21 INFO - 'MOZ_NO_REMOTE': '1', 17:56:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:21 INFO - 'NO_EM_RESTART': '1', 17:56:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 17:56:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:56:21 INFO - 'SHELL': '/bin/bash', 17:56:21 INFO - 'SHLVL': '1', 17:56:21 INFO - 'TERM': 'linux', 17:56:21 INFO - 'TMOUT': '86400', 17:56:21 INFO - 'USER': 'cltbld', 17:56:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540', 17:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:21 INFO - '_': '/tools/buildbot/bin/python'} 17:56:21 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/1455578871/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 17:56:21 INFO - mozversion INFO | application_buildid: 20160215152751 17:56:21 INFO - mozversion INFO | application_changeset: 638572acfc9eeb137c403a226040876cf63e0de6 17:56:21 INFO - mozversion INFO | application_display_name: Nightly 17:56:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:56:21 INFO - mozversion INFO | application_name: Firefox 17:56:21 INFO - mozversion INFO | application_remotingname: firefox 17:56:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:56:21 INFO - mozversion INFO | application_vendor: Mozilla 17:56:21 INFO - mozversion INFO | application_version: 45.0 17:56:21 INFO - mozversion INFO | platform_buildid: 20160215152751 17:56:21 INFO - mozversion INFO | platform_changeset: 638572acfc9eeb137c403a226040876cf63e0de6 17:56:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:56:21 INFO - mozversion INFO | platform_version: 45.0 17:56:21 INFO - 2016-02-15 17:56:21,517 DEBUG : using testdate: 1455587781 17:56:21 INFO - 2016-02-15 17:56:21,517 DEBUG : actual date: 1455587781 17:56:21 INFO - 2016-02-15 17:56:21,524 INFO : starting webserver on 'localhost:57944' 17:56:21 INFO - 2016-02-15 17:56:21,525 INFO : Starting test suite talos-linux64-ix-060 17:56:21 INFO - 2016-02-15 17:56:21,525 INFO : Starting test dromaeo_css 17:56:21 INFO - 2016-02-15 17:56:21,525 DEBUG : operating with platform_type : linux_ 17:56:21 INFO - 2016-02-15 17:56:21,525 INFO : Initialising browser for dromaeo_css test... 17:56:21 INFO - 2016-02-15 17:56:21,536 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7OS0gy/profile http://localhost:57944/getInfo.html 17:56:25 INFO - 2016-02-15 17:56:25,782 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:56:25 INFO - 2016-02-15 17:56:25,782 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:56:25 INFO - 2016-02-15 17:56:25,782 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:56:25 INFO - 2016-02-15 17:56:25,782 DEBUG : BROWSER_OUTPUT: __metrics 17:56:25 INFO - 2016-02-15 17:56:25,944 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] 17:56:27 INFO - 2016-02-15 17:56:27,109 INFO : Browser initialized. 17:56:27 INFO - 2016-02-15 17:56:27,110 INFO : Running cycle 1/1 for dromaeo_css test... 17:56:27 INFO - 2016-02-15 17:56:27,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7OS0gy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:56:38 INFO - 2016-02-15 17:56:38,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 133197824 17:56:38 INFO - 2016-02-15 17:56:38,804 DEBUG : BROWSER_OUTPUT: 17:57:29 INFO - 2016-02-15 17:57:29,752 DEBUG : BROWSER_OUTPUT: 1455587849749 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] 17:59:38 INFO - 2016-02-15 17:59:38,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57944/tests/dromaeo/cssquery-ext.html) 17:59:39 INFO - 2016-02-15 17:59:39,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 248254464 17:59:39 INFO - 2016-02-15 17:59:39,473 DEBUG : BROWSER_OUTPUT: 18:02:41 INFO - 2016-02-15 18:02:41,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-ext.html (next: http://localhost:57944/tests/dromaeo/cssquery-jquery.html) 18:02:42 INFO - 2016-02-15 18:02:42,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 209956864 18:02:42 INFO - 2016-02-15 18:02:42,100 DEBUG : BROWSER_OUTPUT: 18:05:43 INFO - 2016-02-15 18:05:43,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57944/tests/dromaeo/cssquery-mootools.html) 18:05:44 INFO - 2016-02-15 18:05:44,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 204210176 18:05:44 INFO - 2016-02-15 18:05:44,398 DEBUG : BROWSER_OUTPUT: 18:08:46 INFO - 2016-02-15 18:08:46,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57944/tests/dromaeo/cssquery-prototype.html) 18:08:46 INFO - 2016-02-15 18:08:46,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 197492736 18:08:46 INFO - 2016-02-15 18:08:46,660 DEBUG : BROWSER_OUTPUT: 18:11:48 INFO - 2016-02-15 18:11:48,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57944/tests/dromaeo/cssquery-yui.html) 18:11:49 INFO - 2016-02-15 18:11:49,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 199778304 18:11:49 INFO - 2016-02-15 18:11:49,576 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-yui.html (next: http://localhost:57944/tests/dromaeo/cssquery-dojo.html) 18:14:51 INFO - 2016-02-15 18:14:51,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 211296256 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3325.617553981292;3382.5264462975174;3419.179396944734;3420.982895085524;3430.5368775215347;5519.089350257208;5568.749406276717;5575.2194692743;5575.936166929647;5576.86057848554;5564.137558678402;5564.693941833198;5574.358948720898;5575.0522411190095;5586.35756887958;4814.253790662436;4949.158643030675;5027.849164525061;5055.848324550251;5096.719680417576;4947.901041979177;5006.699598024112;5012.198048312271;5013.799448022075;5014.5737612303;4940.086084074458;5000.449950505442;5037.49625037497;5049;5053.166227572447;5002.0246052019875;5081.161608334621;5084.7457627118865;5087.745612719349;5121.692698438105;5018.7490625468945;5116.283720279164;5125.1287281162295;5126.179811230222;5130;5180.663256888291;5189.818356357509;5283;5294.549963253128;5446.373667028302;5962.522998160181;5999.220101386792;6002.519798416116;6005.969970150121;6011.57918945674;5932.762689492415;6012.518998480155;6018.307894592134;6023.879522409571;6031.155638210654;5330.813421530228;5435.673859568399;5514.476124768181;5579.330480342385;5605.383407825177;6053.031514957674;6057;6111.938880611226;6119.571629985859;6141.84645383869;5679.687617181012;5935.198748168942;5944.019236825961;5949.464548190684;5950.4049595041015;5839.445252700986;5873.618214816023;5904.881902361929;5921.733521991435;5948.583599148104;5867.325257595431;5886.911696324559;5902.321233058167;5911.733971971185;5913.142594323799;5853.560982926298;5873.735681894325;5880;5890.3815099414805;5892.469677729025;4323.2434323993175;4487.977560112178;4507.166174257773;4596.839110631112;4611.723296602215;4119.258533463945;4129.793510324472;4132.586741325843;4134.421181034658;4163.479565054368;5695;5722.084466485342;5727.971360143256;5736.77052917887;5759.136129580596;5622.550195984311;5716.085426331767;5822.5633077518505;5900.203472531153;5947.940520594825;5598.300212473441;5672.659640421588;5677.233573467529;5677.37548869624;5691.03252447085;5162.6902385856965;5179.093658609729;5180.145276029413;5190.325257716473;5222.033923724123;5937.435943585352;6079.665618390943;6087.391260873877;6097.237845269341;6191.4118158773945;6002.249718785152;6002.309734380602;6017.187679663364;6017.819465416044;6021.187139736079;6156.538259630635;6206.72069756871;6233.75064997395;6239.469645080219;6242.250929888442;5670.291213598301;5756.56825738063;5766.711664416678;5826.155207494974;5876.294844618673;5934.9406505934385;5997.400259973968;6008.609440386361;6010.639361638316;6081.179040829431;5484.369297530676;5898.557608179318;5916.378780228014;5928.436798504135;5932.377100404568;5683.630564013326;5690.061139911868;5767.942320576741;5780.364159942487;5791.652500849962;5779.653220806765;5795.7391917362975;5796.797112101056;5798.275215598051;5806.187133801187;5622.297212848394;5690.374058853606;5868.38381969887;5869.207656966255;5905.202797622266;5659.575531835047;5720.18781216786;5743.684097374685;5765.509931655856;5797.507211887037 18:14:51 INFO - 2016-02-15 18:14:51,959 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.563745915645;589.7935722497126;612.6569121292076;615.7660089166117;617.3887851027484;31986.36027279453;41103.17793644125;42783.35824962628;42820.14359712808;42842.14315713692;45389.319160212624;45984.54015459844;45994.770026149825;46027.76986115065;46141.7692911535;7775.572343521104;7823.765287041369;9185.219256363218;9358.859617105714;10636.734081647943;10702.357858528474;10808.297460665071;10839.18706097042;10844.891551084467;10847.620333288336;10839.458027098613;10940.3982780947;10941.398223097727;10948.124150068015;10954.342739435659;10833.566657333697;10903.236773425784;10910.399928003957;10930.234883558154;10939.56241750333;10628.734281642943;10680.14558835299;10750.677479675622;10755.677329680122;10764.031237188612;43839.78080109611;44202.33696494555;44385.77807110976;44404.333934991;44448.3332750009;3301.735861131104;3356.3958487472246;3369.545111409953;3605.4231322988458;3853.845846166178;32628.184295392566;32853.6714632853;32877;33012;33026.17434564131;4159.688023398257;4269.103488267468;4283.186194623012;4296.205202037601;4332.588404101605;299003;299675;299991;300698;301234;62163;64248.67875660685;64482;64615.353846461876;64680.676596616715;56164.71917640386;77821;77828.22171778324;77843;78096.21903781003;15837.287322070535;16043.679126417406;16063.277152527931;16065.196740162944;16069.35722571084;11857.16999810005;11873.050155987501;11888.28670279786;11894.92945634897;11897.524099036114;21755.34733957984;21973.340799776033;21978.560428791654;22032.88983555072;22060.88969555142;8075.030996280367;8338.207870252316;8374.162583741578;8374.371922105867;8460.884778805299;921.6958403726754;1103.4979084516526;1110.9611163609236;1113.5323164271026;1131.575659127827;29147.708522914498;29977.250568735955;30138.24654383658;30452;30475.542866857017;1047.512906498482;1093.5133865429966;1104.13877175803;1116.5701205036119;1155.566662501562;14028.85971140296;15638.139902305255;15894.205289735466;16721.163941803105;16894.23975921062;337284;342535;342773;342795;342860;48070.75964620154;49132.75433622809;55017.44982550203;56453.43546564564;56475;1370.6082885365101;1390.311795661134;1392.3664732546667;1398.9020768546306;1398.9090709103875;28984.710152899046;29216.70783292225;29375;29914.551281731226;29999.850000749855;47613.76193119151;48017.5198248027;48030.519694802606;48068.27897581469;48088.75955620199;261966;263475;264468;264577;265165.09009458724;34730.47904281387;44918.77540612276;45255.321170181815;45804.541954580025;45804.77097614491;50793.492065080354;50916.727081821766;51133.23300150575;51783.74108129435;52368.47631523636;41501.792491037355;41751.37372939469;42471.57528424676;43425;43794;42180.78909605432;42804.357934631626;43079;43195.78402108095;43734.12531749411;42932.71201863949;42990.35514467223;43442.348364775185;43462.782686086364;43580.56419435765;36562.63437365699;36782.26435471222;37018.629813702595;37838;38115.47538098445;28484.145475635763;28617.570736438553;28910;28929;28966.855165724035 18:14:51 INFO - 2016-02-15 18:14:51,960 DEBUG : BROWSER_OUTPUT: |2;jquery.html;382.5734306248532;383.85993599010936;384.84413812405984;386.2256176366387;388.44258489068187;14760.852391476083;15008.474703385384;17272.309107635694;19195.520111997208;19196;16845.83154168458;17238.310467581283;17253.482395528154;17992.64014719705;17996.100194990264;6051.455369016799;6174.660393678346;6206.224221972254;6218.502519798428;6222.160008398876;4483.327500874862;4593.311003349508;6130.540209484284;6599.604023758566;6836.248012718597;6643.202815662127;6753.122094127781;6791.932080679179;6814.318568143196;6815.216250131224;6750.257471678112;6799.932000679979;6800.795976120724;6811.897821532656;6815.01182328562;6392.977123660238;6516.641584712839;6523.086767852505;6530.8040758777315;6541.705623246918;12609.495620175181;23582.29253122409;23833.285001449985;23954.64068038981;24029.27912162638;1903.4765439504108;2182.8035476807004;2191.276878630048;2276.1236923784295;2304.585174668559;10388.948055259676;10424.061834434862;11255.831162532568;14342.64143396413;14435.494757683431;1825.7261410788356;1914.3682584747;1987.2647120565484;2012.3359291433792;2066.111572024029;61288.69355653238;63708.36291637117;64770;66015;66127.33872661307;11213.10295176384;11224.326540407601;11235.887641123483;11247.83128253077;11307.773844523228;13368.59894203156;14674.339654715563;14704.117752934859;14766.852331476548;14797.630059248604;6062.151298818169;6175.289841668266;7279.490435669558;7860.528368297921;7957.721479748297;7537.283958023979;7556.055493063367;7561.395088392916;7586.734464293723;7612.162662107164;4516.8193272268745;4727.952720472751;4824.686395384359;4832.057748739033;4866.683665561727;1694.408818648622;1898.3355825461254;1941.4466876940287;1959.5982823521144;1966.675498542753;1005.653049697853;1015.5930444845616;1028.4960369418932;1118.1502058435647;1132.773445310941;14958.551243462714;15912;16758.664826703396;17078.829211707725;17128.657426851394;950.0736781637847;953.6042542344849;964.7202311329636;986.5768159395959;1001.4241810958728;9886.4562449066;10127.949360253151;10163.796724065625;10185.847212291821;10217.846732299022;651081;651134;657229;660072;673412;85286.57356713177;86343.56828215944;88529.55735221283;89720.5513972426;90507;1176.4470698771563;1183.3077649575096;1185.4546908422221;1195.786276928918;1209.6371088673363;15904.204789760697;16142.919285403497;16227.107509087113;16253.51239462818;16507.422240221535;36714.63285367219;37195.44206836846;37439.81280093582;38568.42147367736;39021.6097839018;48851.51148488469;48975.26537101875;50059.74970125126;50525.49474505208;52627.73686131698;9763.902360976299;10317.793644127225;10470.424126673106;10480.161587072864;10480.475976201313;14177.14937103777;16562.917185413997;17389.91305043467;17971.5507112318;18068.54828629295;15170.24148792578;15195.544133676007;15297.46458873934;15394.923025384802;15467.226638667797;11326.773464530828;15169.772453413429;15416.614584635474;16126.193690315671;16228;15997.440089596808;16076.598085047499;16206.837931620534;16266.942648727794;16657.750133747762;10225.233107516817;10240.283180177315;10311.690649280534;10319.845202321821;10451.581936722447;14857.702845942804;15929.761053583974;16003.919980400024;16087.356505739639;16184.67630647357 18:14:51 INFO - 2016-02-15 18:14:51,961 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1510.3128076725084;1523.375416079407;1732.5062357228192;1801.5946412057285;1843.3732530939478;8063.314618257448;8420.242178203953;8421;8435.072142064384;8446.197611226924;8167.877481837777;8223.095459499466;8243.95878020609;8258.13289604592;8259.38054645901;2300.8734519601417;2318.4435735423544;2358.0567772890895;2363.302825666424;2363.3028256664325;2327.8952447139836;2350.4828937633692;2350.976490235093;2351.0830775997374;2352.541254455382;1961.764588249412;2010.2963962613042;2273.15893119546;2294.9082036718596;2368.7394386617457;2254.368776742515;2269.273832373641;2284.7715228477186;2285.2801367569164;2286.9085236590518;2305.884705764705;2348.6477028445697;2358.3396648938324;2358.7995020423286;2359.10354065454;6741.224759152662;6891.793246202622;7435.219301973323;7562.584057876815;7571;4854.199057155565;4914.950850491485;4940.308356830046;4942.233953737176;4953.058918805452;3157.447446696819;3168.8098714077228;3214.1964508872784;3239.3845169417737;3293.324868401996;1032.6385764982272;1055.1664185293685;1069.2996087562658;1078.5577913055688;1104.917131215154;11342;11396.829047564293;11397.259178153394;11425;11439.82840257405;4349.869503914888;4374.650027997753;4377.715448495837;4408.933865992013;4410.029793445437;9874.555644995993;9901.108900198873;9942.254330925209;9968.40189588627;9969.451680157661;4942.876428089255;4967;4975.4527002029745;4978.153713868651;4979.153543897473;4431.512533621299;4447.199504089231;4472.172648060119;4481.708688935209;4491.932621010687;3627.510286111394;3732.757370770891;3734.514513113332;3736.4768932348948;3757.098296408842;1200.507791805373;1207.6678913298738;1208.8730683278304;1209.8729633388543;1216.0636310041218;1146.5814977533307;1169.2049406403557;1177.8115501519715;1181.3207405741732;1183.2486371154207;7689.692412303557;7710.036245469317;7752.418568607377;7782.805429864298;7807.336376407955;1098.5880294889416;1120.523777394604;1138.4990604134155;1214.4656351205442;1214.6477521518661;5418.214358917935;6077.36187700294;6101.328853826076;6105.053716673922;6123.08153776937;8500.70247541333;9746.122848943487;9788.461634610165;9874.506274686237;10056.145227655732;9415.952920235355;9501.477418741897;9785.853212201822;9856.359336643096;9930.950345248228;7528.736494222676;7561.243875612395;7637.274458926393;7639.159692433828;7641.503302285334;7696.268854458817;7756.1468238494845;7808.492447990862;7808.5314881107315;7902.051753789352;8469.407141500036;8774.254188394058;8984.101589841224;9000.279977601645;9015.14356136166;8755.430896991675;8860.645574177219;8961.820763584823;8995.820083598423;9040.90959090427;7297.854042919218;7396.408287337108;7433.92566074354;7434.73978410753;7446.106467223751;7961.920380796118;8076;8078.030636323444;8081.393895457982;8094.231048050426;7238.855222895408;7334.889976650248;7373.889391659022;7443.665035073543;7684.154742978156;7376.594287314035;7379.631018448948;7388.926110739038;7442.92557074444;7456.58988755602;6982.581045137308;7125.144982602121;7133.928660713326;7303.379212766762;7363.226861179499;6734.124563806674;6736.326367363225;6756.797296081126;6772.695228714621;6780.966095169492;6537.084808126771;6625.569337993015;6879.415249703831;6907.585544867324;6931 18:14:51 INFO - 2016-02-15 18:14:51,962 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.9767616266861;333.41319278070597;341.726618705036;344.11562284927743;350.6651148153512;6072.392760723926;6073.362296958822;6084.269887613493;6094.664793436359;6098.57309988301;6064;6066.059760737082;6074.2710874694985;6074.939250607493;6081.3918608139165;4621.191291523986;4686.343911852344;4690.788914498856;4697.506761789997;4707.882302942419;4621.214393553088;4652;4656;4663.090697314025;4667.043256132485;4571.565701258375;4589.563991420827;4599.126166028461;4609.792559334838;4616.030633566955;4315.007548263901;4429.867103986853;4513.345564893072;4552.772361381934;4554.954450455502;4013.8595149169637;4018.7789671568053;4040.5757395473347;4054.087830238173;4056.4726585543985;5698.8290351289525;5707.942920570824;5714.057180565202;5732.541396688255;5737.7131143443075;5019.322391477141;5117.078925793356;5296.629235953485;5399.298091248152;5408.540274076709;6348.587341822767;6362.650054247015;6364.299927008025;6365.809025729235;6374.426301632829;4515.14212299662;4515.977420112911;4516.029053753426;4518.028623845856;4521.208788462006;6478.967605161944;6621.205455345341;6623.9006414903815;6632.568883022588;6646.534742568022;4499.685022048425;4536.61438777701;4538.500764915857;4543.273076307841;4544.500104988449;4588.816447342136;4589.632829373642;4591.173588754056;4595.103954728863;4595.425571803525;5328.17413300939;5334.493223143795;5340.519353258148;5342.439043900412;5344.438833922382;6327.96836015817;6412.358764123644;6423.100765892778;6441.742330306829;6451.612903225821;1579.2735341742928;1614.3291693097588;1620.5057457475348;1621.0435842852773;1621.7405215165518;1056.392574269798;1075.0271004740723;1076.3057827701089;1090.378484263962;1092.7978324010085;6307.432331090224;6310.9368906311265;6345.365463453618;6347.841303967345;6352.872942541123;6637.369449902348;6653.667316634149;6677.499187560952;6684.2647308795995;6686;6200.56596038273;6345.143405640272;6345.682715864188;6349.619022858643;6350.872982540323;3570.357335679603;3599.280143971164;3603.6936860367164;3604.0269127335473;3606.0804494853646;6927.099477067949;6927.965360173167;6935.757248496278;6941.201761797458;6946.51374403797;6497.545171838021;6549.738010479623;6728.562643428161;6819.965900170468;6829.897551536731;6804.863902721918;6960.617166055814;6960.721571137098;6963.860722785617;6974.686139123752;6687.832804179934;6697.966510167613;6702.128723265944;6706.530542861953;6706.865862682816;6471.094046833353;6617.272100069084;6618.437432818265;6623.105880706043;6624.205095388585;6981.930180698128;6985.196702379291;6987.161540615159;6989.825254368681;7000.579965202104;4621.514740952151;4665.720056796603;4670.509596492319;4673.696209746356;4677.158111539956;6594.340565943367;6724.663766811737;6732.730690772511;6733.192016957996;6743.52795304324;6544.411003009752;6556.213254409501;6558.245801732862;6564;6566.080748695091;6496.9025464617125;6548.0832683423405;6549.7380104795275;6554.115194448879;6554.410103090745;6333.081703153109;6441.871162576816;6443.420092191725;6444.709988050456;6448.677566121582;6542.116814230209;6565.376289252514;6568.376004279586;6568.80293591193;6568.94896816507;6339.683015849097;6421.486281097595;6427.260865000585;6429.164208652845;6432.035194720829 18:14:51 INFO - 2016-02-15 18:14:51,962 DEBUG : BROWSER_OUTPUT: |5;yui.html;757.0536828963795;835.5989125219894;923.7459698582885;923.9769005774855;935.9017303183169;13004.609861704152;13403.061785674981;13412.865871341308;13448.125871818338;13467.797983030263;12668.556600518983;12747.93626031871;12777.169483983535;12789.36053197341;12796.552120675778;736.661135877497;742.0316486984483;890.6214858685049;903.4037535226752;916.5142474488532;905.6875377994581;910.4127837544779;917.8256131335058;918.8805455290803;919.2645883293372;766.264386189259;951.7477868364854;959.5586030425977;959.7360725800426;960.1982344742148;766.643510767493;943.8867335919665;959.4962644611564;960.6061514778908;961.1925982175006;714.2607401339588;716.4662326566742;717.2397258905577;717.2683862460314;717.8959050937638;11694.356810375426;12044;12054.216475929124;12076.275423474532;12126.27242365461;11972.281663100242;12920.87079129206;12941.094123411365;12992.935035324763;13723.245221512812;11117.833232501518;11194.944025279903;11283.943580282128;11300.94349528247;11429.542818287258;3764.1906989997283;3779.3008293465796;3787.450819631138;3804.1821008483034;3814.866479673226;50715.74642126803;52999.47000529984;54092.72953635246;54103.72948135273;54206;10633.255672103034;10707.571697132184;10793.460326983619;10874.075703565128;11080.113590912708;18675;18692.906535467235;18693.1306869312;18702.345417910306;18705.53236169107;8032.39757018226;8094.878576821352;8101.108878023413;8129;8140.389470789714;4291.206126866539;4399.38408622793;4502.257127573979;4524.592786649151;4562.794674239667;3240.4653232216892;3244.853981570835;3258.5926759155104;3262.6737326267657;3271.934561308808;587.5974957154363;594.5808205215313;595.2707932782307;615.1695211464487;634.8952422850178;553.5046133710307;699.7061234281513;721.7365661533503;736.6464097233358;744.2892038103598;9081.228095611947;9100.726978190665;9258.583363748647;9318.487483188354;9425;570.7231992483643;679.7960611816435;691.550492180077;722.3065856777553;769.5036701327613;4116.403121547419;4196.181744559843;4224.78876056196;4372.672049596229;4585.747783871919;56773.14840277399;60362.69818650967;60371;60880.695596521735;61067.389326107055;53634.463655362946;56487.43512564904;56509;58480;58534.41465585375;52361.21458178131;52469.950600987766;52623.47376526262;52764.472355276725;53099.73450132724;9216.98613152566;9282.72151835446;9303.209227215762;9368.48473333946;9398.906010939803;37049.814750926074;37440.251194976496;37804.2439151221;40428;40452.39321410123;49442;49884;50003.249951250036;50797.49202507928;51330.23004654858;11098.5560577576;11628.418579071182;11776.352300623548;11881.881181188077;11924;13246.271455070064;13247.66880827987;13294.20234785916;13372.104582960223;13389.062765606313;12110.273383597012;12135.271883687006;12340.629781106221;12404.19372740769;12410.75178496407;11809.11431642613;11898.881011189776;12233.143679942674;12393.504259829506;12573.182743121668;11785.175037747618;11935.701607459883;11955.64133076009;12092.879071209176;12314.199577027464;9561.856572151562;9813.165880899918;10032.899671003197;10146.847797282899;10329.328593641389;10055.49722513886;10211.795764084529;10278.434686092038;10343.120834728832;10559.419231942316 18:14:51 INFO - 2016-02-15 18:14:51,963 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: __startTimestamp1455588891951__endTimestamp 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5519.98 Median:5722.08 stddev:608.03 (10.6%) stddev-sans-first:585.02 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: Values: 3325.6 3382.5 3419.2 3421.0 3430.5 5519.1 5568.7 5575.2 5575.9 5576.9 5564.1 5564.7 5574.4 5575.1 5586.4 4814.3 4949.2 5027.8 5055.8 5096.7 4947.9 5006.7 5012.2 5013.8 5014.6 4940.1 5000.4 5037.5 5049.0 5053.2 5002.0 5081.2 5084.7 5087.7 5121.7 5018.7 5116.3 5125.1 5126.2 5130.0 5180.7 5189.8 5283.0 5294.5 5446.4 5962.5 5999.2 6002.5 6006.0 6011.6 5932.8 6012.5 6018.3 6023.9 6031.2 5330.8 5435.7 5514.5 5579.3 5605.4 6053.0 6057.0 6111.9 6119.6 6141.8 5679.7 5935.2 5944.0 5949.5 5950.4 5839.4 5873.6 5904.9 5921.7 5948.6 5867.3 5886.9 5902.3 5911.7 5913.1 5853.6 5873.7 5880.0 5890.4 5892.5 4323.2 4488.0 4507.2 4596.8 4611.7 4119.3 4129.8 4132.6 4134.4 4163.5 5695.0 5722.1 5728.0 5736.8 5759.1 5622.6 5716.1 5822.6 5900.2 5947.9 5598.3 5672.7 5677.2 5677.4 5691.0 5162.7 5179.1 5180.1 5190.3 5222.0 5937.4 6079.7 6087.4 6097.2 6191.4 6002.2 6002.3 6017.2 6017.8 6021.2 6156.5 6206.7 6233.8 6239.5 6242.3 5670.3 5756.6 5766.7 5826.2 5876.3 5934.9 5997.4 6008.6 6010.6 6081.2 5484.4 5898.6 5916.4 5928.4 5932.4 5683.6 5690.1 5767.9 5780.4 5791.7 5779.7 5795.7 5796.8 5798.3 5806.2 5622.3 5690.4 5868.4 5869.2 5905.2 5659.6 5720.2 5743.7 5765.5 5797.5 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,964 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49862.42 Median:342654.00 stddev:79155.89 (23.1%) stddev-sans-first:79291.40 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: Values: 566.6 589.8 612.7 615.8 617.4 31986.4 41103.2 42783.4 42820.1 42842.1 45389.3 45984.5 45994.8 46027.8 46141.8 7775.6 7823.8 9185.2 9358.9 10636.7 10702.4 10808.3 10839.2 10844.9 10847.6 10839.5 10940.4 10941.4 10948.1 10954.3 10833.6 10903.2 10910.4 10930.2 10939.6 10628.7 10680.1 10750.7 10755.7 10764.0 43839.8 44202.3 44385.8 44404.3 44448.3 3301.7 3356.4 3369.5 3605.4 3853.8 32628.2 32853.7 32877.0 33012.0 33026.2 4159.7 4269.1 4283.2 4296.2 4332.6 299003.0 299675.0 299991.0 300698.0 301234.0 62163.0 64248.7 64482.0 64615.4 64680.7 56164.7 77821.0 77828.2 77843.0 78096.2 15837.3 16043.7 16063.3 16065.2 16069.4 11857.2 11873.1 11888.3 11894.9 11897.5 21755.3 21973.3 21978.6 22032.9 22060.9 8075.0 8338.2 8374.2 8374.4 8460.9 921.7 1103.5 1111.0 1113.5 1131.6 29147.7 29977.3 30138.2 30452.0 30475.5 1047.5 1093.5 1104.1 1116.6 1155.6 14028.9 15638.1 15894.2 16721.2 16894.2 337284.0 342535.0 342773.0 342795.0 342860.0 48070.8 49132.8 55017.4 56453.4 56475.0 1370.6 1390.3 1392.4 1398.9 1398.9 28984.7 29216.7 29375.0 29914.6 29999.9 47613.8 48017.5 48030.5 48068.3 48088.8 261966.0 263475.0 264468.0 264577.0 265165.1 34730.5 44918.8 45255.3 45804.5 45804.8 50793.5 50916.7 51133.2 51783.7 52368.5 41501.8 41751.4 42471.6 43425.0 43794.0 42180.8 42804.4 43079.0 43195.8 43734.1 42932.7 42990.4 43442.3 43462.8 43580.6 36562.6 36782.3 37018.6 37838.0 38115.5 28484.1 28617.6 28910.0 28929.0 28966.9 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33233.55 Median:1950.52 stddev:107528.60 (5512.8%) stddev-sans-first:107801.95 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: Values: 382.6 383.9 384.8 386.2 388.4 14760.9 15008.5 17272.3 19195.5 19196.0 16845.8 17238.3 17253.5 17992.6 17996.1 6051.5 6174.7 6206.2 6218.5 6222.2 4483.3 4593.3 6130.5 6599.6 6836.2 6643.2 6753.1 6791.9 6814.3 6815.2 6750.3 6799.9 6800.8 6811.9 6815.0 6393.0 6516.6 6523.1 6530.8 6541.7 12609.5 23582.3 23833.3 23954.6 24029.3 1903.5 2182.8 2191.3 2276.1 2304.6 10388.9 10424.1 11255.8 14342.6 14435.5 1825.7 1914.4 1987.3 2012.3 2066.1 61288.7 63708.4 64770.0 66015.0 66127.3 11213.1 11224.3 11235.9 11247.8 11307.8 13368.6 14674.3 14704.1 14766.9 14797.6 6062.2 6175.3 7279.5 7860.5 7957.7 7537.3 7556.1 7561.4 7586.7 7612.2 4516.8 4728.0 4824.7 4832.1 4866.7 1694.4 1898.3 1941.4 1959.6 1966.7 1005.7 1015.6 1028.5 1118.2 1132.8 14958.6 15912.0 16758.7 17078.8 17128.7 950.1 953.6 964.7 986.6 1001.4 9886.5 10127.9 10163.8 10185.8 10217.8 651081.0 651134.0 657229.0 660072.0 673412.0 85286.6 86343.6 88529.6 89720.6 90507.0 1176.4 1183.3 1185.5 1195.8 1209.6 15904.2 16142.9 16227.1 16253.5 16507.4 36714.6 37195.4 37439.8 38568.4 39021.6 48851.5 48975.3 50059.7 50525.5 52627.7 9763.9 10317.8 10470.4 10480.2 10480.5 14177.1 16562.9 17389.9 17971.6 18068.5 15170.2 15195.5 15297.5 15394.9 15467.2 11326.8 15169.8 15416.6 16126.2 16228.0 15997.4 16076.6 16206.8 16266.9 16657.8 10225.2 10240.3 10311.7 10319.8 10451.6 14857.7 15929.8 16003.9 16087.4 16184.7 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,965 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5716.11 Median:6330.08 stddev:2993.42 (47.3%) stddev-sans-first:2985.12 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: Values: 1510.3 1523.4 1732.5 1801.6 1843.4 8063.3 8420.2 8421.0 8435.1 8446.2 8167.9 8223.1 8244.0 8258.1 8259.4 2300.9 2318.4 2358.1 2363.3 2363.3 2327.9 2350.5 2351.0 2351.1 2352.5 1961.8 2010.3 2273.2 2294.9 2368.7 2254.4 2269.3 2284.8 2285.3 2286.9 2305.9 2348.6 2358.3 2358.8 2359.1 6741.2 6891.8 7435.2 7562.6 7571.0 4854.2 4915.0 4940.3 4942.2 4953.1 3157.4 3168.8 3214.2 3239.4 3293.3 1032.6 1055.2 1069.3 1078.6 1104.9 11342.0 11396.8 11397.3 11425.0 11439.8 4349.9 4374.7 4377.7 4408.9 4410.0 9874.6 9901.1 9942.3 9968.4 9969.5 4942.9 4967.0 4975.5 4978.2 4979.2 4431.5 4447.2 4472.2 4481.7 4491.9 3627.5 3732.8 3734.5 3736.5 3757.1 1200.5 1207.7 1208.9 1209.9 1216.1 1146.6 1169.2 1177.8 1181.3 1183.2 7689.7 7710.0 7752.4 7782.8 7807.3 1098.6 1120.5 1138.5 1214.5 1214.6 5418.2 6077.4 6101.3 6105.1 6123.1 8500.7 9746.1 9788.5 9874.5 10056.1 9416.0 9501.5 9785.9 9856.4 9931.0 7528.7 7561.2 7637.3 7639.2 7641.5 7696.3 7756.1 7808.5 7808.5 7902.1 8469.4 8774.3 8984.1 9000.3 9015.1 8755.4 8860.6 8961.8 8995.8 9040.9 7297.9 7396.4 7433.9 7434.7 7446.1 7961.9 8076.0 8078.0 8081.4 8094.2 7238.9 7334.9 7373.9 7443.7 7684.2 7376.6 7379.6 7388.9 7442.9 7456.6 6982.6 7125.1 7133.9 7303.4 7363.2 6734.1 6736.3 6756.8 6772.7 6781.0 6537.1 6625.6 6879.4 6907.6 6931.0 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5404.40 Median:6254.00 stddev:1643.08 (26.3%) stddev-sans-first:1602.97 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: Values: 332.0 333.4 341.7 344.1 350.7 6072.4 6073.4 6084.3 6094.7 6098.6 6064.0 6066.1 6074.3 6074.9 6081.4 4621.2 4686.3 4690.8 4697.5 4707.9 4621.2 4652.0 4656.0 4663.1 4667.0 4571.6 4589.6 4599.1 4609.8 4616.0 4315.0 4429.9 4513.3 4552.8 4555.0 4013.9 4018.8 4040.6 4054.1 4056.5 5698.8 5707.9 5714.1 5732.5 5737.7 5019.3 5117.1 5296.6 5399.3 5408.5 6348.6 6362.7 6364.3 6365.8 6374.4 4515.1 4516.0 4516.0 4518.0 4521.2 6479.0 6621.2 6623.9 6632.6 6646.5 4499.7 4536.6 4538.5 4543.3 4544.5 4588.8 4589.6 4591.2 4595.1 4595.4 5328.2 5334.5 5340.5 5342.4 5344.4 6328.0 6412.4 6423.1 6441.7 6451.6 1579.3 1614.3 1620.5 1621.0 1621.7 1056.4 1075.0 1076.3 1090.4 1092.8 6307.4 6310.9 6345.4 6347.8 6352.9 6637.4 6653.7 6677.5 6684.3 6686.0 6200.6 6345.1 6345.7 6349.6 6350.9 3570.4 3599.3 3603.7 3604.0 3606.1 6927.1 6928.0 6935.8 6941.2 6946.5 6497.5 6549.7 6728.6 6820.0 6829.9 6804.9 6960.6 6960.7 6963.9 6974.7 6687.8 6698.0 6702.1 6706.5 6706.9 6471.1 6617.3 6618.4 6623.1 6624.2 6981.9 6985.2 6987.2 6989.8 7000.6 4621.5 4665.7 4670.5 4673.7 4677.2 6594.3 6724.7 6732.7 6733.2 6743.5 6544.4 6556.2 6558.2 6564.0 6566.1 6496.9 6548.1 6549.7 6554.1 6554.4 6333.1 6441.9 6443.4 6444.7 6448.7 6542.1 6565.4 6568.4 6568.8 6568.9 6339.7 6421.5 6427.3 6429.2 6432.0 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14848.79 Median:4543.69 stddev:17545.32 (386.1%) stddev-sans-first:17562.63 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: Values: 757.1 835.6 923.7 924.0 935.9 13004.6 13403.1 13412.9 13448.1 13467.8 12668.6 12747.9 12777.2 12789.4 12796.6 736.7 742.0 890.6 903.4 916.5 905.7 910.4 917.8 918.9 919.3 766.3 951.7 959.6 959.7 960.2 766.6 943.9 959.5 960.6 961.2 714.3 716.5 717.2 717.3 717.9 11694.4 12044.0 12054.2 12076.3 12126.3 11972.3 12920.9 12941.1 12992.9 13723.2 11117.8 11194.9 11283.9 11300.9 11429.5 3764.2 3779.3 3787.5 3804.2 3814.9 50715.7 52999.5 54092.7 54103.7 54206.0 10633.3 10707.6 10793.5 10874.1 11080.1 18675.0 18692.9 18693.1 18702.3 18705.5 8032.4 8094.9 8101.1 8129.0 8140.4 4291.2 4399.4 4502.3 4524.6 4562.8 3240.5 3244.9 3258.6 3262.7 3271.9 587.6 594.6 595.3 615.2 634.9 553.5 699.7 721.7 736.6 744.3 9081.2 9100.7 9258.6 9318.5 9425.0 570.7 679.8 691.6 722.3 769.5 4116.4 4196.2 4224.8 4372.7 4585.7 56773.1 60362.7 60371.0 60880.7 61067.4 53634.5 56487.4 56509.0 58480.0 58534.4 52361.2 52470.0 52623.5 52764.5 53099.7 9217.0 9282.7 9303.2 9368.5 9398.9 37049.8 37440.3 37804.2 40428.0 40452.4 49442.0 49884.0 50003.2 50797.5 51330.2 11098.6 11628.4 11776.4 11881.9 11924.0 13246.3 13247.7 13294.2 13372.1 13389.1 12110.3 12135.3 12340.6 12404.2 12410.8 11809.1 11898.9 12233.1 12393.5 12573.2 11785.2 11935.7 11955.6 12092.9 12314.2 9561.9 9813.2 10032.9 10146.8 10329.3 10055.5 10211.8 10278.4 10343.1 10559.4 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:14:51 INFO - 2016-02-15 18:14:51,967 DEBUG : BROWSER_OUTPUT: 18:14:52 INFO - 2016-02-15 18:14:52,545 INFO : Browser exited with error code: 0 18:14:52 INFO - 2016-02-15 18:14:52,566 INFO : Completed test dromaeo_css (00:18:31) 18:14:52 INFO - 2016-02-15 18:14:52,566 INFO : Starting test kraken 18:14:52 INFO - 2016-02-15 18:14:52,566 DEBUG : operating with platform_type : linux_ 18:14:52 INFO - 2016-02-15 18:14:52,566 INFO : Initialising browser for kraken test... 18:14:52 INFO - 2016-02-15 18:14:52,573 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnZSbi6/profile http://localhost:57944/getInfo.html 18:14:56 INFO - 2016-02-15 18:14:56,274 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:14:56 INFO - 2016-02-15 18:14:56,275 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:14:56 INFO - 2016-02-15 18:14:56,275 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:14:56 INFO - 2016-02-15 18:14:56,275 DEBUG : BROWSER_OUTPUT: __metrics 18:14:56 INFO - 2016-02-15 18:14:56,432 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] 18:14:57 INFO - 2016-02-15 18:14:57,273 INFO : Browser initialized. 18:14:57 INFO - 2016-02-15 18:14:57,274 INFO : Running cycle 1/1 for kraken test... 18:14:57 INFO - 2016-02-15 18:14:57,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnZSbi6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:15:08 INFO - 2016-02-15 18:15:08,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 132517888 18:15:08 INFO - 2016-02-15 18:15:08,897 DEBUG : BROWSER_OUTPUT: 18:15:11 INFO - 2016-02-15 18:15:11,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:11 INFO - 2016-02-15 18:15:11,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 164081664 18:15:11 INFO - 2016-02-15 18:15:11,889 DEBUG : BROWSER_OUTPUT: 18:15:14 INFO - 2016-02-15 18:15:14,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-dft) 18:15:15 INFO - 2016-02-15 18:15:15,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 160321536 18:15:15 INFO - 2016-02-15 18:15:15,045 DEBUG : BROWSER_OUTPUT: 18:15:17 INFO - 2016-02-15 18:15:17,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-fft) 18:15:18 INFO - 2016-02-15 18:15:18,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 158822400 18:15:18 INFO - 2016-02-15 18:15:18,402 DEBUG : BROWSER_OUTPUT: 18:15:20 INFO - 2016-02-15 18:15:20,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-oscillator) 18:15:20 INFO - 2016-02-15 18:15:20,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 159342592 18:15:20 INFO - 2016-02-15 18:15:20,933 DEBUG : BROWSER_OUTPUT: 18:15:23 INFO - 2016-02-15 18:15:23,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:15:23 INFO - 2016-02-15 18:15:23,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 159006720 18:15:23 INFO - 2016-02-15 18:15:23,639 DEBUG : BROWSER_OUTPUT: 18:15:26 INFO - 2016-02-15 18:15:26,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-darkroom) 18:15:27 INFO - 2016-02-15 18:15:27,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 158969856 18:15:27 INFO - 2016-02-15 18:15:27,045 DEBUG : BROWSER_OUTPUT: 18:15:30 INFO - 2016-02-15 18:15:30,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:30 INFO - 2016-02-15 18:15:30,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 159870976 18:15:30 INFO - 2016-02-15 18:15:30,981 DEBUG : BROWSER_OUTPUT: 18:15:33 INFO - 2016-02-15 18:15:33,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57944/tests/kraken/driver.html?testName=json-parse-financial) 18:15:34 INFO - 2016-02-15 18:15:34,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 157904896 18:15:34 INFO - 2016-02-15 18:15:34,219 DEBUG : BROWSER_OUTPUT: 18:15:35 INFO - 2016-02-15 18:15:35,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:36 INFO - 2016-02-15 18:15:36,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 164552704 18:15:36 INFO - 2016-02-15 18:15:36,328 DEBUG : BROWSER_OUTPUT: 18:15:38 INFO - 2016-02-15 18:15:38,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:38 INFO - 2016-02-15 18:15:38,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 162820096 18:15:38 INFO - 2016-02-15 18:15:38,671 DEBUG : BROWSER_OUTPUT: 18:15:40 INFO - 2016-02-15 18:15:40,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:41 INFO - 2016-02-15 18:15:41,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 167342080 18:15:41 INFO - 2016-02-15 18:15:41,208 DEBUG : BROWSER_OUTPUT: 18:15:43 INFO - 2016-02-15 18:15:43,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:44 INFO - 2016-02-15 18:15:44,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 174587904 18:15:44 INFO - 2016-02-15 18:15:44,134 DEBUG : BROWSER_OUTPUT: 18:15:46 INFO - 2016-02-15 18:15:46,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:47 INFO - 2016-02-15 18:15:47,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 172851200 18:15:47 INFO - 2016-02-15 18:15:47,166 DEBUG : BROWSER_OUTPUT: 18:15:48 INFO - 2016-02-15 18:15:48,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57944/tests/kraken/driver.html?testName=ai-astar) 18:15:49 INFO - 2016-02-15 18:15:49,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 231485440 18:15:49 INFO - 2016-02-15 18:15:49,057 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;108;104;108;108;108;98;108;108;98 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;120;148;164;127;152;163;131;162;123 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;160;159;159;160;162;161;158;162;162 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;70;142;73;72;70;72;161;70 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;134;92;92;92;134;91;92;137 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;109;110;109;110 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;145;145;145;146;147 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 18:15:49 INFO - 2016-02-15 18:15:49,059 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;59;59;59;59;58;59;58;56;56 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;64;65;65;64;65;64;65;64 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;77;78;77;78;77;79;79;78 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;116;112;111;120;115;113;119;113;112 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;141;139;139;141;131;153;142;141;131 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;63;63;63;63;63;62;63;65;63 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,889 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: __startTimestamp1455588949058__endTimestamp 18:15:49 INFO - 2016-02-15 18:15:49,060 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,063 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.50 Median:108.00 stddev:4.14 (3.8%) stddev-sans-first:4.36 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: Values: 107.0 108.0 104.0 108.0 108.0 108.0 98.0 108.0 108.0 98.0 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.00 stddev:17.24 (11.4%) stddev-sans-first:18.15 18:15:49 INFO - 2016-02-15 18:15:49,064 DEBUG : BROWSER_OUTPUT: Values: 150.0 120.0 148.0 164.0 127.0 152.0 163.0 131.0 162.0 123.0 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.50 stddev:1.65 (1.0%) stddev-sans-first:1.50 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: Values: 163.0 160.0 159.0 159.0 160.0 162.0 161.0 158.0 162.0 162.0 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:70.00 stddev:34.31 (49.0%) stddev-sans-first:35.83 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 142.0 73.0 72.0 70.0 72.0 161.0 70.0 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:92.00 stddev:20.93 (22.7%) stddev-sans-first:21.69 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 134.0 92.0 92.0 92.0 134.0 91.0 92.0 137.0 18:15:49 INFO - 2016-02-15 18:15:49,065 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 147.0 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,066 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:59.00 stddev:1.37 (2.3%) stddev-sans-first:1.27 18:15:49 INFO - 2016-02-15 18:15:49,067 DEBUG : BROWSER_OUTPUT: Values: 56.0 59.0 59.0 59.0 59.0 58.0 59.0 58.0 56.0 56.0 18:15:49 INFO - 2016-02-15 18:15:49,067 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 64.0 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 77.0 78.0 77.0 78.0 77.0 79.0 79.0 78.0 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:3.21 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: Values: 112.0 116.0 112.0 111.0 120.0 115.0 113.0 119.0 113.0 112.0 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:141.00 stddev:6.74 (4.8%) stddev-sans-first:6.51 18:15:49 INFO - 2016-02-15 18:15:49,068 DEBUG : BROWSER_OUTPUT: Values: 131.0 141.0 139.0 139.0 141.0 131.0 153.0 142.0 141.0 131.0 18:15:49 INFO - 2016-02-15 18:15:49,069 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,069 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 18:15:49 INFO - 2016-02-15 18:15:49,069 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 65.0 63.0 18:15:49 INFO - 2016-02-15 18:15:49,069 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:15:49 INFO - 2016-02-15 18:15:49,069 DEBUG : BROWSER_OUTPUT: 18:15:49 INFO - 2016-02-15 18:15:49,737 INFO : Browser exited with error code: 0 18:15:49 INFO - 2016-02-15 18:15:49,788 INFO : Completed test kraken (00:00:57) 18:15:49 INFO - 2016-02-15 18:15:49,788 INFO : Starting test v8_7 18:15:49 INFO - 2016-02-15 18:15:49,788 DEBUG : operating with platform_type : linux_ 18:15:49 INFO - 2016-02-15 18:15:49,788 INFO : Initialising browser for v8_7 test... 18:15:49 INFO - 2016-02-15 18:15:49,795 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk7Mlea/profile http://localhost:57944/getInfo.html 18:15:53 INFO - 2016-02-15 18:15:53,474 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:15:53 INFO - 2016-02-15 18:15:53,474 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:15:53 INFO - 2016-02-15 18:15:53,474 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:15:53 INFO - 2016-02-15 18:15:53,474 DEBUG : BROWSER_OUTPUT: __metrics 18:15:53 INFO - 2016-02-15 18:15:53,610 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] 18:15:54 INFO - 2016-02-15 18:15:54,341 INFO : Browser initialized. 18:15:54 INFO - 2016-02-15 18:15:54,342 INFO : Running cycle 1/1 for v8_7 test... 18:15:54 INFO - 2016-02-15 18:15:54,342 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk7Mlea/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:16:06 INFO - 2016-02-15 18:16:06,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 132878336 18:16:06 INFO - 2016-02-15 18:16:06,017 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57944/tests/v8_7/run.html (next: http://localhost:57944/tests/v8_7/run.html) 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 423981056 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:16:27 INFO - 2016-02-15 18:16:27,650 DEBUG : BROWSER_OUTPUT: |0;Richards;172.3543605653223 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.2652885443583 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |4;RayTrace;980.3921568627451 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |5;Earley;537.9236148466917 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |6;Boyer;10500 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |7;RegExp;23928.571428571428 18:16:27 INFO - 2016-02-15 18:16:27,651 DEBUG : BROWSER_OUTPUT: |8;Splay;521.6484089723526 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1455588987642__endTimestamp 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,652 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.35 Median:172.35 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: Values: 172.4 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.27 Median:172.27 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: Values: 172.3 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: Values: 281.4 18:16:27 INFO - 2016-02-15 18:16:27,653 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: Values: 5170.1 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:980.39 Median:980.39 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: Values: 980.4 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:537.92 Median:537.92 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,654 DEBUG : BROWSER_OUTPUT: Values: 537.9 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10500.00 Median:10500.00 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: Values: 10500.0 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23928.57 Median:23928.57 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: Values: 23928.6 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,655 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.65 Median:521.65 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: Values: 521.6 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: Values: 4840.6 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:16:27 INFO - 2016-02-15 18:16:27,656 DEBUG : BROWSER_OUTPUT: 18:16:28 INFO - 2016-02-15 18:16:28,321 INFO : Browser exited with error code: 0 18:16:28 INFO - 2016-02-15 18:16:28,338 INFO : Completed test v8_7 (00:00:38) 18:16:28 INFO - 2016-02-15 18:16:28,705 INFO : Completed test suite (00:20:07) 18:16:28 INFO - 2016-02-15 18:16:28,705 DEBUG : Working with test: dromaeo_css 18:16:28 INFO - 2016-02-15 18:16:28,705 DEBUG : Generating results file: dromaeo_css 18:16:28 INFO - 2016-02-15 18:16:28,707 DEBUG : Working with test: kraken 18:16:28 INFO - 2016-02-15 18:16:28,707 DEBUG : Generating results file: kraken 18:16:28 INFO - 2016-02-15 18:16:28,708 INFO : javascript benchmark 18:16:28 INFO - 2016-02-15 18:16:28,708 DEBUG : Working with test: v8_7 18:16:28 INFO - 2016-02-15 18:16:28,708 DEBUG : Generating results file: v8_7 18:16:28 INFO - 2016-02-15 18:16:28,709 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:16:28 INFO - 2016-02-15 18:16:28,778 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 18:16:28 INFO - 2016-02-15 18:16:28,778 DEBUG : process_Request line: dromaeo_css 7406.98 graph.html#tests=[[72,53,35]] 18:16:28 INFO - 2016-02-15 18:16:28,778 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:16:28 INFO - 2016-02-15 18:16:28,905 DEBUG : process_Request line: kraken 1469.00 graph.html#tests=[[232,53,35]] 18:16:28 INFO - 2016-02-15 18:16:28,905 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:16:29 INFO - 2016-02-15 18:16:29,033 DEBUG : process_Request line: v8_7 23087.93 graph.html#tests=[[230,53,35]] 18:16:29 INFO - 2016-02-15 18:16:29,034 INFO : javascript benchmark 18:16:29 INFO - 2016-02-15 18:16:29,038 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3325.617553981292, 3382.5264462975174, 3419.179396944734, 3420.982895085524, 3430.5368775215347, 5519.089350257208, 5568.749406276717, 5575.2194692743, 5575.936166929647, 5576.86057848554, 5564.137558678402, 5564.693941833198, 5574.358948720898, 5575.0522411190095, 5586.35756887958, 4814.253790662436, 4949.158643030675, 5027.849164525061, 5055.848324550251, 5096.719680417576, 4947.901041979177, 5006.699598024112, 5012.198048312271, 5013.799448022075, 5014.5737612303, 4940.086084074458, 5000.449950505442, 5037.49625037497, 5049.0, 5053.166227572447, 5002.0246052019875, 5081.161608334621, 5084.7457627118865, 5087.745612719349, 5121.692698438105, 5018.7490625468945, 5116.283720279164, 5125.1287281162295, 5126.179811230222, 5130.0, 5180.663256888291, 5189.818356357509, 5283.0, 5294.549963253128, 5446.373667028302, 5962.522998160181, 5999.220101386792, 6002.519798416116, 6005.969970150121, 6011.57918945674, 5932.762689492415, 6012.518998480155, 6018.307894592134, 6023.879522409571, 6031.155638210654, 5330.813421530228, 5435.673859568399, 5514.476124768181, 5579.330480342385, 5605.383407825177, 6053.031514957674, 6057.0, 6111.938880611226, 6119.571629985859, 6141.84645383869, 5679.687617181012, 5935.198748168942, 5944.019236825961, 5949.464548190684, 5950.4049595041015, 5839.445252700986, 5873.618214816023, 5904.881902361929, 5921.733521991435, 5948.583599148104, 5867.325257595431, 5886.911696324559, 5902.321233058167, 5911.733971971185, 5913.142594323799, 5853.560982926298, 5873.735681894325, 5880.0, 5890.3815099414805, 5892.469677729025, 4323.2434323993175, 4487.977560112178, 4507.166174257773, 4596.839110631112, 4611.723296602215, 4119.258533463945, 4129.793510324472, 4132.586741325843, 4134.421181034658, 4163.479565054368, 5695.0, 5722.084466485342, 5727.971360143256, 5736.77052917887, 5759.136129580596, 5622.550195984311, 5716.085426331767, 5822.5633077518505, 5900.203472531153, 5947.940520594825, 5598.300212473441, 5672.659640421588, 5677.233573467529, 5677.37548869624, 5691.03252447085, 5162.6902385856965, 5179.093658609729, 5180.145276029413, 5190.325257716473, 5222.033923724123, 5937.435943585352, 6079.665618390943, 6087.391260873877, 6097.237845269341, 6191.4118158773945, 6002.249718785152, 6002.309734380602, 6017.187679663364, 6017.819465416044, 6021.187139736079, 6156.538259630635, 6206.72069756871, 6233.75064997395, 6239.469645080219, 6242.250929888442, 5670.291213598301, 5756.56825738063, 5766.711664416678, 5826.155207494974, 5876.294844618673, 5934.9406505934385, 5997.400259973968, 6008.609440386361, 6010.639361638316, 6081.179040829431, 5484.369297530676, 5898.557608179318, 5916.378780228014, 5928.436798504135, 5932.377100404568, 5683.630564013326, 5690.061139911868, 5767.942320576741, 5780.364159942487, 5791.652500849962, 5779.653220806765, 5795.7391917362975, 5796.797112101056, 5798.275215598051, 5806.187133801187, 5622.297212848394, 5690.374058853606, 5868.38381969887, 5869.207656966255, 5905.202797622266, 5659.575531835047, 5720.18781216786, 5743.684097374685, 5765.509931655856, 5797.507211887037], "unit": "ms", "name": "dojo.html", "value": 5481.468547424336}, {"lowerIsBetter": false, "replicates": [566.563745915645, 589.7935722497126, 612.6569121292076, 615.7660089166117, 617.3887851027484, 31986.36027279453, 41103.17793644125, 42783.35824962628, 42820.14359712808, 42842.14315713692, 45389.319160212624, 45984.54015459844, 45994.770026149825, 46027.76986115065, 46141.7692911535, 7775.572343521104, 7823.765287041369, 9185.219256363218, 9358.859617105714, 10636.734081647943, 10702.357858528474, 10808.297460665071, 10839.18706097042, 10844.891551084467, 10847.620333288336, 10839.458027098613, 10940.3982780947, 10941.398223097727, 10948.124150068015, 10954.342739435659, 10833.566657333697, 10903.236773425784, 10910.399928003957, 10930.234883558154, 10939.56241750333, 10628.734281642943, 10680.14558835299, 10750.677479675622, 10755.677329680122, 10764.031237188612, 43839.78080109611, 44202.33696494555, 44385.77807110976, 44404.333934991, 44448.3332750009, 3301.735861131104, 3356.3958487472246, 3369.545111409953, 3605.4231322988458, 3853.845846166178, 32628.184295392566, 32853.6714632853, 32877.0, 33012.0, 33026.17434564131, 4159.688023398257, 4269.103488267468, 4283.186194623012, 4296.205202037601, 4332.588404101605, 299003.0, 299675.0, 299991.0, 300698.0, 301234.0, 62163.0, 64248.67875660685, 64482.0, 64615.353846461876, 64680.676596616715, 56164.71917640386, 77821.0, 77828.22171778324, 77843.0, 78096.21903781003, 15837.287322070535, 16043.679126417406, 16063.277152527931, 16065.196740162944, 16069.35722571084, 11857.16999810005, 11873.050155987501, 11888.28670279786, 11894.92945634897, 11897.524099036114, 21755.34733957984, 21973.340799776033, 21978.560428791654, 22032.88983555072, 22060.88969555142, 8075.030996280367, 8338.207870252316, 8374.162583741578, 8374.371922105867, 8460.884778805299, 921.6958403726754, 1103.4979084516526, 1110.9611163609236, 1113.5323164271026, 1131.575659127827, 29147.708522914498, 29977.250568735955, 30138.24654383658, 30452.0, 30475.542866857017, 1047.512906498482, 1093.5133865429966, 1104.13877175803, 1116.5701205036119, 1155.566662501562, 14028.85971140296, 15638.139902305255, 15894.205289735466, 16721.163941803105, 16894.23975921062, 337284.0, 342535.0, 342773.0, 342795.0, 342860.0, 48070.75964620154, 49132.75433622809, 55017.44982550203, 56453.43546564564, 56475.0, 1370.6082885365101, 1390.311795661134, 1392.3664732546667, 1398.9020768546306, 1398.9090709103875, 28984.710152899046, 29216.70783292225, 29375.0, 29914.551281731226, 29999.850000749855, 47613.76193119151, 48017.5198248027, 48030.519694802606, 48068.27897581469, 48088.75955620199, 261966.0, 263475.0, 264468.0, 264577.0, 265165.09009458724, 34730.47904281387, 44918.77540612276, 45255.321170181815, 45804.541954580025, 45804.77097614491, 50793.492065080354, 50916.727081821766, 51133.23300150575, 51783.74108129435, 52368.47631523636, 41501.792491037355, 41751.37372939469, 42471.57528424676, 43425.0, 43794.0, 42180.78909605432, 42804.357934631626, 43079.0, 43195.78402108095, 43734.12531749411, 42932.71201863949, 42990.35514467223, 43442.348364775185, 43462.782686086364, 43580.56419435765, 36562.63437365699, 36782.26435471222, 37018.629813702595, 37838.0, 38115.47538098445, 28484.145475635763, 28617.570736438553, 28910.0, 28929.0, 28966.855165724035], "unit": "ms", "name": "ext.html", "value": 20430.93241659336}, {"lowerIsBetter": false, "replicates": [382.5734306248532, 383.85993599010936, 384.84413812405984, 386.2256176366387, 388.44258489068187, 14760.852391476083, 15008.474703385384, 17272.309107635694, 19195.520111997208, 19196.0, 16845.83154168458, 17238.310467581283, 17253.482395528154, 17992.64014719705, 17996.100194990264, 6051.455369016799, 6174.660393678346, 6206.224221972254, 6218.502519798428, 6222.160008398876, 4483.327500874862, 4593.311003349508, 6130.540209484284, 6599.604023758566, 6836.248012718597, 6643.202815662127, 6753.122094127781, 6791.932080679179, 6814.318568143196, 6815.216250131224, 6750.257471678112, 6799.932000679979, 6800.795976120724, 6811.897821532656, 6815.01182328562, 6392.977123660238, 6516.641584712839, 6523.086767852505, 6530.8040758777315, 6541.705623246918, 12609.495620175181, 23582.29253122409, 23833.285001449985, 23954.64068038981, 24029.27912162638, 1903.4765439504108, 2182.8035476807004, 2191.276878630048, 2276.1236923784295, 2304.585174668559, 10388.948055259676, 10424.061834434862, 11255.831162532568, 14342.64143396413, 14435.494757683431, 1825.7261410788356, 1914.3682584747, 1987.2647120565484, 2012.3359291433792, 2066.111572024029, 61288.69355653238, 63708.36291637117, 64770.0, 66015.0, 66127.33872661307, 11213.10295176384, 11224.326540407601, 11235.887641123483, 11247.83128253077, 11307.773844523228, 13368.59894203156, 14674.339654715563, 14704.117752934859, 14766.852331476548, 14797.630059248604, 6062.151298818169, 6175.289841668266, 7279.490435669558, 7860.528368297921, 7957.721479748297, 7537.283958023979, 7556.055493063367, 7561.395088392916, 7586.734464293723, 7612.162662107164, 4516.8193272268745, 4727.952720472751, 4824.686395384359, 4832.057748739033, 4866.683665561727, 1694.408818648622, 1898.3355825461254, 1941.4466876940287, 1959.5982823521144, 1966.675498542753, 1005.653049697853, 1015.5930444845616, 1028.4960369418932, 1118.1502058435647, 1132.773445310941, 14958.551243462714, 15912.0, 16758.664826703396, 17078.829211707725, 17128.657426851394, 950.0736781637847, 953.6042542344849, 964.7202311329636, 986.5768159395959, 1001.4241810958728, 9886.4562449066, 10127.949360253151, 10163.796724065625, 10185.847212291821, 10217.846732299022, 651081.0, 651134.0, 657229.0, 660072.0, 673412.0, 85286.57356713177, 86343.56828215944, 88529.55735221283, 89720.5513972426, 90507.0, 1176.4470698771563, 1183.3077649575096, 1185.4546908422221, 1195.786276928918, 1209.6371088673363, 15904.204789760697, 16142.919285403497, 16227.107509087113, 16253.51239462818, 16507.422240221535, 36714.63285367219, 37195.44206836846, 37439.81280093582, 38568.42147367736, 39021.6097839018, 48851.51148488469, 48975.26537101875, 50059.74970125126, 50525.49474505208, 52627.73686131698, 9763.902360976299, 10317.793644127225, 10470.424126673106, 10480.161587072864, 10480.475976201313, 14177.14937103777, 16562.917185413997, 17389.91305043467, 17971.5507112318, 18068.54828629295, 15170.24148792578, 15195.544133676007, 15297.46458873934, 15394.923025384802, 15467.226638667797, 11326.773464530828, 15169.772453413429, 15416.614584635474, 16126.193690315671, 16228.0, 15997.440089596808, 16076.598085047499, 16206.837931620534, 16266.942648727794, 16657.750133747762, 10225.233107516817, 10240.283180177315, 10311.690649280534, 10319.845202321821, 10451.581936722447, 14857.702845942804, 15929.761053583974, 16003.919980400024, 16087.356505739639, 16184.67630647357], "unit": "ms", "name": "jquery.html", "value": 9633.1563015199}, {"lowerIsBetter": false, "replicates": [1510.3128076725084, 1523.375416079407, 1732.5062357228192, 1801.5946412057285, 1843.3732530939478, 8063.314618257448, 8420.242178203953, 8421.0, 8435.072142064384, 8446.197611226924, 8167.877481837777, 8223.095459499466, 8243.95878020609, 8258.13289604592, 8259.38054645901, 2300.8734519601417, 2318.4435735423544, 2358.0567772890895, 2363.302825666424, 2363.3028256664325, 2327.8952447139836, 2350.4828937633692, 2350.976490235093, 2351.0830775997374, 2352.541254455382, 1961.764588249412, 2010.2963962613042, 2273.15893119546, 2294.9082036718596, 2368.7394386617457, 2254.368776742515, 2269.273832373641, 2284.7715228477186, 2285.2801367569164, 2286.9085236590518, 2305.884705764705, 2348.6477028445697, 2358.3396648938324, 2358.7995020423286, 2359.10354065454, 6741.224759152662, 6891.793246202622, 7435.219301973323, 7562.584057876815, 7571.0, 4854.199057155565, 4914.950850491485, 4940.308356830046, 4942.233953737176, 4953.058918805452, 3157.447446696819, 3168.8098714077228, 3214.1964508872784, 3239.3845169417737, 3293.324868401996, 1032.6385764982272, 1055.1664185293685, 1069.2996087562658, 1078.5577913055688, 1104.917131215154, 11342.0, 11396.829047564293, 11397.259178153394, 11425.0, 11439.82840257405, 4349.869503914888, 4374.650027997753, 4377.715448495837, 4408.933865992013, 4410.029793445437, 9874.555644995993, 9901.108900198873, 9942.254330925209, 9968.40189588627, 9969.451680157661, 4942.876428089255, 4967.0, 4975.4527002029745, 4978.153713868651, 4979.153543897473, 4431.512533621299, 4447.199504089231, 4472.172648060119, 4481.708688935209, 4491.932621010687, 3627.510286111394, 3732.757370770891, 3734.514513113332, 3736.4768932348948, 3757.098296408842, 1200.507791805373, 1207.6678913298738, 1208.8730683278304, 1209.8729633388543, 1216.0636310041218, 1146.5814977533307, 1169.2049406403557, 1177.8115501519715, 1181.3207405741732, 1183.2486371154207, 7689.692412303557, 7710.036245469317, 7752.418568607377, 7782.805429864298, 7807.336376407955, 1098.5880294889416, 1120.523777394604, 1138.4990604134155, 1214.4656351205442, 1214.6477521518661, 5418.214358917935, 6077.36187700294, 6101.328853826076, 6105.053716673922, 6123.08153776937, 8500.70247541333, 9746.122848943487, 9788.461634610165, 9874.506274686237, 10056.145227655732, 9415.952920235355, 9501.477418741897, 9785.853212201822, 9856.359336643096, 9930.950345248228, 7528.736494222676, 7561.243875612395, 7637.274458926393, 7639.159692433828, 7641.503302285334, 7696.268854458817, 7756.1468238494845, 7808.492447990862, 7808.5314881107315, 7902.051753789352, 8469.407141500036, 8774.254188394058, 8984.101589841224, 9000.279977601645, 9015.14356136166, 8755.430896991675, 8860.645574177219, 8961.820763584823, 8995.820083598423, 9040.90959090427, 7297.854042919218, 7396.408287337108, 7433.92566074354, 7434.73978410753, 7446.106467223751, 7961.920380796118, 8076.0, 8078.030636323444, 8081.393895457982, 8094.231048050426, 7238.855222895408, 7334.889976650248, 7373.889391659022, 7443.665035073543, 7684.154742978156, 7376.594287314035, 7379.631018448948, 7388.926110739038, 7442.92557074444, 7456.58988755602, 6982.581045137308, 7125.144982602121, 7133.928660713326, 7303.379212766762, 7363.226861179499, 6734.124563806674, 6736.326367363225, 6756.797296081126, 6772.695228714621, 6780.966095169492, 6537.084808126771, 6625.569337993015, 6879.415249703831, 6907.585544867324, 6931.0], "unit": "ms", "name": "mootools.html", "value": 4677.572874108913}, {"lowerIsBetter": false, "replicates": [331.9767616266861, 333.41319278070597, 341.726618705036, 344.11562284927743, 350.6651148153512, 6072.392760723926, 6073.362296958822, 6084.269887613493, 6094.664793436359, 6098.57309988301, 6064.0, 6066.059760737082, 6074.2710874694985, 6074.939250607493, 6081.3918608139165, 4621.191291523986, 4686.343911852344, 4690.788914498856, 4697.506761789997, 4707.882302942419, 4621.214393553088, 4652.0, 4656.0, 4663.090697314025, 4667.043256132485, 4571.565701258375, 4589.563991420827, 4599.126166028461, 4609.792559334838, 4616.030633566955, 4315.007548263901, 4429.867103986853, 4513.345564893072, 4552.772361381934, 4554.954450455502, 4013.8595149169637, 4018.7789671568053, 4040.5757395473347, 4054.087830238173, 4056.4726585543985, 5698.8290351289525, 5707.942920570824, 5714.057180565202, 5732.541396688255, 5737.7131143443075, 5019.322391477141, 5117.078925793356, 5296.629235953485, 5399.298091248152, 5408.540274076709, 6348.587341822767, 6362.650054247015, 6364.299927008025, 6365.809025729235, 6374.426301632829, 4515.14212299662, 4515.977420112911, 4516.029053753426, 4518.028623845856, 4521.208788462006, 6478.967605161944, 6621.205455345341, 6623.9006414903815, 6632.568883022588, 6646.534742568022, 4499.685022048425, 4536.61438777701, 4538.500764915857, 4543.273076307841, 4544.500104988449, 4588.816447342136, 4589.632829373642, 4591.173588754056, 4595.103954728863, 4595.425571803525, 5328.17413300939, 5334.493223143795, 5340.519353258148, 5342.439043900412, 5344.438833922382, 6327.96836015817, 6412.358764123644, 6423.100765892778, 6441.742330306829, 6451.612903225821, 1579.2735341742928, 1614.3291693097588, 1620.5057457475348, 1621.0435842852773, 1621.7405215165518, 1056.392574269798, 1075.0271004740723, 1076.3057827701089, 1090.378484263962, 1092.7978324010085, 6307.432331090224, 6310.9368906311265, 6345.365463453618, 6347.841303967345, 6352.872942541123, 6637.369449902348, 6653.667316634149, 6677.499187560952, 6684.2647308795995, 6686.0, 6200.56596038273, 6345.143405640272, 6345.682715864188, 6349.619022858643, 6350.872982540323, 3570.357335679603, 3599.280143971164, 3603.6936860367164, 3604.0269127335473, 3606.0804494853646, 6927.099477067949, 6927.965360173167, 6935.757248496278, 6941.201761797458, 6946.51374403797, 6497.545171838021, 6549.738010479623, 6728.562643428161, 6819.965900170468, 6829.897551536731, 6804.863902721918, 6960.617166055814, 6960.721571137098, 6963.860722785617, 6974.686139123752, 6687.832804179934, 6697.966510167613, 6702.128723265944, 6706.530542861953, 6706.865862682816, 6471.094046833353, 6617.272100069084, 6618.437432818265, 6623.105880706043, 6624.205095388585, 6981.930180698128, 6985.196702379291, 6987.161540615159, 6989.825254368681, 7000.579965202104, 4621.514740952151, 4665.720056796603, 4670.509596492319, 4673.696209746356, 4677.158111539956, 6594.340565943367, 6724.663766811737, 6732.730690772511, 6733.192016957996, 6743.52795304324, 6544.411003009752, 6556.213254409501, 6558.245801732862, 6564.0, 6566.080748695091, 6496.9025464617125, 6548.0832683423405, 6549.7380104795275, 6554.115194448879, 6554.410103090745, 6333.081703153109, 6441.871162576816, 6443.420092191725, 6444.709988050456, 6448.677566121582, 6542.116814230209, 6565.376289252514, 6568.376004279586, 6568.80293591193, 6568.94896816507, 6339.683015849097, 6421.486281097595, 6427.260865000585, 6429.164208652845, 6432.035194720829], "unit": "ms", "name": "prototype.html", "value": 4867.661892673453}, {"lowerIsBetter": false, "replicates": [757.0536828963795, 835.5989125219894, 923.7459698582885, 923.9769005774855, 935.9017303183169, 13004.609861704152, 13403.061785674981, 13412.865871341308, 13448.125871818338, 13467.797983030263, 12668.556600518983, 12747.93626031871, 12777.169483983535, 12789.36053197341, 12796.552120675778, 736.661135877497, 742.0316486984483, 890.6214858685049, 903.4037535226752, 916.5142474488532, 905.6875377994581, 910.4127837544779, 917.8256131335058, 918.8805455290803, 919.2645883293372, 766.264386189259, 951.7477868364854, 959.5586030425977, 959.7360725800426, 960.1982344742148, 766.643510767493, 943.8867335919665, 959.4962644611564, 960.6061514778908, 961.1925982175006, 714.2607401339588, 716.4662326566742, 717.2397258905577, 717.2683862460314, 717.8959050937638, 11694.356810375426, 12044.0, 12054.216475929124, 12076.275423474532, 12126.27242365461, 11972.281663100242, 12920.87079129206, 12941.094123411365, 12992.935035324763, 13723.245221512812, 11117.833232501518, 11194.944025279903, 11283.943580282128, 11300.94349528247, 11429.542818287258, 3764.1906989997283, 3779.3008293465796, 3787.450819631138, 3804.1821008483034, 3814.866479673226, 50715.74642126803, 52999.47000529984, 54092.72953635246, 54103.72948135273, 54206.0, 10633.255672103034, 10707.571697132184, 10793.460326983619, 10874.075703565128, 11080.113590912708, 18675.0, 18692.906535467235, 18693.1306869312, 18702.345417910306, 18705.53236169107, 8032.39757018226, 8094.878576821352, 8101.108878023413, 8129.0, 8140.389470789714, 4291.206126866539, 4399.38408622793, 4502.257127573979, 4524.592786649151, 4562.794674239667, 3240.4653232216892, 3244.853981570835, 3258.5926759155104, 3262.6737326267657, 3271.934561308808, 587.5974957154363, 594.5808205215313, 595.2707932782307, 615.1695211464487, 634.8952422850178, 553.5046133710307, 699.7061234281513, 721.7365661533503, 736.6464097233358, 744.2892038103598, 9081.228095611947, 9100.726978190665, 9258.583363748647, 9318.487483188354, 9425.0, 570.7231992483643, 679.7960611816435, 691.550492180077, 722.3065856777553, 769.5036701327613, 4116.403121547419, 4196.181744559843, 4224.78876056196, 4372.672049596229, 4585.747783871919, 56773.14840277399, 60362.69818650967, 60371.0, 60880.695596521735, 61067.389326107055, 53634.463655362946, 56487.43512564904, 56509.0, 58480.0, 58534.41465585375, 52361.21458178131, 52469.950600987766, 52623.47376526262, 52764.472355276725, 53099.73450132724, 9216.98613152566, 9282.72151835446, 9303.209227215762, 9368.48473333946, 9398.906010939803, 37049.814750926074, 37440.251194976496, 37804.2439151221, 40428.0, 40452.39321410123, 49442.0, 49884.0, 50003.249951250036, 50797.49202507928, 51330.23004654858, 11098.5560577576, 11628.418579071182, 11776.352300623548, 11881.881181188077, 11924.0, 13246.271455070064, 13247.66880827987, 13294.20234785916, 13372.104582960223, 13389.062765606313, 12110.273383597012, 12135.271883687006, 12340.629781106221, 12404.19372740769, 12410.75178496407, 11809.11431642613, 11898.881011189776, 12233.143679942674, 12393.504259829506, 12573.182743121668, 11785.175037747618, 11935.701607459883, 11955.64133076009, 12092.879071209176, 12314.199577027464, 9561.856572151562, 9813.165880899918, 10032.899671003197, 10146.847797282899, 10329.328593641389, 10055.49722513886, 10211.795764084529, 10278.434686092038, 10343.120834728832, 10559.419231942316], "unit": "ms", "name": "yui.html", "value": 6722.2136174855705}], "name": "dromaeo_css", "value": 7406.981130609017}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 108.0, 104.0, 108.0, 108.0, 108.0, 98.0, 108.0, 108.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 105.5}, {"lowerIsBetter": true, "replicates": [150.0, 120.0, 148.0, 164.0, 127.0, 152.0, 163.0, 131.0, 162.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 159.0, 159.0, 160.0, 162.0, 161.0, 158.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 142.0, 73.0, 72.0, 70.0, 72.0, 161.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 134.0, 92.0, 92.0, 92.0, 134.0, 91.0, 92.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 56.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 77.0, 78.0, 77.0, 78.0, 77.0, 79.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [112.0, 116.0, 112.0, 111.0, 120.0, 115.0, 113.0, 119.0, 113.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [131.0, 141.0, 139.0, 139.0, 141.0, 131.0, 153.0, 142.0, 141.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 65.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.2}], "name": "kraken", "value": 1469.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.3543605653223], "unit": "score", "name": "Richards", "value": 204.822204}, {"lowerIsBetter": false, "replicates": [172.2652885443583], "unit": "score", "name": "DeltaBlue", "value": 383.81499}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [980.3921568627451], "unit": "score", "name": "RayTrace", "value": 754.7887800000001}, {"lowerIsBetter": false, "replicates": [537.9236148466917], "unit": "score", "name": "Earley", "value": 1238.9547169999996}, {"lowerIsBetter": false, "replicates": [10500.0], "unit": "score", "name": "Boyer", "value": 63.47266666666663}, {"lowerIsBetter": false, "replicates": [23928.571428571428], "unit": "score", "name": "RegExp", "value": 38.071014925373106}, {"lowerIsBetter": false, "replicates": [521.6484089723526], "unit": "score", "name": "Splay", "value": 156.21824700000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23087.932481674517}]} 18:16:29 INFO - RETURN: dromaeo_css: 7406.98 18:16:29 INFO - RETURN: kraken: 1469.00 18:16:29 INFO - RETURN: v8_7: 23087.93 18:16:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23087.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1469.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7406.98"}}} 18:16:29 INFO - Return code: 0 18:16:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:16:29 INFO - # TBPL SUCCESS # 18:16:29 INFO - Running post-action listener: _resource_record_post_action 18:16:29 INFO - Running post-run listener: _resource_record_post_run 18:16:30 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8220672; Write bytes: 412807168; Read time: 1756; Write time: 242296 18:16:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 16461824; Read time: 0; Write time: 7564 18:16:30 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 8216576; Write bytes: 295084032; Read time: 1608; Write time: 172676 18:16:30 INFO - Running post-run listener: _upload_blobber_files 18:16:30 INFO - Blob upload gear active. 18:16:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:16:30 INFO - Copying logs to upload dir... 18:16:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.231733 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-15 18:16:30.342335) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 18:16:30.345808) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009873 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455578871/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-15 18:16:30.396267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:16:30.396595) ========= 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=337fe3f4b1febe37b85fccc40000019e-1455587326.681708-1596126540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 18:16:30.445969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 18:16:30.446300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 18:16:30.446603) ========= ========= Total master_lag: 0.56 =========