builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1453723704.23 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.227635) ========= 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:24.228050) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.228347) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006234 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.250922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.251234) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.316067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.316462) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.364887) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.365195) ========= 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:24.365558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.365841) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 04:08:24-- 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% 26.9M=0s 2016-01-25 04:08:24 (26.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104480 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.527088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.527433) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018567 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.557911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:24.558277) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 04:08:24,771 Setting DEBUG logging. 2016-01-25 04:08:24,771 attempt 1/10 2016-01-25 04:08:24,771 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:25,574 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.130129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:25.698366) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:25.698745) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f84fcce02b11 program finished with exit code 0 elapsedTime=0.003296 script_repo_revision: 'f84fcce02b11' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:25.747345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:25.747649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:25.757398) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 04:08:25.757671) ========= /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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:26 INFO - MultiFileLogger online at 20160125 04:08:26 in /builds/slave/test-pgo 04:08:26 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:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:08:26 INFO - {'append_to_log': False, 04:08:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:08:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:08:26 INFO - 'branch': 'Mozilla-Beta', 04:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:26 INFO - 'config_files': ('talos/linux_config.py',), 04:08:26 INFO - 'default_actions': ('clobber', 04:08:26 INFO - 'read-buildbot-config', 04:08:26 INFO - 'download-and-extract', 04:08:26 INFO - 'populate-webroot', 04:08:26 INFO - 'create-virtualenv', 04:08:26 INFO - 'install', 04:08:26 INFO - 'run-tests'), 04:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:26 INFO - 'download_minidump_stackwalk': True, 04:08:26 INFO - 'download_symbols': 'ondemand', 04:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:26 INFO - 'installer_path': 'installer.exe', 04:08:26 INFO - 'log_level': 'info', 04:08:26 INFO - 'log_name': 'talos', 04:08:26 INFO - 'log_to_console': True, 04:08:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:26 INFO - 'opt_config_files': (), 04:08:26 INFO - 'pip_index': False, 04:08:26 INFO - 'sps_profile': False, 04:08:26 INFO - 'sps_profile_interval': 0, 04:08:26 INFO - 'suite': 'dromaeojs', 04:08:26 INFO - 'system_bits': '32', 04:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:26 INFO - 'title': 'talos-linux64-ix-055', 04:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:26 INFO - 'use_talos_json': True, 04:08:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:26 INFO - 'work_dir': 'build'} 04:08:26 INFO - ##### 04:08:26 INFO - ##### Running clobber step. 04:08:26 INFO - ##### 04:08:26 INFO - Running pre-action listener: _resource_record_pre_action 04:08:26 INFO - Running main action method: clobber 04:08:26 INFO - rmtree: /builds/slave/test-pgo/build 04:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:08:26 INFO - Running post-action listener: _resource_record_post_action 04:08:26 INFO - ##### 04:08:26 INFO - ##### Running read-buildbot-config step. 04:08:26 INFO - ##### 04:08:26 INFO - Running pre-action listener: _resource_record_pre_action 04:08:26 INFO - Running main action method: read_buildbot_config 04:08:26 INFO - Using buildbot properties: 04:08:26 INFO - { 04:08:26 INFO - "properties": { 04:08:26 INFO - "buildnumber": 82, 04:08:26 INFO - "product": "firefox", 04:08:26 INFO - "script_repo_revision": "production", 04:08:26 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:08:26 INFO - "repository": "", 04:08:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:08:26 INFO - "buildid": "20160118120031", 04:08:26 INFO - "slavename": "talos-linux64-ix-055", 04:08:26 INFO - "pgo_build": "True", 04:08:26 INFO - "basedir": "/builds/slave/test-pgo", 04:08:26 INFO - "project": "", 04:08:26 INFO - "platform": "ubuntu64_hw", 04:08:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:08:26 INFO - "slavebuilddir": "test", 04:08:26 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:08:26 INFO - "branch": "mozilla-beta", 04:08:26 INFO - "repo_path": "releases/mozilla-beta", 04:08:26 INFO - "stage_platform": "linux64-pgo", 04:08:26 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 04:08:26 INFO - "revision": "f84fcce02b11" 04:08:26 INFO - }, 04:08:26 INFO - "sourcestamp": { 04:08:26 INFO - "repository": "", 04:08:26 INFO - "hasPatch": false, 04:08:26 INFO - "project": "", 04:08:26 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:26 INFO - "changes": [ 04:08:26 INFO - { 04:08:26 INFO - "category": null, 04:08:26 INFO - "files": [ 04:08:26 INFO - { 04:08:26 INFO - "url": null, 04:08:26 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:26 INFO - } 04:08:26 INFO - ], 04:08:26 INFO - "repository": "", 04:08:26 INFO - "rev": "f84fcce02b11", 04:08:26 INFO - "who": "sendchange", 04:08:26 INFO - "when": 1453155801, 04:08:26 INFO - "number": 7475630, 04:08:26 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 04:08:26 INFO - "project": "", 04:08:26 INFO - "at": "Mon 18 Jan 2016 14:23:21", 04:08:26 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:26 INFO - "revlink": "", 04:08:26 INFO - "properties": [ 04:08:26 INFO - [ 04:08:26 INFO - "buildid", 04:08:26 INFO - "20160118120031", 04:08:26 INFO - "Change" 04:08:26 INFO - ], 04:08:26 INFO - [ 04:08:26 INFO - "builduid", 04:08:26 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 04:08:26 INFO - "Change" 04:08:26 INFO - ], 04:08:26 INFO - [ 04:08:26 INFO - "pgo_build", 04:08:26 INFO - "True", 04:08:26 INFO - "Change" 04:08:26 INFO - ] 04:08:26 INFO - ], 04:08:26 INFO - "revision": "f84fcce02b11" 04:08:26 INFO - } 04:08:26 INFO - ], 04:08:26 INFO - "revision": "f84fcce02b11" 04:08:26 INFO - } 04:08:26 INFO - } 04:08:26 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:26 INFO - Running post-action listener: _resource_record_post_action 04:08:26 INFO - ##### 04:08:26 INFO - ##### Running download-and-extract step. 04:08:26 INFO - ##### 04:08:26 INFO - Running pre-action listener: _resource_record_pre_action 04:08:26 INFO - Running main action method: download_and_extract 04:08:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 04:08:26 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:26 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:26 INFO - Downloaded 1270 bytes. 04:08:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:08:26 INFO - Using the following test package requirements: 04:08:26 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:26 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:26 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'jsshell-linux-x86_64.zip'], 04:08:26 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:26 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:26 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:08:26 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:08:26 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:26 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:26 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:26 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:26 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:26 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:26 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:26 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:26 INFO - Downloaded 22573307 bytes. 04:08:26 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:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:26 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:27 INFO - Return code: 0 04:08:27 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:27 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:27 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:27 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:27 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:28 INFO - Downloaded 22573307 bytes. 04:08:28 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:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:28 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:29 INFO - Return code: 0 04:08:29 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:29 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:29 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:29 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:29 INFO - Downloaded 11131970 bytes. 04:08:29 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:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:29 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:30 INFO - Return code: 0 04:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:30 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:30 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:30 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:31 INFO - Downloaded 56626174 bytes. 04:08:31 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:31 INFO - mkdir: /builds/slave/test-pgo/properties 04:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Contents: 04:08:31 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:31 INFO - Running post-action listener: _resource_record_post_action 04:08:31 INFO - Running post-action listener: set_extra_try_arguments 04:08:31 INFO - ##### 04:08:31 INFO - ##### Running populate-webroot step. 04:08:31 INFO - ##### 04:08:31 INFO - Running pre-action listener: _resource_record_pre_action 04:08:31 INFO - Running main action method: populate_webroot 04:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:08:31 INFO - '../fennec_ids.txt'], 04:08:31 INFO - 'tests': ['tcheck2']}, 04:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:31 INFO - '--tppagecycles', 04:08:31 INFO - '7'], 04:08:31 INFO - 'tests': ['tsvgm']}}, 04:08:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['damp', 'tps']}, 04:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['damp', 'tps']}, 04:08:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:31 INFO - 'other': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other_l64': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'svgr': {'tests': ['tsvgx', 04:08:31 INFO - 'tsvgr_opacity', 04:08:31 INFO - 'tart', 04:08:31 INFO - 'tscrollx', 04:08:31 INFO - 'cart']}, 04:08:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tsvgx', 04:08:31 INFO - 'tsvgr_opacity', 04:08:31 INFO - 'tart', 04:08:31 INFO - 'tscrollx', 04:08:31 INFO - 'cart']}, 04:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['tp5o']}, 04:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tp5o']}, 04:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--xperf_path', 04:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:31 INFO - 'tests': ['tp5n']}, 04:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s', 04:08:31 INFO - '--xperf_path', 04:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:31 INFO - 'tests': ['tp5n']}}, 04:08:31 INFO - 'talos.zip': {'path': '', 04:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:31 INFO - Running post-action listener: _resource_record_post_action 04:08:31 INFO - ##### 04:08:31 INFO - ##### Running create-virtualenv step. 04:08:31 INFO - ##### 04:08:31 INFO - Running pre-action listener: _resource_record_pre_action 04:08:31 INFO - Running main action method: create_virtualenv 04:08:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:08:31 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:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:31 INFO - Using real prefix '/usr' 04:08:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:08:31 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:33 INFO - Installing pip.................done. 04:08:33 INFO - Return code: 0 04:08:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:33 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 04:08:33 INFO - 'HOME': '/home/cltbld', 04:08:33 INFO - 'LANG': 'en_US.UTF-8', 04:08:33 INFO - 'LANGUAGE': 'en_US:en', 04:08:33 INFO - 'LOGNAME': 'cltbld', 04:08:33 INFO - 'MAIL': '/var/mail/cltbld', 04:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:33 INFO - 'MOZ_NO_REMOTE': '1', 04:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:33 INFO - 'NO_EM_RESTART': '1', 04:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:33 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:33 INFO - 'SHELL': '/bin/bash', 04:08:33 INFO - 'SHLVL': '1', 04:08:33 INFO - 'TERM': 'linux', 04:08:33 INFO - 'TMOUT': '86400', 04:08:33 INFO - 'USER': 'cltbld', 04:08:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:33 INFO - '_': '/tools/buildbot/bin/python'} 04:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:34 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:34 INFO - Cleaning up... 04:08:34 INFO - Return code: 0 04:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:34 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 04:08:34 INFO - 'HOME': '/home/cltbld', 04:08:34 INFO - 'LANG': 'en_US.UTF-8', 04:08:34 INFO - 'LANGUAGE': 'en_US:en', 04:08:34 INFO - 'LOGNAME': 'cltbld', 04:08:34 INFO - 'MAIL': '/var/mail/cltbld', 04:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:34 INFO - 'MOZ_NO_REMOTE': '1', 04:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:34 INFO - 'NO_EM_RESTART': '1', 04:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:34 INFO - 'SHELL': '/bin/bash', 04:08:34 INFO - 'SHLVL': '1', 04:08:34 INFO - 'TERM': 'linux', 04:08:34 INFO - 'TMOUT': '86400', 04:08:34 INFO - 'USER': 'cltbld', 04:08:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:34 INFO - '_': '/tools/buildbot/bin/python'} 04:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:34 INFO - Downloading/unpacking psutil>=0.7.1 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:08:36 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:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:36 INFO - Installing collected packages: psutil 04:08:36 INFO - Running setup.py install for psutil 04:08:36 INFO - building 'psutil._psutil_linux' extension 04:08:36 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:36 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:36 INFO - building 'psutil._psutil_posix' extension 04:08:36 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:36 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:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:36 INFO - Successfully installed psutil 04:08:36 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 04:08:37 INFO - 'HOME': '/home/cltbld', 04:08:37 INFO - 'LANG': 'en_US.UTF-8', 04:08:37 INFO - 'LANGUAGE': 'en_US:en', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MAIL': '/var/mail/cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SHLVL': '1', 04:08:37 INFO - 'TERM': 'linux', 04:08:37 INFO - 'TMOUT': '86400', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - '_': '/tools/buildbot/bin/python'} 04:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:08:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:39 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:39 INFO - Installing collected packages: mozsystemmonitor 04:08:39 INFO - Running setup.py install for mozsystemmonitor 04:08:39 INFO - Successfully installed mozsystemmonitor 04:08:39 INFO - Cleaning up... 04:08:39 INFO - Return code: 0 04:08:39 INFO - Installing blobuploader==1.2.4 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', '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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:39 INFO - '_': '/tools/buildbot/bin/python'} 04:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:41 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:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 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:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:08:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Downloading docopt-0.6.1.tar.gz 04:08:41 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:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:41 INFO - Running setup.py install for blobuploader 04:08:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:08:42 INFO - Running setup.py install for requests 04:08:42 INFO - Running setup.py install for docopt 04:08:42 INFO - Successfully installed blobuploader requests docopt 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Installing None 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', '--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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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', '--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:42 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: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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 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 - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:42 INFO - Running setup.py (path:/tmp/pip-ir5ofG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:42 INFO - Running setup.py (path:/tmp/pip-a_6uBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:42 INFO - Running setup.py (path:/tmp/pip-BrNhdW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:42 INFO - Running setup.py (path:/tmp/pip-Ixe6bT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:43 INFO - Running setup.py (path:/tmp/pip-O_eVQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:43 INFO - Running setup.py (path:/tmp/pip-0X21es-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:43 INFO - Running setup.py (path:/tmp/pip-Wscgh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:43 INFO - Running setup.py (path:/tmp/pip-LufFYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:43 INFO - Running setup.py (path:/tmp/pip-eVpsoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:43 INFO - Running setup.py (path:/tmp/pip-KLtAy0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:43 INFO - Running setup.py (path:/tmp/pip-ccd5Bz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:43 INFO - Running setup.py (path:/tmp/pip-5MZzjz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:43 INFO - Running setup.py (path:/tmp/pip-442aXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:43 INFO - Running setup.py (path:/tmp/pip-hSd8dV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:43 INFO - Running setup.py (path:/tmp/pip-oE63_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:43 INFO - Running setup.py (path:/tmp/pip-cCKTci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:43 INFO - Running setup.py (path:/tmp/pip-MnlAqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:43 INFO - Running setup.py install for manifestparser 04:08:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozcrash 04:08:44 INFO - Running setup.py install for mozdebug 04:08:44 INFO - Running setup.py install for mozdevice 04:08:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozfile 04:08:44 INFO - Running setup.py install for mozhttpd 04:08:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozinfo 04:08:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozInstall 04:08:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozleak 04:08:44 INFO - Running setup.py install for mozlog 04:08:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for moznetwork 04:08:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozprocess 04:08:45 INFO - Running setup.py install for mozprofile 04:08:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozrunner 04:08:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozscreenshot 04:08:45 INFO - Running setup.py install for moztest 04:08:45 INFO - Running setup.py install for mozversion 04:08:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 04:08:45 INFO - 'HOME': '/home/cltbld', 04:08:45 INFO - 'LANG': 'en_US.UTF-8', 04:08:45 INFO - 'LANGUAGE': 'en_US:en', 04:08:45 INFO - 'LOGNAME': 'cltbld', 04:08:45 INFO - 'MAIL': '/var/mail/cltbld', 04:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:45 INFO - 'MOZ_NO_REMOTE': '1', 04:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:45 INFO - 'NO_EM_RESTART': '1', 04:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:45 INFO - 'SHELL': '/bin/bash', 04:08:45 INFO - 'SHLVL': '1', 04:08:45 INFO - 'TERM': 'linux', 04:08:45 INFO - 'TMOUT': '86400', 04:08:45 INFO - 'USER': 'cltbld', 04:08:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:45 INFO - '_': '/tools/buildbot/bin/python'} 04:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:45 INFO - Running setup.py (path:/tmp/pip-UD_tXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:46 INFO - Running setup.py (path:/tmp/pip-NrJO0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:46 INFO - Running setup.py (path:/tmp/pip-Z0FzLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:46 INFO - Running setup.py (path:/tmp/pip-W7M1rr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:46 INFO - Running setup.py (path:/tmp/pip-iiz81d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:46 INFO - Running setup.py (path:/tmp/pip-LL9X9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:46 INFO - Running setup.py (path:/tmp/pip-z9zB7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:46 INFO - Running setup.py (path:/tmp/pip-kiITBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:46 INFO - Running setup.py (path:/tmp/pip-g9rtkW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:46 INFO - Running setup.py (path:/tmp/pip-GGcTgB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:46 INFO - Running setup.py (path:/tmp/pip-3wIkUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:46 INFO - Running setup.py (path:/tmp/pip-39Dnld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:46 INFO - Running setup.py (path:/tmp/pip-mkjGqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:46 INFO - Running setup.py (path:/tmp/pip-CcEikF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:46 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:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:46 INFO - Running setup.py (path:/tmp/pip-MCmTwH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:47 INFO - Running setup.py (path:/tmp/pip-3sdBzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:47 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:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:47 INFO - Running setup.py (path:/tmp/pip-5tisW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:47 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:47 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:47 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:47 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:47 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:47 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:47 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: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:48 INFO - Downloading blessings-1.6.tar.gz 04:08:48 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:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:49 INFO - Installing collected packages: blessings 04:08:49 INFO - Running setup.py install for blessings 04:08:49 INFO - Successfully installed blessings 04:08:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:08:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:49 INFO - Reading from file tmpfile_stdout 04:08:49 INFO - Current package versions: 04:08:49 INFO - argparse == 1.2.1 04:08:49 INFO - blessings == 1.6 04:08:49 INFO - blobuploader == 1.2.4 04:08:49 INFO - docopt == 0.6.1 04:08:49 INFO - manifestparser == 1.1 04:08:49 INFO - mozInstall == 1.12 04:08:49 INFO - mozcrash == 0.16 04:08:49 INFO - mozdebug == 0.1 04:08:49 INFO - mozdevice == 0.46 04:08:49 INFO - mozfile == 1.2 04:08:49 INFO - mozhttpd == 0.7 04:08:49 INFO - mozinfo == 0.8 04:08:49 INFO - mozleak == 0.1 04:08:49 INFO - mozlog == 3.0 04:08:49 INFO - moznetwork == 0.27 04:08:49 INFO - mozprocess == 0.22 04:08:49 INFO - mozprofile == 0.27 04:08:49 INFO - mozrunner == 6.11 04:08:49 INFO - mozscreenshot == 0.1 04:08:49 INFO - mozsystemmonitor == 0.0 04:08:49 INFO - moztest == 0.7 04:08:49 INFO - mozversion == 1.4 04:08:49 INFO - psutil == 3.1.1 04:08:49 INFO - requests == 1.2.3 04:08:49 INFO - wsgiref == 0.1.2 04:08:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 04:08:49 INFO - 'HOME': '/home/cltbld', 04:08:49 INFO - 'LANG': 'en_US.UTF-8', 04:08:49 INFO - 'LANGUAGE': 'en_US:en', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MAIL': '/var/mail/cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SHLVL': '1', 04:08:49 INFO - 'TERM': 'linux', 04:08:49 INFO - 'TMOUT': '86400', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 04:08:49 INFO - 'HOME': '/home/cltbld', 04:08:49 INFO - 'LANG': 'en_US.UTF-8', 04:08:49 INFO - 'LANGUAGE': 'en_US:en', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MAIL': '/var/mail/cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SHLVL': '1', 04:08:49 INFO - 'TERM': 'linux', 04:08:49 INFO - 'TMOUT': '86400', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 INFO - Downloading/unpacking jsonschema 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:51 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:51 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:51 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:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:51 INFO - warning: no files found matching '*.txt' 04:08:51 INFO - no previously-included directories found matching 'build' 04:08:51 INFO - no previously-included directories found matching 'dist' 04:08:51 INFO - no previously-included directories found matching '.git*' 04:08:51 INFO - Installing collected packages: jsonschema, functools32 04:08:51 INFO - Running setup.py install for functools32 04:08:52 INFO - warning: no files found matching '*.txt' 04:08:52 INFO - no previously-included directories found matching 'build' 04:08:52 INFO - no previously-included directories found matching 'dist' 04:08:52 INFO - no previously-included directories found matching '.git*' 04:08:52 INFO - Successfully installed jsonschema functools32 04:08:52 INFO - Cleaning up... 04:08:52 INFO - Return code: 0 04:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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 0x7fee61fb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 04:08:52 INFO - 'HOME': '/home/cltbld', 04:08:52 INFO - 'LANG': 'en_US.UTF-8', 04:08:52 INFO - 'LANGUAGE': 'en_US:en', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MAIL': '/var/mail/cltbld', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SHLVL': '1', 04:08:52 INFO - 'TERM': 'linux', 04:08:52 INFO - 'TMOUT': '86400', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - '_': '/tools/buildbot/bin/python'} 04:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:52 INFO - Downloading/unpacking flake8 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 flake8-2.5.0-py2.py3-none-any.whl 04:08:54 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:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:54 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:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 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:08:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.7.0.tar.gz 04:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:54 INFO - no previously-included directories found matching 'docs/_build' 04:08:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:54 INFO - Running setup.py install for pep8 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:54 INFO - no previously-included directories found matching 'docs/_build' 04:08:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:08:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:54 INFO - Cleaning up... 04:08:54 INFO - Return code: 0 04:08:54 INFO - Running post-action listener: _resource_record_post_action 04:08:54 INFO - Running post-action listener: _start_resource_monitoring 04:08:55 INFO - Starting resource monitoring. 04:08:55 INFO - ##### 04:08:55 INFO - ##### Running install step. 04:08:55 INFO - ##### 04:08:55 INFO - Running pre-action listener: _resource_record_pre_action 04:08:55 INFO - Running main action method: install 04:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:55 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 - Detecting whether we're running mozinstall >=1.0... 04:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Output received: 04:08:55 INFO - Usage: mozinstall [options] installer 04:08:55 INFO - Options: 04:08:55 INFO - -h, --help show this help message and exit 04:08:55 INFO - -d DEST, --destination=DEST 04:08:55 INFO - Directory to install application into. [default: 04:08:55 INFO - "/builds/slave/test-pgo"] 04:08:55 INFO - --app=APP Application being installed. [default: firefox] 04:08:55 INFO - mkdir: /builds/slave/test-pgo/build/application 04:08:55 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:08:55 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:09 INFO - Reading from file tmpfile_stdout 04:09:09 INFO - Output received: 04:09:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:09:09 INFO - Running post-action listener: _resource_record_post_action 04:09:09 INFO - ##### 04:09:09 INFO - ##### Running run-tests step. 04:09:09 INFO - ##### 04:09:09 INFO - Running pre-action listener: _resource_record_pre_action 04:09:09 INFO - Running main action method: run_tests 04:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:09:09 INFO - Python 2.7.3 04:09:09 INFO - Return code: 0 04:09:09 INFO - grabbing minidump binary from tooltool 04:09:09 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:09 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 0x1883350>, '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 0x1884250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18846e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:09:09 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:09 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:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:09 INFO - Return code: 0 04:09:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:09:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:09:10 INFO - Return code: 0 04:09:10 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-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:09:10 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-055 --webServer localhost 04:09:10 INFO - Using env: {'DISPLAY': ':0', 04:09:10 INFO - 'HOME': '/home/cltbld', 04:09:10 INFO - 'LANG': 'en_US.UTF-8', 04:09:10 INFO - 'LANGUAGE': 'en_US:en', 04:09:10 INFO - 'LOGNAME': 'cltbld', 04:09:10 INFO - 'MAIL': '/var/mail/cltbld', 04:09:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:10 INFO - 'MOZ_NO_REMOTE': '1', 04:09:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:10 INFO - 'NO_EM_RESTART': '1', 04:09:10 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:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:09:10 INFO - 'SHELL': '/bin/bash', 04:09:10 INFO - 'SHLVL': '1', 04:09:10 INFO - 'TERM': 'linux', 04:09:10 INFO - 'TMOUT': '86400', 04:09:10 INFO - 'USER': 'cltbld', 04:09:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556', 04:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:10 INFO - '_': '/tools/buildbot/bin/python'} 04:09:10 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-055', '--webServer', 'localhost'] with output_timeout 3600 04:09:10 INFO - mozversion INFO | application_buildid: 20160118120031 04:09:10 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:10 INFO - mozversion INFO | application_display_name: Nightly 04:09:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:10 INFO - mozversion INFO | application_name: Firefox 04:09:10 INFO - mozversion INFO | application_remotingname: firefox 04:09:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:10 INFO - mozversion INFO | application_vendor: Mozilla 04:09:10 INFO - mozversion INFO | application_version: 44.0 04:09:10 INFO - mozversion INFO | platform_buildid: 20160118120031 04:09:10 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:10 INFO - mozversion INFO | platform_version: 44.0 04:09:10 INFO - 2016-01-25 04:09:10,852 DEBUG : using testdate: 1453723750 04:09:10 INFO - 2016-01-25 04:09:10,852 DEBUG : actual date: 1453723750 04:09:10 INFO - 2016-01-25 04:09:10,862 INFO : starting webserver on 'localhost:36304' 04:09:10 INFO - 2016-01-25 04:09:10,863 INFO : Starting test suite talos-linux64-ix-055 04:09:10 INFO - 2016-01-25 04:09:10,863 INFO : Starting test dromaeo_css 04:09:10 INFO - 2016-01-25 04:09:10,863 DEBUG : operating with platform_type : linux_ 04:09:10 INFO - 2016-01-25 04:09:10,863 INFO : Initialising browser for dromaeo_css test... 04:09:10 INFO - 2016-01-25 04:09:10,876 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6lUmD0/profile http://localhost:36304/getInfo.html 04:09:14 INFO - 2016-01-25 04:09:14,206 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:14 INFO - 2016-01-25 04:09:14,207 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:14 INFO - 2016-01-25 04:09:14,207 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:14 INFO - 2016-01-25 04:09:14,207 DEBUG : BROWSER_OUTPUT: __metrics 04:09:14 INFO - 2016-01-25 04:09:14,288 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:15 INFO - 2016-01-25 04:09:15,426 INFO : Browser initialized. 04:09:15 INFO - 2016-01-25 04:09:15,426 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:15 INFO - 2016-01-25 04:09:15,427 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6lUmD0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:26 INFO - 2016-01-25 04:09:26,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 128704512 04:09:26 INFO - 2016-01-25 04:09:26,928 DEBUG : BROWSER_OUTPUT: 04:10:17 INFO - 2016-01-25 04:10:17,819 DEBUG : BROWSER_OUTPUT: 1453723817815 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:25 INFO - 2016-01-25 04:12:25,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36304/tests/dromaeo/cssquery-ext.html) 04:12:26 INFO - 2016-01-25 04:12:26,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 239706112 04:12:26 INFO - 2016-01-25 04:12:26,730 DEBUG : BROWSER_OUTPUT: 04:15:28 INFO - 2016-01-25 04:15:28,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-ext.html (next: http://localhost:36304/tests/dromaeo/cssquery-jquery.html) 04:15:29 INFO - 2016-01-25 04:15:29,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 205402112 04:15:29 INFO - 2016-01-25 04:15:29,375 DEBUG : BROWSER_OUTPUT: 04:18:31 INFO - 2016-01-25 04:18:31,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36304/tests/dromaeo/cssquery-mootools.html) 04:18:31 INFO - 2016-01-25 04:18:31,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 210513920 04:18:31 INFO - 2016-01-25 04:18:31,629 DEBUG : BROWSER_OUTPUT: 04:21:33 INFO - 2016-01-25 04:21:33,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36304/tests/dromaeo/cssquery-prototype.html) 04:21:33 INFO - 2016-01-25 04:21:33,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 191422464 04:21:33 INFO - 2016-01-25 04:21:33,935 DEBUG : BROWSER_OUTPUT: 04:24:36 INFO - 2016-01-25 04:24:36,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36304/tests/dromaeo/cssquery-yui.html) 04:24:36 INFO - 2016-01-25 04:24:36,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 194310144 04:24:36 INFO - 2016-01-25 04:24:36,882 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/dromaeo/cssquery-yui.html (next: http://localhost:36304/tests/dromaeo/cssquery-dojo.html) 04:27:39 INFO - 2016-01-25 04:27:39,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 237481984 04:27:39 INFO - 2016-01-25 04:27:39,265 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,265 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:39 INFO - 2016-01-25 04:27:39,265 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:39 INFO - 2016-01-25 04:27:39,266 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:39 INFO - 2016-01-25 04:27:39,266 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:39 INFO - 2016-01-25 04:27:39,266 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3308.5533452983846;3364.7644664873437;3385.9830700846505;3394.2871996880654;3407.863685452582;5592.832215033551;5600.495955364022;5606.159076138581;5617.4382561743905;5625.915611265829;5600.103983362663;5634.098544232924;5645.661260324373;5647.774089036434;5648.491635752782;4926.11329960607;5115.488451154883;5147.202183661539;5202.583793296546;5254.4220135785035;5011.223260394645;5046.949530504685;5122.3084883540805;5147.510986456281;5208.661437006583;5160;5170.741462926858;5172.19830926207;5179.326687530615;5210.973945130269;4950.6782059166035;5144.691318520863;5152.407473140562;5171.689698618076;5212.8957420851375;5055.772490237948;5119.974400128012;5150.407703114152;5167.302414174076;5178.870528236786;5521.1442226454965;5536.640118392332;5546.389897111315;5561.972190139064;5563.388027316992;5823.941760582382;5937.881242375129;6156.7537298508005;6159.137720719058;6174.228221472316;6083.543734219951;6151.446369826737;6178.814635560941;6183.2889217740085;6189.535784816157;5784.2769653793275;5806.419358064244;5809.215755872945;5832.912506312408;5839.416058394169;5923.318818335861;6033.134420546168;6128.647737417829;6274.341194174637;6285.151504546919;5952.494038006731;6028.487578555784;6041.72812223451;6052.788152414644;6060.575759696779;6097.695115244309;6103.6948152592195;6105.633661980295;6111.174991376108;6112.786052488142;5845.210896528914;5959.910601340984;5999.160117583542;6065.181200537871;6102.578645452416;6167.784127555604;6173.660448675366;6175.042868355412;6182.258129024456;6184.288806787187;4695.295705644113;4703.764811759398;4711.8350857719815;4721.268203428474;4729.4797572267025;4050.918981620351;4117.2588933992165;4132.979335103365;4169.374593810952;4207;5773.076307790818;5800.622959507618;5801.274840644919;5801.9129713054335;5814.273215848019;5982.102684597346;6152.538559608047;6160.969195153995;6163.260408750979;6163.630182189083;5605.831825045255;5663.122216056518;5674.546036317167;5694.06048002075;5711.057675483582;5262.97368513155;5271.578273738091;5290.206469029677;5290.92063619046;5292.761825717852;6025.969870150709;6123.479504242189;6269.122322874801;6277.466415354746;6283.622982621057;5978.372270911578;6056.636601803906;6068.059450785136;6071.848203794763;6085.726142323518;6231.470325022424;6266.968665156645;6290.339514350927;6293.937060629335;6304.810855674337;5778.451047150514;5884.117382392676;5976.581639285208;6056.36408177135;6073.119397687399;5973.820785376446;6107.389261073857;6118.051701986199;6133.466633341664;6141.6007959482495;5886.735096920735;5892.616979896293;5901.468867801918;5901.704914754159;5907.32065812437;5703.116017017369;5826.126081087871;5905.498032667271;5972.193753843349;6111.786087486917;5885.411458854252;5896.587238893237;5906.26171728534;5907.70461476933;5907.911381329198;5940.1683764272175;6015.187949626919;6015.608985415934;6026.337102918763;6034.698265086816;5667.20659107717;5775.537956963349;5799.072148456226;5884.411558844253;5901.763929442946 04:27:39 INFO - 2016-01-25 04:27:39,266 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.1860757724031;611.3855575146978;620.1194304088193;642.5662677692557;653.7907869481768;35828.82085589572;44425.33361999568;44838.327425088566;44961.325580116325;44964;48692.51307486924;49226.50773492264;49256;49283.50716492834;49580;8415.074341822394;8503.787405314886;9273.907260927372;9427.198688111519;11002.394868282241;10841.024307812295;10958.342499450058;10963.122950164008;10965;10974;11293.322400655947;11431.485583148737;11450.484728187252;11452.484638191301;11456.083513318956;11289.774204515905;11392;11396.202265841435;11419.657410277705;11425.485853136546;10680.572777088908;10745.140388768958;10752.139828813677;10753.83869241962;10757.354558726502;45908.54091459076;46205.30692039622;46295.30557041647;46395.30407043897;46422.071558568976;3625.4380571011534;3630.7458477906557;3664.0839790052487;4085.8774236772942;4249.596288352602;32588.348233035205;32839.34321313584;33060.834695826605;33162.3367532648;33315.6668433315;3540.150363912668;3598.8560457581666;3622.3479773640734;3675.9448608270895;3683.778973261586;310474;310832;313214;313975.43012285023;319221;67139.66430167817;69009;71301.6434917822;77810.2218977803;79569;70794.29205707877;70819.29180708127;71001.64499177471;71078;71205;16781.412650557173;16854.578635533966;16890.915545422195;16946.491605251864;16950.23723932426;14342.569722908329;14534.05528640635;14545;14555.78166327506;14640.560783176521;23091.884540577525;23398.415039623804;23411.180608678955;23425.531489370118;23589.528209435714;8418.368622353348;8511.276541493919;8572.957135214408;8646.74059778195;8651.6971905983;1073.511552243743;1081.0486771640906;1096.627146770102;1128.7629597784394;1129.768397478515;31878.681213188036;31900.361992760016;32043.198920027186;32383.19042023921;32482.187945301084;1188.411736190574;1197.8203269509643;1232.9876701233052;1301.6680746409795;1313.2448841915937;14602.34289456977;16552.586185345222;16646.250918708443;16747.832521674627;16848.915755421145;282046;287060;287373;287604;289466;51973.480265196864;52882.99999999923;57271;57506.7124664374;57697.711511442176;1450.9201993890438;1480.4078368652624;1483;1500.6248437890526;1505.224809223251;30030.238094059703;30058.24854378658;31961.36077278488;32350.029499115066;32486.512702309956;51575.74212128916;52154.21768673549;52182;52192.21711674404;52198;283231;285390;285592;285751;286946;35763.82118089497;36413;36447.453288200166;36679.449808253434;36869.44695829618;48627;49128;49570.752146239036;49762;50502.494975051246;41277.587224127376;43443.56556434522;45027.549724502336;45970;46142.30786538137;41337.79331103325;41624.375634366115;42096.57903421049;42238.366424503045;42527;40809.79595102005;41269.793651031556;41351;41802;41865.58134418738;35986.820065899505;36338.8183059083;37325.4401183977;37431.81284093562;37734.43398349082;27479.725202748516;28126;28131.156065318075;28165.718342816308;28207.43585128327 04:27:39 INFO - 2016-01-25 04:27:39,267 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.125361370546;389.1167050794696;389.37894058975934;390.1300100775271;394.0228233979732;15123.773143402857;17273.568160795985;17777.822221777777;18437.53906152345;18439.446816595508;13101.934490327534;13315.733685326288;13329.266890321029;19045.714314285262;19385.12766925488;4818.927716084253;4937.753112344386;4950.207966725325;4954.232094025414;4958.132326842806;3876.592957739439;3951.6443520083185;3953.2093581283716;3957.4855268815013;4857.73282469464;5205.141151709963;5275.155975043994;5318.175682769177;5318.202269659562;5318.627696061278;5149.588032957373;5268.288781014571;5311.097113490716;5320.600954928396;5326.493983071602;4579.381783459224;4584.358189853423;4585.908281834378;4608.124456353282;4624.3757092792375;14849.331780069922;15103.39586416542;15257.923710381488;15293.770593441108;15302.770458443132;2002.2891873384883;2070.33749200256;2071.792820717916;2094.183268525276;2113.2709215320688;10489.527971241312;10564.735881602945;10660.946695266552;10704.357738535713;10710.036096751252;1727.9222434990456;1774.7337899315078;1791.587934774996;1855.3413538194018;1861.2182883189093;60009.69995149996;61334.38665613376;61506.07740883935;61706.69146654238;62319.68840155815;7610.695572177051;7676.385889128856;7684.269994350528;7711.652975615999;7725.729599463992;9222;9227.169554740105;9232.630694772268;9241.445513269226;9242.445453272825;5993.790217342459;6359.632678974042;6379.266384365857;6393.488520918316;6399.64801935898;6708.127943367331;6762.526623136431;6779.983002549657;6818.590884546943;6833.453323734089;3618.6019537850816;3649.3978493548266;3660.103274697716;3668.559772827278;3682.502862113634;1224.1002862895764;1241.9875801242054;1271.491403438632;1286.8841804237663;1306.510058727977;505.4288653821232;506.8808829924965;512.1165988669516;521.4108057894555;536.0271107939155;13041.021923355596;13141.605751827461;13186.340682965812;13192.604221873358;13425.93287033578;492.4902725678905;543.3886877263079;546.1616418797128;573.1088157914483;590.0735844723828;6878.759243426456;7023.4781133695105;7024.683889224997;7166.928330716626;7205.963970180115;648305;650700;652254;679497;692825;80851.19148808437;82287;83934.58032709919;84629;85155.57422212849;587.0284678856499;588.5438784941705;588.6556364526714;594.0495207667783;598.7245866901275;11804.70488237801;11996.76006479883;12319;12326.260424374566;12414.255144691348;37549.81225093857;37580.624193757714;38462.42306365351;38537.614623853406;38864.41703374395;47395;47944;48095.27857082077;49140.75429622972;49212.75393623152;7473.103227612722;7475.551466912003;7661.808454788675;7678.270564296383;7696.230376962259;13532.86467135316;13664.453421863014;13719;13821;13827.930860345634;11826.467808948446;11974.580889669169;12082.214656047328;12103.273803571814;12247.510099596273;11883.346415947206;11998.58004969822;12052.698682533006;12143;12339.876601233873;11786.941065294619;12067.396630168632;12117.212381195546;12774.169678970837;12797.488100475877;7673.961630191813;7709.036370453693;7790.065192176975;7790.805229869072;7793.883091753742;11916.76166476683;12100.576479823163;12158.331291778682;12195.268283902995;12227.449764760786 04:27:39 INFO - 2016-01-25 04:27:39,267 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1584.5721655153116;1586.4923224568136;1822.854171666267;1861.6649003179427;1873.7938826729057;7169.354758071772;7449.366803821682;7877.133515313318;8221.424500284982;8233.794155146124;7779.922200777991;7925.2867241948215;7981.321587665041;8017.318527925133;8041.517508949467;2377.738448770634;2403.9639405408934;2411.9397015074674;2412.1195763546357;2413.698287714036;2195.6706494025866;2222.211115054157;2398.1126983016306;2449.730529641738;2479.404942813721;2334.871582062986;2372.3001714494267;2381.392744850061;2383.368407372048;2387.259949415678;2392.688950436441;2399.844010139353;2400.411899084718;2403.6154215325464;2404.4469771952463;2372.4899146683547;2422.0432928993127;2423.042898055276;2423.1397853762014;2423.7455067218043;8152.103268640445;8257.05043919951;8281;8285.668573257062;8286.129956354556;5001.724905130216;5068.062408454448;5071.898562028776;5077.64456488046;5079.263506791532;3133.075742655922;3166.066010526877;3249.4151052810485;3251.951220731691;3266.70599646033;1060.3054998975683;1069.6042464288184;1083.9458027098692;1105.8341248812742;2013.9395818125479;11309.09527237819;11400.543978240861;11402.486888090056;11402.657920262322;11411.144164187719;4506.797194126272;4520.412346395014;4611.262198048364;4616.60758835496;4618.51505591908;9229.261659067259;9245.630174793068;9251.907480925105;9252.53737313145;9253.398529095588;5000.949990500121;5001.124803159432;5005.674631148963;5007.223880298487;5010.073136469692;4574.839880604163;4631.791569379386;4723.929141062887;4733.668643195012;4739.549742774431;3505.5618047744033;3746.1383881706815;3749.343864823645;3782.924341513154;3789.317922773927;1100.1583788401879;1176.5940750441084;1197.4431889171576;1199.688081098903;1207.559240877091;1105.662772854271;1128.9887101129048;1132.8980391764617;1438.755411580034;1474.9852501475063;7660.73187438437;7767.495112817649;7920.4059695523065;7922.445428819928;7926.8810967835525;767.9731209407644;772.729544659376;782.3037496628006;788.046463778834;890.9821803564022;6183;6245.594036387711;6255.030470277115;6306.968465157736;6323.114763933053;9456.47989360578;9976.201903847676;9983.650572229937;9983.900160998297;10001.549930253155;10014.098731114234;10021.048000439947;10025.498725063717;10032.097111259876;10043.397396156253;7456.254374562609;7625.466217364731;7629.809254768676;7631.46579739424;7632;7630.7329243476215;7649.961750191436;7786.532808031537;7797.142314345531;7853.56805375687;8775.254103401283;8912.910870891208;8932.19610235082;8979;8981.55092245372;8841.60212790413;9063.68277110298;9075.727728168165;9078.046805085634;9176.770580735269;7457.627118643937;7493.700251990077;7556;7556.282153195438;7558.924410756042;6681.899771503528;7085.468589855678;7735;7900.604969751605;7980.6408711606955;7187.892181617175;7219.061522002106;7375.8156046099275;7448.813779655552;7539.736109236151;7240.348368646847;7277.090363704537;7285.2714728528845;7383.187849336676;7542.170361260147;7284.67218975158;7487.700491980478;7613.923860761543;7613.961930190314;7624.466287359832;6936.687849046906;6965.895511567229;6967.407770339375;6973.546719463218;6974.19796723363;7052.365287124184;7094.467914906506;7099.680514376969;7100.964495177698;7106.147262328554 04:27:39 INFO - 2016-01-25 04:27:39,268 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.15747465879156;366.0975694912041;366.9267392875839;371.1000823004216;371.4929121748814;5825.417458254173;5965.612235204709;5992.430719081691;6013.27840659121;6042.063480160577;5805.941940580593;5876.853078673035;5897.3218079920825;5902.380250073745;5921.20063791388;4650.441946966369;4658.231391820345;4661;4663.137319595869;4664.207084795593;4514.480834704002;4575.199340115483;4595.333676616889;4672.182368085571;4673.719576825384;4592.885177870563;4601.3558101865765;4609.769511524427;4621.09888571727;4629.976850115745;4596.172688915994;4600.148972440093;4604.930926036112;4606.378138951266;4612.976935115336;4098.918021639551;4106.096658735073;4107.219628270619;4109.97945010276;4110.650594699454;5551.72241387933;5647.37878833328;5658.519025882805;5697.259356283656;5719.399463056402;5379.1662292344745;5411.215373770781;5416.891662166774;5417.052015897241;5418.322709661293;6054.576179667425;6333.809985700436;6336.3346848580695;6339.144215530937;6344.841378965517;4460.8884777880485;4499.61753250974;4548.522405147478;4560.7035542689955;4562.087582483517;6451.41937225652;6470.74117035318;6476.287608363076;6482.967585162091;6484.448821850148;4659.6505262105475;4666.4633567139535;4667.813287468532;4670.182718024332;4672.929906051412;4585.6102231310715;4657.906841863211;4679.2045352289515;4719.811207551728;4728.007118505084;5304.787808487695;5331.253624492574;5332.706701131475;5349.491798279158;5357.035733567917;6345.746170153235;6347.492200623939;6350.174477317919;6354.841128971812;6357.872842543124;1660.6512632347342;1677.8322167783367;1684.2757614225754;1684.5030715938829;1685.6207353345399;1097.5884043483693;1121.1815374776295;1129.8813624569466;1131.4964840645835;1158.137187795098;6077.392260773887;6085.421884920926;6092.573519853657;6095.786647467317;6098.35967223444;6457.5479716419395;6462;6479.319671434431;6481.0602462642655;6486.481081513468;5957.821265362046;6064.120702498113;6073.089036644538;6075.544334174954;6081.513478921675;3582.5521809773777;3608.729345299113;3610.765300255475;3611.8735844245325;3613;6633.137692100093;6640.037194606755;6644.800655980232;6646.86706265872;6652.168478940132;6561.1142495763415;6601.6699165041555;6602.504812139109;6607.6365799880505;6630.469562434993;6570.967145164243;6598.340165983459;6625.834354141185;6647.169103862017;6648.66756662165;6357.777477788255;6385.904211436925;6493.545451818327;6508.674566271762;6519.837004074936;6465.450436712744;6478.578892371981;6485.092087107714;6487.578307410004;6501.382368674968;6650.168728908887;6662.966685166543;6668.633225172468;6671.499637527108;6675.6995935184;4490.753008584559;4572.908541829212;4573.542645735533;4611.262198048296;4621.168189725881;6615.106960560262;6617.172853393326;6619.205695316593;6621.5364924454825;6624.33756624353;6466.062420948842;6478.1578394808375;6479.546431749733;6485.319041500763;6485.383888530582;6336.144620476177;6452.096706461005;6452.677366131581;6453.967730161507;6454.386833250834;6340.682965851781;6346.809595712136;6348.111264422892;6352.301246862749;6353.078803573549;6435.2599451063725;6444.645544495098;6446.194225721785;6448.9032664511005;6449.290578036506;6195.752169913153;6279.937200627935;6289.748410063729;6319.936800631935;6342.23893132827 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: |5;yui.html;783.6551917156451;790.261105866015;884.1512148337596;910.4810258152852;964.6237967192792;14034.22811745355;14307.499237526688;14359.497417590386;14361.497347592836;14379.640508987268;13036.413361398736;13062.934685326583;13116.081874268804;13126.868731312685;13135.93432032841;761.1703243464623;773.6943907156669;895.8387490251785;907.3739120007207;918.4443411735904;908.0420156734642;909.5270459361161;910.2308549275851;913.164454524113;917.1378903830412;952.3714348529971;955.1451450951395;955.574769227694;956.3544607390019;956.7895063086145;785.2814674572759;796.8725003999361;925.9907400926005;938.8826396700413;939.4457270210609;692.9653517324164;694.0144994108379;694.0872752330669;694.2294053600499;698.3470455124475;14003.929980350033;14113;14147;14168.858311416858;14188.148711077369;12162.209456385306;12676.007092729933;12785.10504264702;13069.15050521713;13172.143810652276;9714.9514252429;9750.26872984529;9828.410295382228;9865.408075515421;9994.100530952177;3433.055909624848;3457.757956943015;3463.8268086595567;3465.203003309228;3470.1671598816356;53043.73478132623;53052;53962.460375396135;55249.72375138139;55448.44551554473;9751.561179746928;9842.163416109568;9851.458169800586;9894.20846332306;9949.850752238723;12850.550230742067;12948.546800861925;18333.349998500198;18406.723899141525;18413.26346946107;6546.672666366662;6606.372394622503;6755.425788807908;7016.319224575116;7021.5787052777;4117.711760176819;4119.320312148462;4141.91716165675;4159.230542349675;4195.475565554306;3028.0764366868316;3034.347615262729;3063.6629970703207;3065.2336915771057;3065.57082008519;464.17145395468924;465.8579133364356;474.8385548913386;477.34365247784297;478.7319101303212;510.084398504685;514.920187370958;559.5551536528469;565.7114871415525;639.4500729372736;7835.23260223123;7929.841403172019;8037.799055023671;8057.879131813028;8208.58957052145;453.5215347808094;564.4130104691158;575.6607465755071;605.6184603699729;621.8227805075531;3606.9849866592244;3691.148775894507;3788.6021967693546;3816.1795214029116;4021.4571032910185;65593.67203163954;65866.67066664732;66037.33962660408;67755;68340.3165968344;59659.40340596625;60702.08946865801;61346;62135.37864621296;62169.378306217266;54828.451715483134;55165;55351;55549.16676249859;56606.15090773642;7689.6539655714505;7846;7942.404319676163;7972.960135199287;8034.196580341919;39316.213675725754;39417.80291098641;40039.1992160161;40522;41351.1729765409;48322.758386207846;51839;51866;52014;52603.73698131485;7680.731174408869;7957.721479748181;8113.878291825509;8147.14454982242;8270.586470676322;10657.307275027099;10746.892531074902;10783.784324313627;12103.81844272319;12167.939160304142;10792.946035270088;10807.891921080689;10873.130149588173;10965.835512467478;11365.48855301497;10925.781484370427;11160.107191424504;11323.716907077389;11434.771304574027;12139.635810925687;9521.57152928106;9537.52312384364;9957.900420995988;10392.272540922062;10566.260361774603;8930.419522731001;9132.406393584395;9734.172595329477;9828.16460600857;10360.844587331347;8330.50016998982;8506.362022848187;8508.702195423131;8712.12878712149;8796.032436432115 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,831 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724859260__endTimestamp 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:27:39 INFO - 2016-01-25 04:27:39,270 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5639.52 Median:5845.21 stddev:632.75 (10.8%) stddev-sans-first:607.69 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: Values: 3308.6 3364.8 3386.0 3394.3 3407.9 5592.8 5600.5 5606.2 5617.4 5625.9 5600.1 5634.1 5645.7 5647.8 5648.5 4926.1 5115.5 5147.2 5202.6 5254.4 5011.2 5046.9 5122.3 5147.5 5208.7 5160.0 5170.7 5172.2 5179.3 5211.0 4950.7 5144.7 5152.4 5171.7 5212.9 5055.8 5120.0 5150.4 5167.3 5178.9 5521.1 5536.6 5546.4 5562.0 5563.4 5823.9 5937.9 6156.8 6159.1 6174.2 6083.5 6151.4 6178.8 6183.3 6189.5 5784.3 5806.4 5809.2 5832.9 5839.4 5923.3 6033.1 6128.6 6274.3 6285.2 5952.5 6028.5 6041.7 6052.8 6060.6 6097.7 6103.7 6105.6 6111.2 6112.8 5845.2 5959.9 5999.2 6065.2 6102.6 6167.8 6173.7 6175.0 6182.3 6184.3 4695.3 4703.8 4711.8 4721.3 4729.5 4050.9 4117.3 4133.0 4169.4 4207.0 5773.1 5800.6 5801.3 5801.9 5814.3 5982.1 6152.5 6161.0 6163.3 6163.6 5605.8 5663.1 5674.5 5694.1 5711.1 5263.0 5271.6 5290.2 5290.9 5292.8 6026.0 6123.5 6269.1 6277.5 6283.6 5978.4 6056.6 6068.1 6071.8 6085.7 6231.5 6267.0 6290.3 6293.9 6304.8 5778.5 5884.1 5976.6 6056.4 6073.1 5973.8 6107.4 6118.1 6133.5 6141.6 5886.7 5892.6 5901.5 5901.7 5907.3 5703.1 5826.1 5905.5 5972.2 6111.8 5885.4 5896.6 5906.3 5907.7 5907.9 5940.2 6015.2 6015.6 6026.3 6034.7 5667.2 5775.5 5799.1 5884.4 5901.8 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49892.52 Median:18427.91 stddev:76852.69 (417.0%) stddev-sans-first:76979.07 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: Values: 573.2 611.4 620.1 642.6 653.8 35828.8 44425.3 44838.3 44961.3 44964.0 48692.5 49226.5 49256.0 49283.5 49580.0 8415.1 8503.8 9273.9 9427.2 11002.4 10841.0 10958.3 10963.1 10965.0 10974.0 11293.3 11431.5 11450.5 11452.5 11456.1 11289.8 11392.0 11396.2 11419.7 11425.5 10680.6 10745.1 10752.1 10753.8 10757.4 45908.5 46205.3 46295.3 46395.3 46422.1 3625.4 3630.7 3664.1 4085.9 4249.6 32588.3 32839.3 33060.8 33162.3 33315.7 3540.2 3598.9 3622.3 3675.9 3683.8 310474.0 310832.0 313214.0 313975.4 319221.0 67139.7 69009.0 71301.6 77810.2 79569.0 70794.3 70819.3 71001.6 71078.0 71205.0 16781.4 16854.6 16890.9 16946.5 16950.2 14342.6 14534.1 14545.0 14555.8 14640.6 23091.9 23398.4 23411.2 23425.5 23589.5 8418.4 8511.3 8573.0 8646.7 8651.7 1073.5 1081.0 1096.6 1128.8 1129.8 31878.7 31900.4 32043.2 32383.2 32482.2 1188.4 1197.8 1233.0 1301.7 1313.2 14602.3 16552.6 16646.3 16747.8 16848.9 282046.0 287060.0 287373.0 287604.0 289466.0 51973.5 52883.0 57271.0 57506.7 57697.7 1450.9 1480.4 1483.0 1500.6 1505.2 30030.2 30058.2 31961.4 32350.0 32486.5 51575.7 52154.2 52182.0 52192.2 52198.0 283231.0 285390.0 285592.0 285751.0 286946.0 35763.8 36413.0 36447.5 36679.4 36869.4 48627.0 49128.0 49570.8 49762.0 50502.5 41277.6 43443.6 45027.5 45970.0 46142.3 41337.8 41624.4 42096.6 42238.4 42527.0 40809.8 41269.8 41351.0 41802.0 41865.6 35986.8 36338.8 37325.4 37431.8 37734.4 27479.7 28126.0 28131.2 28165.7 28207.4 04:27:39 INFO - 2016-01-25 04:27:39,271 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31387.40 Median:4585.13 stddev:108798.28 (2372.8%) stddev-sans-first:109078.58 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: Values: 386.1 389.1 389.4 390.1 394.0 15123.8 17273.6 17777.8 18437.5 18439.4 13101.9 13315.7 13329.3 19045.7 19385.1 4818.9 4937.8 4950.2 4954.2 4958.1 3876.6 3951.6 3953.2 3957.5 4857.7 5205.1 5275.2 5318.2 5318.2 5318.6 5149.6 5268.3 5311.1 5320.6 5326.5 4579.4 4584.4 4585.9 4608.1 4624.4 14849.3 15103.4 15257.9 15293.8 15302.8 2002.3 2070.3 2071.8 2094.2 2113.3 10489.5 10564.7 10660.9 10704.4 10710.0 1727.9 1774.7 1791.6 1855.3 1861.2 60009.7 61334.4 61506.1 61706.7 62319.7 7610.7 7676.4 7684.3 7711.7 7725.7 9222.0 9227.2 9232.6 9241.4 9242.4 5993.8 6359.6 6379.3 6393.5 6399.6 6708.1 6762.5 6780.0 6818.6 6833.5 3618.6 3649.4 3660.1 3668.6 3682.5 1224.1 1242.0 1271.5 1286.9 1306.5 505.4 506.9 512.1 521.4 536.0 13041.0 13141.6 13186.3 13192.6 13425.9 492.5 543.4 546.2 573.1 590.1 6878.8 7023.5 7024.7 7166.9 7206.0 648305.0 650700.0 652254.0 679497.0 692825.0 80851.2 82287.0 83934.6 84629.0 85155.6 587.0 588.5 588.7 594.0 598.7 11804.7 11996.8 12319.0 12326.3 12414.3 37549.8 37580.6 38462.4 38537.6 38864.4 47395.0 47944.0 48095.3 49140.8 49212.8 7473.1 7475.6 7661.8 7678.3 7696.2 13532.9 13664.5 13719.0 13821.0 13827.9 11826.5 11974.6 12082.2 12103.3 12247.5 11883.3 11998.6 12052.7 12143.0 12339.9 11786.9 12067.4 12117.2 12774.2 12797.5 7674.0 7709.0 7790.1 7790.8 7793.9 11916.8 12100.6 12158.3 12195.3 12227.4 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5767.98 Median:6502.51 stddev:2982.16 (45.9%) stddev-sans-first:2973.95 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: Values: 1584.6 1586.5 1822.9 1861.7 1873.8 7169.4 7449.4 7877.1 8221.4 8233.8 7779.9 7925.3 7981.3 8017.3 8041.5 2377.7 2404.0 2411.9 2412.1 2413.7 2195.7 2222.2 2398.1 2449.7 2479.4 2334.9 2372.3 2381.4 2383.4 2387.3 2392.7 2399.8 2400.4 2403.6 2404.4 2372.5 2422.0 2423.0 2423.1 2423.7 8152.1 8257.1 8281.0 8285.7 8286.1 5001.7 5068.1 5071.9 5077.6 5079.3 3133.1 3166.1 3249.4 3252.0 3266.7 1060.3 1069.6 1083.9 1105.8 2013.9 11309.1 11400.5 11402.5 11402.7 11411.1 4506.8 4520.4 4611.3 4616.6 4618.5 9229.3 9245.6 9251.9 9252.5 9253.4 5000.9 5001.1 5005.7 5007.2 5010.1 4574.8 4631.8 4723.9 4733.7 4739.5 3505.6 3746.1 3749.3 3782.9 3789.3 1100.2 1176.6 1197.4 1199.7 1207.6 1105.7 1129.0 1132.9 1438.8 1475.0 7660.7 7767.5 7920.4 7922.4 7926.9 768.0 772.7 782.3 788.0 891.0 6183.0 6245.6 6255.0 6307.0 6323.1 9456.5 9976.2 9983.7 9983.9 10001.5 10014.1 10021.0 10025.5 10032.1 10043.4 7456.3 7625.5 7629.8 7631.5 7632.0 7630.7 7650.0 7786.5 7797.1 7853.6 8775.3 8912.9 8932.2 8979.0 8981.6 8841.6 9063.7 9075.7 9078.0 9176.8 7457.6 7493.7 7556.0 7556.3 7558.9 6681.9 7085.5 7735.0 7900.6 7980.6 7187.9 7219.1 7375.8 7448.8 7539.7 7240.3 7277.1 7285.3 7383.2 7542.2 7284.7 7487.7 7613.9 7614.0 7624.5 6936.7 6965.9 6967.4 6973.5 6974.2 7052.4 7094.5 7099.7 7101.0 7106.1 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,273 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5329.08 Median:6048.32 stddev:1563.21 (25.8%) stddev-sans-first:1522.51 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: Values: 363.2 366.1 366.9 371.1 371.5 5825.4 5965.6 5992.4 6013.3 6042.1 5805.9 5876.9 5897.3 5902.4 5921.2 4650.4 4658.2 4661.0 4663.1 4664.2 4514.5 4575.2 4595.3 4672.2 4673.7 4592.9 4601.4 4609.8 4621.1 4630.0 4596.2 4600.1 4604.9 4606.4 4613.0 4098.9 4106.1 4107.2 4110.0 4110.7 5551.7 5647.4 5658.5 5697.3 5719.4 5379.2 5411.2 5416.9 5417.1 5418.3 6054.6 6333.8 6336.3 6339.1 6344.8 4460.9 4499.6 4548.5 4560.7 4562.1 6451.4 6470.7 6476.3 6483.0 6484.4 4659.7 4666.5 4667.8 4670.2 4672.9 4585.6 4657.9 4679.2 4719.8 4728.0 5304.8 5331.3 5332.7 5349.5 5357.0 6345.7 6347.5 6350.2 6354.8 6357.9 1660.7 1677.8 1684.3 1684.5 1685.6 1097.6 1121.2 1129.9 1131.5 1158.1 6077.4 6085.4 6092.6 6095.8 6098.4 6457.5 6462.0 6479.3 6481.1 6486.5 5957.8 6064.1 6073.1 6075.5 6081.5 3582.6 3608.7 3610.8 3611.9 3613.0 6633.1 6640.0 6644.8 6646.9 6652.2 6561.1 6601.7 6602.5 6607.6 6630.5 6571.0 6598.3 6625.8 6647.2 6648.7 6357.8 6385.9 6493.5 6508.7 6519.8 6465.5 6478.6 6485.1 6487.6 6501.4 6650.2 6663.0 6668.6 6671.5 6675.7 4490.8 4572.9 4573.5 4611.3 4621.2 6615.1 6617.2 6619.2 6621.5 6624.3 6466.1 6478.2 6479.5 6485.3 6485.4 6336.1 6452.1 6452.7 6454.0 6454.4 6340.7 6346.8 6348.1 6352.3 6353.1 6435.3 6444.6 6446.2 6448.9 6449.3 6195.8 6279.9 6289.7 6319.9 6342.2 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14803.61 Median:561.98 stddev:18844.56 (3353.2%) stddev-sans-first:18868.02 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: Values: 783.7 790.3 884.2 910.5 964.6 14034.2 14307.5 14359.5 14361.5 14379.6 13036.4 13062.9 13116.1 13126.9 13135.9 761.2 773.7 895.8 907.4 918.4 908.0 909.5 910.2 913.2 917.1 952.4 955.1 955.6 956.4 956.8 785.3 796.9 926.0 938.9 939.4 693.0 694.0 694.1 694.2 698.3 14003.9 14113.0 14147.0 14168.9 14188.1 12162.2 12676.0 12785.1 13069.2 13172.1 9715.0 9750.3 9828.4 9865.4 9994.1 3433.1 3457.8 3463.8 3465.2 3470.2 53043.7 53052.0 53962.5 55249.7 55448.4 9751.6 9842.2 9851.5 9894.2 9949.9 12850.6 12948.5 18333.3 18406.7 18413.3 6546.7 6606.4 6755.4 7016.3 7021.6 4117.7 4119.3 4141.9 4159.2 4195.5 3028.1 3034.3 3063.7 3065.2 3065.6 464.2 465.9 474.8 477.3 478.7 510.1 514.9 559.6 565.7 639.5 7835.2 7929.8 8037.8 8057.9 8208.6 453.5 564.4 575.7 605.6 621.8 3607.0 3691.1 3788.6 3816.2 4021.5 65593.7 65866.7 66037.3 67755.0 68340.3 59659.4 60702.1 61346.0 62135.4 62169.4 54828.5 55165.0 55351.0 55549.2 56606.2 7689.7 7846.0 7942.4 7973.0 8034.2 39316.2 39417.8 40039.2 40522.0 41351.2 48322.8 51839.0 51866.0 52014.0 52603.7 7680.7 7957.7 8113.9 8147.1 8270.6 10657.3 10746.9 10783.8 12103.8 12167.9 10792.9 10807.9 10873.1 10965.8 11365.5 10925.8 11160.1 11323.7 11434.8 12139.6 9521.6 9537.5 9957.9 10392.3 10566.3 8930.4 9132.4 9734.2 9828.2 10360.8 8330.5 8506.4 8508.7 8712.1 8796.0 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:39 INFO - 2016-01-25 04:27:39,274 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,786 INFO : Browser exited with error code: 0 04:27:39 INFO - 2016-01-25 04:27:39,802 INFO : Completed test dromaeo_css (00:18:28) 04:27:39 INFO - 2016-01-25 04:27:39,802 INFO : Starting test kraken 04:27:39 INFO - 2016-01-25 04:27:39,802 DEBUG : operating with platform_type : linux_ 04:27:39 INFO - 2016-01-25 04:27:39,802 INFO : Initialising browser for kraken test... 04:27:39 INFO - 2016-01-25 04:27:39,808 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0hcqy/profile http://localhost:36304/getInfo.html 04:27:43 INFO - 2016-01-25 04:27:43,156 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:43 INFO - 2016-01-25 04:27:43,156 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:43 INFO - 2016-01-25 04:27:43,156 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:43 INFO - 2016-01-25 04:27:43,156 DEBUG : BROWSER_OUTPUT: __metrics 04:27:43 INFO - 2016-01-25 04:27:43,319 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:44 INFO - 2016-01-25 04:27:44,410 INFO : Browser initialized. 04:27:44 INFO - 2016-01-25 04:27:44,410 INFO : Running cycle 1/1 for kraken test... 04:27:44 INFO - 2016-01-25 04:27:44,410 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF0hcqy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:55 INFO - 2016-01-25 04:27:55,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 128552960 04:27:55 INFO - 2016-01-25 04:27:55,937 DEBUG : BROWSER_OUTPUT: 04:27:58 INFO - 2016-01-25 04:27:58,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36304/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:58 INFO - 2016-01-25 04:27:58,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 163840000 04:27:58 INFO - 2016-01-25 04:27:58,931 DEBUG : BROWSER_OUTPUT: 04:28:01 INFO - 2016-01-25 04:28:01,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36304/tests/kraken/driver.html?testName=audio-dft) 04:28:02 INFO - 2016-01-25 04:28:02,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 160452608 04:28:02 INFO - 2016-01-25 04:28:02,037 DEBUG : BROWSER_OUTPUT: 04:28:04 INFO - 2016-01-25 04:28:04,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36304/tests/kraken/driver.html?testName=audio-fft) 04:28:05 INFO - 2016-01-25 04:28:05,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 157532160 04:28:05 INFO - 2016-01-25 04:28:05,373 DEBUG : BROWSER_OUTPUT: 04:28:07 INFO - 2016-01-25 04:28:07,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36304/tests/kraken/driver.html?testName=audio-oscillator) 04:28:07 INFO - 2016-01-25 04:28:07,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 159477760 04:28:07 INFO - 2016-01-25 04:28:07,890 DEBUG : BROWSER_OUTPUT: 04:28:10 INFO - 2016-01-25 04:28:10,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:10 INFO - 2016-01-25 04:28:10,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 155463680 04:28:10 INFO - 2016-01-25 04:28:10,583 DEBUG : BROWSER_OUTPUT: 04:28:13 INFO - 2016-01-25 04:28:13,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36304/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:14 INFO - 2016-01-25 04:28:14,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 155172864 04:28:14 INFO - 2016-01-25 04:28:14,002 DEBUG : BROWSER_OUTPUT: 04:28:17 INFO - 2016-01-25 04:28:17,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36304/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:17 INFO - 2016-01-25 04:28:17,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 155504640 04:28:17 INFO - 2016-01-25 04:28:17,916 DEBUG : BROWSER_OUTPUT: 04:28:20 INFO - 2016-01-25 04:28:20,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36304/tests/kraken/driver.html?testName=json-parse-financial) 04:28:21 INFO - 2016-01-25 04:28:21,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 04:28:21 INFO - 2016-01-25 04:28:21,179 DEBUG : BROWSER_OUTPUT: 04:28:22 INFO - 2016-01-25 04:28:22,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:23 INFO - 2016-01-25 04:28:23,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 159498240 04:28:23 INFO - 2016-01-25 04:28:23,231 DEBUG : BROWSER_OUTPUT: 04:28:24 INFO - 2016-01-25 04:28:24,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:25 INFO - 2016-01-25 04:28:25,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 156270592 04:28:25 INFO - 2016-01-25 04:28:25,540 DEBUG : BROWSER_OUTPUT: 04:28:27 INFO - 2016-01-25 04:28:27,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:28 INFO - 2016-01-25 04:28:28,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 162381824 04:28:28 INFO - 2016-01-25 04:28:28,077 DEBUG : BROWSER_OUTPUT: 04:28:30 INFO - 2016-01-25 04:28:30,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:30 INFO - 2016-01-25 04:28:30,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 165974016 04:28:30 INFO - 2016-01-25 04:28:30,948 DEBUG : BROWSER_OUTPUT: 04:28:33 INFO - 2016-01-25 04:28:33,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:33 INFO - 2016-01-25 04:28:33,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 163418112 04:28:33 INFO - 2016-01-25 04:28:33,935 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36304/tests/kraken/driver.html?testName=ai-astar) 04:28:35 INFO - 2016-01-25 04:28:35,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 221306880 04:28:35 INFO - 2016-01-25 04:28:35,799 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,800 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:35 INFO - 2016-01-25 04:28:35,800 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:35 INFO - 2016-01-25 04:28:35,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:35 INFO - 2016-01-25 04:28:35,801 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:35 INFO - 2016-01-25 04:28:35,801 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;110;109;109;99;108;106;110 04:28:35 INFO - 2016-01-25 04:28:35,801 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;122;151;158;131;144;150;122;158;130 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;160;165;160;159;158;161;161;159 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;70;137;73;70;72;71;153;71 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;88;134;90;89;89;139;89;89;135 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;109;109;109;109;110 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;146;145;146;145;146;145 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;54;56;55;57;55;55;52;54 04:28:35 INFO - 2016-01-25 04:28:35,802 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;62;63;65;63;62;63;62;63 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;78;77;78;77;80;80;77;78 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;113;110;117;114;108;115;122;114 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;140;140;136;128;135;147;134;147;129 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;63;65;64;61;61;62;62;63;60 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:35 INFO - 2016-01-25 04:28:35,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,868 04:28:35 INFO - 2016-01-25 04:28:35,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:35 INFO - 2016-01-25 04:28:35,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724915798__endTimestamp 04:28:35 INFO - 2016-01-25 04:28:35,804 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,807 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:35 INFO - 2016-01-25 04:28:35,808 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:28:35 INFO - 2016-01-25 04:28:35,808 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,808 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.33 (3.1%) stddev-sans-first:3.53 04:28:35 INFO - 2016-01-25 04:28:35,808 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 110.0 109.0 109.0 99.0 108.0 106.0 110.0 04:28:35 INFO - 2016-01-25 04:28:35,808 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.50 stddev:14.33 (9.5%) stddev-sans-first:14.62 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: Values: 153.0 122.0 151.0 158.0 131.0 144.0 150.0 122.0 158.0 130.0 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:2.06 (1.3%) stddev-sans-first:2.01 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 160.0 165.0 160.0 159.0 158.0 161.0 161.0 159.0 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.90 Median:71.00 stddev:31.39 (44.2%) stddev-sans-first:32.83 04:28:35 INFO - 2016-01-25 04:28:35,809 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 137.0 73.0 70.0 72.0 71.0 153.0 71.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:89.00 stddev:22.68 (25.5%) stddev-sans-first:23.54 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: Values: 90.0 88.0 134.0 90.0 89.0 89.0 139.0 89.0 89.0 135.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.37 (2.5%) stddev-sans-first:1.45 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 54.0 56.0 55.0 57.0 55.0 55.0 52.0 54.0 04:28:35 INFO - 2016-01-25 04:28:35,810 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.00 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 62.0 63.0 65.0 63.0 62.0 63.0 62.0 63.0 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.20 (1.5%) stddev-sans-first:1.22 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 78.0 77.0 78.0 77.0 80.0 80.0 77.0 78.0 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.50 stddev:3.77 (3.3%) stddev-sans-first:3.99 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 113.0 110.0 117.0 114.0 108.0 115.0 122.0 114.0 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:138.00 stddev:6.48 (4.7%) stddev-sans-first:6.86 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: Values: 136.0 140.0 140.0 136.0 128.0 135.0 147.0 134.0 147.0 129.0 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.58 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 65.0 64.0 61.0 61.0 62.0 62.0 63.0 60.0 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:35 INFO - 2016-01-25 04:28:35,811 DEBUG : BROWSER_OUTPUT: 04:28:36 INFO - 2016-01-25 04:28:36,498 INFO : Browser exited with error code: 0 04:28:36 INFO - 2016-01-25 04:28:36,556 INFO : Completed test kraken (00:00:56) 04:28:36 INFO - 2016-01-25 04:28:36,556 INFO : Starting test v8_7 04:28:36 INFO - 2016-01-25 04:28:36,556 DEBUG : operating with platform_type : linux_ 04:28:36 INFO - 2016-01-25 04:28:36,556 INFO : Initialising browser for v8_7 test... 04:28:36 INFO - 2016-01-25 04:28:36,563 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpplcQgh/profile http://localhost:36304/getInfo.html 04:28:39 INFO - 2016-01-25 04:28:39,953 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:39 INFO - 2016-01-25 04:28:39,953 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:39 INFO - 2016-01-25 04:28:39,953 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:39 INFO - 2016-01-25 04:28:39,953 DEBUG : BROWSER_OUTPUT: __metrics 04:28:40 INFO - 2016-01-25 04:28:40,102 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:41 INFO - 2016-01-25 04:28:41,149 INFO : Browser initialized. 04:28:41 INFO - 2016-01-25 04:28:41,150 INFO : Running cycle 1/1 for v8_7 test... 04:28:41 INFO - 2016-01-25 04:28:41,151 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpplcQgh/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:52 INFO - 2016-01-25 04:28:52,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 129007616 04:28:52 INFO - 2016-01-25 04:28:52,779 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36304/tests/v8_7/run.html (next: http://localhost:36304/tests/v8_7/run.html) 04:29:14 INFO - 2016-01-25 04:29:14,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 427851776 04:29:14 INFO - 2016-01-25 04:29:14,479 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,480 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: |0;Richards;162.20600162206003 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.09695526450076 04:29:14 INFO - 2016-01-25 04:29:14,481 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.19052956010086 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |4;RayTrace;940.7337723424271 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |5;Earley;558.659217877095 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |6;Boyer;10416.666666666666 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |7;RegExp;23441.86046511628 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |8;Splay;542.8881650380022 04:29:14 INFO - 2016-01-25 04:29:14,482 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 04:29:14 INFO - 2016-01-25 04:29:14,483 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:14 INFO - 2016-01-25 04:29:14,483 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724954479__endTimestamp 04:29:14 INFO - 2016-01-25 04:29:14,483 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,483 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:14 INFO - 2016-01-25 04:29:14,484 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:29:14 INFO - 2016-01-25 04:29:14,484 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,484 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.21 Median:162.21 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,484 DEBUG : BROWSER_OUTPUT: Values: 162.2 04:29:14 INFO - 2016-01-25 04:29:14,484 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.10 Median:170.10 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: Values: 170.1 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: Values: 280.2 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,485 DEBUG : BROWSER_OUTPUT: Values: 5000.0 04:29:14 INFO - 2016-01-25 04:29:14,486 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:940.73 Median:940.73 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: Values: 940.7 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:558.66 Median:558.66 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: Values: 558.7 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10416.67 Median:10416.67 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: Values: 10416.7 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23441.86 Median:23441.86 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: Values: 23441.9 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:542.89 Median:542.89 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,487 DEBUG : BROWSER_OUTPUT: Values: 542.9 04:29:14 INFO - 2016-01-25 04:29:14,488 DEBUG : BROWSER_OUTPUT: 04:29:14 INFO - 2016-01-25 04:29:14,488 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 04:29:14 INFO - 2016-01-25 04:29:14,488 DEBUG : BROWSER_OUTPUT: Values: 4864.1 04:29:14 INFO - 2016-01-25 04:29:14,488 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:14 INFO - 2016-01-25 04:29:14,488 DEBUG : BROWSER_OUTPUT: 04:29:15 INFO - 2016-01-25 04:29:15,186 INFO : Browser exited with error code: 0 04:29:15 INFO - 2016-01-25 04:29:15,197 INFO : Completed test v8_7 (00:00:38) 04:29:15 INFO - 2016-01-25 04:29:15,440 INFO : Completed test suite (00:20:04) 04:29:15 INFO - 2016-01-25 04:29:15,440 DEBUG : Working with test: dromaeo_css 04:29:15 INFO - 2016-01-25 04:29:15,440 DEBUG : Generating results file: dromaeo_css 04:29:15 INFO - 2016-01-25 04:29:15,442 DEBUG : Working with test: kraken 04:29:15 INFO - 2016-01-25 04:29:15,442 DEBUG : Generating results file: kraken 04:29:15 INFO - 2016-01-25 04:29:15,443 INFO : javascript benchmark 04:29:15 INFO - 2016-01-25 04:29:15,443 DEBUG : Working with test: v8_7 04:29:15 INFO - 2016-01-25 04:29:15,443 DEBUG : Generating results file: v8_7 04:29:15 INFO - 2016-01-25 04:29:15,444 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:15 INFO - 2016-01-25 04:29:15,495 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:29:15 INFO - 2016-01-25 04:29:15,495 DEBUG : process_Request line: dromaeo_css 7094.57 graph.html#tests=[[72,53,35]] 04:29:15 INFO - 2016-01-25 04:29:15,495 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:15 INFO - 2016-01-25 04:29:15,525 DEBUG : process_Request line: kraken 1459.20 graph.html#tests=[[232,53,35]] 04:29:15 INFO - 2016-01-25 04:29:15,525 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:15 INFO - 2016-01-25 04:29:15,554 DEBUG : process_Request line: v8_7 23313.74 graph.html#tests=[[230,53,35]] 04:29:15 INFO - 2016-01-25 04:29:15,556 INFO : javascript benchmark 04:29:15 INFO - 2016-01-25 04:29:15,559 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3308.5533452983846, 3364.7644664873437, 3385.9830700846505, 3394.2871996880654, 3407.863685452582, 5592.832215033551, 5600.495955364022, 5606.159076138581, 5617.4382561743905, 5625.915611265829, 5600.103983362663, 5634.098544232924, 5645.661260324373, 5647.774089036434, 5648.491635752782, 4926.11329960607, 5115.488451154883, 5147.202183661539, 5202.583793296546, 5254.4220135785035, 5011.223260394645, 5046.949530504685, 5122.3084883540805, 5147.510986456281, 5208.661437006583, 5160.0, 5170.741462926858, 5172.19830926207, 5179.326687530615, 5210.973945130269, 4950.6782059166035, 5144.691318520863, 5152.407473140562, 5171.689698618076, 5212.8957420851375, 5055.772490237948, 5119.974400128012, 5150.407703114152, 5167.302414174076, 5178.870528236786, 5521.1442226454965, 5536.640118392332, 5546.389897111315, 5561.972190139064, 5563.388027316992, 5823.941760582382, 5937.881242375129, 6156.7537298508005, 6159.137720719058, 6174.228221472316, 6083.543734219951, 6151.446369826737, 6178.814635560941, 6183.2889217740085, 6189.535784816157, 5784.2769653793275, 5806.419358064244, 5809.215755872945, 5832.912506312408, 5839.416058394169, 5923.318818335861, 6033.134420546168, 6128.647737417829, 6274.341194174637, 6285.151504546919, 5952.494038006731, 6028.487578555784, 6041.72812223451, 6052.788152414644, 6060.575759696779, 6097.695115244309, 6103.6948152592195, 6105.633661980295, 6111.174991376108, 6112.786052488142, 5845.210896528914, 5959.910601340984, 5999.160117583542, 6065.181200537871, 6102.578645452416, 6167.784127555604, 6173.660448675366, 6175.042868355412, 6182.258129024456, 6184.288806787187, 4695.295705644113, 4703.764811759398, 4711.8350857719815, 4721.268203428474, 4729.4797572267025, 4050.918981620351, 4117.2588933992165, 4132.979335103365, 4169.374593810952, 4207.0, 5773.076307790818, 5800.622959507618, 5801.274840644919, 5801.9129713054335, 5814.273215848019, 5982.102684597346, 6152.538559608047, 6160.969195153995, 6163.260408750979, 6163.630182189083, 5605.831825045255, 5663.122216056518, 5674.546036317167, 5694.06048002075, 5711.057675483582, 5262.97368513155, 5271.578273738091, 5290.206469029677, 5290.92063619046, 5292.761825717852, 6025.969870150709, 6123.479504242189, 6269.122322874801, 6277.466415354746, 6283.622982621057, 5978.372270911578, 6056.636601803906, 6068.059450785136, 6071.848203794763, 6085.726142323518, 6231.470325022424, 6266.968665156645, 6290.339514350927, 6293.937060629335, 6304.810855674337, 5778.451047150514, 5884.117382392676, 5976.581639285208, 6056.36408177135, 6073.119397687399, 5973.820785376446, 6107.389261073857, 6118.051701986199, 6133.466633341664, 6141.6007959482495, 5886.735096920735, 5892.616979896293, 5901.468867801918, 5901.704914754159, 5907.32065812437, 5703.116017017369, 5826.126081087871, 5905.498032667271, 5972.193753843349, 6111.786087486917, 5885.411458854252, 5896.587238893237, 5906.26171728534, 5907.70461476933, 5907.911381329198, 5940.1683764272175, 6015.187949626919, 6015.608985415934, 6026.337102918763, 6034.698265086816, 5667.20659107717, 5775.537956963349, 5799.072148456226, 5884.411558844253, 5901.763929442946], "unit": "ms", "name": "dojo.html", "value": 5598.016046039455}, {"lowerIsBetter": false, "replicates": [573.1860757724031, 611.3855575146978, 620.1194304088193, 642.5662677692557, 653.7907869481768, 35828.82085589572, 44425.33361999568, 44838.327425088566, 44961.325580116325, 44964.0, 48692.51307486924, 49226.50773492264, 49256.0, 49283.50716492834, 49580.0, 8415.074341822394, 8503.787405314886, 9273.907260927372, 9427.198688111519, 11002.394868282241, 10841.024307812295, 10958.342499450058, 10963.122950164008, 10965.0, 10974.0, 11293.322400655947, 11431.485583148737, 11450.484728187252, 11452.484638191301, 11456.083513318956, 11289.774204515905, 11392.0, 11396.202265841435, 11419.657410277705, 11425.485853136546, 10680.572777088908, 10745.140388768958, 10752.139828813677, 10753.83869241962, 10757.354558726502, 45908.54091459076, 46205.30692039622, 46295.30557041647, 46395.30407043897, 46422.071558568976, 3625.4380571011534, 3630.7458477906557, 3664.0839790052487, 4085.8774236772942, 4249.596288352602, 32588.348233035205, 32839.34321313584, 33060.834695826605, 33162.3367532648, 33315.6668433315, 3540.150363912668, 3598.8560457581666, 3622.3479773640734, 3675.9448608270895, 3683.778973261586, 310474.0, 310832.0, 313214.0, 313975.43012285023, 319221.0, 67139.66430167817, 69009.0, 71301.6434917822, 77810.2218977803, 79569.0, 70794.29205707877, 70819.29180708127, 71001.64499177471, 71078.0, 71205.0, 16781.412650557173, 16854.578635533966, 16890.915545422195, 16946.491605251864, 16950.23723932426, 14342.569722908329, 14534.05528640635, 14545.0, 14555.78166327506, 14640.560783176521, 23091.884540577525, 23398.415039623804, 23411.180608678955, 23425.531489370118, 23589.528209435714, 8418.368622353348, 8511.276541493919, 8572.957135214408, 8646.74059778195, 8651.6971905983, 1073.511552243743, 1081.0486771640906, 1096.627146770102, 1128.7629597784394, 1129.768397478515, 31878.681213188036, 31900.361992760016, 32043.198920027186, 32383.19042023921, 32482.187945301084, 1188.411736190574, 1197.8203269509643, 1232.9876701233052, 1301.6680746409795, 1313.2448841915937, 14602.34289456977, 16552.586185345222, 16646.250918708443, 16747.832521674627, 16848.915755421145, 282046.0, 287060.0, 287373.0, 287604.0, 289466.0, 51973.480265196864, 52882.99999999923, 57271.0, 57506.7124664374, 57697.711511442176, 1450.9201993890438, 1480.4078368652624, 1483.0, 1500.6248437890526, 1505.224809223251, 30030.238094059703, 30058.24854378658, 31961.36077278488, 32350.029499115066, 32486.512702309956, 51575.74212128916, 52154.21768673549, 52182.0, 52192.21711674404, 52198.0, 283231.0, 285390.0, 285592.0, 285751.0, 286946.0, 35763.82118089497, 36413.0, 36447.453288200166, 36679.449808253434, 36869.44695829618, 48627.0, 49128.0, 49570.752146239036, 49762.0, 50502.494975051246, 41277.587224127376, 43443.56556434522, 45027.549724502336, 45970.0, 46142.30786538137, 41337.79331103325, 41624.375634366115, 42096.57903421049, 42238.366424503045, 42527.0, 40809.79595102005, 41269.793651031556, 41351.0, 41802.0, 41865.58134418738, 35986.820065899505, 36338.8183059083, 37325.4401183977, 37431.81284093562, 37734.43398349082, 27479.725202748516, 28126.0, 28131.156065318075, 28165.718342816308, 28207.43585128327], "unit": "ms", "name": "ext.html", "value": 20946.361957871777}, {"lowerIsBetter": false, "replicates": [386.125361370546, 389.1167050794696, 389.37894058975934, 390.1300100775271, 394.0228233979732, 15123.773143402857, 17273.568160795985, 17777.822221777777, 18437.53906152345, 18439.446816595508, 13101.934490327534, 13315.733685326288, 13329.266890321029, 19045.714314285262, 19385.12766925488, 4818.927716084253, 4937.753112344386, 4950.207966725325, 4954.232094025414, 4958.132326842806, 3876.592957739439, 3951.6443520083185, 3953.2093581283716, 3957.4855268815013, 4857.73282469464, 5205.141151709963, 5275.155975043994, 5318.175682769177, 5318.202269659562, 5318.627696061278, 5149.588032957373, 5268.288781014571, 5311.097113490716, 5320.600954928396, 5326.493983071602, 4579.381783459224, 4584.358189853423, 4585.908281834378, 4608.124456353282, 4624.3757092792375, 14849.331780069922, 15103.39586416542, 15257.923710381488, 15293.770593441108, 15302.770458443132, 2002.2891873384883, 2070.33749200256, 2071.792820717916, 2094.183268525276, 2113.2709215320688, 10489.527971241312, 10564.735881602945, 10660.946695266552, 10704.357738535713, 10710.036096751252, 1727.9222434990456, 1774.7337899315078, 1791.587934774996, 1855.3413538194018, 1861.2182883189093, 60009.69995149996, 61334.38665613376, 61506.07740883935, 61706.69146654238, 62319.68840155815, 7610.695572177051, 7676.385889128856, 7684.269994350528, 7711.652975615999, 7725.729599463992, 9222.0, 9227.169554740105, 9232.630694772268, 9241.445513269226, 9242.445453272825, 5993.790217342459, 6359.632678974042, 6379.266384365857, 6393.488520918316, 6399.64801935898, 6708.127943367331, 6762.526623136431, 6779.983002549657, 6818.590884546943, 6833.453323734089, 3618.6019537850816, 3649.3978493548266, 3660.103274697716, 3668.559772827278, 3682.502862113634, 1224.1002862895764, 1241.9875801242054, 1271.491403438632, 1286.8841804237663, 1306.510058727977, 505.4288653821232, 506.8808829924965, 512.1165988669516, 521.4108057894555, 536.0271107939155, 13041.021923355596, 13141.605751827461, 13186.340682965812, 13192.604221873358, 13425.93287033578, 492.4902725678905, 543.3886877263079, 546.1616418797128, 573.1088157914483, 590.0735844723828, 6878.759243426456, 7023.4781133695105, 7024.683889224997, 7166.928330716626, 7205.963970180115, 648305.0, 650700.0, 652254.0, 679497.0, 692825.0, 80851.19148808437, 82287.0, 83934.58032709919, 84629.0, 85155.57422212849, 587.0284678856499, 588.5438784941705, 588.6556364526714, 594.0495207667783, 598.7245866901275, 11804.70488237801, 11996.76006479883, 12319.0, 12326.260424374566, 12414.255144691348, 37549.81225093857, 37580.624193757714, 38462.42306365351, 38537.614623853406, 38864.41703374395, 47395.0, 47944.0, 48095.27857082077, 49140.75429622972, 49212.75393623152, 7473.103227612722, 7475.551466912003, 7661.808454788675, 7678.270564296383, 7696.230376962259, 13532.86467135316, 13664.453421863014, 13719.0, 13821.0, 13827.930860345634, 11826.467808948446, 11974.580889669169, 12082.214656047328, 12103.273803571814, 12247.510099596273, 11883.346415947206, 11998.58004969822, 12052.698682533006, 12143.0, 12339.876601233873, 11786.941065294619, 12067.396630168632, 12117.212381195546, 12774.169678970837, 12797.488100475877, 7673.961630191813, 7709.036370453693, 7790.065192176975, 7790.805229869072, 7793.883091753742, 11916.76166476683, 12100.576479823163, 12158.331291778682, 12195.268283902995, 12227.449764760786], "unit": "ms", "name": "jquery.html", "value": 7591.468841004252}, {"lowerIsBetter": false, "replicates": [1584.5721655153116, 1586.4923224568136, 1822.854171666267, 1861.6649003179427, 1873.7938826729057, 7169.354758071772, 7449.366803821682, 7877.133515313318, 8221.424500284982, 8233.794155146124, 7779.922200777991, 7925.2867241948215, 7981.321587665041, 8017.318527925133, 8041.517508949467, 2377.738448770634, 2403.9639405408934, 2411.9397015074674, 2412.1195763546357, 2413.698287714036, 2195.6706494025866, 2222.211115054157, 2398.1126983016306, 2449.730529641738, 2479.404942813721, 2334.871582062986, 2372.3001714494267, 2381.392744850061, 2383.368407372048, 2387.259949415678, 2392.688950436441, 2399.844010139353, 2400.411899084718, 2403.6154215325464, 2404.4469771952463, 2372.4899146683547, 2422.0432928993127, 2423.042898055276, 2423.1397853762014, 2423.7455067218043, 8152.103268640445, 8257.05043919951, 8281.0, 8285.668573257062, 8286.129956354556, 5001.724905130216, 5068.062408454448, 5071.898562028776, 5077.64456488046, 5079.263506791532, 3133.075742655922, 3166.066010526877, 3249.4151052810485, 3251.951220731691, 3266.70599646033, 1060.3054998975683, 1069.6042464288184, 1083.9458027098692, 1105.8341248812742, 2013.9395818125479, 11309.09527237819, 11400.543978240861, 11402.486888090056, 11402.657920262322, 11411.144164187719, 4506.797194126272, 4520.412346395014, 4611.262198048364, 4616.60758835496, 4618.51505591908, 9229.261659067259, 9245.630174793068, 9251.907480925105, 9252.53737313145, 9253.398529095588, 5000.949990500121, 5001.124803159432, 5005.674631148963, 5007.223880298487, 5010.073136469692, 4574.839880604163, 4631.791569379386, 4723.929141062887, 4733.668643195012, 4739.549742774431, 3505.5618047744033, 3746.1383881706815, 3749.343864823645, 3782.924341513154, 3789.317922773927, 1100.1583788401879, 1176.5940750441084, 1197.4431889171576, 1199.688081098903, 1207.559240877091, 1105.662772854271, 1128.9887101129048, 1132.8980391764617, 1438.755411580034, 1474.9852501475063, 7660.73187438437, 7767.495112817649, 7920.4059695523065, 7922.445428819928, 7926.8810967835525, 767.9731209407644, 772.729544659376, 782.3037496628006, 788.046463778834, 890.9821803564022, 6183.0, 6245.594036387711, 6255.030470277115, 6306.968465157736, 6323.114763933053, 9456.47989360578, 9976.201903847676, 9983.650572229937, 9983.900160998297, 10001.549930253155, 10014.098731114234, 10021.048000439947, 10025.498725063717, 10032.097111259876, 10043.397396156253, 7456.254374562609, 7625.466217364731, 7629.809254768676, 7631.46579739424, 7632.0, 7630.7329243476215, 7649.961750191436, 7786.532808031537, 7797.142314345531, 7853.56805375687, 8775.254103401283, 8912.910870891208, 8932.19610235082, 8979.0, 8981.55092245372, 8841.60212790413, 9063.68277110298, 9075.727728168165, 9078.046805085634, 9176.770580735269, 7457.627118643937, 7493.700251990077, 7556.0, 7556.282153195438, 7558.924410756042, 6681.899771503528, 7085.468589855678, 7735.0, 7900.604969751605, 7980.6408711606955, 7187.892181617175, 7219.061522002106, 7375.8156046099275, 7448.813779655552, 7539.736109236151, 7240.348368646847, 7277.090363704537, 7285.2714728528845, 7383.187849336676, 7542.170361260147, 7284.67218975158, 7487.700491980478, 7613.923860761543, 7613.961930190314, 7624.466287359832, 6936.687849046906, 6965.895511567229, 6967.407770339375, 6973.546719463218, 6974.19796723363, 7052.365287124184, 7094.467914906506, 7099.680514376969, 7100.964495177698, 7106.147262328554], "unit": "ms", "name": "mootools.html", "value": 4721.306074509807}, {"lowerIsBetter": false, "replicates": [363.15747465879156, 366.0975694912041, 366.9267392875839, 371.1000823004216, 371.4929121748814, 5825.417458254173, 5965.612235204709, 5992.430719081691, 6013.27840659121, 6042.063480160577, 5805.941940580593, 5876.853078673035, 5897.3218079920825, 5902.380250073745, 5921.20063791388, 4650.441946966369, 4658.231391820345, 4661.0, 4663.137319595869, 4664.207084795593, 4514.480834704002, 4575.199340115483, 4595.333676616889, 4672.182368085571, 4673.719576825384, 4592.885177870563, 4601.3558101865765, 4609.769511524427, 4621.09888571727, 4629.976850115745, 4596.172688915994, 4600.148972440093, 4604.930926036112, 4606.378138951266, 4612.976935115336, 4098.918021639551, 4106.096658735073, 4107.219628270619, 4109.97945010276, 4110.650594699454, 5551.72241387933, 5647.37878833328, 5658.519025882805, 5697.259356283656, 5719.399463056402, 5379.1662292344745, 5411.215373770781, 5416.891662166774, 5417.052015897241, 5418.322709661293, 6054.576179667425, 6333.809985700436, 6336.3346848580695, 6339.144215530937, 6344.841378965517, 4460.8884777880485, 4499.61753250974, 4548.522405147478, 4560.7035542689955, 4562.087582483517, 6451.41937225652, 6470.74117035318, 6476.287608363076, 6482.967585162091, 6484.448821850148, 4659.6505262105475, 4666.4633567139535, 4667.813287468532, 4670.182718024332, 4672.929906051412, 4585.6102231310715, 4657.906841863211, 4679.2045352289515, 4719.811207551728, 4728.007118505084, 5304.787808487695, 5331.253624492574, 5332.706701131475, 5349.491798279158, 5357.035733567917, 6345.746170153235, 6347.492200623939, 6350.174477317919, 6354.841128971812, 6357.872842543124, 1660.6512632347342, 1677.8322167783367, 1684.2757614225754, 1684.5030715938829, 1685.6207353345399, 1097.5884043483693, 1121.1815374776295, 1129.8813624569466, 1131.4964840645835, 1158.137187795098, 6077.392260773887, 6085.421884920926, 6092.573519853657, 6095.786647467317, 6098.35967223444, 6457.5479716419395, 6462.0, 6479.319671434431, 6481.0602462642655, 6486.481081513468, 5957.821265362046, 6064.120702498113, 6073.089036644538, 6075.544334174954, 6081.513478921675, 3582.5521809773777, 3608.729345299113, 3610.765300255475, 3611.8735844245325, 3613.0, 6633.137692100093, 6640.037194606755, 6644.800655980232, 6646.86706265872, 6652.168478940132, 6561.1142495763415, 6601.6699165041555, 6602.504812139109, 6607.6365799880505, 6630.469562434993, 6570.967145164243, 6598.340165983459, 6625.834354141185, 6647.169103862017, 6648.66756662165, 6357.777477788255, 6385.904211436925, 6493.545451818327, 6508.674566271762, 6519.837004074936, 6465.450436712744, 6478.578892371981, 6485.092087107714, 6487.578307410004, 6501.382368674968, 6650.168728908887, 6662.966685166543, 6668.633225172468, 6671.499637527108, 6675.6995935184, 4490.753008584559, 4572.908541829212, 4573.542645735533, 4611.262198048296, 4621.168189725881, 6615.106960560262, 6617.172853393326, 6619.205695316593, 6621.5364924454825, 6624.33756624353, 6466.062420948842, 6478.1578394808375, 6479.546431749733, 6485.319041500763, 6485.383888530582, 6336.144620476177, 6452.096706461005, 6452.677366131581, 6453.967730161507, 6454.386833250834, 6340.682965851781, 6346.809595712136, 6348.111264422892, 6352.301246862749, 6353.078803573549, 6435.2599451063725, 6444.645544495098, 6446.194225721785, 6448.9032664511005, 6449.290578036506, 6195.752169913153, 6279.937200627935, 6289.748410063729, 6319.936800631935, 6342.23893132827], "unit": "ms", "name": "prototype.html", "value": 4833.695149759563}, {"lowerIsBetter": false, "replicates": [783.6551917156451, 790.261105866015, 884.1512148337596, 910.4810258152852, 964.6237967192792, 14034.22811745355, 14307.499237526688, 14359.497417590386, 14361.497347592836, 14379.640508987268, 13036.413361398736, 13062.934685326583, 13116.081874268804, 13126.868731312685, 13135.93432032841, 761.1703243464623, 773.6943907156669, 895.8387490251785, 907.3739120007207, 918.4443411735904, 908.0420156734642, 909.5270459361161, 910.2308549275851, 913.164454524113, 917.1378903830412, 952.3714348529971, 955.1451450951395, 955.574769227694, 956.3544607390019, 956.7895063086145, 785.2814674572759, 796.8725003999361, 925.9907400926005, 938.8826396700413, 939.4457270210609, 692.9653517324164, 694.0144994108379, 694.0872752330669, 694.2294053600499, 698.3470455124475, 14003.929980350033, 14113.0, 14147.0, 14168.858311416858, 14188.148711077369, 12162.209456385306, 12676.007092729933, 12785.10504264702, 13069.15050521713, 13172.143810652276, 9714.9514252429, 9750.26872984529, 9828.410295382228, 9865.408075515421, 9994.100530952177, 3433.055909624848, 3457.757956943015, 3463.8268086595567, 3465.203003309228, 3470.1671598816356, 53043.73478132623, 53052.0, 53962.460375396135, 55249.72375138139, 55448.44551554473, 9751.561179746928, 9842.163416109568, 9851.458169800586, 9894.20846332306, 9949.850752238723, 12850.550230742067, 12948.546800861925, 18333.349998500198, 18406.723899141525, 18413.26346946107, 6546.672666366662, 6606.372394622503, 6755.425788807908, 7016.319224575116, 7021.5787052777, 4117.711760176819, 4119.320312148462, 4141.91716165675, 4159.230542349675, 4195.475565554306, 3028.0764366868316, 3034.347615262729, 3063.6629970703207, 3065.2336915771057, 3065.57082008519, 464.17145395468924, 465.8579133364356, 474.8385548913386, 477.34365247784297, 478.7319101303212, 510.084398504685, 514.920187370958, 559.5551536528469, 565.7114871415525, 639.4500729372736, 7835.23260223123, 7929.841403172019, 8037.799055023671, 8057.879131813028, 8208.58957052145, 453.5215347808094, 564.4130104691158, 575.6607465755071, 605.6184603699729, 621.8227805075531, 3606.9849866592244, 3691.148775894507, 3788.6021967693546, 3816.1795214029116, 4021.4571032910185, 65593.67203163954, 65866.67066664732, 66037.33962660408, 67755.0, 68340.3165968344, 59659.40340596625, 60702.08946865801, 61346.0, 62135.37864621296, 62169.378306217266, 54828.451715483134, 55165.0, 55351.0, 55549.16676249859, 56606.15090773642, 7689.6539655714505, 7846.0, 7942.404319676163, 7972.960135199287, 8034.196580341919, 39316.213675725754, 39417.80291098641, 40039.1992160161, 40522.0, 41351.1729765409, 48322.758386207846, 51839.0, 51866.0, 52014.0, 52603.73698131485, 7680.731174408869, 7957.721479748181, 8113.878291825509, 8147.14454982242, 8270.586470676322, 10657.307275027099, 10746.892531074902, 10783.784324313627, 12103.81844272319, 12167.939160304142, 10792.946035270088, 10807.891921080689, 10873.130149588173, 10965.835512467478, 11365.48855301497, 10925.781484370427, 11160.107191424504, 11323.716907077389, 11434.771304574027, 12139.635810925687, 9521.57152928106, 9537.52312384364, 9957.900420995988, 10392.272540922062, 10566.260361774603, 8930.419522731001, 9132.406393584395, 9734.172595329477, 9828.16460600857, 10360.844587331347, 8330.50016998982, 8506.362022848187, 8508.702195423131, 8712.12878712149, 8796.032436432115], "unit": "ms", "name": "yui.html", "value": 6276.359787729108}], "name": "dromaeo_css", "value": 7094.571586589218}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 110.0, 109.0, 109.0, 99.0, 108.0, 106.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 151.0, 158.0, 131.0, 144.0, 150.0, 122.0, 158.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 160.0, 165.0, 160.0, 159.0, 158.0, 161.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 137.0, 73.0, 70.0, 72.0, 71.0, 153.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 134.0, 90.0, 89.0, 89.0, 139.0, 89.0, 89.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 54.0, 56.0, 55.0, 57.0, 55.0, 55.0, 52.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 62.0, 63.0, 65.0, 63.0, 62.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.2}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 77.0, 78.0, 77.0, 80.0, 80.0, 77.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.9}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 113.0, 110.0, 117.0, 114.0, 108.0, 115.0, 122.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [136.0, 140.0, 140.0, 136.0, 128.0, 135.0, 147.0, 134.0, 147.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 64.0, 61.0, 61.0, 62.0, 62.0, 63.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.5}], "name": "kraken", "value": 1459.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.20600162206003], "unit": "score", "name": "Richards", "value": 217.63682999999997}, {"lowerIsBetter": false, "replicates": [170.09695526450076], "unit": "score", "name": "DeltaBlue", "value": 388.70772199999993}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [940.7337723424271], "unit": "score", "name": "RayTrace", "value": 786.6083070000002}, {"lowerIsBetter": false, "replicates": [558.659217877095], "unit": "score", "name": "Earley", "value": 1192.9687700000002}, {"lowerIsBetter": false, "replicates": [10416.666666666666], "unit": "score", "name": "Boyer", "value": 63.980448000000024}, {"lowerIsBetter": false, "replicates": [23441.86046511628], "unit": "score", "name": "RegExp", "value": 38.86146329365078}, {"lowerIsBetter": false, "replicates": [542.8881650380022], "unit": "score", "name": "Splay", "value": 150.106422}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 23313.74459112471}]} 04:29:15 INFO - RETURN: dromaeo_css: 7094.57 04:29:15 INFO - RETURN: kraken: 1459.20 04:29:15 INFO - RETURN: v8_7: 23313.74 04:29:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23313.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1459.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7094.57"}}} 04:29:15 INFO - Return code: 0 04:29:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:15 INFO - # TBPL SUCCESS # 04:29:15 INFO - Running post-action listener: _resource_record_post_action 04:29:15 INFO - Running post-run listener: _resource_record_post_run 04:29:16 INFO - Total resource usage - Wall time: 1220s; CPU: 13.0%; Read bytes: 315392; Write bytes: 504250368; Read time: 96; Write time: 401704 04:29:16 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241418240; Read time: 0; Write time: 256828 04:29:16 INFO - run-tests - Wall time: 1206s; CPU: 13.0%; Read bytes: 315392; Write bytes: 259375104; Read time: 96; Write time: 144648 04:29:16 INFO - Running post-run listener: _upload_blobber_files 04:29:16 INFO - Blob upload gear active. 04:29:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:29:16 INFO - Copying logs to upload dir... 04:29:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1250.888436 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-01-25 04:29:16.681068) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:16.685692) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 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.010128 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:16.744470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:16.744852) ========= 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=82e07478c745e68b1fe4678a000001bc-1453723703.592473-801544556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:16.800397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:16.800769) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:16.801339) ========= ========= Total master_lag: 0.32 =========