builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1453723710.86 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.862942) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.863396) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.863682) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006226 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.886071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.886397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.899745) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.900058) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.949012) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.949324) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.949670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:30.949936) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 04:08:31-- 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% 22.2M=0.001s 2016-01-25 04:08:31 (22.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.127144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.127493) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016667 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.177627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.177986) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f84fcce02b11 --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 f84fcce02b11 --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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 04:08:31,638 Setting DEBUG logging. 2016-01-25 04:08:31,638 attempt 1/10 2016-01-25 04:08:31,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f84fcce02b11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 04:08:31,890 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.748671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.749028) ========= echo f84fcce02b11 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f84fcce02b11'] 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f84fcce02b11 program finished with exit code 0 elapsedTime=0.004653 script_repo_revision: 'f84fcce02b11' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.797806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.798132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:31.808273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 04:08:31.808651) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:32 INFO - MultiFileLogger online at 20160125 04:08:32 in /builds/slave/test-pgo 04:08:32 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 04:08:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:08:32 INFO - {'append_to_log': False, 04:08:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:08:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:08:32 INFO - 'branch': 'Mozilla-Beta', 04:08:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:32 INFO - 'config_files': ('talos/linux_config.py',), 04:08:32 INFO - 'default_actions': ('clobber', 04:08:32 INFO - 'read-buildbot-config', 04:08:32 INFO - 'download-and-extract', 04:08:32 INFO - 'populate-webroot', 04:08:32 INFO - 'create-virtualenv', 04:08:32 INFO - 'install', 04:08:32 INFO - 'run-tests'), 04:08:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:32 INFO - 'download_minidump_stackwalk': True, 04:08:32 INFO - 'download_symbols': 'ondemand', 04:08:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:32 INFO - 'installer_path': 'installer.exe', 04:08:32 INFO - 'log_level': 'info', 04:08:32 INFO - 'log_name': 'talos', 04:08:32 INFO - 'log_to_console': True, 04:08:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:32 INFO - 'opt_config_files': (), 04:08:32 INFO - 'pip_index': False, 04:08:32 INFO - 'sps_profile': False, 04:08:32 INFO - 'sps_profile_interval': 0, 04:08:32 INFO - 'suite': 'dromaeojs', 04:08:32 INFO - 'system_bits': '32', 04:08:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:32 INFO - 'title': 'talos-linux64-ix-062', 04:08:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:32 INFO - 'use_talos_json': True, 04:08:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:08:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:32 INFO - 'work_dir': 'build'} 04:08:32 INFO - ##### 04:08:32 INFO - ##### Running clobber step. 04:08:32 INFO - ##### 04:08:32 INFO - Running pre-action listener: _resource_record_pre_action 04:08:32 INFO - Running main action method: clobber 04:08:32 INFO - rmtree: /builds/slave/test-pgo/build 04:08:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:08:32 INFO - Running post-action listener: _resource_record_post_action 04:08:32 INFO - ##### 04:08:32 INFO - ##### Running read-buildbot-config step. 04:08:32 INFO - ##### 04:08:32 INFO - Running pre-action listener: _resource_record_pre_action 04:08:32 INFO - Running main action method: read_buildbot_config 04:08:32 INFO - Using buildbot properties: 04:08:32 INFO - { 04:08:32 INFO - "properties": { 04:08:32 INFO - "buildnumber": 84, 04:08:32 INFO - "product": "firefox", 04:08:32 INFO - "script_repo_revision": "production", 04:08:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:08:32 INFO - "repository": "", 04:08:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:08:32 INFO - "buildid": "20160118120031", 04:08:32 INFO - "slavename": "talos-linux64-ix-062", 04:08:32 INFO - "pgo_build": "True", 04:08:32 INFO - "basedir": "/builds/slave/test-pgo", 04:08:32 INFO - "project": "", 04:08:32 INFO - "platform": "ubuntu64_hw", 04:08:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:08:32 INFO - "slavebuilddir": "test", 04:08:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:08:32 INFO - "branch": "mozilla-beta", 04:08:32 INFO - "repo_path": "releases/mozilla-beta", 04:08:32 INFO - "stage_platform": "linux64-pgo", 04:08:32 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 04:08:32 INFO - "revision": "f84fcce02b11" 04:08:32 INFO - }, 04:08:32 INFO - "sourcestamp": { 04:08:32 INFO - "repository": "", 04:08:32 INFO - "hasPatch": false, 04:08:32 INFO - "project": "", 04:08:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:32 INFO - "changes": [ 04:08:32 INFO - { 04:08:32 INFO - "category": null, 04:08:32 INFO - "files": [ 04:08:32 INFO - { 04:08:32 INFO - "url": null, 04:08:32 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2" 04:08:32 INFO - } 04:08:32 INFO - ], 04:08:32 INFO - "repository": "", 04:08:32 INFO - "rev": "f84fcce02b11", 04:08:32 INFO - "who": "sendchange", 04:08:32 INFO - "when": 1453155801, 04:08:32 INFO - "number": 7475630, 04:08:32 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 04:08:32 INFO - "project": "", 04:08:32 INFO - "at": "Mon 18 Jan 2016 14:23:21", 04:08:32 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:32 INFO - "revlink": "", 04:08:32 INFO - "properties": [ 04:08:32 INFO - [ 04:08:32 INFO - "buildid", 04:08:32 INFO - "20160118120031", 04:08:32 INFO - "Change" 04:08:32 INFO - ], 04:08:32 INFO - [ 04:08:32 INFO - "builduid", 04:08:32 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 04:08:32 INFO - "Change" 04:08:32 INFO - ], 04:08:32 INFO - [ 04:08:32 INFO - "pgo_build", 04:08:32 INFO - "True", 04:08:32 INFO - "Change" 04:08:32 INFO - ] 04:08:32 INFO - ], 04:08:32 INFO - "revision": "f84fcce02b11" 04:08:32 INFO - } 04:08:32 INFO - ], 04:08:32 INFO - "revision": "f84fcce02b11" 04:08:32 INFO - } 04:08:32 INFO - } 04:08:32 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2. 04:08:32 INFO - Running post-action listener: _resource_record_post_action 04:08:32 INFO - ##### 04:08:32 INFO - ##### Running download-and-extract step. 04:08:32 INFO - ##### 04:08:32 INFO - Running pre-action listener: _resource_record_pre_action 04:08:32 INFO - Running main action method: download_and_extract 04:08:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:08: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')]} 04:08:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 04:08:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:08:32 INFO - Downloaded 1270 bytes. 04:08:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:08:32 INFO - Using the following test package requirements: 04:08:32 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:32 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:32 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'jsshell-linux-x86_64.zip'], 04:08:32 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:32 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:32 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:08:32 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:08:32 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:32 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:32 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:32 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:32 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08: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')]} 04:08:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:33 INFO - Downloaded 22573307 bytes. 04:08:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:34 INFO - Return code: 0 04:08:34 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:34 INFO - Downloaded 22573307 bytes. 04:08:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:35 INFO - Return code: 0 04:08: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')]} 04:08:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:08:36 INFO - Downloaded 11131970 bytes. 04:08:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:08:36 INFO - Return code: 0 04:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:08:37 INFO - Downloaded 56626174 bytes. 04:08:37 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:37 INFO - mkdir: /builds/slave/test-pgo/properties 04:08:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:08:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:08:37 INFO - Contents: 04:08:37 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:37 INFO - Running post-action listener: _resource_record_post_action 04:08:37 INFO - Running post-action listener: set_extra_try_arguments 04:08:37 INFO - ##### 04:08:37 INFO - ##### Running populate-webroot step. 04:08:37 INFO - ##### 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: populate_webroot 04:08:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:37 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:08:37 INFO - '../fennec_ids.txt'], 04:08:37 INFO - 'tests': ['tcheck2']}, 04:08:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:37 INFO - '--tppagecycles', 04:08:37 INFO - '7'], 04:08:37 INFO - 'tests': ['tsvgm']}}, 04:08:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['damp', 'tps']}, 04:08:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['damp', 'tps']}, 04:08:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:37 INFO - 'other': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'other_l64': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore']}, 04:08:37 INFO - 'svgr': {'tests': ['tsvgx', 04:08:37 INFO - 'tsvgr_opacity', 04:08:37 INFO - 'tart', 04:08:37 INFO - 'tscrollx', 04:08:37 INFO - 'cart']}, 04:08:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['tsvgx', 04:08:37 INFO - 'tsvgr_opacity', 04:08:37 INFO - 'tart', 04:08:37 INFO - 'tscrollx', 04:08:37 INFO - 'cart']}, 04:08:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['tp5o']}, 04:08:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--e10s'], 04:08:37 INFO - 'tests': ['tp5o']}, 04:08:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--xperf_path', 04:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:37 INFO - 'tests': ['tp5n']}, 04:08:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--e10s', 04:08:37 INFO - '--xperf_path', 04:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:37 INFO - 'tests': ['tp5n']}}, 04:08:37 INFO - 'talos.zip': {'path': '', 04:08:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:37 INFO - Running post-action listener: _resource_record_post_action 04:08:37 INFO - ##### 04:08:37 INFO - ##### Running create-virtualenv step. 04:08:37 INFO - ##### 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: create_virtualenv 04:08:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:08:37 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 04:08:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:37 INFO - Using real prefix '/usr' 04:08:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:08:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:39 INFO - Installing pip.................done. 04:08:39 INFO - Return code: 0 04:08:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:39 INFO - Using env: {'DISPLAY': ':0', 04:08:39 INFO - 'HOME': '/home/cltbld', 04:08:39 INFO - 'LANG': 'en_US.UTF-8', 04:08:39 INFO - 'LANGUAGE': 'en_US:en', 04:08:39 INFO - 'LOGNAME': 'cltbld', 04:08:39 INFO - 'MAIL': '/var/mail/cltbld', 04:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:39 INFO - 'MOZ_NO_REMOTE': '1', 04:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:39 INFO - 'NO_EM_RESTART': '1', 04:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:39 INFO - 'SHELL': '/bin/bash', 04:08:39 INFO - 'SHLVL': '1', 04:08:39 INFO - 'TERM': 'linux', 04:08:39 INFO - 'TMOUT': '86400', 04:08:39 INFO - 'USER': 'cltbld', 04:08:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:39 INFO - '_': '/tools/buildbot/bin/python'} 04:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:40 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 04:08:40 INFO - Cleaning up... 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:40 INFO - Using env: {'DISPLAY': ':0', 04:08:40 INFO - 'HOME': '/home/cltbld', 04:08:40 INFO - 'LANG': 'en_US.UTF-8', 04:08:40 INFO - 'LANGUAGE': 'en_US:en', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MAIL': '/var/mail/cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SHLVL': '1', 04:08:40 INFO - 'TERM': 'linux', 04:08:40 INFO - 'TMOUT': '86400', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - '_': '/tools/buildbot/bin/python'} 04:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:40 INFO - Downloading/unpacking psutil>=0.7.1 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:08:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:08:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:42 INFO - Installing collected packages: psutil 04:08:42 INFO - Running setup.py install for psutil 04:08:42 INFO - building 'psutil._psutil_linux' extension 04:08:42 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 04:08:42 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 04:08:42 INFO - building 'psutil._psutil_posix' extension 04:08:42 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 04:08:42 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 04:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:42 INFO - Successfully installed psutil 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:08:42 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')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 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')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:42 INFO - Using env: {'DISPLAY': ':0', 04:08:42 INFO - 'HOME': '/home/cltbld', 04:08:42 INFO - 'LANG': 'en_US.UTF-8', 04:08:42 INFO - 'LANGUAGE': 'en_US:en', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MAIL': '/var/mail/cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SHLVL': '1', 04:08:42 INFO - 'TERM': 'linux', 04:08:42 INFO - 'TMOUT': '86400', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - '_': '/tools/buildbot/bin/python'} 04:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:42 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 04:08:42 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 04:08:42 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 04:08:42 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 04:08:42 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 04:08:42 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 04:08:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:08:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:44 INFO - Installing collected packages: mozsystemmonitor 04:08:44 INFO - Running setup.py install for mozsystemmonitor 04:08:44 INFO - Successfully installed mozsystemmonitor 04:08:44 INFO - Cleaning up... 04:08:44 INFO - Return code: 0 04:08:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:44 INFO - Using env: {'DISPLAY': ':0', 04:08:44 INFO - 'HOME': '/home/cltbld', 04:08:44 INFO - 'LANG': 'en_US.UTF-8', 04:08:44 INFO - 'LANGUAGE': 'en_US:en', 04:08:44 INFO - 'LOGNAME': 'cltbld', 04:08:44 INFO - 'MAIL': '/var/mail/cltbld', 04:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:44 INFO - 'MOZ_NO_REMOTE': '1', 04:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:44 INFO - 'NO_EM_RESTART': '1', 04:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:44 INFO - 'SHELL': '/bin/bash', 04:08:44 INFO - 'SHLVL': '1', 04:08:44 INFO - 'TERM': 'linux', 04:08:44 INFO - 'TMOUT': '86400', 04:08:44 INFO - 'USER': 'cltbld', 04:08:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:44 INFO - '_': '/tools/buildbot/bin/python'} 04:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:08:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:08:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:08:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:47 INFO - Downloading docopt-0.6.1.tar.gz 04:08:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:08:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:47 INFO - Running setup.py install for blobuploader 04:08:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:08:47 INFO - Running setup.py install for requests 04:08:48 INFO - Running setup.py install for docopt 04:08:48 INFO - Successfully installed blobuploader requests docopt 04:08:48 INFO - Cleaning up... 04:08:48 INFO - Return code: 0 04:08:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:48 INFO - Using env: {'DISPLAY': ':0', 04:08:48 INFO - 'HOME': '/home/cltbld', 04:08:48 INFO - 'LANG': 'en_US.UTF-8', 04:08:48 INFO - 'LANGUAGE': 'en_US:en', 04:08:48 INFO - 'LOGNAME': 'cltbld', 04:08:48 INFO - 'MAIL': '/var/mail/cltbld', 04:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:48 INFO - 'MOZ_NO_REMOTE': '1', 04:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:48 INFO - 'NO_EM_RESTART': '1', 04:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:48 INFO - 'SHELL': '/bin/bash', 04:08:48 INFO - 'SHLVL': '1', 04:08:48 INFO - 'TERM': 'linux', 04:08:48 INFO - 'TMOUT': '86400', 04:08:48 INFO - 'USER': 'cltbld', 04:08:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:48 INFO - '_': '/tools/buildbot/bin/python'} 04:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:48 INFO - Running setup.py (path:/tmp/pip-uYWM0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:48 INFO - Running setup.py (path:/tmp/pip-9x0av3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:48 INFO - Running setup.py (path:/tmp/pip-joDC4i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:48 INFO - Running setup.py (path:/tmp/pip-JK65Ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:48 INFO - Running setup.py (path:/tmp/pip-k_VfpZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:48 INFO - Running setup.py (path:/tmp/pip-Kmm2ZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:48 INFO - Running setup.py (path:/tmp/pip-1AigR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:48 INFO - Running setup.py (path:/tmp/pip-9jix6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:49 INFO - Running setup.py (path:/tmp/pip-aK7pbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:49 INFO - Running setup.py (path:/tmp/pip-yFqNWK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:49 INFO - Running setup.py (path:/tmp/pip-E5y6ry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:49 INFO - Running setup.py (path:/tmp/pip-T4kLNO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:49 INFO - Running setup.py (path:/tmp/pip-Gie2Yp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:49 INFO - Running setup.py (path:/tmp/pip-uhMLHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:49 INFO - Running setup.py (path:/tmp/pip-A40XXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:49 INFO - Running setup.py (path:/tmp/pip-ANABmC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:49 INFO - Running setup.py (path:/tmp/pip-lNz_Cz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:49 INFO - Running setup.py install for manifestparser 04:08:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:08:49 INFO - Running setup.py install for mozcrash 04:08:49 INFO - Running setup.py install for mozdebug 04:08:49 INFO - Running setup.py install for mozdevice 04:08:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for mozfile 04:08:50 INFO - Running setup.py install for mozhttpd 04:08:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for mozinfo 04:08:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for mozInstall 04:08:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for mozleak 04:08:50 INFO - Running setup.py install for mozlog 04:08:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for moznetwork 04:08:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Running setup.py install for mozprocess 04:08:50 INFO - Running setup.py install for mozprofile 04:08:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:08:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:08:51 INFO - Running setup.py install for mozrunner 04:08:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:08:51 INFO - Running setup.py install for mozscreenshot 04:08:51 INFO - Running setup.py install for moztest 04:08:51 INFO - Running setup.py install for mozversion 04:08:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:08:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:51 INFO - Cleaning up... 04:08:51 INFO - Return code: 0 04:08:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:51 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')]} 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 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')]} 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:51 INFO - Using env: {'DISPLAY': ':0', 04:08:51 INFO - 'HOME': '/home/cltbld', 04:08:51 INFO - 'LANG': 'en_US.UTF-8', 04:08:51 INFO - 'LANGUAGE': 'en_US:en', 04:08:51 INFO - 'LOGNAME': 'cltbld', 04:08:51 INFO - 'MAIL': '/var/mail/cltbld', 04:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:51 INFO - 'MOZ_NO_REMOTE': '1', 04:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:51 INFO - 'NO_EM_RESTART': '1', 04:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:51 INFO - 'SHELL': '/bin/bash', 04:08:51 INFO - 'SHLVL': '1', 04:08:51 INFO - 'TERM': 'linux', 04:08:51 INFO - 'TMOUT': '86400', 04:08:51 INFO - 'USER': 'cltbld', 04:08:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:51 INFO - '_': '/tools/buildbot/bin/python'} 04:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:51 INFO - Running setup.py (path:/tmp/pip-AtvemM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:51 INFO - Running setup.py (path:/tmp/pip-Sf7eA4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:51 INFO - Running setup.py (path:/tmp/pip-7SRbXL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:51 INFO - Running setup.py (path:/tmp/pip-oyeqQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 04:08:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:51 INFO - Running setup.py (path:/tmp/pip-5DSerT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:52 INFO - Running setup.py (path:/tmp/pip-vOBOzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:52 INFO - Running setup.py (path:/tmp/pip-cIpDyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:52 INFO - Running setup.py (path:/tmp/pip-QTMAZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:52 INFO - Running setup.py (path:/tmp/pip-7pBoAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:52 INFO - Running setup.py (path:/tmp/pip-oHOFke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:52 INFO - Running setup.py (path:/tmp/pip-DTFoc5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:52 INFO - Running setup.py (path:/tmp/pip-Cy3fKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:52 INFO - Running setup.py (path:/tmp/pip-7IbkZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:52 INFO - Running setup.py (path:/tmp/pip-o2x6sk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:52 INFO - Running setup.py (path:/tmp/pip-hBqDw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:52 INFO - Running setup.py (path:/tmp/pip-no6Mla-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:52 INFO - Running setup.py (path:/tmp/pip-xTue40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:52 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Downloading blessings-1.6.tar.gz 04:08:54 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.6.tar.gz 04:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:54 INFO - Installing collected packages: blessings 04:08:54 INFO - Running setup.py install for blessings 04:08:54 INFO - Successfully installed blessings 04:08:54 INFO - Cleaning up... 04:08:54 INFO - Return code: 0 04:08:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:08:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Current package versions: 04:08:55 INFO - argparse == 1.2.1 04:08:55 INFO - blessings == 1.6 04:08:55 INFO - blobuploader == 1.2.4 04:08:55 INFO - docopt == 0.6.1 04:08:55 INFO - manifestparser == 1.1 04:08:55 INFO - mozInstall == 1.12 04:08:55 INFO - mozcrash == 0.16 04:08:55 INFO - mozdebug == 0.1 04:08:55 INFO - mozdevice == 0.46 04:08:55 INFO - mozfile == 1.2 04:08:55 INFO - mozhttpd == 0.7 04:08:55 INFO - mozinfo == 0.8 04:08:55 INFO - mozleak == 0.1 04:08:55 INFO - mozlog == 3.0 04:08:55 INFO - moznetwork == 0.27 04:08:55 INFO - mozprocess == 0.22 04:08:55 INFO - mozprofile == 0.27 04:08:55 INFO - mozrunner == 6.11 04:08:55 INFO - mozscreenshot == 0.1 04:08:55 INFO - mozsystemmonitor == 0.0 04:08:55 INFO - moztest == 0.7 04:08:55 INFO - mozversion == 1.4 04:08:55 INFO - psutil == 3.1.1 04:08:55 INFO - requests == 1.2.3 04:08:55 INFO - wsgiref == 0.1.2 04:08:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08: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')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:55 INFO - Using env: {'DISPLAY': ':0', 04:08:55 INFO - 'HOME': '/home/cltbld', 04:08:55 INFO - 'LANG': 'en_US.UTF-8', 04:08:55 INFO - 'LANGUAGE': 'en_US:en', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MAIL': '/var/mail/cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SHLVL': '1', 04:08:55 INFO - 'TERM': 'linux', 04:08:55 INFO - 'TMOUT': '86400', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - '_': '/tools/buildbot/bin/python'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:08: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')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:55 INFO - Using env: {'DISPLAY': ':0', 04:08:55 INFO - 'HOME': '/home/cltbld', 04:08:55 INFO - 'LANG': 'en_US.UTF-8', 04:08:55 INFO - 'LANGUAGE': 'en_US:en', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MAIL': '/var/mail/cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SHLVL': '1', 04:08:55 INFO - 'TERM': 'linux', 04:08:55 INFO - 'TMOUT': '86400', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - '_': '/tools/buildbot/bin/python'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:55 INFO - Downloading/unpacking jsonschema 04:08:55 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 04:08:55 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 04:08:55 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 04:08:55 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 04:08:55 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 04:08:55 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 04:08:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:08:57 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:08:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:57 INFO - warning: no files found matching '*.txt' 04:08:57 INFO - no previously-included directories found matching 'build' 04:08:57 INFO - no previously-included directories found matching 'dist' 04:08:57 INFO - no previously-included directories found matching '.git*' 04:08:57 INFO - Installing collected packages: jsonschema, functools32 04:08:57 INFO - Running setup.py install for functools32 04:08:57 INFO - warning: no files found matching '*.txt' 04:08:57 INFO - no previously-included directories found matching 'build' 04:08:57 INFO - no previously-included directories found matching 'dist' 04:08:57 INFO - no previously-included directories found matching '.git*' 04:08:57 INFO - Successfully installed jsonschema functools32 04:08:57 INFO - Cleaning up... 04:08:57 INFO - Return code: 0 04:08:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f11b24adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd91600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', '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 04:08:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 04:08:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 04:08:57 INFO - Using env: {'DISPLAY': ':0', 04:08:57 INFO - 'HOME': '/home/cltbld', 04:08:57 INFO - 'LANG': 'en_US.UTF-8', 04:08:57 INFO - 'LANGUAGE': 'en_US:en', 04:08:57 INFO - 'LOGNAME': 'cltbld', 04:08:57 INFO - 'MAIL': '/var/mail/cltbld', 04:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:57 INFO - 'MOZ_NO_REMOTE': '1', 04:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:57 INFO - 'NO_EM_RESTART': '1', 04:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:57 INFO - 'SHELL': '/bin/bash', 04:08:57 INFO - 'SHLVL': '1', 04:08:57 INFO - 'TERM': 'linux', 04:08:57 INFO - 'TMOUT': '86400', 04:08:57 INFO - 'USER': 'cltbld', 04:08:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:57 INFO - '_': '/tools/buildbot/bin/python'} 04:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:57 INFO - Downloading/unpacking flake8 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:08:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:08:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:09:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:09:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.7.0.tar.gz 04:09:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:00 INFO - no previously-included directories found matching 'docs/_build' 04:09:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:00 INFO - Running setup.py install for pep8 04:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:00 INFO - no previously-included directories found matching 'docs/_build' 04:09:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:09:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:00 INFO - Cleaning up... 04:09:00 INFO - Return code: 0 04:09:00 INFO - Running post-action listener: _resource_record_post_action 04:09:00 INFO - Running post-action listener: _start_resource_monitoring 04:09:00 INFO - Starting resource monitoring. 04:09:00 INFO - ##### 04:09:00 INFO - ##### Running install step. 04:09:00 INFO - ##### 04:09:00 INFO - Running pre-action listener: _resource_record_pre_action 04:09:00 INFO - Running main action method: install 04:09:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:09:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:09:00 INFO - Reading from file tmpfile_stdout 04:09:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:09:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:09:00 INFO - Reading from file tmpfile_stdout 04:09:00 INFO - Output received: 04:09:00 INFO - Usage: mozinstall [options] installer 04:09:00 INFO - Options: 04:09:00 INFO - -h, --help show this help message and exit 04:09:00 INFO - -d DEST, --destination=DEST 04:09:00 INFO - Directory to install application into. [default: 04:09:00 INFO - "/builds/slave/test-pgo"] 04:09:00 INFO - --app=APP Application being installed. [default: firefox] 04:09:00 INFO - mkdir: /builds/slave/test-pgo/build/application 04:09:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:09:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:09:15 INFO - Reading from file tmpfile_stdout 04:09:15 INFO - Output received: 04:09:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:09:15 INFO - Running post-action listener: _resource_record_post_action 04:09:15 INFO - ##### 04:09:15 INFO - ##### Running run-tests step. 04:09:15 INFO - ##### 04:09:15 INFO - Running pre-action listener: _resource_record_pre_action 04:09:15 INFO - Running main action method: run_tests 04:09:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:09:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:09:15 INFO - Python 2.7.3 04:09:15 INFO - Return code: 0 04:09:15 INFO - grabbing minidump binary from tooltool 04:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:15 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 0xe20350>, '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 0xe21250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe216e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:09:15 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 04:09:15 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 04:09:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:15 INFO - Return code: 0 04:09:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:09:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:09:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:09:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:09:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:09:16 INFO - Return code: 0 04:09:16 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:09:16 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 04:09:16 INFO - Using env: {'DISPLAY': ':0', 04:09:16 INFO - 'HOME': '/home/cltbld', 04:09:16 INFO - 'LANG': 'en_US.UTF-8', 04:09:16 INFO - 'LANGUAGE': 'en_US:en', 04:09:16 INFO - 'LOGNAME': 'cltbld', 04:09:16 INFO - 'MAIL': '/var/mail/cltbld', 04:09:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:16 INFO - 'MOZ_NO_REMOTE': '1', 04:09:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:16 INFO - 'NO_EM_RESTART': '1', 04:09:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:16 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:09:16 INFO - 'SHELL': '/bin/bash', 04:09:16 INFO - 'SHLVL': '1', 04:09:16 INFO - 'TERM': 'linux', 04:09:16 INFO - 'TMOUT': '86400', 04:09:16 INFO - 'USER': 'cltbld', 04:09:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807', 04:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:16 INFO - '_': '/tools/buildbot/bin/python'} 04:09:16 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/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 04:09:16 INFO - mozversion INFO | application_buildid: 20160118120031 04:09:16 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:16 INFO - mozversion INFO | application_display_name: Nightly 04:09:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:16 INFO - mozversion INFO | application_name: Firefox 04:09:16 INFO - mozversion INFO | application_remotingname: firefox 04:09:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:16 INFO - mozversion INFO | application_vendor: Mozilla 04:09:16 INFO - mozversion INFO | application_version: 44.0 04:09:16 INFO - mozversion INFO | platform_buildid: 20160118120031 04:09:16 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:16 INFO - mozversion INFO | platform_version: 44.0 04:09:16 INFO - 2016-01-25 04:09:16,607 DEBUG : using testdate: 1453723756 04:09:16 INFO - 2016-01-25 04:09:16,607 DEBUG : actual date: 1453723756 04:09:16 INFO - 2016-01-25 04:09:16,615 INFO : starting webserver on 'localhost:39603' 04:09:16 INFO - 2016-01-25 04:09:16,616 INFO : Starting test suite talos-linux64-ix-062 04:09:16 INFO - 2016-01-25 04:09:16,616 INFO : Starting test dromaeo_css 04:09:16 INFO - 2016-01-25 04:09:16,616 DEBUG : operating with platform_type : linux_ 04:09:16 INFO - 2016-01-25 04:09:16,617 INFO : Initialising browser for dromaeo_css test... 04:09:16 INFO - 2016-01-25 04:09:16,631 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbsDG4n/profile http://localhost:39603/getInfo.html 04:09:19 INFO - 2016-01-25 04:09:19,869 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:19 INFO - 2016-01-25 04:09:19,870 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:19 INFO - 2016-01-25 04:09:19,870 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:19 INFO - 2016-01-25 04:09:19,870 DEBUG : BROWSER_OUTPUT: __metrics 04:09:20 INFO - 2016-01-25 04:09:20,012 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] 04:09:21 INFO - 2016-01-25 04:09:21,245 INFO : Browser initialized. 04:09:21 INFO - 2016-01-25 04:09:21,246 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:21 INFO - 2016-01-25 04:09:21,247 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbsDG4n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:32 INFO - 2016-01-25 04:09:32,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 129118208 04:09:32 INFO - 2016-01-25 04:09:32,803 DEBUG : BROWSER_OUTPUT: 04:10:23 INFO - 2016-01-25 04:10:23,623 DEBUG : BROWSER_OUTPUT: 1453723823618 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] 04:12:31 INFO - 2016-01-25 04:12:31,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39603/tests/dromaeo/cssquery-ext.html) 04:12:32 INFO - 2016-01-25 04:12:32,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 204582912 04:12:32 INFO - 2016-01-25 04:12:32,522 DEBUG : BROWSER_OUTPUT: 04:15:34 INFO - 2016-01-25 04:15:34,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-ext.html (next: http://localhost:39603/tests/dromaeo/cssquery-jquery.html) 04:15:35 INFO - 2016-01-25 04:15:35,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 206712832 04:15:35 INFO - 2016-01-25 04:15:35,148 DEBUG : BROWSER_OUTPUT: 04:18:36 INFO - 2016-01-25 04:18:36,896 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39603/tests/dromaeo/cssquery-mootools.html) 04:18:37 INFO - 2016-01-25 04:18:37,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 211288064 04:18:37 INFO - 2016-01-25 04:18:37,457 DEBUG : BROWSER_OUTPUT: 04:21:39 INFO - 2016-01-25 04:21:39,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39603/tests/dromaeo/cssquery-prototype.html) 04:21:39 INFO - 2016-01-25 04:21:39,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 191066112 04:21:39 INFO - 2016-01-25 04:21:39,728 DEBUG : BROWSER_OUTPUT: 04:24:42 INFO - 2016-01-25 04:24:42,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39603/tests/dromaeo/cssquery-yui.html) 04:24:42 INFO - 2016-01-25 04:24:42,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 194170880 04:24:42 INFO - 2016-01-25 04:24:42,677 DEBUG : BROWSER_OUTPUT: 04:27:44 INFO - 2016-01-25 04:27:44,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-yui.html (next: http://localhost:39603/tests/dromaeo/cssquery-dojo.html) 04:27:45 INFO - 2016-01-25 04:27:45,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 235053056 04:27:45 INFO - 2016-01-25 04:27:45,104 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3316.867325306988;3402.9829850850742;3414.8463319150637;3415.6584341565845;3442.208292092818;5564.916526252105;5577.163425486179;5579.442055794419;5584.6090773645865;5598.300212473441;5653.9151912721345;5665.8583535411635;5675.943240567593;5690.573207009481;5695.943040569593;4932.53140951609;5137.511936366049;5159.406668233145;5222.216667499886;5262.81580144695;5116.2069879168785;5146.6911985281;5148.922766158511;5150.510701483353;5150.871228219287;5074.112030394666;5144.17693169093;5191.247269145972;5192.896142077157;5197.324347834776;5012.072766538202;5136;5202.817901373433;5210.739463026834;5211.478852114796;5111.463296353903;5150.587952963791;5170.405403378584;5205;5205.089109405839;5323.600729945231;5372.194170874361;5391.48780865821;5490.560755139619;5491.341039075297;6039.547033972426;6114.96942515289;6115.908261376083;6117.357677443849;6117.755289788403;6128.846778830521;6137.877242455126;6145.661988590626;6147.815565533041;6160.907586386208;5516.3380394352935;5591.133374326986;5613.747381367848;5693.373728889819;5730;6131.448169664752;6225.56076372458;6239.78160764371;6261.968690156611;6269.0909818076125;5895.4399332063385;6043.12374705674;6056.576039677268;6062.393760623902;6072.817815465455;6066.332703402622;6084.756609735649;6181.412765787243;6182.1345011698395;6190.133381326618;6042.274927008787;6062.636241825417;6065.029595264737;6069.908951365733;6101.389861013863;5959.255093113361;6048.697565121726;6070.0591408331775;6072.574919755575;6099.085137229363;4587.9541204588195;4623.16782979067;4623.237165867661;4629.3518907353;4676.205045142334;4094.160697057096;4097.078157414618;4105.322621767435;4117.402976568381;4124.9587504125175;5428.321459817523;5619.381867994517;5638.520725738276;5647.0964645656495;5649.943500564942;5916.792912248051;6041.577089603686;6187.133801267826;6201.193844800147;6201.441870231701;5785.30576330843;5794.652320860761;5797.913031304533;5801.6519008859605;5822.1266809978;5119.820806271762;5215.634905556574;5309.601779866525;5324.201369794484;5336.599755018389;6007.339192688801;6097.579210215478;6102.526025185527;6119.96940015306;6135.32511423743;6082.42340956269;6110.413802721403;6117.143599896107;6120.969395152996;6127.908081378872;5979.372165922516;6099.695015249308;6133.671320645445;6258.7809426671665;6265.0602409637095;5992.221011268507;6009.7295621698;6060.181875446759;6061.212042434631;6069.878602427839;6136.417040381157;6141.447269745744;6145.231846019247;6155.507559395148;6160.815175544741;5740.339860915881;5845.736941837543;5929.940700592939;5993.760249590142;6009.699515024318;5913.91129133072;5919.911201331897;5953.285605727167;5969.582129250911;5970.0746384310505;5851.034579294369;5854.092615644582;5857.648541087548;5893.823185304448;5914.4381283777975;5698.344690360495;5844.094165404369;5896.734646940984;6006.371300233828;6041.969790151021;5878.794242201502;5880.26496687914;5886.764529418775;5891.263592050994;5910.911336330045 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.8134378342714;629.288903539001;650.3983814971152;658.1608449227232;661.3386613386614;35152.296954060934;42714.57285427145;43005.78497107514;43094.78452607737;43163.35254971178;46686.53313466864;47278;47319;47351.763241183835;47376.28935565961;8246.299064579518;8399.95800020999;9077.455352678828;9242.39924404915;10418.218633602472;10733.087687546567;10835.78328433431;10837.945810270938;10864.076553492963;10874.945625271863;10841.891581084166;10937.781244375108;10939.45302734864;10951.561937522489;10961;10834.40410777407;10934.617288394868;10934.726631834188;10956.068734157567;10956.397398143139;10553.102986246178;10670.786584268271;10682.465876706134;10691.305065170816;10692.786144277072;43052.354214686806;43414.56585434169;43530.347044794355;43586.782066089465;43606.563934360565;3795.35478968576;3822.7515211511163;3886.727929044968;4360.236958532244;4459.264221403465;32247.83876080628;32945;32995;32995.505067424005;33177.834110829535;3389.237421580149;3472.374972504948;3483.9651603483894;3537.8054207018604;3571.607123216444;322853;323941;324115;324864;324996;64288.35711642917;64877;68057.61798337035;74161.25838741651;75134.24865751273;70799;71079.2892071083;71151.64424177846;71176.288237118;71304;18293.268269269345;18320.908395457936;18489.075546222633;18635.534111647044;18670.43988680342;13919.582412527641;13966.650833729034;13982;14007.299635018207;14088.436462541384;22435.887820560794;22698.886505567698;22755.31734047981;22801.543969120856;22874.284428667917;8633.525156116348;8888.955555222183;9006.50464224474;9061.818763624691;9101.089891010846;955.3742298794301;1055.8152323343384;1058.571278632155;1081.6809041332826;1163.4822503985815;31204.531932021036;35160;35400.46899296513;35968.820155899055;36002.81998590042;1121.9551217951355;1124.1119515582598;1165.609520810521;1174.629991552658;1176.5235079792697;14516;15719.68560628781;15910.76133857993;16144.273507692182;16871.325146993982;374552;376382;377238;379038;380254;58658;59391.10913336303;59399.10901336483;59455.702721486115;59505;1388.0630574362467;1425.5224499792685;1520.361448191762;1531.5788158256346;1540.6134478968793;31276.687233127377;31290.53064204084;31629.5255571162;31725.841370792998;32375.67624323821;49168;49640;49685.75157124191;49703.75148124236;49722.25416618681;320925;323584;324522;324720;326830;36012.8199359012;36027.81986090053;36236.09409764777;36270.4559431614;50311.49688503068;48422.75788621034;48919;49458.25812612742;49792.75103624459;49811.75094124506;40436.08422313236;41351.58648413477;41656.375154373316;41992.79003604963;42293.577064228964;41197.79401102975;41460.58539414567;41494.79252603718;41685.58314416817;42205.57794422139;40245.79877100596;41177.79411102925;41839.7908010458;41890;42000.36999445072;36042.8197859009;36748;37046.62953370432;37627.40600379042;37889.2422151561;27925.418554166255;28053.94378291446;28244.87020519156;28258.85870570634;28368.290792730346 04:27:45 INFO - 2016-01-25 04:27:45,105 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.78316251318006;384.5981843388041;384.9769013859167;392.33695055356463;395.8080331039445;17239.56901077472;17366.913165434155;18335.174917128727;18454.077296135205;18645.813541864576;16013.199340032981;16314.184290785442;16344;17878.553036174104;18025.7296140558;5510.476504732044;5666.829995100154;5734.569907256951;5769.740361683714;5782.103773915029;5687.090065589507;5747.59766816323;5755.827325180251;5760.654360738348;5765.365809760923;5128.71792051437;5683.943160568403;5702.7433765480655;5751.539876809866;5759.3376761672525;5647.604667673265;5721.227634269362;5736.426357364272;5738.081906894919;5743.224664670258;4559.544045595447;4652;4659.510751371125;5140.820071297524;5148.665336753099;15227.543173704807;15305;15495.690086198325;15593.922030389775;15632.4528641497;2062.9071691773756;2074.761402438724;2080.6566916458764;2107.7576078750985;2124.0547956159517;10633.57465701371;10806.081483073947;10860.565577376896;10868.347899126078;11029.952154545386;1736.713442282022;1738.2959901240017;1742.0679936234053;1763.8324359185856;1773.17547340486;69692.30307696908;70497.59004819926;71697.28302716959;71847.92228116583;72024.27975720228;7795.844083118419;7825.843483130306;7934.246246606564;7968.880466793003;7970.561619111005;9554.474503902353;9568.186704130088;9572;9572.56923438447;9575.664851730156;5905.143754155623;6070.089486577049;6261.8747625047245;6332.271788744261;6349.714262858182;6472.611643301417;6571.441427478718;6592.703328350236;6621.834454138685;6676.0987266718375;3591.048372181374;3607.5851277102943;3642.0530662028063;3664.1755604988666;3681.9447708284397;1235.9814602780966;1243.720162963326;1273.3951373097889;1280.6862318731971;1287.1633438265203;451.7131621420356;458.0518327063014;473.4200604259823;505.11100463185056;505.16395365669877;11246.49390777417;13102.213867168;13403.463861445432;13621.182729036289;13817.723645527034;512.7231295100604;522.9686218826882;525.0339375548932;531.9228711836762;555.3973938276933;7123.358897699232;7310.926890731131;7338.41292696583;7354.742584009534;7357;612650;621703;630316;661768;663345;83458.58270708607;87867;87928;89524.10475895288;91893;507.99746001270495;597.7907732293662;601.2484394506866;611.0711718188329;612.4059662127729;10623.734406639896;10787;10870.673879783619;10996.945015275192;11148.721281968015;35904;36157.09607259734;36890.8155459221;37186.814065929495;37218;49482;50885.491145088075;51528.48471515237;51605;52211;8861.822763544564;9221;9304.674336398193;9323.20752736025;9399.765005874635;13446.93276533611;13532.86467135316;13649.11280766747;13698.863011370157;13724.93137534306;11260.436978151223;11352.772944541228;11911.702207444883;12130.939345303217;12221.083418743452;11752.76494470123;11990.520379184734;12083.154179207371;12224.266544007389;12462.937685311515;10074.899251007397;11362.091032717197;12040.939795301318;12070.094742894142;12649.430775614936;9544.475053872104;9588.952055239679;9589.376690515093;9688.612455501983;9701.126898579161;12166.39168041612;12237.816432753338;12358.382080895739;12419.44112514921;12621.684457888627 04:27:45 INFO - 2016-01-25 04:27:45,106 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1531.5788158256478;1558.984410155898;1796.3353559183088;1874.3908229825306;1874.7937726850043;7191.82020449489;7330.486865919388;8124.715634952778;8323.209295116969;8350.164983501654;8050.5974701264995;8219.876701849462;8323.875141872863;8327.37544684148;8332.875006874901;2441.304228294941;2485.72657007729;2486.0677246032737;2488.3530282126685;2490.476999830038;2172.370012696324;2224.9666255006186;2398.1126983016306;2449.3998970252223;2481.2060140754966;2365.302235840423;2376.7266764322067;2380.7976322012564;2397.832151749378;2398.328468028955;2327.5461285049423;2345.9296221113395;2348.6242201247887;2351.7295511016196;2351.811855051592;2395.700537432821;2441.047991283383;2442.096424323012;2442.6702395176603;2443.7800597946093;8144.1041485437145;8221.79445513861;8223.917760822374;8224.300934420582;8225.8354832903;4976.527229913152;5042.39491261051;5047.798088076473;5052.040112378636;5052.974735126338;3183.267848394859;3183.856726447292;3285.014495651319;3294.8517316720804;3305.586801649794;1077.3159044007034;1084.7505073833063;1085.7177133945152;1089.727568107973;1093.4696672114019;11106.944465277702;11116.722081947935;11121.55513779448;11131;11134;4585.312203169485;4585.6102231310715;4632.837850675211;4662.090892275974;4666.253399456139;9599.376040557341;9620.037996200324;9635.56639951204;9636.277279204087;9639.421634701801;4963.751812409365;5000.174971129795;5031.597472202215;5031.798728050837;5044.924326135111;4543.023250001265;4549.977250113794;4552.408186935677;4568;4604.861854144381;3294.3246634439884;4098.672106231495;4106.568810274878;4119.382092686121;4144.91710165795;1247.4261839553908;1269.4033804112053;1317.236003118189;1320.8679132086716;1332.733453309342;1360.7210521842999;1462.9634259143606;1481.9259037048105;1483.8664520193233;1499.6175975126273;8034.839303213903;8099.473534220257;8104.918950810535;8107.310878575269;8149.185081491803;1235.3637876493613;1243.8134279858093;1247.376311844078;1249.144336129754;1263.406199086428;6416.4225219729515;6420.807375778734;6503.154589903283;6518.837029074216;6518.902216466757;9980.550875210633;10203.897961020295;10204.081632653097;10211.642592509226;10221.846672299922;9801.264905132144;10111.241656875616;10125.088742013108;10132.848007279898;10162.136218421369;7868.370530357558;7904.56524891125;7910.920890791019;7911.248431399008;7919.762407127795;7493.063367079115;7559.395248380007;7580.469367144247;7588.8482230356185;7600.80997975055;8638.78403039904;9053.954730226571;9088.772780680536;9093;9212.401193922373;9137.177654010906;9300.581473833558;9309.953450232977;9450.621975120917;9500.85748713756;7469.887951680837;7498.175200727806;7498.887516687363;7506.099268087864;7515;7353.77938661841;7447.813804654927;8043.919560804317;8195.34437245007;8221.79445513867;7434.553926764412;7510.873368994695;7521.736739214101;7582.431317651309;7620.80947976305;7365.447591430557;7372.668229929559;7432.293932076444;7457.627118643937;7511.51175173612;7108.218096009331;7177.138743350832;7216.7834964951135;7218.963905180441;7447.478676492594;6858.965705171442;7138.964305178441;7147.3210045045635;7155.391791697764;7156.212816590275;7181;7197.064381630564;7232.204457509564;7275.163356213891;7277.490575659653 04:27:45 INFO - 2016-01-25 04:27:45,106 DEBUG : BROWSER_OUTPUT: |4;prototype.html;352.7424979764772;359.41236079010815;364.8248840556531;369.0588998054959;371.0834239428612;5897.911531327033;5981.671008094553;5987.730552125154;5996.850078748033;6012.188354572131;5739.827805165852;5875.764969401219;5879.735411906464;5891.911621325684;5893.941060589393;4608.5621865922685;4610.654200934943;4613.123506533765;4615.676902616819;4615.676902616819;4433.202023635744;4528.818847246106;4542.931856022145;4618.699784514012;4620.838270660528;4544.341070544769;4565.201089809287;4568.611668008223;4588.816447342119;4591.494935557086;4527.886802829939;4530.07133537624;4531.207038768235;4541.091781643684;4543.636509079282;4040.030392705759;4086.6117718816663;4089.141280331134;4098.426220329156;4098.7130900836955;5588.497035266845;5620.859478513029;5629.240052592889;5671.177679236529;5679.971600142014;5322.175062865262;5325.094733895208;5332.733363331818;5332.813351532716;5335.413104558495;6063.696815159225;6300.621962682254;6310.0850376695125;6314.589551679126;6319.14691516644;4362.192994296065;4389.956100438987;4427.512973572904;4429.933550996738;4430.778461076933;6393.1688880445245;6485.238561634241;6485.513586480985;6490.156279683611;6495.772647957346;4472.463304403427;4515.164694531522;4517.796699148546;4518.051209246095;4524.705894116872;4495.460544734653;4563.338315944169;4564.794584243717;4570.8171673133365;4636.466806317249;5318.494742999409;5321.946780532223;5322.068637988336;5327.973360133252;5331.786728530893;6367.331430199855;6369.49044076482;6379.330170332141;6386.840328991812;6398.488120950406;1655.7433597792362;1675.9581010474592;1675.9832401676072;1678.6139187986832;1678.7397953317256;1100.2298391126244;1110.9833352499718;1114.8940850619178;1126.9492872820742;1147.0307590086363;6171.691415429301;6173.351798061229;6173.536984726164;6176.227971503562;6184.196054512974;6522.478201743849;6541.5093867960095;6551.868962620721;6560.934390656128;6563.1796025496815;6043.305019922677;6157.784477543354;6162.137300777895;6167.537434692416;6169.907451388232;3571.2500374921037;3583.498310236569;3585.032041348821;3587.856485740593;3613.0244833895226;6721.428678562279;6722.394984451423;6722.495812813961;6728.259891411941;6734.562253453608;6629.767958121539;6654.434373078343;6727.461803055744;6727.62998035103;6735.932640673531;6663.666816659148;6669.366410190927;6694.531382803157;6708.899366509506;6709.832254193587;6362.268339141058;6459.709313081016;6538.313477084837;6549.901751473636;6559.409653131241;6361.904571431525;6444.194475690539;6469.159009328757;6475.449586784987;6475.579087359307;6600.504962127956;6616.040674102324;6622.867542649216;6642.6014439133805;6684.097646817811;4492.707973981681;4502.662300327423;4540.2054640438455;4544.727316361029;4554.499005109369;6526.543141980205;6526.934730652632;6532.771353002622;6537.542372034102;6539.509536784665;6321.431071203429;6331.240251169889;6336.17629708135;6338.809835704937;6343.492520598434;6295.716692748929;6372.808815735535;6391.2330520337855;6397.520185985976;6399.55203135776;6275.278342990432;6278.0269058296035;6279.183706118175;6288.811335659938;6291.528135389773;6332.208473940757;6351.936480635134;6425.45383642377;6449.451796597342;6457.838554036187;6180.351063138306;6205.28639206479;6246.531510136667;6291.276503202191;6310.873782524415 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: |5;yui.html;785.0814546980033;841.2092632925054;931.362017018342;937.0916372272819;963.7783309838738;14001.299935003248;14413.13521188728;14480.203588802611;14519.637009074766;14519.709605807877;13109.213447193175;13140.802887956688;13158.73682526349;13213;13219.206847589152;753.3596443023414;761.8019314978118;900.1763386501343;906.3791302957462;917.775145089454;911.4850109688039;912.0970239462918;918.0268914950174;918.7381596245071;918.8208299381623;957.7653474898659;962.6486332488661;964.1178321835512;964.7829238421369;964.9083337083001;775.11249619186;783.0564170174954;940.5767404667927;951.6764300137986;954.2223088183108;708.0335342257832;708.8157079159456;711.2176605733704;713.0872483221485;714.3249629100502;14122.576322710334;14733.631659208499;14773.778393324108;14818.33317500715;14852;12336.321502317458;13122.737545249138;13201;13255.536056238081;13523.120997135155;10120.342177758423;10159.847602285972;10206.540705668189;10217.540210690537;10286;3361.798292102482;3392.4911263310455;3405.250844814137;3412.692857642824;3418.2308980479193;53993.1901021485;54205.1869221962;54231.72884135554;55110.72444637791;55292.44707552913;9788.461634610023;9813.389794114528;9827.606895724233;9855.507224638739;9920.107190352903;13736.145620341325;21041.15835366599;21091.578168436547;21117.57764844725;21152.259670911444;6811.489138314646;6861.382475577222;6911.75808846688;6965;6987.441004719611;4159.272127377757;4268.637165840876;4287.892802679958;4300.075483771005;4341.110072435144;3056.49567821307;3087.737542308929;3088.042706760911;3110.5956225690516;3118.8284644344326;489.2783144861301;491.3440556856565;492.47797334824486;494.873807179167;500.2396357536524;536.4608568388744;536.9167778994262;546.1725485888882;552.914735774378;620.6803496199461;7682.846343073107;8417.873731894026;8687.843305511333;8741.956290218508;8999.37004409698;521.6687403498805;551.613870290798;578.3320265093823;637.2830565613684;643.7167646235641;4158.542560318362;4186.120914607905;4195.119025004783;4195.755583582426;4199.811008504625;69617;69834.65082674554;70679.64660176667;70713;71105.64447177835;60446.69776651177;61350.38649613536;61861.38138618646;61867.6906615464;62318.376816231255;56503.43496565064;56517;56613.43386566164;56832.43167568272;58207.41792582105;8282.58587070632;8357.122502137188;8423.073461919306;8538.743837684631;8541.402101852811;40202.9949251271;40684.79657601693;40728.1854362917;41472.58527414808;41894.37158442565;51075.74462127666;54241.72879135579;54384.45615543794;54689;54951;8429.199226073513;8543.231109200202;8561.529115898686;8601.268892143988;8622.223999840044;12084;12140.635780926586;12413.875861241271;12458.626241212778;12532.686682832637;10405.323653962469;10816.729581760519;10856.891431085589;10870.782584348111;10977.890221097687;10546.630867919586;10751.19366047534;10963.671089867317;11663.825042624538;12004.279743215435;9448.716538503855;9523.476208808583;10199.54102065394;10262.43556604394;10533.210009249491;9905.554250058909;9981.500924953869;10071.798564028531;10183.287169898333;10510.737231569272;8787.91212087871;9189.770255743393;9192.356535042483;9271.258299335903;9279.39683920543 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,802 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724865097__endTimestamp 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:27:45 INFO - 2016-01-25 04:27:45,108 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,109 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5629.56 Median:5878.79 stddev:633.17 (10.8%) stddev-sans-first:608.57 04:27:45 INFO - 2016-01-25 04:27:45,109 DEBUG : BROWSER_OUTPUT: Values: 3316.9 3403.0 3414.8 3415.7 3442.2 5564.9 5577.2 5579.4 5584.6 5598.3 5653.9 5665.9 5675.9 5690.6 5695.9 4932.5 5137.5 5159.4 5222.2 5262.8 5116.2 5146.7 5148.9 5150.5 5150.9 5074.1 5144.2 5191.2 5192.9 5197.3 5012.1 5136.0 5202.8 5210.7 5211.5 5111.5 5150.6 5170.4 5205.0 5205.1 5323.6 5372.2 5391.5 5490.6 5491.3 6039.5 6115.0 6115.9 6117.4 6117.8 6128.8 6137.9 6145.7 6147.8 6160.9 5516.3 5591.1 5613.7 5693.4 5730.0 6131.4 6225.6 6239.8 6262.0 6269.1 5895.4 6043.1 6056.6 6062.4 6072.8 6066.3 6084.8 6181.4 6182.1 6190.1 6042.3 6062.6 6065.0 6069.9 6101.4 5959.3 6048.7 6070.1 6072.6 6099.1 4588.0 4623.2 4623.2 4629.4 4676.2 4094.2 4097.1 4105.3 4117.4 4125.0 5428.3 5619.4 5638.5 5647.1 5649.9 5916.8 6041.6 6187.1 6201.2 6201.4 5785.3 5794.7 5797.9 5801.7 5822.1 5119.8 5215.6 5309.6 5324.2 5336.6 6007.3 6097.6 6102.5 6120.0 6135.3 6082.4 6110.4 6117.1 6121.0 6127.9 5979.4 6099.7 6133.7 6258.8 6265.1 5992.2 6009.7 6060.2 6061.2 6069.9 6136.4 6141.4 6145.2 6155.5 6160.8 5740.3 5845.7 5929.9 5993.8 6009.7 5913.9 5919.9 5953.3 5969.6 5970.1 5851.0 5854.1 5857.6 5893.8 5914.4 5698.3 5844.1 5896.7 6006.4 6042.0 5878.8 5880.3 5886.8 5891.3 5910.9 04:27:45 INFO - 2016-01-25 04:27:45,109 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,109 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53575.69 Median:36007.82 stddev:89627.47 (248.9%) stddev-sans-first:89790.64 04:27:45 INFO - 2016-01-25 04:27:45,110 DEBUG : BROWSER_OUTPUT: Values: 601.8 629.3 650.4 658.2 661.3 35152.3 42714.6 43005.8 43094.8 43163.4 46686.5 47278.0 47319.0 47351.8 47376.3 8246.3 8400.0 9077.5 9242.4 10418.2 10733.1 10835.8 10837.9 10864.1 10874.9 10841.9 10937.8 10939.5 10951.6 10961.0 10834.4 10934.6 10934.7 10956.1 10956.4 10553.1 10670.8 10682.5 10691.3 10692.8 43052.4 43414.6 43530.3 43586.8 43606.6 3795.4 3822.8 3886.7 4360.2 4459.3 32247.8 32945.0 32995.0 32995.5 33177.8 3389.2 3472.4 3484.0 3537.8 3571.6 322853.0 323941.0 324115.0 324864.0 324996.0 64288.4 64877.0 68057.6 74161.3 75134.2 70799.0 71079.3 71151.6 71176.3 71304.0 18293.3 18320.9 18489.1 18635.5 18670.4 13919.6 13966.7 13982.0 14007.3 14088.4 22435.9 22698.9 22755.3 22801.5 22874.3 8633.5 8889.0 9006.5 9061.8 9101.1 955.4 1055.8 1058.6 1081.7 1163.5 31204.5 35160.0 35400.5 35968.8 36002.8 1122.0 1124.1 1165.6 1174.6 1176.5 14516.0 15719.7 15910.8 16144.3 16871.3 374552.0 376382.0 377238.0 379038.0 380254.0 58658.0 59391.1 59399.1 59455.7 59505.0 1388.1 1425.5 1520.4 1531.6 1540.6 31276.7 31290.5 31629.5 31725.8 32375.7 49168.0 49640.0 49685.8 49703.8 49722.3 320925.0 323584.0 324522.0 324720.0 326830.0 36012.8 36027.8 36236.1 36270.5 50311.5 48422.8 48919.0 49458.3 49792.8 49811.8 40436.1 41351.6 41656.4 41992.8 42293.6 41197.8 41460.6 41494.8 41685.6 42205.6 40245.8 41177.8 41839.8 41890.0 42000.4 36042.8 36748.0 37046.6 37627.4 37889.2 27925.4 28053.9 28244.9 28258.9 28368.3 04:27:45 INFO - 2016-01-25 04:27:45,110 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,110 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31288.29 Median:24977.71 stddev:104592.93 (418.7%) stddev-sans-first:104860.59 04:27:45 INFO - 2016-01-25 04:27:45,110 DEBUG : BROWSER_OUTPUT: Values: 383.8 384.6 385.0 392.3 395.8 17239.6 17366.9 18335.2 18454.1 18645.8 16013.2 16314.2 16344.0 17878.6 18025.7 5510.5 5666.8 5734.6 5769.7 5782.1 5687.1 5747.6 5755.8 5760.7 5765.4 5128.7 5683.9 5702.7 5751.5 5759.3 5647.6 5721.2 5736.4 5738.1 5743.2 4559.5 4652.0 4659.5 5140.8 5148.7 15227.5 15305.0 15495.7 15593.9 15632.5 2062.9 2074.8 2080.7 2107.8 2124.1 10633.6 10806.1 10860.6 10868.3 11030.0 1736.7 1738.3 1742.1 1763.8 1773.2 69692.3 70497.6 71697.3 71847.9 72024.3 7795.8 7825.8 7934.2 7968.9 7970.6 9554.5 9568.2 9572.0 9572.6 9575.7 5905.1 6070.1 6261.9 6332.3 6349.7 6472.6 6571.4 6592.7 6621.8 6676.1 3591.0 3607.6 3642.1 3664.2 3681.9 1236.0 1243.7 1273.4 1280.7 1287.2 451.7 458.1 473.4 505.1 505.2 11246.5 13102.2 13403.5 13621.2 13817.7 512.7 523.0 525.0 531.9 555.4 7123.4 7310.9 7338.4 7354.7 7357.0 612650.0 621703.0 630316.0 661768.0 663345.0 83458.6 87867.0 87928.0 89524.1 91893.0 508.0 597.8 601.2 611.1 612.4 10623.7 10787.0 10870.7 10996.9 11148.7 35904.0 36157.1 36890.8 37186.8 37218.0 49482.0 50885.5 51528.5 51605.0 52211.0 8861.8 9221.0 9304.7 9323.2 9399.8 13446.9 13532.9 13649.1 13698.9 13724.9 11260.4 11352.8 11911.7 12130.9 12221.1 11752.8 11990.5 12083.2 12224.3 12462.9 10074.9 11362.1 12040.9 12070.1 12649.4 9544.5 9589.0 9589.4 9688.6 9701.1 12166.4 12237.8 12358.4 12419.4 12621.7 04:27:45 INFO - 2016-01-25 04:27:45,110 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,111 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5855.99 Median:5049.92 stddev:2999.67 (59.4%) stddev-sans-first:2990.47 04:27:45 INFO - 2016-01-25 04:27:45,111 DEBUG : BROWSER_OUTPUT: Values: 1531.6 1559.0 1796.3 1874.4 1874.8 7191.8 7330.5 8124.7 8323.2 8350.2 8050.6 8219.9 8323.9 8327.4 8332.9 2441.3 2485.7 2486.1 2488.4 2490.5 2172.4 2225.0 2398.1 2449.4 2481.2 2365.3 2376.7 2380.8 2397.8 2398.3 2327.5 2345.9 2348.6 2351.7 2351.8 2395.7 2441.0 2442.1 2442.7 2443.8 8144.1 8221.8 8223.9 8224.3 8225.8 4976.5 5042.4 5047.8 5052.0 5053.0 3183.3 3183.9 3285.0 3294.9 3305.6 1077.3 1084.8 1085.7 1089.7 1093.5 11106.9 11116.7 11121.6 11131.0 11134.0 4585.3 4585.6 4632.8 4662.1 4666.3 9599.4 9620.0 9635.6 9636.3 9639.4 4963.8 5000.2 5031.6 5031.8 5044.9 4543.0 4550.0 4552.4 4568.0 4604.9 3294.3 4098.7 4106.6 4119.4 4144.9 1247.4 1269.4 1317.2 1320.9 1332.7 1360.7 1463.0 1481.9 1483.9 1499.6 8034.8 8099.5 8104.9 8107.3 8149.2 1235.4 1243.8 1247.4 1249.1 1263.4 6416.4 6420.8 6503.2 6518.8 6518.9 9980.6 10203.9 10204.1 10211.6 10221.8 9801.3 10111.2 10125.1 10132.8 10162.1 7868.4 7904.6 7910.9 7911.2 7919.8 7493.1 7559.4 7580.5 7588.8 7600.8 8638.8 9054.0 9088.8 9093.0 9212.4 9137.2 9300.6 9310.0 9450.6 9500.9 7469.9 7498.2 7498.9 7506.1 7515.0 7353.8 7447.8 8043.9 8195.3 8221.8 7434.6 7510.9 7521.7 7582.4 7620.8 7365.4 7372.7 7432.3 7457.6 7511.5 7108.2 7177.1 7216.8 7219.0 7447.5 6859.0 7139.0 7147.3 7155.4 7156.2 7181.0 7197.1 7232.2 7275.2 7277.5 04:27:45 INFO - 2016-01-25 04:27:45,111 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,111 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5307.20 Median:6053.50 stddev:1574.73 (26.0%) stddev-sans-first:1534.61 04:27:45 INFO - 2016-01-25 04:27:45,112 DEBUG : BROWSER_OUTPUT: Values: 352.7 359.4 364.8 369.1 371.1 5897.9 5981.7 5987.7 5996.9 6012.2 5739.8 5875.8 5879.7 5891.9 5893.9 4608.6 4610.7 4613.1 4615.7 4615.7 4433.2 4528.8 4542.9 4618.7 4620.8 4544.3 4565.2 4568.6 4588.8 4591.5 4527.9 4530.1 4531.2 4541.1 4543.6 4040.0 4086.6 4089.1 4098.4 4098.7 5588.5 5620.9 5629.2 5671.2 5680.0 5322.2 5325.1 5332.7 5332.8 5335.4 6063.7 6300.6 6310.1 6314.6 6319.1 4362.2 4390.0 4427.5 4429.9 4430.8 6393.2 6485.2 6485.5 6490.2 6495.8 4472.5 4515.2 4517.8 4518.1 4524.7 4495.5 4563.3 4564.8 4570.8 4636.5 5318.5 5321.9 5322.1 5328.0 5331.8 6367.3 6369.5 6379.3 6386.8 6398.5 1655.7 1676.0 1676.0 1678.6 1678.7 1100.2 1111.0 1114.9 1126.9 1147.0 6171.7 6173.4 6173.5 6176.2 6184.2 6522.5 6541.5 6551.9 6560.9 6563.2 6043.3 6157.8 6162.1 6167.5 6169.9 3571.3 3583.5 3585.0 3587.9 3613.0 6721.4 6722.4 6722.5 6728.3 6734.6 6629.8 6654.4 6727.5 6727.6 6735.9 6663.7 6669.4 6694.5 6708.9 6709.8 6362.3 6459.7 6538.3 6549.9 6559.4 6361.9 6444.2 6469.2 6475.4 6475.6 6600.5 6616.0 6622.9 6642.6 6684.1 4492.7 4502.7 4540.2 4544.7 4554.5 6526.5 6526.9 6532.8 6537.5 6539.5 6321.4 6331.2 6336.2 6338.8 6343.5 6295.7 6372.8 6391.2 6397.5 6399.6 6275.3 6278.0 6279.2 6288.8 6291.5 6332.2 6351.9 6425.5 6449.5 6457.8 6180.4 6205.3 6246.5 6291.3 6310.9 04:27:45 INFO - 2016-01-25 04:27:45,112 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,112 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15307.00 Median:27617.59 stddev:19407.82 (70.3%) stddev-sans-first:19431.62 04:27:45 INFO - 2016-01-25 04:27:45,112 DEBUG : BROWSER_OUTPUT: Values: 785.1 841.2 931.4 937.1 963.8 14001.3 14413.1 14480.2 14519.6 14519.7 13109.2 13140.8 13158.7 13213.0 13219.2 753.4 761.8 900.2 906.4 917.8 911.5 912.1 918.0 918.7 918.8 957.8 962.6 964.1 964.8 964.9 775.1 783.1 940.6 951.7 954.2 708.0 708.8 711.2 713.1 714.3 14122.6 14733.6 14773.8 14818.3 14852.0 12336.3 13122.7 13201.0 13255.5 13523.1 10120.3 10159.8 10206.5 10217.5 10286.0 3361.8 3392.5 3405.3 3412.7 3418.2 53993.2 54205.2 54231.7 55110.7 55292.4 9788.5 9813.4 9827.6 9855.5 9920.1 13736.1 21041.2 21091.6 21117.6 21152.3 6811.5 6861.4 6911.8 6965.0 6987.4 4159.3 4268.6 4287.9 4300.1 4341.1 3056.5 3087.7 3088.0 3110.6 3118.8 489.3 491.3 492.5 494.9 500.2 536.5 536.9 546.2 552.9 620.7 7682.8 8417.9 8687.8 8742.0 8999.4 521.7 551.6 578.3 637.3 643.7 4158.5 4186.1 4195.1 4195.8 4199.8 69617.0 69834.7 70679.6 70713.0 71105.6 60446.7 61350.4 61861.4 61867.7 62318.4 56503.4 56517.0 56613.4 56832.4 58207.4 8282.6 8357.1 8423.1 8538.7 8541.4 40203.0 40684.8 40728.2 41472.6 41894.4 51075.7 54241.7 54384.5 54689.0 54951.0 8429.2 8543.2 8561.5 8601.3 8622.2 12084.0 12140.6 12413.9 12458.6 12532.7 10405.3 10816.7 10856.9 10870.8 10977.9 10546.6 10751.2 10963.7 11663.8 12004.3 9448.7 9523.5 10199.5 10262.4 10533.2 9905.6 9981.5 10071.8 10183.3 10510.7 8787.9 9189.8 9192.4 9271.3 9279.4 04:27:45 INFO - 2016-01-25 04:27:45,112 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:45 INFO - 2016-01-25 04:27:45,113 DEBUG : BROWSER_OUTPUT: 04:27:45 INFO - 2016-01-25 04:27:45,681 INFO : Browser exited with error code: 0 04:27:45 INFO - 2016-01-25 04:27:45,700 INFO : Completed test dromaeo_css (00:18:29) 04:27:45 INFO - 2016-01-25 04:27:45,700 INFO : Starting test kraken 04:27:45 INFO - 2016-01-25 04:27:45,700 DEBUG : operating with platform_type : linux_ 04:27:45 INFO - 2016-01-25 04:27:45,700 INFO : Initialising browser for kraken test... 04:27:45 INFO - 2016-01-25 04:27:45,706 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNWQGZ2/profile http://localhost:39603/getInfo.html 04:27:48 INFO - 2016-01-25 04:27:48,988 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:48 INFO - 2016-01-25 04:27:48,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:48 INFO - 2016-01-25 04:27:48,989 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:48 INFO - 2016-01-25 04:27:48,989 DEBUG : BROWSER_OUTPUT: __metrics 04:27:49 INFO - 2016-01-25 04:27:49,125 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] 04:27:50 INFO - 2016-01-25 04:27:50,157 INFO : Browser initialized. 04:27:50 INFO - 2016-01-25 04:27:50,158 INFO : Running cycle 1/1 for kraken test... 04:27:50 INFO - 2016-01-25 04:27:50,158 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNWQGZ2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:01 INFO - 2016-01-25 04:28:01,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 128344064 04:28:01 INFO - 2016-01-25 04:28:01,692 DEBUG : BROWSER_OUTPUT: 04:28:04 INFO - 2016-01-25 04:28:04,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:04 INFO - 2016-01-25 04:28:04,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 162930688 04:28:04 INFO - 2016-01-25 04:28:04,696 DEBUG : BROWSER_OUTPUT: 04:28:07 INFO - 2016-01-25 04:28:07,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-dft) 04:28:07 INFO - 2016-01-25 04:28:07,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 160608256 04:28:07 INFO - 2016-01-25 04:28:07,840 DEBUG : BROWSER_OUTPUT: 04:28:10 INFO - 2016-01-25 04:28:10,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-fft) 04:28:11 INFO - 2016-01-25 04:28:11,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 156807168 04:28:11 INFO - 2016-01-25 04:28:11,209 DEBUG : BROWSER_OUTPUT: 04:28:13 INFO - 2016-01-25 04:28:13,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator) 04:28:13 INFO - 2016-01-25 04:28:13,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 157990912 04:28:13 INFO - 2016-01-25 04:28:13,777 DEBUG : BROWSER_OUTPUT: 04:28:15 INFO - 2016-01-25 04:28:15,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:16 INFO - 2016-01-25 04:28:16,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 154570752 04:28:16 INFO - 2016-01-25 04:28:16,473 DEBUG : BROWSER_OUTPUT: 04:28:19 INFO - 2016-01-25 04:28:19,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:19 INFO - 2016-01-25 04:28:19,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 155537408 04:28:19 INFO - 2016-01-25 04:28:19,903 DEBUG : BROWSER_OUTPUT: 04:28:23 INFO - 2016-01-25 04:28:23,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:23 INFO - 2016-01-25 04:28:23,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 157556736 04:28:23 INFO - 2016-01-25 04:28:23,811 DEBUG : BROWSER_OUTPUT: 04:28:26 INFO - 2016-01-25 04:28:26,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial) 04:28:27 INFO - 2016-01-25 04:28:27,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 157290496 04:28:27 INFO - 2016-01-25 04:28:27,124 DEBUG : BROWSER_OUTPUT: 04:28:28 INFO - 2016-01-25 04:28:28,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:29 INFO - 2016-01-25 04:28:29,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 161275904 04:28:29 INFO - 2016-01-25 04:28:29,213 DEBUG : BROWSER_OUTPUT: 04:28:30 INFO - 2016-01-25 04:28:30,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:31 INFO - 2016-01-25 04:28:31,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 161226752 04:28:31 INFO - 2016-01-25 04:28:31,553 DEBUG : BROWSER_OUTPUT: 04:28:33 INFO - 2016-01-25 04:28:33,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:34 INFO - 2016-01-25 04:28:34,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 165400576 04:28:34 INFO - 2016-01-25 04:28:34,076 DEBUG : BROWSER_OUTPUT: 04:28:36 INFO - 2016-01-25 04:28:36,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:36 INFO - 2016-01-25 04:28:36,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 170524672 04:28:36 INFO - 2016-01-25 04:28:36,939 DEBUG : BROWSER_OUTPUT: 04:28:39 INFO - 2016-01-25 04:28:39,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:39 INFO - 2016-01-25 04:28:39,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 168337408 04:28:39 INFO - 2016-01-25 04:28:39,940 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39603/tests/kraken/driver.html?testName=ai-astar) 04:28:41 INFO - 2016-01-25 04:28:41,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 227225600 04:28:41 INFO - 2016-01-25 04:28:41,807 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:41 INFO - 2016-01-25 04:28:41,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:41 INFO - 2016-01-25 04:28:41,810 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:41 INFO - 2016-01-25 04:28:41,810 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:41 INFO - 2016-01-25 04:28:41,810 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;106;108;111;109;100;112;106;110 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;124;147;157;132;149;155;129;165;123 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;161;160;161;161;164;161;160 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;72;153;72;72;70;71;150;74 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;134;91;89;90;130;90;89;136 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;110;110;109;110 04:28:41 INFO - 2016-01-25 04:28:41,811 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;145;146;145;145;146;145 04:28:41 INFO - 2016-01-25 04:28:41,812 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;96 04:28:41 INFO - 2016-01-25 04:28:41,812 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;57;57;56;55;55;57;64;55;57 04:28:41 INFO - 2016-01-25 04:28:41,813 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;64;63;64;64;64;63;63;64 04:28:41 INFO - 2016-01-25 04:28:41,813 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;78;79;79;79;78;79;86;79;78 04:28:41 INFO - 2016-01-25 04:28:41,813 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;122;108;108;115;116;112;114;114;108 04:28:41 INFO - 2016-01-25 04:28:41,813 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;135;137;135;134;136;137;134;136;136 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;63;62;64;63;63;62;63;62;61 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,884 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724921808__endTimestamp 04:28:41 INFO - 2016-01-25 04:28:41,814 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.56 (3.2%) stddev-sans-first:3.72 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 106.0 108.0 111.0 109.0 100.0 112.0 106.0 110.0 04:28:41 INFO - 2016-01-25 04:28:41,816 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:152.00 stddev:15.25 (10.0%) stddev-sans-first:15.61 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: Values: 155.0 124.0 147.0 157.0 132.0 149.0 155.0 129.0 165.0 123.0 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 161.0 160.0 161.0 161.0 164.0 161.0 160.0 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:71.50 stddev:33.76 (47.2%) stddev-sans-first:35.27 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 72.0 153.0 72.0 72.0 70.0 71.0 150.0 74.0 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:89.50 stddev:21.13 (23.6%) stddev-sans-first:21.81 04:28:41 INFO - 2016-01-25 04:28:41,817 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 134.0 91.0 89.0 90.0 130.0 90.0 89.0 136.0 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,818 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 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.79 (4.9%) stddev-sans-first:2.78 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: Values: 54.0 57.0 57.0 56.0 55.0 55.0 57.0 64.0 55.0 57.0 04:28:41 INFO - 2016-01-25 04:28:41,818 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 63.0 64.0 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.37 (3.0%) stddev-sans-first:2.51 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: Values: 79.0 78.0 79.0 79.0 79.0 78.0 79.0 86.0 79.0 78.0 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.50 Median:114.00 stddev:4.65 (4.1%) stddev-sans-first:4.64 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: Values: 108.0 122.0 108.0 108.0 115.0 116.0 112.0 114.0 114.0 108.0 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:136.00 stddev:1.17 (0.9%) stddev-sans-first:1.13 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: Values: 134.0 135.0 137.0 135.0 134.0 136.0 137.0 134.0 136.0 136.0 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 62.0 64.0 63.0 63.0 62.0 63.0 62.0 61.0 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:41 INFO - 2016-01-25 04:28:41,819 DEBUG : BROWSER_OUTPUT: 04:28:42 INFO - 2016-01-25 04:28:42,425 INFO : Browser exited with error code: 0 04:28:42 INFO - 2016-01-25 04:28:42,480 INFO : Completed test kraken (00:00:56) 04:28:42 INFO - 2016-01-25 04:28:42,480 INFO : Starting test v8_7 04:28:42 INFO - 2016-01-25 04:28:42,480 DEBUG : operating with platform_type : linux_ 04:28:42 INFO - 2016-01-25 04:28:42,480 INFO : Initialising browser for v8_7 test... 04:28:42 INFO - 2016-01-25 04:28:42,486 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphQ51qc/profile http://localhost:39603/getInfo.html 04:28:45 INFO - 2016-01-25 04:28:45,582 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:45 INFO - 2016-01-25 04:28:45,582 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:45 INFO - 2016-01-25 04:28:45,582 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:45 INFO - 2016-01-25 04:28:45,582 DEBUG : BROWSER_OUTPUT: __metrics 04:28:45 INFO - 2016-01-25 04:28:45,683 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] 04:28:46 INFO - 2016-01-25 04:28:46,781 INFO : Browser initialized. 04:28:46 INFO - 2016-01-25 04:28:46,782 INFO : Running cycle 1/1 for v8_7 test... 04:28:46 INFO - 2016-01-25 04:28:46,782 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphQ51qc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:58 INFO - 2016-01-25 04:28:58,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 128696320 04:28:58 INFO - 2016-01-25 04:28:58,302 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39603/tests/v8_7/run.html (next: http://localhost:39603/tests/v8_7/run.html) 04:29:19 INFO - 2016-01-25 04:29:19,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 428281856 04:29:19 INFO - 2016-01-25 04:29:19,946 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: |0;Richards;166.72224074691565 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.909919202338 04:29:19 INFO - 2016-01-25 04:29:19,948 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 04:29:19 INFO - 2016-01-25 04:29:19,949 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 04:29:19 INFO - 2016-01-25 04:29:19,949 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 04:29:19 INFO - 2016-01-25 04:29:19,949 DEBUG : BROWSER_OUTPUT: |5;Earley;559.9104143337066 04:29:19 INFO - 2016-01-25 04:29:19,949 DEBUG : BROWSER_OUTPUT: |6;Boyer;10562.5 04:29:19 INFO - 2016-01-25 04:29:19,949 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 04:29:19 INFO - 2016-01-25 04:29:19,950 DEBUG : BROWSER_OUTPUT: |8;Splay;518.4033177812338 04:29:19 INFO - 2016-01-25 04:29:19,950 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 04:29:19 INFO - 2016-01-25 04:29:19,950 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:19 INFO - 2016-01-25 04:29:19,950 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724959946__endTimestamp 04:29:19 INFO - 2016-01-25 04:29:19,951 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,951 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:19 INFO - 2016-01-25 04:29:19,951 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:29:19 INFO - 2016-01-25 04:29:19,951 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,952 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,952 DEBUG : BROWSER_OUTPUT: Values: 166.7 04:29:19 INFO - 2016-01-25 04:29:19,952 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,952 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.91 Median:171.91 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,953 DEBUG : BROWSER_OUTPUT: Values: 171.9 04:29:19 INFO - 2016-01-25 04:29:19,953 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,953 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: Values: 280.0 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: Values: 4995.0 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: Values: 950.6 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,954 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:559.91 Median:559.91 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: Values: 559.9 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10562.50 Median:10562.50 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: Values: 10562.5 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: Values: 24261.9 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: Values: 518.4 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: Values: 4812.5 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:19 INFO - 2016-01-25 04:29:19,955 DEBUG : BROWSER_OUTPUT: 04:29:20 INFO - 2016-01-25 04:29:20,629 INFO : Browser exited with error code: 0 04:29:20 INFO - 2016-01-25 04:29:20,641 INFO : Completed test v8_7 (00:00:38) 04:29:20 INFO - 2016-01-25 04:29:20,962 INFO : Completed test suite (00:20:04) 04:29:20 INFO - 2016-01-25 04:29:20,962 DEBUG : Working with test: dromaeo_css 04:29:20 INFO - 2016-01-25 04:29:20,963 DEBUG : Generating results file: dromaeo_css 04:29:20 INFO - 2016-01-25 04:29:20,964 DEBUG : Working with test: kraken 04:29:20 INFO - 2016-01-25 04:29:20,964 DEBUG : Generating results file: kraken 04:29:20 INFO - 2016-01-25 04:29:20,964 INFO : javascript benchmark 04:29:20 INFO - 2016-01-25 04:29:20,964 DEBUG : Working with test: v8_7 04:29:20 INFO - 2016-01-25 04:29:20,964 DEBUG : Generating results file: v8_7 04:29:20 INFO - 2016-01-25 04:29:20,965 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:21 INFO - 2016-01-25 04:29:21,019 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:29:21 INFO - 2016-01-25 04:29:21,019 DEBUG : process_Request line: dromaeo_css 7195.62 graph.html#tests=[[72,53,35]] 04:29:21 INFO - 2016-01-25 04:29:21,019 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:21 INFO - 2016-01-25 04:29:21,048 DEBUG : process_Request line: kraken 1464.40 graph.html#tests=[[232,53,35]] 04:29:21 INFO - 2016-01-25 04:29:21,048 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:21 INFO - 2016-01-25 04:29:21,079 DEBUG : process_Request line: v8_7 23221.60 graph.html#tests=[[230,53,35]] 04:29:21 INFO - 2016-01-25 04:29:21,080 INFO : javascript benchmark 04:29:21 INFO - 2016-01-25 04:29:21,084 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3316.867325306988, 3402.9829850850742, 3414.8463319150637, 3415.6584341565845, 3442.208292092818, 5564.916526252105, 5577.163425486179, 5579.442055794419, 5584.6090773645865, 5598.300212473441, 5653.9151912721345, 5665.8583535411635, 5675.943240567593, 5690.573207009481, 5695.943040569593, 4932.53140951609, 5137.511936366049, 5159.406668233145, 5222.216667499886, 5262.81580144695, 5116.2069879168785, 5146.6911985281, 5148.922766158511, 5150.510701483353, 5150.871228219287, 5074.112030394666, 5144.17693169093, 5191.247269145972, 5192.896142077157, 5197.324347834776, 5012.072766538202, 5136.0, 5202.817901373433, 5210.739463026834, 5211.478852114796, 5111.463296353903, 5150.587952963791, 5170.405403378584, 5205.0, 5205.089109405839, 5323.600729945231, 5372.194170874361, 5391.48780865821, 5490.560755139619, 5491.341039075297, 6039.547033972426, 6114.96942515289, 6115.908261376083, 6117.357677443849, 6117.755289788403, 6128.846778830521, 6137.877242455126, 6145.661988590626, 6147.815565533041, 6160.907586386208, 5516.3380394352935, 5591.133374326986, 5613.747381367848, 5693.373728889819, 5730.0, 6131.448169664752, 6225.56076372458, 6239.78160764371, 6261.968690156611, 6269.0909818076125, 5895.4399332063385, 6043.12374705674, 6056.576039677268, 6062.393760623902, 6072.817815465455, 6066.332703402622, 6084.756609735649, 6181.412765787243, 6182.1345011698395, 6190.133381326618, 6042.274927008787, 6062.636241825417, 6065.029595264737, 6069.908951365733, 6101.389861013863, 5959.255093113361, 6048.697565121726, 6070.0591408331775, 6072.574919755575, 6099.085137229363, 4587.9541204588195, 4623.16782979067, 4623.237165867661, 4629.3518907353, 4676.205045142334, 4094.160697057096, 4097.078157414618, 4105.322621767435, 4117.402976568381, 4124.9587504125175, 5428.321459817523, 5619.381867994517, 5638.520725738276, 5647.0964645656495, 5649.943500564942, 5916.792912248051, 6041.577089603686, 6187.133801267826, 6201.193844800147, 6201.441870231701, 5785.30576330843, 5794.652320860761, 5797.913031304533, 5801.6519008859605, 5822.1266809978, 5119.820806271762, 5215.634905556574, 5309.601779866525, 5324.201369794484, 5336.599755018389, 6007.339192688801, 6097.579210215478, 6102.526025185527, 6119.96940015306, 6135.32511423743, 6082.42340956269, 6110.413802721403, 6117.143599896107, 6120.969395152996, 6127.908081378872, 5979.372165922516, 6099.695015249308, 6133.671320645445, 6258.7809426671665, 6265.0602409637095, 5992.221011268507, 6009.7295621698, 6060.181875446759, 6061.212042434631, 6069.878602427839, 6136.417040381157, 6141.447269745744, 6145.231846019247, 6155.507559395148, 6160.815175544741, 5740.339860915881, 5845.736941837543, 5929.940700592939, 5993.760249590142, 6009.699515024318, 5913.91129133072, 5919.911201331897, 5953.285605727167, 5969.582129250911, 5970.0746384310505, 5851.034579294369, 5854.092615644582, 5857.648541087548, 5893.823185304448, 5914.4381283777975, 5698.344690360495, 5844.094165404369, 5896.734646940984, 6006.371300233828, 6041.969790151021, 5878.794242201502, 5880.26496687914, 5886.764529418775, 5891.263592050994, 5910.911336330045], "unit": "ms", "name": "dojo.html", "value": 5588.044841426922}, {"lowerIsBetter": false, "replicates": [601.8134378342714, 629.288903539001, 650.3983814971152, 658.1608449227232, 661.3386613386614, 35152.296954060934, 42714.57285427145, 43005.78497107514, 43094.78452607737, 43163.35254971178, 46686.53313466864, 47278.0, 47319.0, 47351.763241183835, 47376.28935565961, 8246.299064579518, 8399.95800020999, 9077.455352678828, 9242.39924404915, 10418.218633602472, 10733.087687546567, 10835.78328433431, 10837.945810270938, 10864.076553492963, 10874.945625271863, 10841.891581084166, 10937.781244375108, 10939.45302734864, 10951.561937522489, 10961.0, 10834.40410777407, 10934.617288394868, 10934.726631834188, 10956.068734157567, 10956.397398143139, 10553.102986246178, 10670.786584268271, 10682.465876706134, 10691.305065170816, 10692.786144277072, 43052.354214686806, 43414.56585434169, 43530.347044794355, 43586.782066089465, 43606.563934360565, 3795.35478968576, 3822.7515211511163, 3886.727929044968, 4360.236958532244, 4459.264221403465, 32247.83876080628, 32945.0, 32995.0, 32995.505067424005, 33177.834110829535, 3389.237421580149, 3472.374972504948, 3483.9651603483894, 3537.8054207018604, 3571.607123216444, 322853.0, 323941.0, 324115.0, 324864.0, 324996.0, 64288.35711642917, 64877.0, 68057.61798337035, 74161.25838741651, 75134.24865751273, 70799.0, 71079.2892071083, 71151.64424177846, 71176.288237118, 71304.0, 18293.268269269345, 18320.908395457936, 18489.075546222633, 18635.534111647044, 18670.43988680342, 13919.582412527641, 13966.650833729034, 13982.0, 14007.299635018207, 14088.436462541384, 22435.887820560794, 22698.886505567698, 22755.31734047981, 22801.543969120856, 22874.284428667917, 8633.525156116348, 8888.955555222183, 9006.50464224474, 9061.818763624691, 9101.089891010846, 955.3742298794301, 1055.8152323343384, 1058.571278632155, 1081.6809041332826, 1163.4822503985815, 31204.531932021036, 35160.0, 35400.46899296513, 35968.820155899055, 36002.81998590042, 1121.9551217951355, 1124.1119515582598, 1165.609520810521, 1174.629991552658, 1176.5235079792697, 14516.0, 15719.68560628781, 15910.76133857993, 16144.273507692182, 16871.325146993982, 374552.0, 376382.0, 377238.0, 379038.0, 380254.0, 58658.0, 59391.10913336303, 59399.10901336483, 59455.702721486115, 59505.0, 1388.0630574362467, 1425.5224499792685, 1520.361448191762, 1531.5788158256346, 1540.6134478968793, 31276.687233127377, 31290.53064204084, 31629.5255571162, 31725.841370792998, 32375.67624323821, 49168.0, 49640.0, 49685.75157124191, 49703.75148124236, 49722.25416618681, 320925.0, 323584.0, 324522.0, 324720.0, 326830.0, 36012.8199359012, 36027.81986090053, 36236.09409764777, 36270.4559431614, 50311.49688503068, 48422.75788621034, 48919.0, 49458.25812612742, 49792.75103624459, 49811.75094124506, 40436.08422313236, 41351.58648413477, 41656.375154373316, 41992.79003604963, 42293.577064228964, 41197.79401102975, 41460.58539414567, 41494.79252603718, 41685.58314416817, 42205.57794422139, 40245.79877100596, 41177.79411102925, 41839.7908010458, 41890.0, 42000.36999445072, 36042.8197859009, 36748.0, 37046.62953370432, 37627.40600379042, 37889.2422151561, 27925.418554166255, 28053.94378291446, 28244.87020519156, 28258.85870570634, 28368.290792730346], "unit": "ms", "name": "ext.html", "value": 21053.394356673092}, {"lowerIsBetter": false, "replicates": [383.78316251318006, 384.5981843388041, 384.9769013859167, 392.33695055356463, 395.8080331039445, 17239.56901077472, 17366.913165434155, 18335.174917128727, 18454.077296135205, 18645.813541864576, 16013.199340032981, 16314.184290785442, 16344.0, 17878.553036174104, 18025.7296140558, 5510.476504732044, 5666.829995100154, 5734.569907256951, 5769.740361683714, 5782.103773915029, 5687.090065589507, 5747.59766816323, 5755.827325180251, 5760.654360738348, 5765.365809760923, 5128.71792051437, 5683.943160568403, 5702.7433765480655, 5751.539876809866, 5759.3376761672525, 5647.604667673265, 5721.227634269362, 5736.426357364272, 5738.081906894919, 5743.224664670258, 4559.544045595447, 4652.0, 4659.510751371125, 5140.820071297524, 5148.665336753099, 15227.543173704807, 15305.0, 15495.690086198325, 15593.922030389775, 15632.4528641497, 2062.9071691773756, 2074.761402438724, 2080.6566916458764, 2107.7576078750985, 2124.0547956159517, 10633.57465701371, 10806.081483073947, 10860.565577376896, 10868.347899126078, 11029.952154545386, 1736.713442282022, 1738.2959901240017, 1742.0679936234053, 1763.8324359185856, 1773.17547340486, 69692.30307696908, 70497.59004819926, 71697.28302716959, 71847.92228116583, 72024.27975720228, 7795.844083118419, 7825.843483130306, 7934.246246606564, 7968.880466793003, 7970.561619111005, 9554.474503902353, 9568.186704130088, 9572.0, 9572.56923438447, 9575.664851730156, 5905.143754155623, 6070.089486577049, 6261.8747625047245, 6332.271788744261, 6349.714262858182, 6472.611643301417, 6571.441427478718, 6592.703328350236, 6621.834454138685, 6676.0987266718375, 3591.048372181374, 3607.5851277102943, 3642.0530662028063, 3664.1755604988666, 3681.9447708284397, 1235.9814602780966, 1243.720162963326, 1273.3951373097889, 1280.6862318731971, 1287.1633438265203, 451.7131621420356, 458.0518327063014, 473.4200604259823, 505.11100463185056, 505.16395365669877, 11246.49390777417, 13102.213867168, 13403.463861445432, 13621.182729036289, 13817.723645527034, 512.7231295100604, 522.9686218826882, 525.0339375548932, 531.9228711836762, 555.3973938276933, 7123.358897699232, 7310.926890731131, 7338.41292696583, 7354.742584009534, 7357.0, 612650.0, 621703.0, 630316.0, 661768.0, 663345.0, 83458.58270708607, 87867.0, 87928.0, 89524.10475895288, 91893.0, 507.99746001270495, 597.7907732293662, 601.2484394506866, 611.0711718188329, 612.4059662127729, 10623.734406639896, 10787.0, 10870.673879783619, 10996.945015275192, 11148.721281968015, 35904.0, 36157.09607259734, 36890.8155459221, 37186.814065929495, 37218.0, 49482.0, 50885.491145088075, 51528.48471515237, 51605.0, 52211.0, 8861.822763544564, 9221.0, 9304.674336398193, 9323.20752736025, 9399.765005874635, 13446.93276533611, 13532.86467135316, 13649.11280766747, 13698.863011370157, 13724.93137534306, 11260.436978151223, 11352.772944541228, 11911.702207444883, 12130.939345303217, 12221.083418743452, 11752.76494470123, 11990.520379184734, 12083.154179207371, 12224.266544007389, 12462.937685311515, 10074.899251007397, 11362.091032717197, 12040.939795301318, 12070.094742894142, 12649.430775614936, 9544.475053872104, 9588.952055239679, 9589.376690515093, 9688.612455501983, 9701.126898579161, 12166.39168041612, 12237.816432753338, 12358.382080895739, 12419.44112514921, 12621.684457888627], "unit": "ms", "name": "jquery.html", "value": 7830.081441866884}, {"lowerIsBetter": false, "replicates": [1531.5788158256478, 1558.984410155898, 1796.3353559183088, 1874.3908229825306, 1874.7937726850043, 7191.82020449489, 7330.486865919388, 8124.715634952778, 8323.209295116969, 8350.164983501654, 8050.5974701264995, 8219.876701849462, 8323.875141872863, 8327.37544684148, 8332.875006874901, 2441.304228294941, 2485.72657007729, 2486.0677246032737, 2488.3530282126685, 2490.476999830038, 2172.370012696324, 2224.9666255006186, 2398.1126983016306, 2449.3998970252223, 2481.2060140754966, 2365.302235840423, 2376.7266764322067, 2380.7976322012564, 2397.832151749378, 2398.328468028955, 2327.5461285049423, 2345.9296221113395, 2348.6242201247887, 2351.7295511016196, 2351.811855051592, 2395.700537432821, 2441.047991283383, 2442.096424323012, 2442.6702395176603, 2443.7800597946093, 8144.1041485437145, 8221.79445513861, 8223.917760822374, 8224.300934420582, 8225.8354832903, 4976.527229913152, 5042.39491261051, 5047.798088076473, 5052.040112378636, 5052.974735126338, 3183.267848394859, 3183.856726447292, 3285.014495651319, 3294.8517316720804, 3305.586801649794, 1077.3159044007034, 1084.7505073833063, 1085.7177133945152, 1089.727568107973, 1093.4696672114019, 11106.944465277702, 11116.722081947935, 11121.55513779448, 11131.0, 11134.0, 4585.312203169485, 4585.6102231310715, 4632.837850675211, 4662.090892275974, 4666.253399456139, 9599.376040557341, 9620.037996200324, 9635.56639951204, 9636.277279204087, 9639.421634701801, 4963.751812409365, 5000.174971129795, 5031.597472202215, 5031.798728050837, 5044.924326135111, 4543.023250001265, 4549.977250113794, 4552.408186935677, 4568.0, 4604.861854144381, 3294.3246634439884, 4098.672106231495, 4106.568810274878, 4119.382092686121, 4144.91710165795, 1247.4261839553908, 1269.4033804112053, 1317.236003118189, 1320.8679132086716, 1332.733453309342, 1360.7210521842999, 1462.9634259143606, 1481.9259037048105, 1483.8664520193233, 1499.6175975126273, 8034.839303213903, 8099.473534220257, 8104.918950810535, 8107.310878575269, 8149.185081491803, 1235.3637876493613, 1243.8134279858093, 1247.376311844078, 1249.144336129754, 1263.406199086428, 6416.4225219729515, 6420.807375778734, 6503.154589903283, 6518.837029074216, 6518.902216466757, 9980.550875210633, 10203.897961020295, 10204.081632653097, 10211.642592509226, 10221.846672299922, 9801.264905132144, 10111.241656875616, 10125.088742013108, 10132.848007279898, 10162.136218421369, 7868.370530357558, 7904.56524891125, 7910.920890791019, 7911.248431399008, 7919.762407127795, 7493.063367079115, 7559.395248380007, 7580.469367144247, 7588.8482230356185, 7600.80997975055, 8638.78403039904, 9053.954730226571, 9088.772780680536, 9093.0, 9212.401193922373, 9137.177654010906, 9300.581473833558, 9309.953450232977, 9450.621975120917, 9500.85748713756, 7469.887951680837, 7498.175200727806, 7498.887516687363, 7506.099268087864, 7515.0, 7353.77938661841, 7447.813804654927, 8043.919560804317, 8195.34437245007, 8221.79445513867, 7434.553926764412, 7510.873368994695, 7521.736739214101, 7582.431317651309, 7620.80947976305, 7365.447591430557, 7372.668229929559, 7432.293932076444, 7457.627118643937, 7511.51175173612, 7108.218096009331, 7177.138743350832, 7216.7834964951135, 7218.963905180441, 7447.478676492594, 6858.965705171442, 7138.964305178441, 7147.3210045045635, 7155.391791697764, 7156.212816590275, 7181.0, 7197.064381630564, 7232.204457509564, 7275.163356213891, 7277.490575659653], "unit": "ms", "name": "mootools.html", "value": 4840.37406073971}, {"lowerIsBetter": false, "replicates": [352.7424979764772, 359.41236079010815, 364.8248840556531, 369.0588998054959, 371.0834239428612, 5897.911531327033, 5981.671008094553, 5987.730552125154, 5996.850078748033, 6012.188354572131, 5739.827805165852, 5875.764969401219, 5879.735411906464, 5891.911621325684, 5893.941060589393, 4608.5621865922685, 4610.654200934943, 4613.123506533765, 4615.676902616819, 4615.676902616819, 4433.202023635744, 4528.818847246106, 4542.931856022145, 4618.699784514012, 4620.838270660528, 4544.341070544769, 4565.201089809287, 4568.611668008223, 4588.816447342119, 4591.494935557086, 4527.886802829939, 4530.07133537624, 4531.207038768235, 4541.091781643684, 4543.636509079282, 4040.030392705759, 4086.6117718816663, 4089.141280331134, 4098.426220329156, 4098.7130900836955, 5588.497035266845, 5620.859478513029, 5629.240052592889, 5671.177679236529, 5679.971600142014, 5322.175062865262, 5325.094733895208, 5332.733363331818, 5332.813351532716, 5335.413104558495, 6063.696815159225, 6300.621962682254, 6310.0850376695125, 6314.589551679126, 6319.14691516644, 4362.192994296065, 4389.956100438987, 4427.512973572904, 4429.933550996738, 4430.778461076933, 6393.1688880445245, 6485.238561634241, 6485.513586480985, 6490.156279683611, 6495.772647957346, 4472.463304403427, 4515.164694531522, 4517.796699148546, 4518.051209246095, 4524.705894116872, 4495.460544734653, 4563.338315944169, 4564.794584243717, 4570.8171673133365, 4636.466806317249, 5318.494742999409, 5321.946780532223, 5322.068637988336, 5327.973360133252, 5331.786728530893, 6367.331430199855, 6369.49044076482, 6379.330170332141, 6386.840328991812, 6398.488120950406, 1655.7433597792362, 1675.9581010474592, 1675.9832401676072, 1678.6139187986832, 1678.7397953317256, 1100.2298391126244, 1110.9833352499718, 1114.8940850619178, 1126.9492872820742, 1147.0307590086363, 6171.691415429301, 6173.351798061229, 6173.536984726164, 6176.227971503562, 6184.196054512974, 6522.478201743849, 6541.5093867960095, 6551.868962620721, 6560.934390656128, 6563.1796025496815, 6043.305019922677, 6157.784477543354, 6162.137300777895, 6167.537434692416, 6169.907451388232, 3571.2500374921037, 3583.498310236569, 3585.032041348821, 3587.856485740593, 3613.0244833895226, 6721.428678562279, 6722.394984451423, 6722.495812813961, 6728.259891411941, 6734.562253453608, 6629.767958121539, 6654.434373078343, 6727.461803055744, 6727.62998035103, 6735.932640673531, 6663.666816659148, 6669.366410190927, 6694.531382803157, 6708.899366509506, 6709.832254193587, 6362.268339141058, 6459.709313081016, 6538.313477084837, 6549.901751473636, 6559.409653131241, 6361.904571431525, 6444.194475690539, 6469.159009328757, 6475.449586784987, 6475.579087359307, 6600.504962127956, 6616.040674102324, 6622.867542649216, 6642.6014439133805, 6684.097646817811, 4492.707973981681, 4502.662300327423, 4540.2054640438455, 4544.727316361029, 4554.499005109369, 6526.543141980205, 6526.934730652632, 6532.771353002622, 6537.542372034102, 6539.509536784665, 6321.431071203429, 6331.240251169889, 6336.17629708135, 6338.809835704937, 6343.492520598434, 6295.716692748929, 6372.808815735535, 6391.2330520337855, 6397.520185985976, 6399.55203135776, 6275.278342990432, 6278.0269058296035, 6279.183706118175, 6288.811335659938, 6291.528135389773, 6332.208473940757, 6351.936480635134, 6425.45383642377, 6449.451796597342, 6457.838554036187, 6180.351063138306, 6205.28639206479, 6246.531510136667, 6291.276503202191, 6310.873782524415], "unit": "ms", "name": "prototype.html", "value": 4808.217573507728}, {"lowerIsBetter": false, "replicates": [785.0814546980033, 841.2092632925054, 931.362017018342, 937.0916372272819, 963.7783309838738, 14001.299935003248, 14413.13521188728, 14480.203588802611, 14519.637009074766, 14519.709605807877, 13109.213447193175, 13140.802887956688, 13158.73682526349, 13213.0, 13219.206847589152, 753.3596443023414, 761.8019314978118, 900.1763386501343, 906.3791302957462, 917.775145089454, 911.4850109688039, 912.0970239462918, 918.0268914950174, 918.7381596245071, 918.8208299381623, 957.7653474898659, 962.6486332488661, 964.1178321835512, 964.7829238421369, 964.9083337083001, 775.11249619186, 783.0564170174954, 940.5767404667927, 951.6764300137986, 954.2223088183108, 708.0335342257832, 708.8157079159456, 711.2176605733704, 713.0872483221485, 714.3249629100502, 14122.576322710334, 14733.631659208499, 14773.778393324108, 14818.33317500715, 14852.0, 12336.321502317458, 13122.737545249138, 13201.0, 13255.536056238081, 13523.120997135155, 10120.342177758423, 10159.847602285972, 10206.540705668189, 10217.540210690537, 10286.0, 3361.798292102482, 3392.4911263310455, 3405.250844814137, 3412.692857642824, 3418.2308980479193, 53993.1901021485, 54205.1869221962, 54231.72884135554, 55110.72444637791, 55292.44707552913, 9788.461634610023, 9813.389794114528, 9827.606895724233, 9855.507224638739, 9920.107190352903, 13736.145620341325, 21041.15835366599, 21091.578168436547, 21117.57764844725, 21152.259670911444, 6811.489138314646, 6861.382475577222, 6911.75808846688, 6965.0, 6987.441004719611, 4159.272127377757, 4268.637165840876, 4287.892802679958, 4300.075483771005, 4341.110072435144, 3056.49567821307, 3087.737542308929, 3088.042706760911, 3110.5956225690516, 3118.8284644344326, 489.2783144861301, 491.3440556856565, 492.47797334824486, 494.873807179167, 500.2396357536524, 536.4608568388744, 536.9167778994262, 546.1725485888882, 552.914735774378, 620.6803496199461, 7682.846343073107, 8417.873731894026, 8687.843305511333, 8741.956290218508, 8999.37004409698, 521.6687403498805, 551.613870290798, 578.3320265093823, 637.2830565613684, 643.7167646235641, 4158.542560318362, 4186.120914607905, 4195.119025004783, 4195.755583582426, 4199.811008504625, 69617.0, 69834.65082674554, 70679.64660176667, 70713.0, 71105.64447177835, 60446.69776651177, 61350.38649613536, 61861.38138618646, 61867.6906615464, 62318.376816231255, 56503.43496565064, 56517.0, 56613.43386566164, 56832.43167568272, 58207.41792582105, 8282.58587070632, 8357.122502137188, 8423.073461919306, 8538.743837684631, 8541.402101852811, 40202.9949251271, 40684.79657601693, 40728.1854362917, 41472.58527414808, 41894.37158442565, 51075.74462127666, 54241.72879135579, 54384.45615543794, 54689.0, 54951.0, 8429.199226073513, 8543.231109200202, 8561.529115898686, 8601.268892143988, 8622.223999840044, 12084.0, 12140.635780926586, 12413.875861241271, 12458.626241212778, 12532.686682832637, 10405.323653962469, 10816.729581760519, 10856.891431085589, 10870.782584348111, 10977.890221097687, 10546.630867919586, 10751.19366047534, 10963.671089867317, 11663.825042624538, 12004.279743215435, 9448.716538503855, 9523.476208808583, 10199.54102065394, 10262.43556604394, 10533.210009249491, 9905.554250058909, 9981.500924953869, 10071.798564028531, 10183.287169898333, 10510.737231569272, 8787.91212087871, 9189.770255743393, 9192.356535042483, 9271.258299335903, 9279.39683920543], "unit": "ms", "name": "yui.html", "value": 6473.785306755118}], "name": "dromaeo_css", "value": 7195.617503530864}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 108.0, 111.0, 109.0, 100.0, 112.0, 106.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 147.0, 157.0, 132.0, 149.0, 155.0, 129.0, 165.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 164.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 153.0, 72.0, 72.0, 70.0, 71.0, 150.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 134.0, 91.0, 89.0, 90.0, 130.0, 90.0, 89.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 57.0, 56.0, 55.0, 55.0, 57.0, 64.0, 55.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0, 86.0, 79.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [108.0, 122.0, 108.0, 108.0, 115.0, 116.0, 112.0, 114.0, 114.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.5}, {"lowerIsBetter": true, "replicates": [134.0, 135.0, 137.0, 135.0, 134.0, 136.0, 137.0, 134.0, 136.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 62.0, 64.0, 63.0, 63.0, 62.0, 63.0, 62.0, 61.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.5}], "name": "kraken", "value": 1464.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [171.909919202338], "unit": "score", "name": "DeltaBlue", "value": 384.60840599999995}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [559.9104143337066], "unit": "score", "name": "Earley", "value": 1190.3029180000005}, {"lowerIsBetter": false, "replicates": [10562.5], "unit": "score", "name": "Boyer", "value": 63.09708875739642}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 23221.596288060475}]} 04:29:21 INFO - RETURN: dromaeo_css: 7195.62 04:29:21 INFO - RETURN: kraken: 1464.40 04:29:21 INFO - RETURN: v8_7: 23221.60 04:29:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23221.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1464.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7195.62"}}} 04:29:21 INFO - Return code: 0 04:29:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:21 INFO - # TBPL SUCCESS # 04:29:21 INFO - Running post-action listener: _resource_record_post_action 04:29:21 INFO - Running post-run listener: _resource_record_post_run 04:29:22 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 323584; Write bytes: 503173120; Read time: 224; Write time: 494716 04:29:22 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 238116864; Read time: 132; Write time: 338064 04:29:22 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 319488; Write bytes: 258199552; Read time: 92; Write time: 153784 04:29:22 INFO - Running post-run listener: _upload_blobber_files 04:29:22 INFO - Blob upload gear active. 04:29:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:29:22 INFO - Copying logs to upload dir... 04:29:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1250.106057 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 04:29:21.992348) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:21.996683) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:22.060030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:22.060454) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453723710.586253-1626703807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:22.114293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:22.114649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:22.115004) ========= ========= Total master_lag: 0.34 =========