builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1453117815.5 results: success (0) buildid: 20160118013521 builduid: 7e33df36f9284a899e35566de241d001 revision: ef3cfadfccb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.501746) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.502200) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.502657) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.526188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.526509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.546776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.547078) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.596724) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.597021) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.597375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.597690) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 03:50:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.5M=0s 2016-01-18 03:50:16 (35.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163903 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.774161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.774516) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015443 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.824398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:15.824783) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ef3cfadfccb9 --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 ef3cfadfccb9 --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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 03:50:16,397 Setting DEBUG logging. 2016-01-18 03:50:16,397 attempt 1/10 2016-01-18 03:50:16,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ef3cfadfccb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 03:50:16,662 unpacking tar archive at: mozilla-beta-ef3cfadfccb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.445066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.445574) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004683 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.496259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.496562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.509333) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.509585) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 03:50:16.509961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-18 03:50:16.510235) ========= /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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:17 INFO - MultiFileLogger online at 20160118 03:50:17 in /builds/slave/test-pgo 03:50:17 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 03:50:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:50:17 INFO - {'append_to_log': False, 03:50:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:50:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:50:17 INFO - 'branch': 'Mozilla-Beta', 03:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:17 INFO - 'config_files': ('talos/linux_config.py',), 03:50:17 INFO - 'default_actions': ('clobber', 03:50:17 INFO - 'read-buildbot-config', 03:50:17 INFO - 'download-and-extract', 03:50:17 INFO - 'populate-webroot', 03:50:17 INFO - 'create-virtualenv', 03:50:17 INFO - 'install', 03:50:17 INFO - 'run-tests'), 03:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:17 INFO - 'download_minidump_stackwalk': True, 03:50:17 INFO - 'download_symbols': 'ondemand', 03:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:17 INFO - 'installer_path': 'installer.exe', 03:50:17 INFO - 'log_level': 'info', 03:50:17 INFO - 'log_name': 'talos', 03:50:17 INFO - 'log_to_console': True, 03:50:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:17 INFO - 'opt_config_files': (), 03:50:17 INFO - 'pip_index': False, 03:50:17 INFO - 'sps_profile': False, 03:50:17 INFO - 'sps_profile_interval': 0, 03:50:17 INFO - 'suite': 'dromaeojs', 03:50:17 INFO - 'system_bits': '32', 03:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:17 INFO - 'title': 'talos-linux64-ix-015', 03:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:17 INFO - 'use_talos_json': True, 03:50:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:17 INFO - 'work_dir': 'build'} 03:50:17 INFO - ##### 03:50:17 INFO - ##### Running clobber step. 03:50:17 INFO - ##### 03:50:17 INFO - Running pre-action listener: _resource_record_pre_action 03:50:17 INFO - Running main action method: clobber 03:50:17 INFO - rmtree: /builds/slave/test-pgo/build 03:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:50:17 INFO - Running post-action listener: _resource_record_post_action 03:50:17 INFO - ##### 03:50:17 INFO - ##### Running read-buildbot-config step. 03:50:17 INFO - ##### 03:50:17 INFO - Running pre-action listener: _resource_record_pre_action 03:50:17 INFO - Running main action method: read_buildbot_config 03:50:17 INFO - Using buildbot properties: 03:50:17 INFO - { 03:50:17 INFO - "properties": { 03:50:17 INFO - "buildnumber": 55, 03:50:17 INFO - "product": "firefox", 03:50:17 INFO - "script_repo_revision": "production", 03:50:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:50:17 INFO - "repository": "", 03:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:50:17 INFO - "buildid": "20160118013521", 03:50:17 INFO - "slavename": "talos-linux64-ix-015", 03:50:17 INFO - "pgo_build": "True", 03:50:17 INFO - "basedir": "/builds/slave/test-pgo", 03:50:17 INFO - "project": "", 03:50:17 INFO - "platform": "ubuntu64_hw", 03:50:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:50:17 INFO - "slavebuilddir": "test", 03:50:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:50:17 INFO - "branch": "mozilla-beta", 03:50:17 INFO - "repo_path": "releases/mozilla-beta", 03:50:17 INFO - "stage_platform": "linux64-pgo", 03:50:17 INFO - "builduid": "7e33df36f9284a899e35566de241d001", 03:50:17 INFO - "revision": "ef3cfadfccb9" 03:50:17 INFO - }, 03:50:17 INFO - "sourcestamp": { 03:50:17 INFO - "repository": "", 03:50:17 INFO - "hasPatch": false, 03:50:17 INFO - "project": "", 03:50:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 03:50:17 INFO - "changes": [ 03:50:17 INFO - { 03:50:17 INFO - "category": null, 03:50:17 INFO - "files": [ 03:50:17 INFO - { 03:50:17 INFO - "url": null, 03:50:17 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2" 03:50:17 INFO - } 03:50:17 INFO - ], 03:50:17 INFO - "repository": "", 03:50:17 INFO - "rev": "ef3cfadfccb9", 03:50:17 INFO - "who": "sendchange", 03:50:17 INFO - "when": 1453117780, 03:50:17 INFO - "number": 7473749, 03:50:17 INFO - "comments": "Bug 1237775 - Change pref for network monitoring on linux to false. r=mcmanus, a=sylvestre, a=ritu", 03:50:17 INFO - "project": "", 03:50:17 INFO - "at": "Mon 18 Jan 2016 03:49:40", 03:50:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 03:50:17 INFO - "revlink": "", 03:50:17 INFO - "properties": [ 03:50:17 INFO - [ 03:50:17 INFO - "buildid", 03:50:17 INFO - "20160118013521", 03:50:17 INFO - "Change" 03:50:17 INFO - ], 03:50:17 INFO - [ 03:50:17 INFO - "builduid", 03:50:17 INFO - "7e33df36f9284a899e35566de241d001", 03:50:17 INFO - "Change" 03:50:17 INFO - ], 03:50:17 INFO - [ 03:50:17 INFO - "pgo_build", 03:50:17 INFO - "True", 03:50:17 INFO - "Change" 03:50:17 INFO - ] 03:50:17 INFO - ], 03:50:17 INFO - "revision": "ef3cfadfccb9" 03:50:17 INFO - } 03:50:17 INFO - ], 03:50:17 INFO - "revision": "ef3cfadfccb9" 03:50:17 INFO - } 03:50:17 INFO - } 03:50:17 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2. 03:50:17 INFO - Running post-action listener: _resource_record_post_action 03:50:17 INFO - ##### 03:50:17 INFO - ##### Running download-and-extract step. 03:50:17 INFO - ##### 03:50:17 INFO - Running pre-action listener: _resource_record_pre_action 03:50:17 INFO - Running main action method: download_and_extract 03:50:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:50:17 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')]} 03:50:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/test_packages.json 03:50:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:50:17 INFO - Downloaded 1270 bytes. 03:50:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:50:17 INFO - Using the following test package requirements: 03:50:17 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:50:17 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:50:17 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'jsshell-linux-x86_64.zip'], 03:50:17 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:50:17 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:50:17 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 03:50:17 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 03:50:17 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:50:17 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 03:50:17 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 03:50:17 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:50:17 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:50:17 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')]} 03:50:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:50:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:22 INFO - Downloaded 22573301 bytes. 03:50:22 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 03:50:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:50:22 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 03:50:23 INFO - Return code: 0 03:50:23 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 03:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:50:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:26 INFO - Downloaded 22573301 bytes. 03:50: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 03:50:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 03:50: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 03:50:27 INFO - Return code: 0 03:50: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')]} 03:50:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 03:50:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:29 INFO - Downloaded 11131970 bytes. 03:50: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 03:50:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 03:50: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 03:50:29 INFO - Return code: 0 03:50: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')]} 03:50:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2 03:50:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/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 03:50:41 INFO - Downloaded 56633225 bytes. 03:50:41 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2 03:50:41 INFO - mkdir: /builds/slave/test-pgo/properties 03:50:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:50:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:50:41 INFO - Contents: 03:50:41 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2 03:50:41 INFO - Running post-action listener: _resource_record_post_action 03:50:41 INFO - Running post-action listener: set_extra_try_arguments 03:50:41 INFO - ##### 03:50:41 INFO - ##### Running populate-webroot step. 03:50:41 INFO - ##### 03:50:41 INFO - Running pre-action listener: _resource_record_pre_action 03:50:41 INFO - Running main action method: populate_webroot 03:50:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:50:41 INFO - '../fennec_ids.txt'], 03:50:41 INFO - 'tests': ['tcheck2']}, 03:50:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:41 INFO - '--tppagecycles', 03:50:41 INFO - '7'], 03:50:41 INFO - 'tests': ['tsvgm']}}, 03:50:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:50:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:50:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'tests': ['damp', 'tps']}, 03:50:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['damp', 'tps']}, 03:50:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:50:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:41 INFO - 'other': {'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'other_l64': {'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'other_nol64': {'tests': ['a11yr', 03:50:41 INFO - 'ts_paint', 03:50:41 INFO - 'tpaint', 03:50:41 INFO - 'sessionrestore', 03:50:41 INFO - 'sessionrestore_no_auto_restore']}, 03:50:41 INFO - 'svgr': {'tests': ['tsvgx', 03:50:41 INFO - 'tsvgr_opacity', 03:50:41 INFO - 'tart', 03:50:41 INFO - 'tscrollx', 03:50:41 INFO - 'cart']}, 03:50:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['tsvgx', 03:50:41 INFO - 'tsvgr_opacity', 03:50:41 INFO - 'tart', 03:50:41 INFO - 'tscrollx', 03:50:41 INFO - 'cart']}, 03:50:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'tests': ['tp5o']}, 03:50:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'talos_options': ['--e10s'], 03:50:41 INFO - 'tests': ['tp5o']}, 03:50:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'talos_options': ['--xperf_path', 03:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:41 INFO - 'tests': ['tp5n']}, 03:50:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:41 INFO - 'talos_options': ['--e10s', 03:50:41 INFO - '--xperf_path', 03:50:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:41 INFO - 'tests': ['tp5n']}}, 03:50:41 INFO - 'talos.zip': {'path': '', 03:50:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:41 INFO - Running post-action listener: _resource_record_post_action 03:50:41 INFO - ##### 03:50:41 INFO - ##### Running create-virtualenv step. 03:50:41 INFO - ##### 03:50:41 INFO - Running pre-action listener: _resource_record_pre_action 03:50:41 INFO - Running main action method: create_virtualenv 03:50:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:50:41 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 03:50:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:50:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:41 INFO - Using real prefix '/usr' 03:50:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:50:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:43 INFO - Installing pip.................done. 03:50:43 INFO - Return code: 0 03:50:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:43 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:43 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 03:50:43 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 03:50:43 INFO - Using env: {'DISPLAY': ':0', 03:50:43 INFO - 'HOME': '/home/cltbld', 03:50:43 INFO - 'LANG': 'en_US.UTF-8', 03:50:43 INFO - 'LANGUAGE': 'en_US:en', 03:50:43 INFO - 'LOGNAME': 'cltbld', 03:50:43 INFO - 'MAIL': '/var/mail/cltbld', 03:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:43 INFO - 'MOZ_NO_REMOTE': '1', 03:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:43 INFO - 'NO_EM_RESTART': '1', 03:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:43 INFO - 'SHELL': '/bin/bash', 03:50:43 INFO - 'SHLVL': '1', 03:50:43 INFO - 'TERM': 'linux', 03:50:43 INFO - 'TMOUT': '86400', 03:50:43 INFO - 'USER': 'cltbld', 03:50:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:43 INFO - '_': '/tools/buildbot/bin/python'} 03:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:44 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 03:50:44 INFO - Cleaning up... 03:50:44 INFO - Return code: 0 03:50:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:50:44 INFO - Using env: {'DISPLAY': ':0', 03:50:44 INFO - 'HOME': '/home/cltbld', 03:50:44 INFO - 'LANG': 'en_US.UTF-8', 03:50:44 INFO - 'LANGUAGE': 'en_US:en', 03:50:44 INFO - 'LOGNAME': 'cltbld', 03:50:44 INFO - 'MAIL': '/var/mail/cltbld', 03:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:44 INFO - 'MOZ_NO_REMOTE': '1', 03:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:44 INFO - 'NO_EM_RESTART': '1', 03:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:44 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:44 INFO - 'SHELL': '/bin/bash', 03:50:44 INFO - 'SHLVL': '1', 03:50:44 INFO - 'TERM': 'linux', 03:50:44 INFO - 'TMOUT': '86400', 03:50:44 INFO - 'USER': 'cltbld', 03:50:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:44 INFO - '_': '/tools/buildbot/bin/python'} 03:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:44 INFO - Downloading/unpacking psutil>=0.7.1 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:50:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:50:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:46 INFO - Installing collected packages: psutil 03:50:46 INFO - Running setup.py install for psutil 03:50:46 INFO - building 'psutil._psutil_linux' extension 03:50:46 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 03:50:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:50:46 INFO - building 'psutil._psutil_posix' extension 03:50:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:50:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:50:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:46 INFO - Successfully installed psutil 03:50:46 INFO - Cleaning up... 03:50:46 INFO - Return code: 0 03:50:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:46 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:46 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 03:50:46 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 03:50:46 INFO - Using env: {'DISPLAY': ':0', 03:50:46 INFO - 'HOME': '/home/cltbld', 03:50:46 INFO - 'LANG': 'en_US.UTF-8', 03:50:46 INFO - 'LANGUAGE': 'en_US:en', 03:50:46 INFO - 'LOGNAME': 'cltbld', 03:50:46 INFO - 'MAIL': '/var/mail/cltbld', 03:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:46 INFO - 'MOZ_NO_REMOTE': '1', 03:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:46 INFO - 'NO_EM_RESTART': '1', 03:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:46 INFO - 'SHELL': '/bin/bash', 03:50:46 INFO - 'SHLVL': '1', 03:50:46 INFO - 'TERM': 'linux', 03:50:46 INFO - 'TMOUT': '86400', 03:50:46 INFO - 'USER': 'cltbld', 03:50:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:46 INFO - '_': '/tools/buildbot/bin/python'} 03:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:50:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:50:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:50:48 INFO - Installing collected packages: mozsystemmonitor 03:50:48 INFO - Running setup.py install for mozsystemmonitor 03:50:48 INFO - Successfully installed mozsystemmonitor 03:50:48 INFO - Cleaning up... 03:50:48 INFO - Return code: 0 03:50:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:48 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:48 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 03:50:48 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 03:50:48 INFO - Using env: {'DISPLAY': ':0', 03:50:48 INFO - 'HOME': '/home/cltbld', 03:50:48 INFO - 'LANG': 'en_US.UTF-8', 03:50:48 INFO - 'LANGUAGE': 'en_US:en', 03:50:48 INFO - 'LOGNAME': 'cltbld', 03:50:48 INFO - 'MAIL': '/var/mail/cltbld', 03:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:48 INFO - 'MOZ_NO_REMOTE': '1', 03:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:48 INFO - 'NO_EM_RESTART': '1', 03:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:48 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:48 INFO - 'SHELL': '/bin/bash', 03:50:48 INFO - 'SHLVL': '1', 03:50:48 INFO - 'TERM': 'linux', 03:50:48 INFO - 'TMOUT': '86400', 03:50:48 INFO - 'USER': 'cltbld', 03:50:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:48 INFO - '_': '/tools/buildbot/bin/python'} 03:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:50:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:50:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:50:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:51 INFO - Downloading docopt-0.6.1.tar.gz 03:50:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:50:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:51 INFO - Running setup.py install for blobuploader 03:50:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:50:51 INFO - Running setup.py install for requests 03:50:51 INFO - Running setup.py install for docopt 03:50:51 INFO - Successfully installed blobuploader requests docopt 03:50:51 INFO - Cleaning up... 03:50:51 INFO - Return code: 0 03:50:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:51 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:51 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 03:50:51 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 03:50:51 INFO - Using env: {'DISPLAY': ':0', 03:50:51 INFO - 'HOME': '/home/cltbld', 03:50:51 INFO - 'LANG': 'en_US.UTF-8', 03:50:51 INFO - 'LANGUAGE': 'en_US:en', 03:50:51 INFO - 'LOGNAME': 'cltbld', 03:50:51 INFO - 'MAIL': '/var/mail/cltbld', 03:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:51 INFO - 'MOZ_NO_REMOTE': '1', 03:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:51 INFO - 'NO_EM_RESTART': '1', 03:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:51 INFO - 'SHELL': '/bin/bash', 03:50:51 INFO - 'SHLVL': '1', 03:50:51 INFO - 'TERM': 'linux', 03:50:51 INFO - 'TMOUT': '86400', 03:50:51 INFO - 'USER': 'cltbld', 03:50:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:51 INFO - '_': '/tools/buildbot/bin/python'} 03:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:52 INFO - Running setup.py (path:/tmp/pip-YxDwLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:52 INFO - Running setup.py (path:/tmp/pip-j6IM0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:52 INFO - Running setup.py (path:/tmp/pip-b5FnQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:52 INFO - Running setup.py (path:/tmp/pip-tkLzoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:52 INFO - Running setup.py (path:/tmp/pip-SCRTfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:52 INFO - Running setup.py (path:/tmp/pip-02hDih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:52 INFO - Running setup.py (path:/tmp/pip-LUde5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:52 INFO - Running setup.py (path:/tmp/pip-OScHvv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:52 INFO - Running setup.py (path:/tmp/pip-KDz99Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:52 INFO - Running setup.py (path:/tmp/pip-e8zIrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:52 INFO - Running setup.py (path:/tmp/pip-o_hLg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:52 INFO - Running setup.py (path:/tmp/pip-KmCDS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:53 INFO - Running setup.py (path:/tmp/pip-yY0cHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:53 INFO - Running setup.py (path:/tmp/pip-YWzSji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:53 INFO - Running setup.py (path:/tmp/pip-Ypof_9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:53 INFO - Running setup.py (path:/tmp/pip-qFIJEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:53 INFO - Running setup.py (path:/tmp/pip-9LDacc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:53 INFO - Running setup.py install for manifestparser 03:50:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:50:53 INFO - Running setup.py install for mozcrash 03:50:53 INFO - Running setup.py install for mozdebug 03:50:53 INFO - Running setup.py install for mozdevice 03:50:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:50:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:50:53 INFO - Running setup.py install for mozfile 03:50:53 INFO - Running setup.py install for mozhttpd 03:50:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozinfo 03:50:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozInstall 03:50:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozleak 03:50:54 INFO - Running setup.py install for mozlog 03:50:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for moznetwork 03:50:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozprocess 03:50:54 INFO - Running setup.py install for mozprofile 03:50:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozrunner 03:50:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:50:54 INFO - Running setup.py install for mozscreenshot 03:50:54 INFO - Running setup.py install for moztest 03:50:55 INFO - Running setup.py install for mozversion 03:50:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:50:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:55 INFO - Cleaning up... 03:50:55 INFO - Return code: 0 03:50:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:50:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:50:55 INFO - Using env: {'DISPLAY': ':0', 03:50:55 INFO - 'HOME': '/home/cltbld', 03:50:55 INFO - 'LANG': 'en_US.UTF-8', 03:50:55 INFO - 'LANGUAGE': 'en_US:en', 03:50:55 INFO - 'LOGNAME': 'cltbld', 03:50:55 INFO - 'MAIL': '/var/mail/cltbld', 03:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:55 INFO - 'MOZ_NO_REMOTE': '1', 03:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:55 INFO - 'NO_EM_RESTART': '1', 03:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:55 INFO - 'SHELL': '/bin/bash', 03:50:55 INFO - 'SHLVL': '1', 03:50:55 INFO - 'TERM': 'linux', 03:50:55 INFO - 'TMOUT': '86400', 03:50:55 INFO - 'USER': 'cltbld', 03:50:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:55 INFO - '_': '/tools/buildbot/bin/python'} 03:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:55 INFO - Running setup.py (path:/tmp/pip-BreU5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:55 INFO - Running setup.py (path:/tmp/pip-OGuxHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:55 INFO - Running setup.py (path:/tmp/pip-IHHOrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:50:55 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)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:55 INFO - Running setup.py (path:/tmp/pip-vZQD18-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:50:55 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)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:55 INFO - Running setup.py (path:/tmp/pip-bz91wo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:50:55 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)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:55 INFO - Running setup.py (path:/tmp/pip-rzOf1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:50:55 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)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:55 INFO - Running setup.py (path:/tmp/pip-LFIYNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:50:55 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)) 03:50:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:55 INFO - Running setup.py (path:/tmp/pip-0wC6Me-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:56 INFO - Running setup.py (path:/tmp/pip-h2wRr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:56 INFO - Running setup.py (path:/tmp/pip-2EzdPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:50:56 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)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:56 INFO - Running setup.py (path:/tmp/pip-rAbMi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:56 INFO - Running setup.py (path:/tmp/pip-abvHsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:56 INFO - Running setup.py (path:/tmp/pip-yUM9N9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:56 INFO - Running setup.py (path:/tmp/pip-zhkeOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:56 INFO - Running setup.py (path:/tmp/pip-NEdnjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:56 INFO - Running setup.py (path:/tmp/pip-3UkCWr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:56 INFO - Running setup.py (path:/tmp/pip-52paof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:50:56 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)) 03:50:56 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)) 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:56 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)) 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:56 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)) 03:50:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:58 INFO - Downloading blessings-1.5.1.tar.gz 03:50:58 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:50:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:58 INFO - Installing collected packages: blessings 03:50:58 INFO - Running setup.py install for blessings 03:50:58 INFO - Successfully installed blessings 03:50:58 INFO - Cleaning up... 03:50:58 INFO - Return code: 0 03:50:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:50:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:50:58 INFO - Reading from file tmpfile_stdout 03:50:58 INFO - Current package versions: 03:50:58 INFO - argparse == 1.2.1 03:50:58 INFO - blessings == 1.5.1 03:50:58 INFO - blobuploader == 1.2.4 03:50:58 INFO - docopt == 0.6.1 03:50:58 INFO - manifestparser == 1.1 03:50:58 INFO - mozInstall == 1.12 03:50:58 INFO - mozcrash == 0.16 03:50:58 INFO - mozdebug == 0.1 03:50:58 INFO - mozdevice == 0.46 03:50:58 INFO - mozfile == 1.2 03:50:58 INFO - mozhttpd == 0.7 03:50:58 INFO - mozinfo == 0.8 03:50:58 INFO - mozleak == 0.1 03:50:58 INFO - mozlog == 3.0 03:50:58 INFO - moznetwork == 0.27 03:50:58 INFO - mozprocess == 0.22 03:50:58 INFO - mozprofile == 0.27 03:50:58 INFO - mozrunner == 6.11 03:50:58 INFO - mozscreenshot == 0.1 03:50:58 INFO - mozsystemmonitor == 0.0 03:50:58 INFO - moztest == 0.7 03:50:58 INFO - mozversion == 1.4 03:50:58 INFO - psutil == 3.1.1 03:50:58 INFO - requests == 1.2.3 03:50:58 INFO - wsgiref == 0.1.2 03:50:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:50:58 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')]} 03:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:58 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')]} 03:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:58 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:58 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 03:50:58 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 03:50:58 INFO - Using env: {'DISPLAY': ':0', 03:50:58 INFO - 'HOME': '/home/cltbld', 03:50:58 INFO - 'LANG': 'en_US.UTF-8', 03:50:58 INFO - 'LANGUAGE': 'en_US:en', 03:50:58 INFO - 'LOGNAME': 'cltbld', 03:50:58 INFO - 'MAIL': '/var/mail/cltbld', 03:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:58 INFO - 'MOZ_NO_REMOTE': '1', 03:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:58 INFO - 'NO_EM_RESTART': '1', 03:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:58 INFO - 'SHELL': '/bin/bash', 03:50:58 INFO - 'SHLVL': '1', 03:50:58 INFO - 'TERM': 'linux', 03:50:58 INFO - 'TMOUT': '86400', 03:50:58 INFO - 'USER': 'cltbld', 03:50:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:58 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:50:59 INFO - Cleaning up... 03:50:59 INFO - Return code: 0 03:50:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:59 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:50:59 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 03:50:59 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 03:50:59 INFO - Using env: {'DISPLAY': ':0', 03:50:59 INFO - 'HOME': '/home/cltbld', 03:50:59 INFO - 'LANG': 'en_US.UTF-8', 03:50:59 INFO - 'LANGUAGE': 'en_US:en', 03:50:59 INFO - 'LOGNAME': 'cltbld', 03:50:59 INFO - 'MAIL': '/var/mail/cltbld', 03:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:59 INFO - 'MOZ_NO_REMOTE': '1', 03:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:59 INFO - 'NO_EM_RESTART': '1', 03:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:50:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:50:59 INFO - 'SHELL': '/bin/bash', 03:50:59 INFO - 'SHLVL': '1', 03:50:59 INFO - 'TERM': 'linux', 03:50:59 INFO - 'TMOUT': '86400', 03:50:59 INFO - 'USER': 'cltbld', 03:50:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:59 INFO - '_': '/tools/buildbot/bin/python'} 03:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:59 INFO - Downloading/unpacking jsonschema 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:51:01 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 03:51:01 INFO - Downloading/unpacking functools32 (from jsonschema) 03:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:51:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:01 INFO - warning: no files found matching '*.txt' 03:51:01 INFO - no previously-included directories found matching 'build' 03:51:01 INFO - no previously-included directories found matching 'dist' 03:51:01 INFO - no previously-included directories found matching '.git*' 03:51:01 INFO - Installing collected packages: jsonschema, functools32 03:51:01 INFO - Running setup.py install for functools32 03:51:02 INFO - warning: no files found matching '*.txt' 03:51:02 INFO - no previously-included directories found matching 'build' 03:51:02 INFO - no previously-included directories found matching 'dist' 03:51:02 INFO - no previously-included directories found matching '.git*' 03:51:02 INFO - Successfully installed jsonschema functools32 03:51:02 INFO - Cleaning up... 03:51:02 INFO - Return code: 0 03:51:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:02 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 0x7fe9f3f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1015600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', '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 03:51:02 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 03:51:02 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 03:51:02 INFO - Using env: {'DISPLAY': ':0', 03:51:02 INFO - 'HOME': '/home/cltbld', 03:51:02 INFO - 'LANG': 'en_US.UTF-8', 03:51:02 INFO - 'LANGUAGE': 'en_US:en', 03:51:02 INFO - 'LOGNAME': 'cltbld', 03:51:02 INFO - 'MAIL': '/var/mail/cltbld', 03:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:02 INFO - 'MOZ_NO_REMOTE': '1', 03:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:02 INFO - 'NO_EM_RESTART': '1', 03:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:51:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:51:02 INFO - 'SHELL': '/bin/bash', 03:51:02 INFO - 'SHLVL': '1', 03:51:02 INFO - 'TERM': 'linux', 03:51:02 INFO - 'TMOUT': '86400', 03:51:02 INFO - 'USER': 'cltbld', 03:51:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:02 INFO - '_': '/tools/buildbot/bin/python'} 03:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:02 INFO - Downloading/unpacking flake8 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:51:04 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 03:51:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:51:04 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 03:51:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 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 03:51:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:51:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:04 INFO - no previously-included directories found matching 'docs/_build' 03:51:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:51:05 INFO - Running setup.py install for pep8 03:51:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:05 INFO - no previously-included directories found matching 'docs/_build' 03:51:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:51:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:51:05 INFO - Cleaning up... 03:51:05 INFO - Return code: 0 03:51:05 INFO - Running post-action listener: _resource_record_post_action 03:51:05 INFO - Running post-action listener: _start_resource_monitoring 03:51:05 INFO - Starting resource monitoring. 03:51:05 INFO - ##### 03:51:05 INFO - ##### Running install step. 03:51:05 INFO - ##### 03:51:05 INFO - Running pre-action listener: _resource_record_pre_action 03:51:05 INFO - Running main action method: install 03:51:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:51:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:51:05 INFO - Reading from file tmpfile_stdout 03:51:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:51:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:51:05 INFO - Reading from file tmpfile_stdout 03:51:05 INFO - Output received: 03:51:05 INFO - Usage: mozinstall [options] installer 03:51:05 INFO - Options: 03:51:05 INFO - -h, --help show this help message and exit 03:51:05 INFO - -d DEST, --destination=DEST 03:51:05 INFO - Directory to install application into. [default: 03:51:05 INFO - "/builds/slave/test-pgo"] 03:51:05 INFO - --app=APP Application being installed. [default: firefox] 03:51:05 INFO - mkdir: /builds/slave/test-pgo/build/application 03:51:05 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'] 03:51:05 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 03:51:19 INFO - Reading from file tmpfile_stdout 03:51:19 INFO - Output received: 03:51:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:51:19 INFO - Running post-action listener: _resource_record_post_action 03:51:19 INFO - ##### 03:51:19 INFO - ##### Running run-tests step. 03:51:19 INFO - ##### 03:51:19 INFO - Running pre-action listener: _resource_record_pre_action 03:51:19 INFO - Running main action method: run_tests 03:51:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:51:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:51:19 INFO - Python 2.7.3 03:51:19 INFO - Return code: 0 03:51:19 INFO - grabbing minidump binary from tooltool 03:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a4350>, '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 0x10a5250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a56e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:51:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:51:19 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 03:51:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:19 INFO - Return code: 0 03:51:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:51:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:51:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:51:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:51:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:51:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:51:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:51:20 INFO - Return code: 0 03:51:20 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/1453109721/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:51:20 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/1453109721/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 03:51:20 INFO - Using env: {'DISPLAY': ':0', 03:51:20 INFO - 'HOME': '/home/cltbld', 03:51:20 INFO - 'LANG': 'en_US.UTF-8', 03:51:20 INFO - 'LANGUAGE': 'en_US:en', 03:51:20 INFO - 'LOGNAME': 'cltbld', 03:51:20 INFO - 'MAIL': '/var/mail/cltbld', 03:51:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:51:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:20 INFO - 'MOZ_NO_REMOTE': '1', 03:51:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:20 INFO - 'NO_EM_RESTART': '1', 03:51:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:51:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:51:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:51:20 INFO - 'SHELL': '/bin/bash', 03:51:20 INFO - 'SHLVL': '1', 03:51:20 INFO - 'TERM': 'linux', 03:51:20 INFO - 'TMOUT': '86400', 03:51:20 INFO - 'USER': 'cltbld', 03:51:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138', 03:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:20 INFO - '_': '/tools/buildbot/bin/python'} 03:51:20 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/1453109721/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 03:51:20 INFO - mozversion INFO | application_buildid: 20160118013521 03:51:20 INFO - mozversion INFO | application_changeset: ef3cfadfccb97588653ae06eefdac28ec447c1f6 03:51:20 INFO - mozversion INFO | application_display_name: Nightly 03:51:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:20 INFO - mozversion INFO | application_name: Firefox 03:51:20 INFO - mozversion INFO | application_remotingname: firefox 03:51:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:51:20 INFO - mozversion INFO | application_vendor: Mozilla 03:51:20 INFO - mozversion INFO | application_version: 44.0 03:51:20 INFO - mozversion INFO | platform_buildid: 20160118013521 03:51:20 INFO - mozversion INFO | platform_changeset: ef3cfadfccb97588653ae06eefdac28ec447c1f6 03:51:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:51:20 INFO - mozversion INFO | platform_version: 44.0 03:51:20 INFO - 2016-01-18 03:51:20,880 DEBUG : using testdate: 1453117880 03:51:20 INFO - 2016-01-18 03:51:20,880 DEBUG : actual date: 1453117880 03:51:20 INFO - 2016-01-18 03:51:20,927 INFO : starting webserver on 'localhost:38811' 03:51:20 INFO - 2016-01-18 03:51:20,929 INFO : Starting test suite talos-linux64-ix-015 03:51:20 INFO - 2016-01-18 03:51:20,929 INFO : Starting test dromaeo_css 03:51:20 INFO - 2016-01-18 03:51:20,929 DEBUG : operating with platform_type : linux_ 03:51:20 INFO - 2016-01-18 03:51:20,929 INFO : Initialising browser for dromaeo_css test... 03:51:20 INFO - 2016-01-18 03:51:20,942 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKyRYrM/profile http://localhost:38811/getInfo.html 03:51:24 INFO - 2016-01-18 03:51:24,359 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:51:24 INFO - 2016-01-18 03:51:24,359 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:51:24 INFO - 2016-01-18 03:51:24,359 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:51:24 INFO - 2016-01-18 03:51:24,359 DEBUG : BROWSER_OUTPUT: __metrics 03:51:24 INFO - 2016-01-18 03:51:24,428 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] 03:51:25 INFO - 2016-01-18 03:51:25,624 INFO : Browser initialized. 03:51:25 INFO - 2016-01-18 03:51:25,625 INFO : Running cycle 1/1 for dromaeo_css test... 03:51:25 INFO - 2016-01-18 03:51:25,625 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKyRYrM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:51:37 INFO - 2016-01-18 03:51:37,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 128798720 03:51:37 INFO - 2016-01-18 03:51:37,199 DEBUG : BROWSER_OUTPUT: 03:52:28 INFO - 2016-01-18 03:52:28,024 DEBUG : BROWSER_OUTPUT: 1453117948023 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] 03:54:35 INFO - 2016-01-18 03:54:35,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38811/tests/dromaeo/cssquery-ext.html) 03:54:36 INFO - 2016-01-18 03:54:36,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 204509184 03:54:36 INFO - 2016-01-18 03:54:36,990 DEBUG : BROWSER_OUTPUT: 03:57:39 INFO - 2016-01-18 03:57:39,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-ext.html (next: http://localhost:38811/tests/dromaeo/cssquery-jquery.html) 03:57:39 INFO - 2016-01-18 03:57:39,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 213229568 03:57:39 INFO - 2016-01-18 03:57:39,564 DEBUG : BROWSER_OUTPUT: 04:00:41 INFO - 2016-01-18 04:00:41,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38811/tests/dromaeo/cssquery-mootools.html) 04:00:41 INFO - 2016-01-18 04:00:41,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 204017664 04:00:41 INFO - 2016-01-18 04:00:41,847 DEBUG : BROWSER_OUTPUT: 04:03:43 INFO - 2016-01-18 04:03:43,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38811/tests/dromaeo/cssquery-prototype.html) 04:03:44 INFO - 2016-01-18 04:03:44,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 190164992 04:03:44 INFO - 2016-01-18 04:03:44,101 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2016-01-18 04:06:46,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38811/tests/dromaeo/cssquery-yui.html) 04:06:47 INFO - 2016-01-18 04:06:47,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 193093632 04:06:47 INFO - 2016-01-18 04:06:47,041 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/dromaeo/cssquery-yui.html (next: http://localhost:38811/tests/dromaeo/cssquery-dojo.html) 04:09:49 INFO - 2016-01-18 04:09:49,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 237658112 04:09:49 INFO - 2016-01-18 04:09:49,365 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3326.5841769778776;3386.830658467076;3395.7283417326616;3422.8801991930286;3424.811635360056;5534.335879694432;5574.721263936797;5585.329760428749;5591.888162236753;5611.691356975365;5597.244372009777;5600.019996500617;5610.214569960209;5622.184783206443;5628.380878103405;5000.1249781288125;5088.516590923866;5094.057599344114;5160.277561141444;5210.218467229908;5175.378954525443;5186.299849520305;5200.791968321262;5201.921971170435;5204.583633309345;5027.09512287788;5143.3570803649545;5159;5219.295395121667;5225.843224703246;5071.1632580624155;5154.175331946889;5202.713850738208;5220.112580861262;5224.190250511177;5129.794808207667;5160.14857548504;5172.120739474299;5178.948210517922;5226.268322434862;5239.397469291042;5340.118880384732;5344.43883392246;5394.811181608625;5459.617826752129;6094.268687757498;6096.11606317086;6098.54260930432;6100.786472473442;6105.542084343692;6111.174991376151;6145;6147.600405973598;6149.2313460817395;6151.108089327067;5435.755391007414;5547.057000309957;5554.416786237427;5635.464630860061;5668.348139963916;6202.72087756052;6203.627782333075;6210.658413787195;6211.409916057967;6220.34686357935;5844.094165404369;6022.096685497123;6039.063945088518;6048.848778780566;6063.060225665029;6006.909896351558;6072;6080.878382432326;6091.908621370683;6121.785737499166;6027.517798576104;6035.909461358083;6065.696715164224;6082.60463069899;6088.299845517822;5711.800086997018;5846.532277417797;6097.054956481752;6106.053561697944;6110.991686371699;4591.563801438858;4600.907981840344;4625.3755742974945;4683.086798074342;4694.600958918462;4212.283911735012;4219.493660760667;4225.809838557272;4226.091390351028;4252.213340532012;5614.466625670555;5906.438888305604;5917.378675239124;5917.7928772493615;5918.260217472816;5849.1226316052935;5922.407759224043;5929.110633405024;5956.851078723066;6053.031514957674;5742.511886489695;5858.970705146532;5866.941330586725;5873.383294754075;5880.294364676266;5143.742812859342;5275.024120537712;5330.093884039723;5335.946640533545;5359.08895487768;6142.262928448526;6172.105044768484;6211.596246243979;6214.8135555933395;6215.564910456224;6098.817035489031;6108.541859360477;6124.112003759519;6146;6162.22972128484;6105.358937311518;6119.8470038247615;6224.813255602339;6319.46284565817;6332.810015699536;5994.940050599438;6029.336772954884;6034.758609655564;6042.90935635957;6045.909311360245;6128.325884152829;6133.478654314434;6134.570580059353;6140.846478837886;6148.9692551536955;5766.740496677576;5810.738516766671;5854.970725146517;5949.196858424058;5986.431289027535;5955.2853657559635;5991.730372133352;5993.490553302844;5995.46040856325;5997.100434934795;5908.5568582357355;5910.7340169693325;5911.261092363455;5912.674802885883;5929.555283353679;5828.475437210672;5880.735366908585;5965.254343207099;5973;5981.52147828164;5913.349531551612;5928.288605367384;5931.110333450017;5934.673592952429;5939.227900372924 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.441929731742;604.3171216525327;605.9728759752222;611.9510439164867;614.1494030767386;44275;45212.77393613032;45271.77364113183;45313.546864531345;45325.54674453254;47220.29169562459;47396.52603473973;47634.76182619091;47709.52290477094;47751.522484775145;8136.837263254732;8217.301529369981;9263.490508022056;9433.716988490321;10691.893081069167;10839.295445796037;10917.672469825919;10930.617428390007;10942.781144377108;10958.506867190956;11026.393548354838;11099;11127.221094523387;11144;11151.553937842476;10922.235443518957;10971.890281097167;11039.337639741641;11041.723956901142;11053;10762.300450470773;10762.838557421645;10822.837657435144;10841.13270938323;10849.132069434427;45328;45797;45984;46020;46029.53970460286;3727.627237276278;3775.6413140751583;3889.202713443737;3956.485656864618;4249.915001699979;33764.83117584397;34077.659223407696;34272.48591271133;34397.82801086004;34595.48106778401;3855.4409610606585;3858.479105320802;3894.727369084137;3938.468306778577;3966.960330396688;327531;329022;329149;329346;329863;62627;63887.68056159782;66553.66723166354;66919;66928;73231;74639.77521573438;75013.62493187499;75030;75105.24894750983;18646.34737784171;18798.624027519647;18805.811941880405;18835.90582047081;18836.152373143243;13250.403731832092;13296.135751176143;13298.135621184592;13298.268595227355;13308.866911330957;22888.427789305068;23070.538589228123;23119.53760924806;23156.884215578815;23194.072237110664;8687.52218627969;8806.735797926072;8854.645814167361;8937;8987.955060224656;1013.1236480444362;1017.9949100254452;1056.2447849787438;1090.5419723716059;1140.925839820409;31431.842840785648;35120.824395877855;35349.823250884096;35473.290534189175;36312.27375452476;1086.3481910853425;1115.475726408603;1128.9040431563244;1187.8337032815414;1191.980856367793;15814.68370632581;16148.677026459405;16340.428085017205;17484.65030699379;18244.270229190683;452903;456572;457414;458831;458845;65181.34818651753;65845.34154658488;65931.67034164799;65980;66056;1524.4588171199064;1531.257340190007;1544.5984044148827;1554.5414102839463;1562.640592663671;32737.50893736548;33165.50251746178;36082.63917360898;36124.45813312855;36149.638503614624;57278.42721572731;57669.13496297643;57940.71029644825;57959.420405795405;58044.70977645085;344875;351160;351691;351840;354466;31947.520787187746;36150.8192459036;36455;36605;36846.078848029014;46880.97895408212;48122.518774811804;48476.5152348472;48840.755796220794;48904;38308.616913830505;39444.2111157781;39541.80229098836;40812.38781418222;40913.38629920613;40474.797626011685;40520.392194116524;40835;40950.385744213265;41416.980802355916;39655;40054;40186.39720404138;40409.39385909273;40623.39064913969;35705.1073723159;35732.46401304034;36059.81970090133;36249.637503624625;36266.8186659065;27816.176543713296;27923.955579583242;27942.901449332698;28033.939490509714;28189.71810281953 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.46776563161455;385.8386257365331;387.32798594438646;392.54072734900166;393.7814512945316;14393.928030359859;17585.296588136476;20394.388168354955;20439.591208175847;20842.89578552105;19959.800401995977;20112.296069637567;20220.797792022076;20236.08937597808;20243.291484798036;5906.37983011784;6043.305019922721;6043.909341359883;6044.063170208625;6044.818655440322;5914.763409463616;6039.305479869805;6087.05650624154;6094.969525152368;6097.359777223394;4491.528389519102;4618.12255671423;6050.788222412217;6053;6053.636781793084;6492;6644.368784965469;6678;6682.365175308338;6686.732530698766;5653.095504719226;5959.970200149015;6074.301455332649;6081.817545473643;6083.239595050619;24327.148549800848;24486.387840303956;24645.383865403328;25048.749512505005;25153.49693006148;2502.0867383404925;2508.109621084507;2527.027094568586;2533.4679717259396;2581.4320849413098;15175.696486070327;15271;15320.770188447183;15368.385264589402;15711.764323535157;1822.261983896524;1844.9538761530935;1858.8605854560963;1869.44851268876;1961.3821646181407;68040.9999999995;69093;69345;69928.30071699269;70503.29496705018;7989.640466179036;8050.718224862218;8081.868538404628;8122.472039317544;8128.552929588811;9667.081627245401;9680.322377433653;9683.225341972626;9691.806163876683;9698.854517182248;6511.934880651228;6597.043428702811;6612.570182938093;6648.434883034899;6648.601083934883;6867.381935625817;6870.381665650016;6876.862462750817;6884.4148247399535;6915.654217289115;3694.6305369463375;3720.925581488355;3730.235301763132;3771.792551409644;3783.281176576442;1264.7091169030991;1293.6313150751992;1309.4958441000283;1311.849137349198;1317.3413293353324;495.5960891873112;504.50306448148547;515.4536191636877;519.714157213531;527.7519565804066;13196.868031319564;13222;13479.326033698277;13945.302734863217;13980.720385592434;504.94950504949213;547.6850810783815;548.483443279333;548.9258950041693;549.8680316724037;6993.230744618088;7113.5376200547835;7151.713931442788;7219.783406497709;7282.12614486265;578320;593355;601886.9905650443;607490;614502;86039.56980215058;88731;89128.5543572278;89224.5538772302;89849.55075224713;589.1163255117324;592.5674257791836;593.0511182108678;594.197832925547;595.4373117404011;12425.751484970431;12561.685957851127;12823.679408014874;12886.613401597968;12897.548585799826;39744.2051158981;40265.59734402619;40343.19313613653;41049.589504105774;41888.58111418847;53678;53960.46039539712;55316.17025744537;55670.16494752663;56621.43378566326;7555.886661700189;7694.345980591713;7726.1501234863;7839.902413661978;7845.450818442654;13781.173129612256;13939.09395889264;13972.860271397156;14069.366878490697;14324.57026289213;12149.210301330386;12183.512659493876;12392.938035309766;12520.373981300716;12543.372831358578;11567.190296679151;11865.525378984745;11913.702157446132;12040.75918481608;12182.695432614255;10340.431276279876;10449.68650940473;12155.939220303842;12163.148579599343;12222.633321000385;7641.197674244347;7699.615019248903;7718.189590092959;7721.845563088819;7723.266289702469;11752.294862307946;11821.527138914691;11859.822102668639;11865.644030679094;12114.75770484603 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1554.8522890325414;1569.4899157773727;1793.023580855778;1817.1096162880187;1852.99938033462;7237.384822290099;7370;8108.837823243532;8236.09402965674;8252.422330436872;7923.207679232089;8107.432479726407;8188.590570471482;8204.261616454518;8207;2410.3853517353095;2440.511897620474;2441.3652450362943;2445.254197469771;2447.4615584571366;2190.9342719718356;2223.1107556977177;2415.855048697084;2457.69278840145;2477.417806815397;2367.75138610446;2434.866082365469;2438.794773586496;2467.099508679328;2467.247489515706;2427.3567504611206;2446.7063952325657;2446.9143579974702;2447.9632805507845;2453.288546321565;2451.9387015324583;2492.5887228607257;2505.185814610241;2506.724260331362;2507.3230227838562;8062.234087761653;8088.352931765504;8107.918920810835;8118.878216826753;8121.30968867647;5121.334226550562;5200.5059519345605;5207.401148867891;5208.5051920067535;5211.270422140903;3226.757993150523;3293.5059741038795;3375.375555522236;3386.762926595139;3389.254364039907;1109.0960866893456;1109.7003808971613;1168.182272409317;1172.0916289875329;1215.9452824622913;11132.220744547885;11224.66326010221;11238.550457981753;11243.381614011227;11244.325340479516;4695.084458530554;4739.644526660514;4742.715437073786;4784.2823576463115;4788.976055119771;9661.9033809661;9673.613055477703;9689.079537443931;9701.6604418845;9711.611535538641;5247.63266571344;5250.081235783722;5253.395859476209;5256.9737151314;5262.10544207478;4786.138495070851;4790.640701947368;4791.832285869978;4813.3983252093485;4813.518648135228;3526.4710293456187;3925.980370098131;3948.664363529132;3962.0293028208275;3981.3231750602467;1220.6155061155707;1296.5267677297718;1336.4921329894578;1344.072589912957;1350.3585796746663;1221.3893053473264;1236.5239382837672;1267.8351814264086;1475.203390169318;1497.5582203249849;7556.1310449297935;7558.433117516099;7566.167721550625;7609;7712;769.8883661868998;776.4952780692595;795.1928792275729;800.8398320335956;913.1051569461964;6337.6197428154455;6395.968020159869;6415.903761443582;6417.39034791694;6439.130717353191;9402.90597094034;9626.989166137595;9645.517724113906;9650.71047868565;9682.806343873082;9369.390989585656;9540.570674319672;9546.474943878153;9558.90441095594;9560.760980975392;7610.086789585285;7711.305982461606;7711.652975615999;7720.729774457867;7729.111152217454;7747.806304842198;7802.21977802238;7802.765917022499;7852.37181025528;7887.408444366581;8688.869666954874;8867.512286824029;8870.201681848665;8916.86624700643;8923.553822308728;8864;8967.730968070968;8995.865062024206;9003.414778039669;9151.267898567965;7524.172341042371;7619.161892191965;7622.237776222333;7625.885611715939;7628.389728821792;6952.721891124298;7101.041359416413;7981.920180798118;8040.67837286502;8098.635561399633;7503.287187717158;7540.509866858637;7540.8491830164185;7541.6229188539255;7662.73180438682;7459.365953893763;7484.513506622052;7502.924970750441;7573.659185336563;7582.128055273493;7502.474826762074;7556.0177176966645;7672.501287416523;7729.458937874295;7731.574763388067;7054.118235220598;7080.858382832417;7091.929080709333;7094.077769889881;7097.467689923174;6539.509536784665;6675.098861653614;6691.59850408977;6696.19645642526;6704.631245281556 04:09:49 INFO - 2016-01-18 04:09:49,366 DEBUG : BROWSER_OUTPUT: |4;prototype.html;361.3098980946392;362.85485805677723;366.3497292306155;368.625844767561;371.5133175540043;5777.508911742507;5854.88290234195;5868.471837534621;5882.764689412418;5893.292804863411;5717.2281741964825;5796.362400135992;5800.854978625536;5810.622309549876;5814.709264536767;4595.770211489429;4600.700954437968;4601.585857272845;4606.907861842761;4609.539046095397;4435.157320109185;4505.12150130723;4523.61549268311;4623.2371658676275;4634.536546345372;4505.324201369788;4546.47715512717;4574.885627859314;4588.4723256825555;4600.378948841913;4547.636189104864;4558.931616025762;4559.521250268707;4566.520515345874;4570.177368073745;4075.0627355708057;4075.205334959684;4081.0205550667624;4081.530623978251;4090.3046482097816;5474.151506516457;5546.667199967975;5556.91664625031;5589.580781441367;5601.719914004324;5226.033183860998;5228.320318358589;5230.660007099526;5232.9738351308;5234.241035049935;6005.3394126646035;6210.099535567318;6210.254769427697;6215.316315205324;6219.253689557237;4282.036541778106;4376.146651402978;4432.268675668543;4433.290673492225;4437.312216606431;6306.306306306303;6348.396902294275;6384.3934826191435;6390.201224846847;6394.456471199954;4541.636669066466;4549.522300158502;4559.612432943237;4562.019165879352;4563.863084107482;4521.11838191556;4595.977020114878;4598.724076555417;4606.677532572688;4685.8594242172785;5313.814016509404;5315.707636079976;5323.574114070865;5325.440828713007;5327.680339179584;6282.465990390777;6292.653904035231;6294.433500984934;6295.087212354275;6297.401746834135;1658.9004659720456;1661.6759731852173;1663.12685839935;1677.1614192903548;1682.0832646207846;1119.4626579241847;1124.1849658997162;1130.0338210829786;1144.5250221158292;1148.2995372822572;6130.846728831815;6162.938370616326;6172.722227499773;6173.41352571505;6173.59871608344;6480.125183100221;6482.513811464159;6484.416402523795;6491.091247225392;6493.675316234169;5954.583179177503;6058.12157237207;6064.272287325549;6065.696715164312;6075.939240607538;3563.80399078048;3588.5693716753635;3591.048372181374;3593.6047034826147;3593.9101522462147;6518.57629254097;6572.572782769104;6587.934120658828;6600.537962342686;6607.141071660653;6528.520939048694;6614;6635.137432133792;6637.23671777742;6637.46900247979;6611.537192396486;6636.601803891685;6660.70026848793;6663.133792607027;6679.098321726602;6295.5907865988565;6384.329645387167;6481.4166724994975;6481.805545833632;6489.675516224075;6271.745650869753;6286.088517164894;6325.399087086719;6348.365163483615;6350.364963503613;6618.404343609098;6625.602463852184;6628.138342015507;6629.602223866584;6632.83417914556;4514.142312960527;4553.61294289989;4553.8406155785715;4556.362109304634;4556.8177272908715;6394.392532709385;6411.134496842867;6413.16628838248;6417.839554011187;6418.390252925965;6197.597156184834;6246.187995560548;6246.250449945854;6248.843778905563;6271.592346497463;6199.442050215503;6212.347703491068;6224.1597384352535;6240.188775459162;6256.186695729526;6211.0372892201785;6215.254169499508;6217.129601855653;6221.502279817694;6223.813285601439;6315.5894866833505;6335.809925702236;6345.587536810092;6346.460550853045;6351.555391122762;6099.75600975956;6152.538559607958;6187.783427580013;6194.225721784777;6206.441420272197 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: |5;yui.html;859.9484030958141;905.7509184974132;941.2093841173413;949.9930074121428;972.2173650211581;15126;15541.37834486622;15549.067055976635;15564.922175389107;15579;13664.38510267038;13760.724785504284;13766.036377453558;13784.724305513884;13796.31018449076;762.0246085011166;764.396127059625;902.562257305208;906.6373450619772;920.052346083535;908.1418059933366;913.2739472119648;915.4873270968279;919.2554031234688;920.7882187096972;954.4798085043668;955.6559638530124;959;959.9424034557949;962.7929995051063;789.2383849585149;790.7588185603389;932.4312169576552;942.0344147249056;946.5693109635099;698.7903628911306;698.7973487688564;698.8567343694531;699.2308460693248;699.3391245273219;14224.217668028254;14320.212388318638;14329;14334.49829255971;14349.426022959069;13815;14048.43806247749;14083.577492675236;14155.716885662332;14233.28833558318;11734.823977640342;11855.110866685032;11966.700832479171;12028.939855300667;12070.27578345302;3962.2075584883137;3966.801659916993;3968.6428221460205;4024.3561030235023;4096.959030409687;56193.43806561923;56614;58127.41872581305;58562.12156817694;58644;9113.635454581743;9116.817663646823;11337.093032557375;11481.770364592661;11520.539178432937;13953.511627093003;14205.076670016417;14214.857851421353;14231.50189743354;14247.78628320576;7800.258975397442;7934.722284720007;8076.626973414416;8142.18578142181;8225.670973161126;5057.544820966131;5119.129747942859;5132.486751324837;5158.767855446514;5265.815696450606;3179.586653735;3198.056573310879;3201.695838895301;3203.8718451262152;3204.5673834032573;495.6951474843018;496.44646219465034;499.398225138707;500.2046745674395;500.3720330984664;569.4334137533181;719.9568025918462;723.2731105239201;744.5383862005591;765.4450523370512;8946.910530894738;8967.820643587222;9001.099890011077;9003.324750643727;9035.683751068682;576.5243673968993;589.2428229724783;603.5563860562484;643.829385212919;756.4477931110321;4445.310976798602;4543.704659197141;4599.586037256663;4600.838970636011;4621;72279;73189.26810731931;73258;73384.63307683427;73470;61451.38548614546;61956;62771;62908;63059;57674.71162644244;58110.12834807481;58345.99999999915;58803.70598146982;58990;8916.074337147216;8976.640934362813;8986.640534378552;9043.909560904307;9170.67902623405;41637;42413;42544.57455425406;43230.351544727484;43276.35085473784;50263;56458.15312770394;57288.42711572831;57814.132788009054;58065.129023065536;8020.358371330396;8201.343892488705;8284.50292982423;8302.211289927447;8366.372522060748;12767.233965962072;12808.359582021048;12856.742865142833;13016.869831301567;13318.334083295991;11376.601818936297;11697.707557311136;11703.882961170279;11730.12024098213;12059.336736479578;11636.243644163102;11785.587504437304;11834.289942603471;12055.939720301343;12290.139690221598;11433.142514311294;11495.482703278205;11809.350485723367;11880.405979700807;11986.280823150639;9848.950755246178;9990.500474976077;10020.849687254842;10180.49097545105;10222.284440089123;9494.525273736424;9695.951520242636;9798.902010980084;9805.754856128653;9813.803723925625 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: __startTimestamp1453118989358__endTimestamp 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:09:49 INFO - 2016-01-18 04:09:49,368 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:09:49 INFO - 2016-01-18 04:09:49,369 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,369 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5636.63 Median:5910.73 stddev:624.71 (10.6%) stddev-sans-first:599.77 04:09:49 INFO - 2016-01-18 04:09:49,369 DEBUG : BROWSER_OUTPUT: Values: 3326.6 3386.8 3395.7 3422.9 3424.8 5534.3 5574.7 5585.3 5591.9 5611.7 5597.2 5600.0 5610.2 5622.2 5628.4 5000.1 5088.5 5094.1 5160.3 5210.2 5175.4 5186.3 5200.8 5201.9 5204.6 5027.1 5143.4 5159.0 5219.3 5225.8 5071.2 5154.2 5202.7 5220.1 5224.2 5129.8 5160.1 5172.1 5178.9 5226.3 5239.4 5340.1 5344.4 5394.8 5459.6 6094.3 6096.1 6098.5 6100.8 6105.5 6111.2 6145.0 6147.6 6149.2 6151.1 5435.8 5547.1 5554.4 5635.5 5668.3 6202.7 6203.6 6210.7 6211.4 6220.3 5844.1 6022.1 6039.1 6048.8 6063.1 6006.9 6072.0 6080.9 6091.9 6121.8 6027.5 6035.9 6065.7 6082.6 6088.3 5711.8 5846.5 6097.1 6106.1 6111.0 4591.6 4600.9 4625.4 4683.1 4694.6 4212.3 4219.5 4225.8 4226.1 4252.2 5614.5 5906.4 5917.4 5917.8 5918.3 5849.1 5922.4 5929.1 5956.9 6053.0 5742.5 5859.0 5866.9 5873.4 5880.3 5143.7 5275.0 5330.1 5335.9 5359.1 6142.3 6172.1 6211.6 6214.8 6215.6 6098.8 6108.5 6124.1 6146.0 6162.2 6105.4 6119.8 6224.8 6319.5 6332.8 5994.9 6029.3 6034.8 6042.9 6045.9 6128.3 6133.5 6134.6 6140.8 6149.0 5766.7 5810.7 5855.0 5949.2 5986.4 5955.3 5991.7 5993.5 5995.5 5997.1 5908.6 5910.7 5911.3 5912.7 5929.6 5828.5 5880.7 5965.3 5973.0 5981.5 5913.3 5928.3 5931.1 5934.7 5939.2 04:09:49 INFO - 2016-01-18 04:09:49,369 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,369 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57143.69 Median:36258.23 stddev:100640.42 (277.6%) stddev-sans-first:100833.07 04:09:49 INFO - 2016-01-18 04:09:49,370 DEBUG : BROWSER_OUTPUT: Values: 559.4 604.3 606.0 612.0 614.1 44275.0 45212.8 45271.8 45313.5 45325.5 47220.3 47396.5 47634.8 47709.5 47751.5 8136.8 8217.3 9263.5 9433.7 10691.9 10839.3 10917.7 10930.6 10942.8 10958.5 11026.4 11099.0 11127.2 11144.0 11151.6 10922.2 10971.9 11039.3 11041.7 11053.0 10762.3 10762.8 10822.8 10841.1 10849.1 45328.0 45797.0 45984.0 46020.0 46029.5 3727.6 3775.6 3889.2 3956.5 4249.9 33764.8 34077.7 34272.5 34397.8 34595.5 3855.4 3858.5 3894.7 3938.5 3967.0 327531.0 329022.0 329149.0 329346.0 329863.0 62627.0 63887.7 66553.7 66919.0 66928.0 73231.0 74639.8 75013.6 75030.0 75105.2 18646.3 18798.6 18805.8 18835.9 18836.2 13250.4 13296.1 13298.1 13298.3 13308.9 22888.4 23070.5 23119.5 23156.9 23194.1 8687.5 8806.7 8854.6 8937.0 8988.0 1013.1 1018.0 1056.2 1090.5 1140.9 31431.8 35120.8 35349.8 35473.3 36312.3 1086.3 1115.5 1128.9 1187.8 1192.0 15814.7 16148.7 16340.4 17484.7 18244.3 452903.0 456572.0 457414.0 458831.0 458845.0 65181.3 65845.3 65931.7 65980.0 66056.0 1524.5 1531.3 1544.6 1554.5 1562.6 32737.5 33165.5 36082.6 36124.5 36149.6 57278.4 57669.1 57940.7 57959.4 58044.7 344875.0 351160.0 351691.0 351840.0 354466.0 31947.5 36150.8 36455.0 36605.0 36846.1 46881.0 48122.5 48476.5 48840.8 48904.0 38308.6 39444.2 39541.8 40812.4 40913.4 40474.8 40520.4 40835.0 40950.4 41417.0 39655.0 40054.0 40186.4 40409.4 40623.4 35705.1 35732.5 36059.8 36249.6 36266.8 27816.2 27924.0 27942.9 28033.9 28189.7 04:09:49 INFO - 2016-01-18 04:09:49,370 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,371 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30975.98 Median:517.58 stddev:98203.05 (18973.4%) stddev-sans-first:98451.67 04:09:49 INFO - 2016-01-18 04:09:49,371 DEBUG : BROWSER_OUTPUT: Values: 385.5 385.8 387.3 392.5 393.8 14393.9 17585.3 20394.4 20439.6 20842.9 19959.8 20112.3 20220.8 20236.1 20243.3 5906.4 6043.3 6043.9 6044.1 6044.8 5914.8 6039.3 6087.1 6095.0 6097.4 4491.5 4618.1 6050.8 6053.0 6053.6 6492.0 6644.4 6678.0 6682.4 6686.7 5653.1 5960.0 6074.3 6081.8 6083.2 24327.1 24486.4 24645.4 25048.7 25153.5 2502.1 2508.1 2527.0 2533.5 2581.4 15175.7 15271.0 15320.8 15368.4 15711.8 1822.3 1845.0 1858.9 1869.4 1961.4 68041.0 69093.0 69345.0 69928.3 70503.3 7989.6 8050.7 8081.9 8122.5 8128.6 9667.1 9680.3 9683.2 9691.8 9698.9 6511.9 6597.0 6612.6 6648.4 6648.6 6867.4 6870.4 6876.9 6884.4 6915.7 3694.6 3720.9 3730.2 3771.8 3783.3 1264.7 1293.6 1309.5 1311.8 1317.3 495.6 504.5 515.5 519.7 527.8 13196.9 13222.0 13479.3 13945.3 13980.7 504.9 547.7 548.5 548.9 549.9 6993.2 7113.5 7151.7 7219.8 7282.1 578320.0 593355.0 601887.0 607490.0 614502.0 86039.6 88731.0 89128.6 89224.6 89849.6 589.1 592.6 593.1 594.2 595.4 12425.8 12561.7 12823.7 12886.6 12897.5 39744.2 40265.6 40343.2 41049.6 41888.6 53678.0 53960.5 55316.2 55670.2 56621.4 7555.9 7694.3 7726.2 7839.9 7845.5 13781.2 13939.1 13972.9 14069.4 14324.6 12149.2 12183.5 12392.9 12520.4 12543.4 11567.2 11865.5 11913.7 12040.8 12182.7 10340.4 10449.7 12155.9 12163.1 12222.6 7641.2 7699.6 7718.2 7721.8 7723.3 11752.3 11821.5 11859.8 11865.6 12114.8 04:09:49 INFO - 2016-01-18 04:09:49,371 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,371 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5801.30 Median:7003.42 stddev:2942.31 (42.0%) stddev-sans-first:2933.25 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: Values: 1554.9 1569.5 1793.0 1817.1 1853.0 7237.4 7370.0 8108.8 8236.1 8252.4 7923.2 8107.4 8188.6 8204.3 8207.0 2410.4 2440.5 2441.4 2445.3 2447.5 2190.9 2223.1 2415.9 2457.7 2477.4 2367.8 2434.9 2438.8 2467.1 2467.2 2427.4 2446.7 2446.9 2448.0 2453.3 2451.9 2492.6 2505.2 2506.7 2507.3 8062.2 8088.4 8107.9 8118.9 8121.3 5121.3 5200.5 5207.4 5208.5 5211.3 3226.8 3293.5 3375.4 3386.8 3389.3 1109.1 1109.7 1168.2 1172.1 1215.9 11132.2 11224.7 11238.6 11243.4 11244.3 4695.1 4739.6 4742.7 4784.3 4789.0 9661.9 9673.6 9689.1 9701.7 9711.6 5247.6 5250.1 5253.4 5257.0 5262.1 4786.1 4790.6 4791.8 4813.4 4813.5 3526.5 3926.0 3948.7 3962.0 3981.3 1220.6 1296.5 1336.5 1344.1 1350.4 1221.4 1236.5 1267.8 1475.2 1497.6 7556.1 7558.4 7566.2 7609.0 7712.0 769.9 776.5 795.2 800.8 913.1 6337.6 6396.0 6415.9 6417.4 6439.1 9402.9 9627.0 9645.5 9650.7 9682.8 9369.4 9540.6 9546.5 9558.9 9560.8 7610.1 7711.3 7711.7 7720.7 7729.1 7747.8 7802.2 7802.8 7852.4 7887.4 8688.9 8867.5 8870.2 8916.9 8923.6 8864.0 8967.7 8995.9 9003.4 9151.3 7524.2 7619.2 7622.2 7625.9 7628.4 6952.7 7101.0 7981.9 8040.7 8098.6 7503.3 7540.5 7540.8 7541.6 7662.7 7459.4 7484.5 7502.9 7573.7 7582.1 7502.5 7556.0 7672.5 7729.5 7731.6 7054.1 7080.9 7091.9 7094.1 7097.5 6539.5 6675.1 6691.6 6696.2 6704.6 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5257.92 Median:5979.96 stddev:1540.56 (25.8%) stddev-sans-first:1500.40 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: Values: 361.3 362.9 366.3 368.6 371.5 5777.5 5854.9 5868.5 5882.8 5893.3 5717.2 5796.4 5800.9 5810.6 5814.7 4595.8 4600.7 4601.6 4606.9 4609.5 4435.2 4505.1 4523.6 4623.2 4634.5 4505.3 4546.5 4574.9 4588.5 4600.4 4547.6 4558.9 4559.5 4566.5 4570.2 4075.1 4075.2 4081.0 4081.5 4090.3 5474.2 5546.7 5556.9 5589.6 5601.7 5226.0 5228.3 5230.7 5233.0 5234.2 6005.3 6210.1 6210.3 6215.3 6219.3 4282.0 4376.1 4432.3 4433.3 4437.3 6306.3 6348.4 6384.4 6390.2 6394.5 4541.6 4549.5 4559.6 4562.0 4563.9 4521.1 4596.0 4598.7 4606.7 4685.9 5313.8 5315.7 5323.6 5325.4 5327.7 6282.5 6292.7 6294.4 6295.1 6297.4 1658.9 1661.7 1663.1 1677.2 1682.1 1119.5 1124.2 1130.0 1144.5 1148.3 6130.8 6162.9 6172.7 6173.4 6173.6 6480.1 6482.5 6484.4 6491.1 6493.7 5954.6 6058.1 6064.3 6065.7 6075.9 3563.8 3588.6 3591.0 3593.6 3593.9 6518.6 6572.6 6587.9 6600.5 6607.1 6528.5 6614.0 6635.1 6637.2 6637.5 6611.5 6636.6 6660.7 6663.1 6679.1 6295.6 6384.3 6481.4 6481.8 6489.7 6271.7 6286.1 6325.4 6348.4 6350.4 6618.4 6625.6 6628.1 6629.6 6632.8 4514.1 4553.6 4553.8 4556.4 4556.8 6394.4 6411.1 6413.2 6417.8 6418.4 6197.6 6246.2 6246.3 6248.8 6271.6 6199.4 6212.3 6224.2 6240.2 6256.2 6211.0 6215.3 6217.1 6221.5 6223.8 6315.6 6335.8 6345.6 6346.5 6351.6 6099.8 6152.5 6187.8 6194.2 6206.4 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,372 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15853.27 Median:28928.93 stddev:20004.66 (69.2%) stddev-sans-first:20029.10 04:09:49 INFO - 2016-01-18 04:09:49,373 DEBUG : BROWSER_OUTPUT: Values: 859.9 905.8 941.2 950.0 972.2 15126.0 15541.4 15549.1 15564.9 15579.0 13664.4 13760.7 13766.0 13784.7 13796.3 762.0 764.4 902.6 906.6 920.1 908.1 913.3 915.5 919.3 920.8 954.5 955.7 959.0 959.9 962.8 789.2 790.8 932.4 942.0 946.6 698.8 698.8 698.9 699.2 699.3 14224.2 14320.2 14329.0 14334.5 14349.4 13815.0 14048.4 14083.6 14155.7 14233.3 11734.8 11855.1 11966.7 12028.9 12070.3 3962.2 3966.8 3968.6 4024.4 4097.0 56193.4 56614.0 58127.4 58562.1 58644.0 9113.6 9116.8 11337.1 11481.8 11520.5 13953.5 14205.1 14214.9 14231.5 14247.8 7800.3 7934.7 8076.6 8142.2 8225.7 5057.5 5119.1 5132.5 5158.8 5265.8 3179.6 3198.1 3201.7 3203.9 3204.6 495.7 496.4 499.4 500.2 500.4 569.4 720.0 723.3 744.5 765.4 8946.9 8967.8 9001.1 9003.3 9035.7 576.5 589.2 603.6 643.8 756.4 4445.3 4543.7 4599.6 4600.8 4621.0 72279.0 73189.3 73258.0 73384.6 73470.0 61451.4 61956.0 62771.0 62908.0 63059.0 57674.7 58110.1 58346.0 58803.7 58990.0 8916.1 8976.6 8986.6 9043.9 9170.7 41637.0 42413.0 42544.6 43230.4 43276.4 50263.0 56458.2 57288.4 57814.1 58065.1 8020.4 8201.3 8284.5 8302.2 8366.4 12767.2 12808.4 12856.7 13016.9 13318.3 11376.6 11697.7 11703.9 11730.1 12059.3 11636.2 11785.6 11834.3 12055.9 12290.1 11433.1 11495.5 11809.4 11880.4 11986.3 9849.0 9990.5 10020.8 10180.5 10222.3 9494.5 9696.0 9798.9 9805.8 9813.8 04:09:49 INFO - 2016-01-18 04:09:49,373 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:09:49 INFO - 2016-01-18 04:09:49,373 DEBUG : BROWSER_OUTPUT: 04:09:49 INFO - 2016-01-18 04:09:49,976 INFO : Browser exited with error code: 0 04:09:49 INFO - 2016-01-18 04:09:49,994 INFO : Completed test dromaeo_css (00:18:29) 04:09:49 INFO - 2016-01-18 04:09:49,994 INFO : Starting test kraken 04:09:49 INFO - 2016-01-18 04:09:49,995 DEBUG : operating with platform_type : linux_ 04:09:49 INFO - 2016-01-18 04:09:49,995 INFO : Initialising browser for kraken test... 04:09:50 INFO - 2016-01-18 04:09:50,001 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSYZAC8/profile http://localhost:38811/getInfo.html 04:09:53 INFO - 2016-01-18 04:09:53,269 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:53 INFO - 2016-01-18 04:09:53,269 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:53 INFO - 2016-01-18 04:09:53,269 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:53 INFO - 2016-01-18 04:09:53,269 DEBUG : BROWSER_OUTPUT: __metrics 04:09:53 INFO - 2016-01-18 04:09:53,330 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:53 INFO - 2016-01-18 04:09:53,892 DEBUG : BROWSER_OUTPUT: console.error: 04:09:53 INFO - 2016-01-18 04:09:53,892 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 04:09:53 INFO - 2016-01-18 04:09:53,892 DEBUG : BROWSER_OUTPUT: Stack: 04:09:53 INFO - 2016-01-18 04:09:53,892 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 04:09:53 INFO - 2016-01-18 04:09:53,893 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 04:09:53 INFO - 2016-01-18 04:09:53,893 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.scheduleWalkerLoop/<@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:1 04:09:53 INFO - 2016-01-18 04:09:53,893 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 04:09:53 INFO - 2016-01-18 04:09:53,893 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 04:09:53 INFO - 2016-01-18 04:09:53,893 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 04:09:53 INFO - 2016-01-18 04:09:53,894 DEBUG : BROWSER_OUTPUT: 04:09:54 INFO - 2016-01-18 04:09:54,400 INFO : Browser initialized. 04:09:54 INFO - 2016-01-18 04:09:54,401 INFO : Running cycle 1/1 for kraken test... 04:09:54 INFO - 2016-01-18 04:09:54,401 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSYZAC8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:05 INFO - 2016-01-18 04:10:05,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 128344064 04:10:05 INFO - 2016-01-18 04:10:05,954 DEBUG : BROWSER_OUTPUT: 04:10:08 INFO - 2016-01-18 04:10:08,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38811/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:08 INFO - 2016-01-18 04:10:08,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 163688448 04:10:08 INFO - 2016-01-18 04:10:08,958 DEBUG : BROWSER_OUTPUT: 04:10:11 INFO - 2016-01-18 04:10:11,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38811/tests/kraken/driver.html?testName=audio-dft) 04:10:12 INFO - 2016-01-18 04:10:12,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 161763328 04:10:12 INFO - 2016-01-18 04:10:12,041 DEBUG : BROWSER_OUTPUT: 04:10:14 INFO - 2016-01-18 04:10:14,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38811/tests/kraken/driver.html?testName=audio-fft) 04:10:15 INFO - 2016-01-18 04:10:15,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 157736960 04:10:15 INFO - 2016-01-18 04:10:15,367 DEBUG : BROWSER_OUTPUT: 04:10:17 INFO - 2016-01-18 04:10:17,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38811/tests/kraken/driver.html?testName=audio-oscillator) 04:10:17 INFO - 2016-01-18 04:10:17,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 158228480 04:10:17 INFO - 2016-01-18 04:10:17,892 DEBUG : BROWSER_OUTPUT: 04:10:20 INFO - 2016-01-18 04:10:20,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38811/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:20 INFO - 2016-01-18 04:10:20,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 156426240 04:10:20 INFO - 2016-01-18 04:10:20,588 DEBUG : BROWSER_OUTPUT: 04:10:23 INFO - 2016-01-18 04:10:23,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38811/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:24 INFO - 2016-01-18 04:10:24,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 156033024 04:10:24 INFO - 2016-01-18 04:10:24,032 DEBUG : BROWSER_OUTPUT: 04:10:27 INFO - 2016-01-18 04:10:27,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38811/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:27 INFO - 2016-01-18 04:10:27,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 157220864 04:10:27 INFO - 2016-01-18 04:10:27,885 DEBUG : BROWSER_OUTPUT: 04:10:30 INFO - 2016-01-18 04:10:30,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38811/tests/kraken/driver.html?testName=json-parse-financial) 04:10:31 INFO - 2016-01-18 04:10:31,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 156925952 04:10:31 INFO - 2016-01-18 04:10:31,185 DEBUG : BROWSER_OUTPUT: 04:10:32 INFO - 2016-01-18 04:10:32,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38811/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:33 INFO - 2016-01-18 04:10:33,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 161722368 04:10:33 INFO - 2016-01-18 04:10:33,235 DEBUG : BROWSER_OUTPUT: 04:10:34 INFO - 2016-01-18 04:10:34,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:35 INFO - 2016-01-18 04:10:35,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 161193984 04:10:35 INFO - 2016-01-18 04:10:35,576 DEBUG : BROWSER_OUTPUT: 04:10:37 INFO - 2016-01-18 04:10:37,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:38 INFO - 2016-01-18 04:10:38,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 164311040 04:10:38 INFO - 2016-01-18 04:10:38,115 DEBUG : BROWSER_OUTPUT: 04:10:40 INFO - 2016-01-18 04:10:40,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:40 INFO - 2016-01-18 04:10:40,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 165765120 04:10:40 INFO - 2016-01-18 04:10:40,969 DEBUG : BROWSER_OUTPUT: 04:10:43 INFO - 2016-01-18 04:10:43,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:43 INFO - 2016-01-18 04:10:43,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 166690816 04:10:43 INFO - 2016-01-18 04:10:43,949 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38811/tests/kraken/driver.html?testName=ai-astar) 04:10:45 INFO - 2016-01-18 04:10:45,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 225013760 04:10:45 INFO - 2016-01-18 04:10:45,800 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,801 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:10:45 INFO - 2016-01-18 04:10:45,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:10:45 INFO - 2016-01-18 04:10:45,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:10:45 INFO - 2016-01-18 04:10:45,802 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:10:45 INFO - 2016-01-18 04:10:45,802 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;107;109;109;98;108;106;108 04:10:45 INFO - 2016-01-18 04:10:45,803 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;146;153;127;144;149;121;153;122 04:10:45 INFO - 2016-01-18 04:10:45,803 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;161;161;158;159;160;162;160;158 04:10:45 INFO - 2016-01-18 04:10:45,803 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;71;142;72;70;71;71;159;78 04:10:45 INFO - 2016-01-18 04:10:45,803 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;88;89;135;89;90;90;131;89;90;136 04:10:45 INFO - 2016-01-18 04:10:45,803 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;109;109;110 04:10:45 INFO - 2016-01-18 04:10:45,804 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;145;145;145;146;145;145;144;146 04:10:45 INFO - 2016-01-18 04:10:45,804 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 04:10:45 INFO - 2016-01-18 04:10:45,804 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;56;55;54;55;54;57;57;52;53 04:10:45 INFO - 2016-01-18 04:10:45,804 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;61;61;61;61;61;61;62;63 04:10:45 INFO - 2016-01-18 04:10:45,805 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;78;78;79;80;79;77;78;78;80 04:10:45 INFO - 2016-01-18 04:10:45,805 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;114;107;106;121;110;114;109;127;108 04:10:45 INFO - 2016-01-18 04:10:45,805 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;127;138;136;137;131;136;137;135;150;138 04:10:45 INFO - 2016-01-18 04:10:45,805 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;62;62;63;62;61;61;62;61;60 04:10:45 INFO - 2016-01-18 04:10:45,806 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:10:45 INFO - 2016-01-18 04:10:45,806 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:10:45 INFO - 2016-01-18 04:10:45,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 04:10:45 INFO - 2016-01-18 04:10:45,806 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:10:45 INFO - 2016-01-18 04:10:45,807 DEBUG : BROWSER_OUTPUT: __startTimestamp1453119045800__endTimestamp 04:10:45 INFO - 2016-01-18 04:10:45,807 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,808 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:10:45 INFO - 2016-01-18 04:10:45,808 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:10:45 INFO - 2016-01-18 04:10:45,809 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,809 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:3.47 (3.2%) stddev-sans-first:3.57 04:10:45 INFO - 2016-01-18 04:10:45,809 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 107.0 109.0 109.0 98.0 108.0 106.0 108.0 04:10:45 INFO - 2016-01-18 04:10:45,809 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,810 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.50 stddev:13.10 (8.9%) stddev-sans-first:13.23 04:10:45 INFO - 2016-01-18 04:10:45,810 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 146.0 153.0 127.0 144.0 149.0 121.0 153.0 122.0 04:10:45 INFO - 2016-01-18 04:10:45,810 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,811 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 04:10:45 INFO - 2016-01-18 04:10:45,811 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 161.0 161.0 158.0 159.0 160.0 162.0 160.0 158.0 04:10:45 INFO - 2016-01-18 04:10:45,811 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.60 Median:71.00 stddev:33.47 (47.1%) stddev-sans-first:34.95 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 142.0 72.0 70.0 71.0 71.0 159.0 78.0 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:89.00 stddev:21.64 (24.3%) stddev-sans-first:22.29 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: Values: 88.0 89.0 135.0 89.0 90.0 90.0 131.0 89.0 90.0 136.0 04:10:45 INFO - 2016-01-18 04:10:45,812 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 145.0 145.0 145.0 146.0 145.0 145.0 144.0 146.0 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:10:45 INFO - 2016-01-18 04:10:45,813 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.71 (3.1%) stddev-sans-first:1.72 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: Values: 53.0 56.0 55.0 54.0 55.0 54.0 57.0 57.0 52.0 53.0 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 63.0 04:10:45 INFO - 2016-01-18 04:10:45,814 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 78.0 79.0 80.0 79.0 77.0 78.0 78.0 80.0 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:112.00 stddev:6.82 (6.1%) stddev-sans-first:7.04 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: Values: 108.0 114.0 107.0 106.0 121.0 110.0 114.0 109.0 127.0 108.0 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:137.00 stddev:5.87 (4.3%) stddev-sans-first:5.13 04:10:45 INFO - 2016-01-18 04:10:45,815 DEBUG : BROWSER_OUTPUT: Values: 127.0 138.0 136.0 137.0 131.0 136.0 137.0 135.0 150.0 138.0 04:10:45 INFO - 2016-01-18 04:10:45,816 DEBUG : BROWSER_OUTPUT: 04:10:45 INFO - 2016-01-18 04:10:45,816 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.14 (1.8%) stddev-sans-first:0.88 04:10:45 INFO - 2016-01-18 04:10:45,816 DEBUG : BROWSER_OUTPUT: Values: 64.0 62.0 62.0 63.0 62.0 61.0 61.0 62.0 61.0 60.0 04:10:45 INFO - 2016-01-18 04:10:45,816 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:10:45 INFO - 2016-01-18 04:10:45,816 DEBUG : BROWSER_OUTPUT: 04:10:46 INFO - 2016-01-18 04:10:46,524 INFO : Browser exited with error code: 0 04:10:46 INFO - 2016-01-18 04:10:46,580 INFO : Completed test kraken (00:00:56) 04:10:46 INFO - 2016-01-18 04:10:46,580 INFO : Starting test v8_7 04:10:46 INFO - 2016-01-18 04:10:46,580 DEBUG : operating with platform_type : linux_ 04:10:46 INFO - 2016-01-18 04:10:46,580 INFO : Initialising browser for v8_7 test... 04:10:46 INFO - 2016-01-18 04:10:46,586 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU2yYol/profile http://localhost:38811/getInfo.html 04:10:49 INFO - 2016-01-18 04:10:49,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:49 INFO - 2016-01-18 04:10:49,917 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:49 INFO - 2016-01-18 04:10:49,917 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:49 INFO - 2016-01-18 04:10:49,917 DEBUG : BROWSER_OUTPUT: __metrics 04:10:50 INFO - 2016-01-18 04:10:50,079 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:10:51 INFO - 2016-01-18 04:10:51,144 INFO : Browser initialized. 04:10:51 INFO - 2016-01-18 04:10:51,145 INFO : Running cycle 1/1 for v8_7 test... 04:10:51 INFO - 2016-01-18 04:10:51,145 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU2yYol/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:11:02 INFO - 2016-01-18 04:11:02,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 128851968 04:11:02 INFO - 2016-01-18 04:11:02,626 DEBUG : BROWSER_OUTPUT: 04:11:23 INFO - 2016-01-18 04:11:23,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38811/tests/v8_7/run.html (next: http://localhost:38811/tests/v8_7/run.html) 04:11:24 INFO - 2016-01-18 04:11:24,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 420540416 04:11:24 INFO - 2016-01-18 04:11:24,219 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: |0;Richards;162.73393002441009 04:11:24 INFO - 2016-01-18 04:11:24,220 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.06802721088437 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |4;RayTrace;959.6928982725528 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |5;Earley;551.2679162072767 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |6;Boyer;10458.333333333334 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |7;RegExp;23904.761904761905 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |8;Splay;536.7686527106817 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: __startTimestamp1453119084219__endTimestamp 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,221 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.73 Median:162.73 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: Values: 162.7 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.07 Median:170.07 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: Values: 170.1 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: Values: 279.4 04:11:24 INFO - 2016-01-18 04:11:24,222 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: Values: 5035.2 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:959.69 Median:959.69 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: Values: 959.7 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.27 Median:551.27 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: Values: 551.3 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10458.33 Median:10458.33 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: Values: 10458.3 04:11:24 INFO - 2016-01-18 04:11:24,223 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23904.76 Median:23904.76 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: Values: 23904.8 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:536.77 Median:536.77 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: Values: 536.8 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: Values: 4817.3 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:11:24 INFO - 2016-01-18 04:11:24,224 DEBUG : BROWSER_OUTPUT: 04:11:24 INFO - 2016-01-18 04:11:24,852 INFO : Browser exited with error code: 0 04:11:24 INFO - 2016-01-18 04:11:24,866 INFO : Completed test v8_7 (00:00:38) 04:11:25 INFO - 2016-01-18 04:11:25,276 INFO : Completed test suite (00:20:04) 04:11:25 INFO - 2016-01-18 04:11:25,276 DEBUG : Working with test: dromaeo_css 04:11:25 INFO - 2016-01-18 04:11:25,276 DEBUG : Generating results file: dromaeo_css 04:11:25 INFO - 2016-01-18 04:11:25,278 DEBUG : Working with test: kraken 04:11:25 INFO - 2016-01-18 04:11:25,278 DEBUG : Generating results file: kraken 04:11:25 INFO - 2016-01-18 04:11:25,278 INFO : javascript benchmark 04:11:25 INFO - 2016-01-18 04:11:25,278 DEBUG : Working with test: v8_7 04:11:25 INFO - 2016-01-18 04:11:25,279 DEBUG : Generating results file: v8_7 04:11:25 INFO - 2016-01-18 04:11:25,279 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:25 INFO - 2016-01-18 04:11:25,406 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:11:25 INFO - 2016-01-18 04:11:25,407 DEBUG : process_Request line: dromaeo_css 7317.25 graph.html#tests=[[72,53,35]] 04:11:25 INFO - 2016-01-18 04:11:25,407 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:25 INFO - 2016-01-18 04:11:25,518 DEBUG : process_Request line: kraken 1451.90 graph.html#tests=[[232,53,35]] 04:11:25 INFO - 2016-01-18 04:11:25,518 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:11:25 INFO - 2016-01-18 04:11:25,552 DEBUG : process_Request line: v8_7 23276.62 graph.html#tests=[[230,53,35]] 04:11:25 INFO - 2016-01-18 04:11:25,553 INFO : javascript benchmark 04:11:25 INFO - 2016-01-18 04:11:25,556 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3326.5841769778776, 3386.830658467076, 3395.7283417326616, 3422.8801991930286, 3424.811635360056, 5534.335879694432, 5574.721263936797, 5585.329760428749, 5591.888162236753, 5611.691356975365, 5597.244372009777, 5600.019996500617, 5610.214569960209, 5622.184783206443, 5628.380878103405, 5000.1249781288125, 5088.516590923866, 5094.057599344114, 5160.277561141444, 5210.218467229908, 5175.378954525443, 5186.299849520305, 5200.791968321262, 5201.921971170435, 5204.583633309345, 5027.09512287788, 5143.3570803649545, 5159.0, 5219.295395121667, 5225.843224703246, 5071.1632580624155, 5154.175331946889, 5202.713850738208, 5220.112580861262, 5224.190250511177, 5129.794808207667, 5160.14857548504, 5172.120739474299, 5178.948210517922, 5226.268322434862, 5239.397469291042, 5340.118880384732, 5344.43883392246, 5394.811181608625, 5459.617826752129, 6094.268687757498, 6096.11606317086, 6098.54260930432, 6100.786472473442, 6105.542084343692, 6111.174991376151, 6145.0, 6147.600405973598, 6149.2313460817395, 6151.108089327067, 5435.755391007414, 5547.057000309957, 5554.416786237427, 5635.464630860061, 5668.348139963916, 6202.72087756052, 6203.627782333075, 6210.658413787195, 6211.409916057967, 6220.34686357935, 5844.094165404369, 6022.096685497123, 6039.063945088518, 6048.848778780566, 6063.060225665029, 6006.909896351558, 6072.0, 6080.878382432326, 6091.908621370683, 6121.785737499166, 6027.517798576104, 6035.909461358083, 6065.696715164224, 6082.60463069899, 6088.299845517822, 5711.800086997018, 5846.532277417797, 6097.054956481752, 6106.053561697944, 6110.991686371699, 4591.563801438858, 4600.907981840344, 4625.3755742974945, 4683.086798074342, 4694.600958918462, 4212.283911735012, 4219.493660760667, 4225.809838557272, 4226.091390351028, 4252.213340532012, 5614.466625670555, 5906.438888305604, 5917.378675239124, 5917.7928772493615, 5918.260217472816, 5849.1226316052935, 5922.407759224043, 5929.110633405024, 5956.851078723066, 6053.031514957674, 5742.511886489695, 5858.970705146532, 5866.941330586725, 5873.383294754075, 5880.294364676266, 5143.742812859342, 5275.024120537712, 5330.093884039723, 5335.946640533545, 5359.08895487768, 6142.262928448526, 6172.105044768484, 6211.596246243979, 6214.8135555933395, 6215.564910456224, 6098.817035489031, 6108.541859360477, 6124.112003759519, 6146.0, 6162.22972128484, 6105.358937311518, 6119.8470038247615, 6224.813255602339, 6319.46284565817, 6332.810015699536, 5994.940050599438, 6029.336772954884, 6034.758609655564, 6042.90935635957, 6045.909311360245, 6128.325884152829, 6133.478654314434, 6134.570580059353, 6140.846478837886, 6148.9692551536955, 5766.740496677576, 5810.738516766671, 5854.970725146517, 5949.196858424058, 5986.431289027535, 5955.2853657559635, 5991.730372133352, 5993.490553302844, 5995.46040856325, 5997.100434934795, 5908.5568582357355, 5910.7340169693325, 5911.261092363455, 5912.674802885883, 5929.555283353679, 5828.475437210672, 5880.735366908585, 5965.254343207099, 5973.0, 5981.52147828164, 5913.349531551612, 5928.288605367384, 5931.110333450017, 5934.673592952429, 5939.227900372924], "unit": "ms", "name": "dojo.html", "value": 5596.2806110472}, {"lowerIsBetter": false, "replicates": [559.441929731742, 604.3171216525327, 605.9728759752222, 611.9510439164867, 614.1494030767386, 44275.0, 45212.77393613032, 45271.77364113183, 45313.546864531345, 45325.54674453254, 47220.29169562459, 47396.52603473973, 47634.76182619091, 47709.52290477094, 47751.522484775145, 8136.837263254732, 8217.301529369981, 9263.490508022056, 9433.716988490321, 10691.893081069167, 10839.295445796037, 10917.672469825919, 10930.617428390007, 10942.781144377108, 10958.506867190956, 11026.393548354838, 11099.0, 11127.221094523387, 11144.0, 11151.553937842476, 10922.235443518957, 10971.890281097167, 11039.337639741641, 11041.723956901142, 11053.0, 10762.300450470773, 10762.838557421645, 10822.837657435144, 10841.13270938323, 10849.132069434427, 45328.0, 45797.0, 45984.0, 46020.0, 46029.53970460286, 3727.627237276278, 3775.6413140751583, 3889.202713443737, 3956.485656864618, 4249.915001699979, 33764.83117584397, 34077.659223407696, 34272.48591271133, 34397.82801086004, 34595.48106778401, 3855.4409610606585, 3858.479105320802, 3894.727369084137, 3938.468306778577, 3966.960330396688, 327531.0, 329022.0, 329149.0, 329346.0, 329863.0, 62627.0, 63887.68056159782, 66553.66723166354, 66919.0, 66928.0, 73231.0, 74639.77521573438, 75013.62493187499, 75030.0, 75105.24894750983, 18646.34737784171, 18798.624027519647, 18805.811941880405, 18835.90582047081, 18836.152373143243, 13250.403731832092, 13296.135751176143, 13298.135621184592, 13298.268595227355, 13308.866911330957, 22888.427789305068, 23070.538589228123, 23119.53760924806, 23156.884215578815, 23194.072237110664, 8687.52218627969, 8806.735797926072, 8854.645814167361, 8937.0, 8987.955060224656, 1013.1236480444362, 1017.9949100254452, 1056.2447849787438, 1090.5419723716059, 1140.925839820409, 31431.842840785648, 35120.824395877855, 35349.823250884096, 35473.290534189175, 36312.27375452476, 1086.3481910853425, 1115.475726408603, 1128.9040431563244, 1187.8337032815414, 1191.980856367793, 15814.68370632581, 16148.677026459405, 16340.428085017205, 17484.65030699379, 18244.270229190683, 452903.0, 456572.0, 457414.0, 458831.0, 458845.0, 65181.34818651753, 65845.34154658488, 65931.67034164799, 65980.0, 66056.0, 1524.4588171199064, 1531.257340190007, 1544.5984044148827, 1554.5414102839463, 1562.640592663671, 32737.50893736548, 33165.50251746178, 36082.63917360898, 36124.45813312855, 36149.638503614624, 57278.42721572731, 57669.13496297643, 57940.71029644825, 57959.420405795405, 58044.70977645085, 344875.0, 351160.0, 351691.0, 351840.0, 354466.0, 31947.520787187746, 36150.8192459036, 36455.0, 36605.0, 36846.078848029014, 46880.97895408212, 48122.518774811804, 48476.5152348472, 48840.755796220794, 48904.0, 38308.616913830505, 39444.2111157781, 39541.80229098836, 40812.38781418222, 40913.38629920613, 40474.797626011685, 40520.392194116524, 40835.0, 40950.385744213265, 41416.980802355916, 39655.0, 40054.0, 40186.39720404138, 40409.39385909273, 40623.39064913969, 35705.1073723159, 35732.46401304034, 36059.81970090133, 36249.637503624625, 36266.8186659065, 27816.176543713296, 27923.955579583242, 27942.901449332698, 28033.939490509714, 28189.71810281953], "unit": "ms", "name": "ext.html", "value": 21467.293911291505}, {"lowerIsBetter": false, "replicates": [385.46776563161455, 385.8386257365331, 387.32798594438646, 392.54072734900166, 393.7814512945316, 14393.928030359859, 17585.296588136476, 20394.388168354955, 20439.591208175847, 20842.89578552105, 19959.800401995977, 20112.296069637567, 20220.797792022076, 20236.08937597808, 20243.291484798036, 5906.37983011784, 6043.305019922721, 6043.909341359883, 6044.063170208625, 6044.818655440322, 5914.763409463616, 6039.305479869805, 6087.05650624154, 6094.969525152368, 6097.359777223394, 4491.528389519102, 4618.12255671423, 6050.788222412217, 6053.0, 6053.636781793084, 6492.0, 6644.368784965469, 6678.0, 6682.365175308338, 6686.732530698766, 5653.095504719226, 5959.970200149015, 6074.301455332649, 6081.817545473643, 6083.239595050619, 24327.148549800848, 24486.387840303956, 24645.383865403328, 25048.749512505005, 25153.49693006148, 2502.0867383404925, 2508.109621084507, 2527.027094568586, 2533.4679717259396, 2581.4320849413098, 15175.696486070327, 15271.0, 15320.770188447183, 15368.385264589402, 15711.764323535157, 1822.261983896524, 1844.9538761530935, 1858.8605854560963, 1869.44851268876, 1961.3821646181407, 68040.9999999995, 69093.0, 69345.0, 69928.30071699269, 70503.29496705018, 7989.640466179036, 8050.718224862218, 8081.868538404628, 8122.472039317544, 8128.552929588811, 9667.081627245401, 9680.322377433653, 9683.225341972626, 9691.806163876683, 9698.854517182248, 6511.934880651228, 6597.043428702811, 6612.570182938093, 6648.434883034899, 6648.601083934883, 6867.381935625817, 6870.381665650016, 6876.862462750817, 6884.4148247399535, 6915.654217289115, 3694.6305369463375, 3720.925581488355, 3730.235301763132, 3771.792551409644, 3783.281176576442, 1264.7091169030991, 1293.6313150751992, 1309.4958441000283, 1311.849137349198, 1317.3413293353324, 495.5960891873112, 504.50306448148547, 515.4536191636877, 519.714157213531, 527.7519565804066, 13196.868031319564, 13222.0, 13479.326033698277, 13945.302734863217, 13980.720385592434, 504.94950504949213, 547.6850810783815, 548.483443279333, 548.9258950041693, 549.8680316724037, 6993.230744618088, 7113.5376200547835, 7151.713931442788, 7219.783406497709, 7282.12614486265, 578320.0, 593355.0, 601886.9905650443, 607490.0, 614502.0, 86039.56980215058, 88731.0, 89128.5543572278, 89224.5538772302, 89849.55075224713, 589.1163255117324, 592.5674257791836, 593.0511182108678, 594.197832925547, 595.4373117404011, 12425.751484970431, 12561.685957851127, 12823.679408014874, 12886.613401597968, 12897.548585799826, 39744.2051158981, 40265.59734402619, 40343.19313613653, 41049.589504105774, 41888.58111418847, 53678.0, 53960.46039539712, 55316.17025744537, 55670.16494752663, 56621.43378566326, 7555.886661700189, 7694.345980591713, 7726.1501234863, 7839.902413661978, 7845.450818442654, 13781.173129612256, 13939.09395889264, 13972.860271397156, 14069.366878490697, 14324.57026289213, 12149.210301330386, 12183.512659493876, 12392.938035309766, 12520.373981300716, 12543.372831358578, 11567.190296679151, 11865.525378984745, 11913.702157446132, 12040.75918481608, 12182.695432614255, 10340.431276279876, 10449.68650940473, 12155.939220303842, 12163.148579599343, 12222.633321000385, 7641.197674244347, 7699.615019248903, 7718.189590092959, 7721.845563088819, 7723.266289702469, 11752.294862307946, 11821.527138914691, 11859.822102668639, 11865.644030679094, 12114.75770484603], "unit": "ms", "name": "jquery.html", "value": 8256.666251979494}, {"lowerIsBetter": false, "replicates": [1554.8522890325414, 1569.4899157773727, 1793.023580855778, 1817.1096162880187, 1852.99938033462, 7237.384822290099, 7370.0, 8108.837823243532, 8236.09402965674, 8252.422330436872, 7923.207679232089, 8107.432479726407, 8188.590570471482, 8204.261616454518, 8207.0, 2410.3853517353095, 2440.511897620474, 2441.3652450362943, 2445.254197469771, 2447.4615584571366, 2190.9342719718356, 2223.1107556977177, 2415.855048697084, 2457.69278840145, 2477.417806815397, 2367.75138610446, 2434.866082365469, 2438.794773586496, 2467.099508679328, 2467.247489515706, 2427.3567504611206, 2446.7063952325657, 2446.9143579974702, 2447.9632805507845, 2453.288546321565, 2451.9387015324583, 2492.5887228607257, 2505.185814610241, 2506.724260331362, 2507.3230227838562, 8062.234087761653, 8088.352931765504, 8107.918920810835, 8118.878216826753, 8121.30968867647, 5121.334226550562, 5200.5059519345605, 5207.401148867891, 5208.5051920067535, 5211.270422140903, 3226.757993150523, 3293.5059741038795, 3375.375555522236, 3386.762926595139, 3389.254364039907, 1109.0960866893456, 1109.7003808971613, 1168.182272409317, 1172.0916289875329, 1215.9452824622913, 11132.220744547885, 11224.66326010221, 11238.550457981753, 11243.381614011227, 11244.325340479516, 4695.084458530554, 4739.644526660514, 4742.715437073786, 4784.2823576463115, 4788.976055119771, 9661.9033809661, 9673.613055477703, 9689.079537443931, 9701.6604418845, 9711.611535538641, 5247.63266571344, 5250.081235783722, 5253.395859476209, 5256.9737151314, 5262.10544207478, 4786.138495070851, 4790.640701947368, 4791.832285869978, 4813.3983252093485, 4813.518648135228, 3526.4710293456187, 3925.980370098131, 3948.664363529132, 3962.0293028208275, 3981.3231750602467, 1220.6155061155707, 1296.5267677297718, 1336.4921329894578, 1344.072589912957, 1350.3585796746663, 1221.3893053473264, 1236.5239382837672, 1267.8351814264086, 1475.203390169318, 1497.5582203249849, 7556.1310449297935, 7558.433117516099, 7566.167721550625, 7609.0, 7712.0, 769.8883661868998, 776.4952780692595, 795.1928792275729, 800.8398320335956, 913.1051569461964, 6337.6197428154455, 6395.968020159869, 6415.903761443582, 6417.39034791694, 6439.130717353191, 9402.90597094034, 9626.989166137595, 9645.517724113906, 9650.71047868565, 9682.806343873082, 9369.390989585656, 9540.570674319672, 9546.474943878153, 9558.90441095594, 9560.760980975392, 7610.086789585285, 7711.305982461606, 7711.652975615999, 7720.729774457867, 7729.111152217454, 7747.806304842198, 7802.21977802238, 7802.765917022499, 7852.37181025528, 7887.408444366581, 8688.869666954874, 8867.512286824029, 8870.201681848665, 8916.86624700643, 8923.553822308728, 8864.0, 8967.730968070968, 8995.865062024206, 9003.414778039669, 9151.267898567965, 7524.172341042371, 7619.161892191965, 7622.237776222333, 7625.885611715939, 7628.389728821792, 6952.721891124298, 7101.041359416413, 7981.920180798118, 8040.67837286502, 8098.635561399633, 7503.287187717158, 7540.509866858637, 7540.8491830164185, 7541.6229188539255, 7662.73180438682, 7459.365953893763, 7484.513506622052, 7502.924970750441, 7573.659185336563, 7582.128055273493, 7502.474826762074, 7556.0177176966645, 7672.501287416523, 7729.458937874295, 7731.574763388067, 7054.118235220598, 7080.858382832417, 7091.929080709333, 7094.077769889881, 7097.467689923174, 6539.509536784665, 6675.098861653614, 6691.59850408977, 6696.19645642526, 6704.631245281556], "unit": "ms", "name": "mootools.html", "value": 4773.575383300286}, {"lowerIsBetter": false, "replicates": [361.3098980946392, 362.85485805677723, 366.3497292306155, 368.625844767561, 371.5133175540043, 5777.508911742507, 5854.88290234195, 5868.471837534621, 5882.764689412418, 5893.292804863411, 5717.2281741964825, 5796.362400135992, 5800.854978625536, 5810.622309549876, 5814.709264536767, 4595.770211489429, 4600.700954437968, 4601.585857272845, 4606.907861842761, 4609.539046095397, 4435.157320109185, 4505.12150130723, 4523.61549268311, 4623.2371658676275, 4634.536546345372, 4505.324201369788, 4546.47715512717, 4574.885627859314, 4588.4723256825555, 4600.378948841913, 4547.636189104864, 4558.931616025762, 4559.521250268707, 4566.520515345874, 4570.177368073745, 4075.0627355708057, 4075.205334959684, 4081.0205550667624, 4081.530623978251, 4090.3046482097816, 5474.151506516457, 5546.667199967975, 5556.91664625031, 5589.580781441367, 5601.719914004324, 5226.033183860998, 5228.320318358589, 5230.660007099526, 5232.9738351308, 5234.241035049935, 6005.3394126646035, 6210.099535567318, 6210.254769427697, 6215.316315205324, 6219.253689557237, 4282.036541778106, 4376.146651402978, 4432.268675668543, 4433.290673492225, 4437.312216606431, 6306.306306306303, 6348.396902294275, 6384.3934826191435, 6390.201224846847, 6394.456471199954, 4541.636669066466, 4549.522300158502, 4559.612432943237, 4562.019165879352, 4563.863084107482, 4521.11838191556, 4595.977020114878, 4598.724076555417, 4606.677532572688, 4685.8594242172785, 5313.814016509404, 5315.707636079976, 5323.574114070865, 5325.440828713007, 5327.680339179584, 6282.465990390777, 6292.653904035231, 6294.433500984934, 6295.087212354275, 6297.401746834135, 1658.9004659720456, 1661.6759731852173, 1663.12685839935, 1677.1614192903548, 1682.0832646207846, 1119.4626579241847, 1124.1849658997162, 1130.0338210829786, 1144.5250221158292, 1148.2995372822572, 6130.846728831815, 6162.938370616326, 6172.722227499773, 6173.41352571505, 6173.59871608344, 6480.125183100221, 6482.513811464159, 6484.416402523795, 6491.091247225392, 6493.675316234169, 5954.583179177503, 6058.12157237207, 6064.272287325549, 6065.696715164312, 6075.939240607538, 3563.80399078048, 3588.5693716753635, 3591.048372181374, 3593.6047034826147, 3593.9101522462147, 6518.57629254097, 6572.572782769104, 6587.934120658828, 6600.537962342686, 6607.141071660653, 6528.520939048694, 6614.0, 6635.137432133792, 6637.23671777742, 6637.46900247979, 6611.537192396486, 6636.601803891685, 6660.70026848793, 6663.133792607027, 6679.098321726602, 6295.5907865988565, 6384.329645387167, 6481.4166724994975, 6481.805545833632, 6489.675516224075, 6271.745650869753, 6286.088517164894, 6325.399087086719, 6348.365163483615, 6350.364963503613, 6618.404343609098, 6625.602463852184, 6628.138342015507, 6629.602223866584, 6632.83417914556, 4514.142312960527, 4553.61294289989, 4553.8406155785715, 4556.362109304634, 4556.8177272908715, 6394.392532709385, 6411.134496842867, 6413.16628838248, 6417.839554011187, 6418.390252925965, 6197.597156184834, 6246.187995560548, 6246.250449945854, 6248.843778905563, 6271.592346497463, 6199.442050215503, 6212.347703491068, 6224.1597384352535, 6240.188775459162, 6256.186695729526, 6211.0372892201785, 6215.254169499508, 6217.129601855653, 6221.502279817694, 6223.813285601439, 6315.5894866833505, 6335.809925702236, 6345.587536810092, 6346.460550853045, 6351.555391122762, 6099.75600975956, 6152.538559607958, 6187.783427580013, 6194.225721784777, 6206.441420272197], "unit": "ms", "name": "prototype.html", "value": 4772.847063261417}, {"lowerIsBetter": false, "replicates": [859.9484030958141, 905.7509184974132, 941.2093841173413, 949.9930074121428, 972.2173650211581, 15126.0, 15541.37834486622, 15549.067055976635, 15564.922175389107, 15579.0, 13664.38510267038, 13760.724785504284, 13766.036377453558, 13784.724305513884, 13796.31018449076, 762.0246085011166, 764.396127059625, 902.562257305208, 906.6373450619772, 920.052346083535, 908.1418059933366, 913.2739472119648, 915.4873270968279, 919.2554031234688, 920.7882187096972, 954.4798085043668, 955.6559638530124, 959.0, 959.9424034557949, 962.7929995051063, 789.2383849585149, 790.7588185603389, 932.4312169576552, 942.0344147249056, 946.5693109635099, 698.7903628911306, 698.7973487688564, 698.8567343694531, 699.2308460693248, 699.3391245273219, 14224.217668028254, 14320.212388318638, 14329.0, 14334.49829255971, 14349.426022959069, 13815.0, 14048.43806247749, 14083.577492675236, 14155.716885662332, 14233.28833558318, 11734.823977640342, 11855.110866685032, 11966.700832479171, 12028.939855300667, 12070.27578345302, 3962.2075584883137, 3966.801659916993, 3968.6428221460205, 4024.3561030235023, 4096.959030409687, 56193.43806561923, 56614.0, 58127.41872581305, 58562.12156817694, 58644.0, 9113.635454581743, 9116.817663646823, 11337.093032557375, 11481.770364592661, 11520.539178432937, 13953.511627093003, 14205.076670016417, 14214.857851421353, 14231.50189743354, 14247.78628320576, 7800.258975397442, 7934.722284720007, 8076.626973414416, 8142.18578142181, 8225.670973161126, 5057.544820966131, 5119.129747942859, 5132.486751324837, 5158.767855446514, 5265.815696450606, 3179.586653735, 3198.056573310879, 3201.695838895301, 3203.8718451262152, 3204.5673834032573, 495.6951474843018, 496.44646219465034, 499.398225138707, 500.2046745674395, 500.3720330984664, 569.4334137533181, 719.9568025918462, 723.2731105239201, 744.5383862005591, 765.4450523370512, 8946.910530894738, 8967.820643587222, 9001.099890011077, 9003.324750643727, 9035.683751068682, 576.5243673968993, 589.2428229724783, 603.5563860562484, 643.829385212919, 756.4477931110321, 4445.310976798602, 4543.704659197141, 4599.586037256663, 4600.838970636011, 4621.0, 72279.0, 73189.26810731931, 73258.0, 73384.63307683427, 73470.0, 61451.38548614546, 61956.0, 62771.0, 62908.0, 63059.0, 57674.71162644244, 58110.12834807481, 58345.99999999915, 58803.70598146982, 58990.0, 8916.074337147216, 8976.640934362813, 8986.640534378552, 9043.909560904307, 9170.67902623405, 41637.0, 42413.0, 42544.57455425406, 43230.351544727484, 43276.35085473784, 50263.0, 56458.15312770394, 57288.42711572831, 57814.132788009054, 58065.129023065536, 8020.358371330396, 8201.343892488705, 8284.50292982423, 8302.211289927447, 8366.372522060748, 12767.233965962072, 12808.359582021048, 12856.742865142833, 13016.869831301567, 13318.334083295991, 11376.601818936297, 11697.707557311136, 11703.882961170279, 11730.12024098213, 12059.336736479578, 11636.243644163102, 11785.587504437304, 11834.289942603471, 12055.939720301343, 12290.139690221598, 11433.142514311294, 11495.482703278205, 11809.350485723367, 11880.405979700807, 11986.280823150639, 9848.950755246178, 9990.500474976077, 10020.849687254842, 10180.49097545105, 10222.284440089123, 9494.525273736424, 9695.951520242636, 9798.902010980084, 9805.754856128653, 9813.803723925625], "unit": "ms", "name": "yui.html", "value": 6791.152265645318}], "name": "dromaeo_css", "value": 7317.247640040251}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 107.0, 109.0, 109.0, 98.0, 108.0, 106.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.7}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 146.0, 153.0, 127.0, 144.0, 149.0, 121.0, 153.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 161.0, 161.0, 158.0, 159.0, 160.0, 162.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 142.0, 72.0, 70.0, 71.0, 71.0, 159.0, 78.0], "unit": "ms", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [88.0, 89.0, 135.0, 89.0, 90.0, 90.0, 131.0, 89.0, 90.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 55.0, 54.0, 55.0, 54.0, 57.0, 57.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 61.4}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 78.0, 79.0, 80.0, 79.0, 77.0, 78.0, 78.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [108.0, 114.0, 107.0, 106.0, 121.0, 110.0, 114.0, 109.0, 127.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [127.0, 138.0, 136.0, 137.0, 131.0, 136.0, 137.0, 135.0, 150.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0, 61.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 61.8}], "name": "kraken", "value": 1451.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.73393002441009], "unit": "score", "name": "Richards", "value": 216.93078999999992}, {"lowerIsBetter": false, "replicates": [170.06802721088437], "unit": "score", "name": "DeltaBlue", "value": 388.77383999999984}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [959.6928982725528], "unit": "score", "name": "RayTrace", "value": 771.0685379999996}, {"lowerIsBetter": false, "replicates": [551.2679162072767], "unit": "score", "name": "Earley", "value": 1208.9638819999998}, {"lowerIsBetter": false, "replicates": [10458.333333333334], "unit": "score", "name": "Boyer", "value": 63.725545816733074}, {"lowerIsBetter": false, "replicates": [23904.761904761905], "unit": "score", "name": "RegExp", "value": 38.10893426294821}, {"lowerIsBetter": false, "replicates": [536.7686527106817], "unit": "score", "name": "Splay", "value": 151.81773299999998}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23276.620958328145}]} 04:11:25 INFO - RETURN: dromaeo_css: 7317.25 04:11:25 INFO - RETURN: kraken: 1451.90 04:11:25 INFO - RETURN: v8_7: 23276.62 04:11:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23276.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1451.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7317.25"}}} 04:11:25 INFO - Return code: 0 04:11:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:11:25 INFO - # TBPL SUCCESS # 04:11:25 INFO - Running post-action listener: _resource_record_post_action 04:11:25 INFO - Running post-run listener: _resource_record_post_run 04:11:26 INFO - Total resource usage - Wall time: 1220s; CPU: 12.0%; Read bytes: 315392; Write bytes: 277585920; Read time: 56; Write time: 139280 04:11:26 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 14077952; Read time: 0; Write time: 1372 04:11:26 INFO - run-tests - Wall time: 1206s; CPU: 12.0%; Read bytes: 315392; Write bytes: 263507968; Read time: 56; Write time: 137908 04:11:26 INFO - Running post-run listener: _upload_blobber_files 04:11:26 INFO - Blob upload gear active. 04:11:26 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:11:26 INFO - Copying logs to upload dir... 04:11:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.776299 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-18 04:11:26.305969) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-18 04:11:26.309076) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010041 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453109721/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-18 04:11:26.359619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:11:26.359939) ========= 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=20e666a3d4cfbb71505a330e000001b4-1453116564.67682-1346336138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:11:26.409436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 04:11:26.409748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 04:11:26.410032) ========= ========= Total master_lag: 0.27 =========