builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1457927490.51 results: success (0) buildid: 20160313180626 builduid: 0105a0b2ac1f4f7c911a6c1e4d62ee6b revision: 34a219cbd67d2bf0c555321ef8308a6aefcef23d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.508833) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.509236) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.509540) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006338 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.535888) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.536154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.552958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.553298) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.602969) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.603228) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.603604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.603902) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-13 20:51:30-- 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% 88.8M=0s 2016-03-13 20:51:31 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.763645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.763940) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.824116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:30.824573) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 34a219cbd67d2bf0c555321ef8308a6aefcef23d --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-aurora --rev 34a219cbd67d2bf0c555321ef8308a6aefcef23d --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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-13 20:51:31,141 truncating revision to first 12 chars 2016-03-13 20:51:31,141 Setting DEBUG logging. 2016-03-13 20:51:31,141 attempt 1/10 2016-03-13 20:51:31,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/34a219cbd67d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 20:51:31,397 unpacking tar archive at: mozilla-aurora-34a219cbd67d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:31.394710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:31.395050) ========= echo 34a219cbd67d2bf0c555321ef8308a6aefcef23d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34a219cbd67d2bf0c555321ef8308a6aefcef23d'] 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 34a219cbd67d2bf0c555321ef8308a6aefcef23d program finished with exit code 0 elapsedTime=0.003816 script_repo_revision: '34a219cbd67d2bf0c555321ef8308a6aefcef23d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:31.443162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:31.443469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 20:51:31.455057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-13 20:51:31.455321) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:51:31 INFO - MultiFileLogger online at 20160313 20:51:31 in /builds/slave/test-pgo 20:51:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:51:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:51:31 INFO - {'append_to_log': False, 20:51:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:51:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:51:31 INFO - 'branch': 'Mozilla-Aurora', 20:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 20:51:31 INFO - 'config_files': ('talos/linux_config.py',), 20:51:31 INFO - 'default_actions': ('clobber', 20:51:31 INFO - 'read-buildbot-config', 20:51:31 INFO - 'download-and-extract', 20:51:31 INFO - 'populate-webroot', 20:51:31 INFO - 'create-virtualenv', 20:51:31 INFO - 'install', 20:51:31 INFO - 'run-tests'), 20:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:51:31 INFO - 'download_minidump_stackwalk': True, 20:51:31 INFO - 'download_symbols': 'ondemand', 20:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 20:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 20:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:51:31 INFO - 'installer_path': 'installer.exe', 20:51:31 INFO - 'log_level': 'info', 20:51:31 INFO - 'log_name': 'talos', 20:51:31 INFO - 'log_to_console': True, 20:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:51:31 INFO - 'opt_config_files': (), 20:51:31 INFO - 'pip_index': False, 20:51:31 INFO - 'sps_profile': False, 20:51:31 INFO - 'sps_profile_interval': 0, 20:51:31 INFO - 'suite': 'dromaeojs', 20:51:31 INFO - 'system_bits': '32', 20:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:51:31 INFO - 'title': 'talos-linux64-ix-011', 20:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:51:31 INFO - 'use_talos_json': True, 20:51:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:51:31 INFO - 'work_dir': 'build'} 20:51:31 INFO - ##### 20:51:31 INFO - ##### Running clobber step. 20:51:31 INFO - ##### 20:51:31 INFO - Running pre-action listener: _resource_record_pre_action 20:51:31 INFO - Running main action method: clobber 20:51:31 INFO - rmtree: /builds/slave/test-pgo/build 20:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:51:32 INFO - Running post-action listener: _resource_record_post_action 20:51:32 INFO - ##### 20:51:32 INFO - ##### Running read-buildbot-config step. 20:51:32 INFO - ##### 20:51:32 INFO - Running pre-action listener: _resource_record_pre_action 20:51:32 INFO - Running main action method: read_buildbot_config 20:51:32 INFO - Using buildbot properties: 20:51:32 INFO - { 20:51:32 INFO - "project": "", 20:51:32 INFO - "product": "firefox", 20:51:32 INFO - "script_repo_revision": "production", 20:51:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:51:32 INFO - "repository": "", 20:51:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:51:32 INFO - "buildid": "20160313180626", 20:51:32 INFO - "pgo_build": "True", 20:51:32 INFO - "basedir": "/builds/slave/test-pgo", 20:51:32 INFO - "buildnumber": 353, 20:51:32 INFO - "slavename": "talos-linux64-ix-011", 20:51:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:51:32 INFO - "platform": "ubuntu64_hw", 20:51:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:51:32 INFO - "branch": "mozilla-aurora", 20:51:32 INFO - "repo_path": "releases/mozilla-aurora", 20:51:32 INFO - "revision": "34a219cbd67d2bf0c555321ef8308a6aefcef23d", 20:51:32 INFO - "stage_platform": "linux64-pgo", 20:51:32 INFO - "builduid": "0105a0b2ac1f4f7c911a6c1e4d62ee6b", 20:51:32 INFO - "slavebuilddir": "test" 20:51:32 INFO - } 20:51:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 20:51:32 INFO - Running post-action listener: _resource_record_post_action 20:51:32 INFO - ##### 20:51:32 INFO - ##### Running download-and-extract step. 20:51:32 INFO - ##### 20:51:32 INFO - Running pre-action listener: _resource_record_pre_action 20:51:32 INFO - Running main action method: download_and_extract 20:51:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:32 INFO - https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 20:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 20:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 20:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:51:33 INFO - Downloaded 1448 bytes. 20:51:33 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 20:51:33 INFO - Using the following test package requirements: 20:51:33 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 20:51:33 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:51:33 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:51:33 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'jsshell-linux-x86_64.zip'], 20:51:33 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:51:33 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 20:51:33 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:51:33 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:51:33 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:51:33 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 20:51:33 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 20:51:33 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:51:33 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:33 INFO - https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:51:34 INFO - Downloaded 23306096 bytes. 20:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:51:36 INFO - Return code: 0 20:51:36 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:36 INFO - https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 20:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:51:38 INFO - Downloaded 23306096 bytes. 20:51:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:51:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:51:39 INFO - Return code: 0 20:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:39 INFO - https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 20:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 20:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 20:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:51:40 INFO - Downloaded 10845161 bytes. 20:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:51:41 INFO - Return code: 0 20:51:41 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')]} 20:51:41 INFO - https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 20:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 20:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 20:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:51:43 INFO - Downloaded 60439973 bytes. 20:51:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 20:51:43 INFO - mkdir: /builds/slave/test-pgo/properties 20:51:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:51:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:51:43 INFO - Contents: 20:51:43 INFO - build_url:https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 20:51:43 INFO - Running post-action listener: _resource_record_post_action 20:51:43 INFO - Running post-action listener: set_extra_try_arguments 20:51:43 INFO - ##### 20:51:43 INFO - ##### Running populate-webroot step. 20:51:43 INFO - ##### 20:51:44 INFO - Running pre-action listener: _resource_record_pre_action 20:51:44 INFO - Running main action method: populate_webroot 20:51:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:51:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:51:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:51:44 INFO - '--tppagecycles', 20:51:44 INFO - '7'], 20:51:44 INFO - 'tests': ['tsvgm']}}, 20:51:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:51:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:51:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:51:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:51:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:51:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:51:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'tests': ['damp', 'tps']}, 20:51:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['damp', 'tps']}, 20:51:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:51:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:51:44 INFO - 'other': {'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'other_l64': {'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'other_nol64': {'tests': ['a11yr', 20:51:44 INFO - 'ts_paint', 20:51:44 INFO - 'tpaint', 20:51:44 INFO - 'sessionrestore', 20:51:44 INFO - 'sessionrestore_no_auto_restore', 20:51:44 INFO - 'tabpaint']}, 20:51:44 INFO - 'svgr': {'tests': ['tsvgx', 20:51:44 INFO - 'tsvgr_opacity', 20:51:44 INFO - 'tart', 20:51:44 INFO - 'tscrollx', 20:51:44 INFO - 'cart']}, 20:51:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['tsvgx', 20:51:44 INFO - 'tsvgr_opacity', 20:51:44 INFO - 'tart', 20:51:44 INFO - 'tscrollx', 20:51:44 INFO - 'cart']}, 20:51:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'tests': ['tp5o']}, 20:51:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'talos_options': ['--e10s'], 20:51:44 INFO - 'tests': ['tp5o']}, 20:51:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'talos_options': ['--xperf_path', 20:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:51:44 INFO - 'tests': ['tp5n']}, 20:51:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:44 INFO - 'talos_options': ['--e10s', 20:51:44 INFO - '--xperf_path', 20:51:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:51:44 INFO - 'tests': ['tp5n']}}, 20:51:44 INFO - 'talos.zip': {'path': '', 20:51:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:51:44 INFO - Running post-action listener: _resource_record_post_action 20:51:44 INFO - ##### 20:51:44 INFO - ##### Running create-virtualenv step. 20:51:44 INFO - ##### 20:51:44 INFO - Running pre-action listener: _resource_record_pre_action 20:51:44 INFO - Running main action method: create_virtualenv 20:51:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:51:44 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 20:51:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:51:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:51:44 INFO - Using real prefix '/usr' 20:51:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:51:44 INFO - Installing distribute.............................................................................................................................................................................................done. 20:51:46 INFO - Installing pip.................done. 20:51:46 INFO - Return code: 0 20:51:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:51: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')]} 20:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:51:46 INFO - Using env: {'DISPLAY': ':0', 20:51:46 INFO - 'HOME': '/home/cltbld', 20:51:46 INFO - 'LANG': 'en_US.UTF-8', 20:51:46 INFO - 'LANGUAGE': 'en_US:en', 20:51:46 INFO - 'LOGNAME': 'cltbld', 20:51:46 INFO - 'MAIL': '/var/mail/cltbld', 20:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:46 INFO - 'MOZ_NO_REMOTE': '1', 20:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:46 INFO - 'NO_EM_RESTART': '1', 20:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:46 INFO - 'SHELL': '/bin/bash', 20:51:46 INFO - 'SHLVL': '1', 20:51:46 INFO - 'TERM': 'linux', 20:51:46 INFO - 'TMOUT': '86400', 20:51:46 INFO - 'USER': 'cltbld', 20:51:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:46 INFO - '_': '/tools/buildbot/bin/python'} 20:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:46 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 20:51:46 INFO - Cleaning up... 20:51:46 INFO - Return code: 0 20:51:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:51: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')]} 20:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:51:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:51:46 INFO - Using env: {'DISPLAY': ':0', 20:51:46 INFO - 'HOME': '/home/cltbld', 20:51:46 INFO - 'LANG': 'en_US.UTF-8', 20:51:46 INFO - 'LANGUAGE': 'en_US:en', 20:51:46 INFO - 'LOGNAME': 'cltbld', 20:51:46 INFO - 'MAIL': '/var/mail/cltbld', 20:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:46 INFO - 'MOZ_NO_REMOTE': '1', 20:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:46 INFO - 'NO_EM_RESTART': '1', 20:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:46 INFO - 'SHELL': '/bin/bash', 20:51:46 INFO - 'SHLVL': '1', 20:51:46 INFO - 'TERM': 'linux', 20:51:46 INFO - 'TMOUT': '86400', 20:51:46 INFO - 'USER': 'cltbld', 20:51:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:46 INFO - '_': '/tools/buildbot/bin/python'} 20:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:47 INFO - Downloading/unpacking psutil>=0.7.1 20:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:51:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:51:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:51:48 INFO - Installing collected packages: psutil 20:51:48 INFO - Running setup.py install for psutil 20:51:49 INFO - building 'psutil._psutil_linux' extension 20:51:49 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 20:51:49 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 20:51:49 INFO - building 'psutil._psutil_posix' extension 20:51:49 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 20:51:49 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 20:51:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:51:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:51:49 INFO - Successfully installed psutil 20:51:49 INFO - Cleaning up... 20:51:49 INFO - Return code: 0 20:51:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:51:49 INFO - Using env: {'DISPLAY': ':0', 20:51:49 INFO - 'HOME': '/home/cltbld', 20:51:49 INFO - 'LANG': 'en_US.UTF-8', 20:51:49 INFO - 'LANGUAGE': 'en_US:en', 20:51:49 INFO - 'LOGNAME': 'cltbld', 20:51:49 INFO - 'MAIL': '/var/mail/cltbld', 20:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:49 INFO - 'MOZ_NO_REMOTE': '1', 20:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:49 INFO - 'NO_EM_RESTART': '1', 20:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:49 INFO - 'SHELL': '/bin/bash', 20:51:49 INFO - 'SHLVL': '1', 20:51:49 INFO - 'TERM': 'linux', 20:51:49 INFO - 'TMOUT': '86400', 20:51:49 INFO - 'USER': 'cltbld', 20:51:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:49 INFO - '_': '/tools/buildbot/bin/python'} 20:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:51:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:51:51 INFO - Installing collected packages: mozsystemmonitor 20:51:51 INFO - Running setup.py install for mozsystemmonitor 20:51:51 INFO - Successfully installed mozsystemmonitor 20:51:51 INFO - Cleaning up... 20:51:51 INFO - Return code: 0 20:51:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:51: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')]} 20:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:51:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:51:51 INFO - Using env: {'DISPLAY': ':0', 20:51:51 INFO - 'HOME': '/home/cltbld', 20:51:51 INFO - 'LANG': 'en_US.UTF-8', 20:51:51 INFO - 'LANGUAGE': 'en_US:en', 20:51:51 INFO - 'LOGNAME': 'cltbld', 20:51:51 INFO - 'MAIL': '/var/mail/cltbld', 20:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:51 INFO - 'MOZ_NO_REMOTE': '1', 20:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:51 INFO - 'NO_EM_RESTART': '1', 20:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:51 INFO - 'SHELL': '/bin/bash', 20:51:51 INFO - 'SHLVL': '1', 20:51:51 INFO - 'TERM': 'linux', 20:51:51 INFO - 'TMOUT': '86400', 20:51:51 INFO - 'USER': 'cltbld', 20:51:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:51 INFO - '_': '/tools/buildbot/bin/python'} 20:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:51:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:51:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:51:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:51:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:54 INFO - Downloading docopt-0.6.1.tar.gz 20:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:51:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:51:54 INFO - Running setup.py install for blobuploader 20:51:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:51:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:51:54 INFO - Running setup.py install for requests 20:51:54 INFO - Running setup.py install for docopt 20:51:54 INFO - Successfully installed blobuploader requests docopt 20:51:54 INFO - Cleaning up... 20:51:55 INFO - Return code: 0 20:51:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:51: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')]} 20:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:51:55 INFO - Using env: {'DISPLAY': ':0', 20:51:55 INFO - 'HOME': '/home/cltbld', 20:51:55 INFO - 'LANG': 'en_US.UTF-8', 20:51:55 INFO - 'LANGUAGE': 'en_US:en', 20:51:55 INFO - 'LOGNAME': 'cltbld', 20:51:55 INFO - 'MAIL': '/var/mail/cltbld', 20:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:55 INFO - 'MOZ_NO_REMOTE': '1', 20:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:55 INFO - 'NO_EM_RESTART': '1', 20:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:55 INFO - 'SHELL': '/bin/bash', 20:51:55 INFO - 'SHLVL': '1', 20:51:55 INFO - 'TERM': 'linux', 20:51:55 INFO - 'TMOUT': '86400', 20:51:55 INFO - 'USER': 'cltbld', 20:51:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:55 INFO - '_': '/tools/buildbot/bin/python'} 20:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:51:55 INFO - Running setup.py (path:/tmp/pip-Nugkz0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:51:55 INFO - Running setup.py (path:/tmp/pip-xbsxEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:51:55 INFO - Running setup.py (path:/tmp/pip-DO_k3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:51:55 INFO - Running setup.py (path:/tmp/pip-RGiU6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:51:55 INFO - Running setup.py (path:/tmp/pip-obYTr6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:51:55 INFO - Running setup.py (path:/tmp/pip-4ohGuU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:51:55 INFO - Running setup.py (path:/tmp/pip-TB_Rbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:51:55 INFO - Running setup.py (path:/tmp/pip-5zutTq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:51:55 INFO - Running setup.py (path:/tmp/pip-Qv1IDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:51:55 INFO - Running setup.py (path:/tmp/pip-1BfnmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:51:56 INFO - Running setup.py (path:/tmp/pip-AgNBnQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:51:56 INFO - Running setup.py (path:/tmp/pip-OBeEwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:51:56 INFO - Running setup.py (path:/tmp/pip-wvvJhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:51:56 INFO - Running setup.py (path:/tmp/pip-7H0k9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:51:56 INFO - Running setup.py (path:/tmp/pip-WPuHVD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:51:56 INFO - Running setup.py (path:/tmp/pip-Zdg5_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:51:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:51:56 INFO - Running setup.py (path:/tmp/pip-zTHCky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:51:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:51:56 INFO - Running setup.py install for manifestparser 20:51:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:51:56 INFO - Running setup.py install for mozcrash 20:51:56 INFO - Running setup.py install for mozdebug 20:51:56 INFO - Running setup.py install for mozdevice 20:51:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:51:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:51:56 INFO - Running setup.py install for mozfile 20:51:57 INFO - Running setup.py install for mozhttpd 20:51:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozinfo 20:51:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozInstall 20:51:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozleak 20:51:57 INFO - Running setup.py install for mozlog 20:51:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for moznetwork 20:51:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozprocess 20:51:57 INFO - Running setup.py install for mozprofile 20:51:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozrunner 20:51:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:51:57 INFO - Running setup.py install for mozscreenshot 20:51:58 INFO - Running setup.py install for moztest 20:51:58 INFO - Running setup.py install for mozversion 20:51:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:51:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:51:58 INFO - Cleaning up... 20:51:58 INFO - Return code: 0 20:51:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:51: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')]} 20:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:51:58 INFO - Using env: {'DISPLAY': ':0', 20:51:58 INFO - 'HOME': '/home/cltbld', 20:51:58 INFO - 'LANG': 'en_US.UTF-8', 20:51:58 INFO - 'LANGUAGE': 'en_US:en', 20:51:58 INFO - 'LOGNAME': 'cltbld', 20:51:58 INFO - 'MAIL': '/var/mail/cltbld', 20:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:58 INFO - 'MOZ_NO_REMOTE': '1', 20:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:51:58 INFO - 'NO_EM_RESTART': '1', 20:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:51:58 INFO - 'SHELL': '/bin/bash', 20:51:58 INFO - 'SHLVL': '1', 20:51:58 INFO - 'TERM': 'linux', 20:51:58 INFO - 'TMOUT': '86400', 20:51:58 INFO - 'USER': 'cltbld', 20:51:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:58 INFO - '_': '/tools/buildbot/bin/python'} 20:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:51:58 INFO - Running setup.py (path:/tmp/pip-epL3TY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:51:58 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:51:58 INFO - Running setup.py (path:/tmp/pip-5rRaio-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:51:58 INFO - Running setup.py (path:/tmp/pip-H2XoVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:51:58 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:51:58 INFO - Running setup.py (path:/tmp/pip-3Bqt7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:51:58 INFO - Running setup.py (path:/tmp/pip-ipIoQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:51:58 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:51:58 INFO - Running setup.py (path:/tmp/pip-F7bi1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:51:58 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)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:51:58 INFO - Running setup.py (path:/tmp/pip-zuM2K5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 20:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:51:59 INFO - Running setup.py (path:/tmp/pip-S8eM7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:51:59 INFO - Running setup.py (path:/tmp/pip-Vf2E20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:51:59 INFO - Running setup.py (path:/tmp/pip-EUszIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:51:59 INFO - Running setup.py (path:/tmp/pip-itygrc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:51:59 INFO - Running setup.py (path:/tmp/pip-UcBNCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:51:59 INFO - Running setup.py (path:/tmp/pip-4KUjKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:51:59 INFO - Running setup.py (path:/tmp/pip-pgAeug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:51:59 INFO - Running setup.py (path:/tmp/pip-puqVd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:51:59 INFO - Running setup.py (path:/tmp/pip-ZXWHRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:51:59 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)) 20:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:51:59 INFO - Running setup.py (path:/tmp/pip-duSUYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:51:59 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)) 20:51:59 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:51: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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:51:59 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)) 20:51: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:51:59 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:51:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:52:01 INFO - Downloading blessings-1.6.tar.gz 20:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:52:01 INFO - Installing collected packages: blessings 20:52:01 INFO - Running setup.py install for blessings 20:52:01 INFO - Successfully installed blessings 20:52:01 INFO - Cleaning up... 20:52:02 INFO - Return code: 0 20:52:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:52:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:52:02 INFO - Reading from file tmpfile_stdout 20:52:02 INFO - Current package versions: 20:52:02 INFO - argparse == 1.2.1 20:52:02 INFO - blessings == 1.6 20:52:02 INFO - blobuploader == 1.2.4 20:52:02 INFO - docopt == 0.6.1 20:52:02 INFO - manifestparser == 1.1 20:52:02 INFO - mozInstall == 1.12 20:52:02 INFO - mozcrash == 0.17 20:52:02 INFO - mozdebug == 0.1 20:52:02 INFO - mozdevice == 0.48 20:52:02 INFO - mozfile == 1.2 20:52:02 INFO - mozhttpd == 0.7 20:52:02 INFO - mozinfo == 0.9 20:52:02 INFO - mozleak == 0.1 20:52:02 INFO - mozlog == 3.1 20:52:02 INFO - moznetwork == 0.27 20:52:02 INFO - mozprocess == 0.22 20:52:02 INFO - mozprofile == 0.28 20:52:02 INFO - mozrunner == 6.11 20:52:02 INFO - mozscreenshot == 0.1 20:52:02 INFO - mozsystemmonitor == 0.0 20:52:02 INFO - moztest == 0.7 20:52:02 INFO - mozversion == 1.4 20:52:02 INFO - psutil == 3.1.1 20:52:02 INFO - requests == 1.2.3 20:52:02 INFO - wsgiref == 0.1.2 20:52:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:52: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')]} 20:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52: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')]} 20:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:52:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 20:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:52:02 INFO - Using env: {'DISPLAY': ':0', 20:52:02 INFO - 'HOME': '/home/cltbld', 20:52:02 INFO - 'LANG': 'en_US.UTF-8', 20:52:02 INFO - 'LANGUAGE': 'en_US:en', 20:52:02 INFO - 'LOGNAME': 'cltbld', 20:52:02 INFO - 'MAIL': '/var/mail/cltbld', 20:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:02 INFO - 'MOZ_NO_REMOTE': '1', 20:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:02 INFO - 'NO_EM_RESTART': '1', 20:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:52:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:52:02 INFO - 'SHELL': '/bin/bash', 20:52:02 INFO - 'SHLVL': '1', 20:52:02 INFO - 'TERM': 'linux', 20:52:02 INFO - 'TMOUT': '86400', 20:52:02 INFO - 'USER': 'cltbld', 20:52:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:02 INFO - '_': '/tools/buildbot/bin/python'} 20:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 20:52:02 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 2)) 20:52:02 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 3)) 20:52:02 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 4)) 20:52:02 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 5)) 20:52:02 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 6)) 20:52:02 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 7)) 20:52:02 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 8)) 20:52:02 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 9)) 20:52:02 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:52:02 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 4)) 20:52:02 INFO - Cleaning up... 20:52:02 INFO - Return code: 0 20:52:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:52: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')]} 20:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52: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')]} 20:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:52:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:52:02 INFO - Using env: {'DISPLAY': ':0', 20:52:02 INFO - 'HOME': '/home/cltbld', 20:52:02 INFO - 'LANG': 'en_US.UTF-8', 20:52:02 INFO - 'LANGUAGE': 'en_US:en', 20:52:02 INFO - 'LOGNAME': 'cltbld', 20:52:02 INFO - 'MAIL': '/var/mail/cltbld', 20:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:02 INFO - 'MOZ_NO_REMOTE': '1', 20:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:02 INFO - 'NO_EM_RESTART': '1', 20:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:52:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:52:02 INFO - 'SHELL': '/bin/bash', 20:52:02 INFO - 'SHLVL': '1', 20:52:02 INFO - 'TERM': 'linux', 20:52:02 INFO - 'TMOUT': '86400', 20:52:02 INFO - 'USER': 'cltbld', 20:52:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:02 INFO - '_': '/tools/buildbot/bin/python'} 20:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:52:02 INFO - Downloading/unpacking jsonschema 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:52:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:52:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:52: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 20:52:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:52:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:52:04 INFO - warning: no files found matching '*.txt' 20:52:04 INFO - no previously-included directories found matching 'build' 20:52:04 INFO - no previously-included directories found matching 'dist' 20:52:04 INFO - no previously-included directories found matching '.git*' 20:52:04 INFO - Installing collected packages: jsonschema, functools32 20:52:04 INFO - Running setup.py install for functools32 20:52:04 INFO - warning: no files found matching '*.txt' 20:52:04 INFO - no previously-included directories found matching 'build' 20:52:04 INFO - no previously-included directories found matching 'dist' 20:52:04 INFO - no previously-included directories found matching '.git*' 20:52:04 INFO - Successfully installed jsonschema functools32 20:52:04 INFO - Cleaning up... 20:52:04 INFO - Return code: 0 20:52:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:52:04 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')]} 20:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:04 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')]} 20:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d0ee85f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe506d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', '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 20:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:52:04 INFO - Using env: {'DISPLAY': ':0', 20:52:04 INFO - 'HOME': '/home/cltbld', 20:52:04 INFO - 'LANG': 'en_US.UTF-8', 20:52:04 INFO - 'LANGUAGE': 'en_US:en', 20:52:04 INFO - 'LOGNAME': 'cltbld', 20:52:04 INFO - 'MAIL': '/var/mail/cltbld', 20:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:04 INFO - 'MOZ_NO_REMOTE': '1', 20:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:04 INFO - 'NO_EM_RESTART': '1', 20:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:52:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:52:04 INFO - 'SHELL': '/bin/bash', 20:52:04 INFO - 'SHLVL': '1', 20:52:04 INFO - 'TERM': 'linux', 20:52:04 INFO - 'TMOUT': '86400', 20:52:04 INFO - 'USER': 'cltbld', 20:52:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:04 INFO - '_': '/tools/buildbot/bin/python'} 20:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:52:05 INFO - Downloading/unpacking flake8 20:52:05 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 20:52:05 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 20:52:05 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 20:52:05 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 20:52:05 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 20:52:05 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 20:52:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:52:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:52:06 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 20:52:06 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 20:52:06 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 20:52:06 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 20:52:06 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 20:52:06 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 20:52:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:52:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 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 20:52:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:52:07 INFO - no previously-included directories found matching 'docs/_build' 20:52:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:52:07 INFO - Running setup.py install for pep8 20:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:52:07 INFO - no previously-included directories found matching 'docs/_build' 20:52:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:52:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:52:07 INFO - Cleaning up... 20:52:07 INFO - Return code: 0 20:52:07 INFO - Running post-action listener: _resource_record_post_action 20:52:07 INFO - Running post-action listener: _start_resource_monitoring 20:52:07 INFO - Starting resource monitoring. 20:52:07 INFO - ##### 20:52:07 INFO - ##### Running install step. 20:52:07 INFO - ##### 20:52:07 INFO - Running pre-action listener: _resource_record_pre_action 20:52:07 INFO - Running main action method: install 20:52:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:52:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:52:08 INFO - Reading from file tmpfile_stdout 20:52:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:52:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:52:08 INFO - Reading from file tmpfile_stdout 20:52:08 INFO - Output received: 20:52:08 INFO - Usage: mozinstall [options] installer 20:52:08 INFO - Options: 20:52:08 INFO - -h, --help show this help message and exit 20:52:08 INFO - -d DEST, --destination=DEST 20:52:08 INFO - Directory to install application into. [default: 20:52:08 INFO - "/builds/slave/test-pgo"] 20:52:08 INFO - --app=APP Application being installed. [default: firefox] 20:52:08 INFO - mkdir: /builds/slave/test-pgo/build/application 20:52:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:52:23 INFO - Reading from file tmpfile_stdout 20:52:23 INFO - Output received: 20:52:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:52:23 INFO - Running post-action listener: _resource_record_post_action 20:52:23 INFO - ##### 20:52:23 INFO - ##### Running run-tests step. 20:52:23 INFO - ##### 20:52:23 INFO - Running pre-action listener: _resource_record_pre_action 20:52:23 INFO - Running main action method: run_tests 20:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:52:23 INFO - Python 2.7.3 20:52:23 INFO - Return code: 0 20:52:23 INFO - grabbing minidump binary from tooltool 20:52: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')]} 20:52:23 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 0xedf920>, '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 0xee0820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee0cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:52:23 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 20:52:23 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 20:52:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:52:23 INFO - Return code: 0 20:52:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:52:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:52:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:52:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:52:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:52:24 INFO - Return code: 0 20:52:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:52:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:52:24 INFO - Using env: {'DISPLAY': ':0', 20:52:24 INFO - 'HOME': '/home/cltbld', 20:52:24 INFO - 'LANG': 'en_US.UTF-8', 20:52:24 INFO - 'LANGUAGE': 'en_US:en', 20:52:24 INFO - 'LOGNAME': 'cltbld', 20:52:24 INFO - 'MAIL': '/var/mail/cltbld', 20:52:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:52:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:24 INFO - 'MOZ_NO_REMOTE': '1', 20:52:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:52:24 INFO - 'NO_EM_RESTART': '1', 20:52:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:52:24 INFO - 'PWD': '/builds/slave/test-pgo', 20:52:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:52:24 INFO - 'SHELL': '/bin/bash', 20:52:24 INFO - 'SHLVL': '1', 20:52:24 INFO - 'TERM': 'linux', 20:52:24 INFO - 'TMOUT': '86400', 20:52:24 INFO - 'USER': 'cltbld', 20:52:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643', 20:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:24 INFO - '_': '/tools/buildbot/bin/python'} 20:52:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:52:24 INFO - mozversion application_buildid: 20160313180626 20:52:24 INFO - mozversion application_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 20:52:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:52:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:52:24 INFO - mozversion application_name: Firefox 20:52:24 INFO - mozversion application_remotingname: firefox-dev 20:52:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:52:24 INFO - mozversion application_vendor: Mozilla 20:52:24 INFO - mozversion application_version: 47.0a2 20:52:24 INFO - mozversion platform_buildid: 20160313180626 20:52:24 INFO - mozversion platform_changeset: 34a219cbd67d2bf0c555321ef8308a6aefcef23d 20:52:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:52:24 INFO - mozversion platform_version: 47.0a2 20:52:24 INFO - using testdate: 1457927544 20:52:24 INFO - actual date: 1457927544 20:52:24 INFO - starting webserver on 'localhost:36029' 20:52:24 INFO - SUITE-START | Running 2 tests 20:52:24 INFO - TEST-START | dromaeo_css 20:52:24 INFO - operating with platform_type : linux_ 20:52:24 INFO - Initialising browser for dromaeo_css test... 20:52:24 INFO - TEST-INFO | started process 13210 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfr977f/profile http://localhost:36029/getInfo.html) 20:52:29 INFO - PROCESS | 13210 | __metrics Screen width/height:1600/1200 20:52:29 INFO - PROCESS | 13210 | colorDepth:24 20:52:29 INFO - PROCESS | 13210 | Browser inner width/height: 1024/697 20:52:29 INFO - PROCESS | 13210 | __metrics 20:52:31 INFO - PROCESS | 13210 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:52:32 INFO - TEST-INFO | 13210: exit 0 20:52:32 INFO - Browser initialized. 20:52:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:52:32 INFO - TEST-INFO | started process 13300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfr977f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:52:43 INFO - PROCESS | 13300 | RSS: Main: 144650240 20:52:43 INFO - PROCESS | 13300 | 20:53:35 INFO - PROCESS | 13300 | 1457927615228 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] 20:55:42 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36029/tests/dromaeo/cssquery-ext.html) 20:55:44 INFO - PROCESS | 13300 | RSS: Main: 259198976 20:55:44 INFO - PROCESS | 13300 | 20:58:46 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-ext.html (next: http://localhost:36029/tests/dromaeo/cssquery-jquery.html) 20:58:46 INFO - PROCESS | 13300 | RSS: Main: 225116160 20:58:46 INFO - PROCESS | 13300 | 21:01:48 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36029/tests/dromaeo/cssquery-mootools.html) 21:01:49 INFO - PROCESS | 13300 | RSS: Main: 220352512 21:01:49 INFO - PROCESS | 13300 | 21:04:51 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36029/tests/dromaeo/cssquery-prototype.html) 21:04:51 INFO - PROCESS | 13300 | RSS: Main: 196939776 21:04:51 INFO - PROCESS | 13300 | 21:07:54 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36029/tests/dromaeo/cssquery-yui.html) 21:07:54 INFO - PROCESS | 13300 | RSS: Main: 208859136 21:07:54 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:36029/tests/dromaeo/cssquery-yui.html (next: http://localhost:36029/tests/dromaeo/cssquery-dojo.html) 21:10:57 INFO - PROCESS | 13300 | RSS: Main: 254939136 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | __start_tp_report 21:10:57 INFO - PROCESS | 13300 | _x_x_mozilla_page_load 21:10:57 INFO - PROCESS | 13300 | _x_x_mozilla_page_load_details 21:10:57 INFO - PROCESS | 13300 | |i|pagename|runs| 21:10:57 INFO - PROCESS | 13300 | |0;dojo.html;3317.5853018372704;3345.9665403345957;3372;3374.8481318340687;3409.6419875913034;5406.756695948682;5414.0796064669;5417.079096553585;5442.537384322328;5465.808696695616;5418.458154184579;5444.265024221729;5450.809221677242;5452.83641490755;5456.372517160517;4862.854114376574;4943.233798761189;4988.376452943382;5002.799888004475;5046.243063540462;4958.107540642683;5055.191169412895;5055.9241611375855;5060.974695126519;5061.16490779021;4957.330760347343;5014.774335154927;5022.773975171126;5024.0705469488075;5058.898822023557;5040.873978150539;5064.620153488466;5078.31442755227;5081.771320290596;5105.84682459525;4843.4187897452175;4924.261360795874;4995.625328100371;5009.574186194178;5014.648974571782;5210.895782084375;5222.242774797671;5232.241325007891;5239.607029472805;5294.205869119624;5795.88408231833;5822.446867547576;5848.2689663792025;5857.828434313112;5859.121131830217;5913.467787899067;5945.940540594582;5970.761169553212;5974.97012514939;5998.520118390518;5513.255710479074;5516.200150978166;5527.723613819293;5528.281323427928;5530.225768392428;5831;5923.585349025527;5972.731227094791;6009.489193418608;6010.2186715726675;5773.39379365169;5790.71046447676;5792.102224155263;5799.159121927297;5800.854978625483;5857.707114644336;5879.617824841457;5881.441263080001;5888.146218798251;5896.941030589639;5737.168110624019;5803.564732644984;5892.292924849045;5900.940990590125;5926.940730592639;5867.207926929896;5895.911561326584;5905.645661260338;5909.645421274738;5911.261092363455;4372.497162826316;4490.483594386622;4506.662000349987;4507.3689683444345;4542.931856022163;4037.152198038445;4063.146739184745;4076.286649836267;4076.857309994136;4099.877003689894;5525.033119204123;5546.528545073714;5549.944500555023;5551.056320425538;5553.333599967949;5770.913436298459;5850.765969361178;5889.911651325234;5902.439268269508;5916.763329466773;5572.192032155314;5573.554115670737;5594.300712410949;5602.439756024365;5637.436256374412;5081.23781432788;5093.2360145977655;5102.209157580581;5105.0810854045885;5105.310783044241;5920.73356698941;5981.252343457068;6052.425019623129;6118.847028824226;6145.877082458415;5858.179854820329;5866.090755932837;5871.530277577698;5874.324452687995;5880.14737863016;6069.998450255658;6070.0591408331775;6089.878202436015;6094.75620975156;6094.8171554853425;5711.857203569944;5782.5373970081455;5796;5840.707964601668;5867;5927.110933360031;5944.524438045032;5946.405359464019;5947.375525569752;5947.405259474018;5735.971320143372;5782.421757824352;5809.50619197373;5816.272965879265;5827.271591051119;5599.776008959596;5691.630044047124;5703.401142880104;5746.511546518593;5772.19189313488;5659.377468478547;5668.886622267614;5681.062624667049;5683.516901063456;5689.829305120853;5533.806316778893;5753.021986262429;5761.625494342854;5780.682062486603;5796.072628379439;5491.121420572689;5595.216669666169;5656.123300888369;5676.148577713376;5708.400617935057 21:10:57 INFO - PROCESS | 13300 | |1;ext.html;568.985775355616;580.904815012365;587.6914619824591;589.4812564942849;605.5639939243742;31023;31504.369912601735;38430.42354364683;38883.22233555334;38951.80524097382;36708.44937325942;37098.25803483935;37146.8142659287;38145.42781858274;38170.8091459543;8665.566721663923;8853.291736661084;8898.065703101178;8906.153915378029;8924.821503569925;8840.292776577891;9011.369204155711;9075;9075.591598378089;9080.500572468512;9069.274458043341;9143.222826059793;9162.541872906362;9163.450192988408;9175.72472825813;9034.909650903473;9059.320550958671;9079.546022698905;9082.500462474562;9093.772655683595;8823.647054117828;8973.641054357819;8981.910180898172;8987.55062246885;8997.685081022133;40277.79861100676;40743.185136297405;40747;40782.388264176065;40794.796026019976;3575.1598374382;3600.4059330210484;3659.1433803041255;3681.300552894968;3810.942835857464;31633.20916977094;32165.517517237262;32197.195070123435;32219.355612887844;32687.182820429443;3759.248150369937;3785.299719551864;3811.542614886204;3813.2564149990762;3864.111254411473;300285;300774;301361;302103;302307;44905;59465.40534594685;60640;60880.26038828264;60987.695061524406;43568;43670.126597467875;43679.56320436818;43761.78119109384;43798.34302485465;14429.711405771826;14651.560453186421;14654.48709295191;14657.633559161106;14665.48670796517;12137;12189.939050304869;12228.633141005785;12249.203801752858;12271;14841.554753357417;14899.851001490064;15228.390864365523;15257.237138143048;15404.537863864101;5774.711264436762;5861.648301101863;5898.557608179403;5950;5967.9701601491715;936.0358830404695;974.2741657465234;983.9557219924977;1028.4240825137947;1095.3482677806692;30416;30609.69390306113;30767;30854;31235.687643123732;1139.9145064120057;1175.8236264560385;1179.4397661110904;1213.5995121609847;1233.8149277608431;15656.765148522782;16506.2572184252;17612.559686007695;18160.545986350182;18281.45155645333;449273;451257;452113;454213;454754;58393;58854.411455884896;58930;58938.41061589329;59006.40993590095;1291.0639786154964;1418.829740431155;1452.3319273134266;1463.9707205855823;1468.647524594111;27689;27794.583081253393;28201.43597128087;28239.29401764972;28296;45281;45794;45828.77085614551;45904.77047614741;46013.309800352356;259612;260254;260304;261839;413367;33002.83498582492;33063.33873322472;33242.66757332395;33286;33414.16464588405;38957.80521097376;39233.607663922994;39396.409053863645;40341.79829100836;40378.79810600928;33356;33547.49678754869;33596;33659;33798;32684.50973235356;33009.50485742764;33601.327973440886;35628;35746.8212658935;36152.819235903655;36571;36603.81698091599;36913.63086369102;37088.62911370852;31634.209144770644;32253.35493290168;32535.837320814193;32654.836725816218;32957.67042329546;25161.622575661015;25410.618840717034;25423.247895583147;25587.744122558535;25834.22497325083 21:10:57 INFO - PROCESS | 13300 | |2;jquery.html;371.2482223497418;391.68665067945653;396.5315908469775;405.40405603762457;409.22451953548045;18580.4425867224;18822;19019.524511887194;19134.043297835124;19143.234270629175;9948.950255248714;11586.652400428;11853.288802671846;11865.110116741236;12492.562760303392;5249.921251181226;5364.785408583652;5433.212184233284;5436.075867102602;5440.782368705247;5654.264945557072;5720.79977200798;5768.538516918637;5798.9130163047585;5805.854853628651;3987.282289187945;5760.337561180476;5815.127730840365;6029.095635654643;6030.819075427744;5915.024021036524;5965.403459654043;5973.551983601247;5980.28236611605;6005.429484198994;5566.944330556683;5688.374278829326;5692.573057020699;5694.487496125327;5800.825975220708;13885.86114138866;13890.791638125436;13997.440102395893;14005.299735013208;14774.48289309869;2218.6228341182036;2336.7663233676667;2360.9645855312183;2363.9054437822465;2370.4784947311564;10218.591256349811;10241.23190760696;10252.384856908535;10325.380477171393;10850.565977360897;1903.5050886769402;1977.7132315814126;1978.663627183368;2003.6393449179143;2003.6994450832492;66665.66667166633;67930.66034669794;69124.6543767283;70341.64829175822;70541;11353.602623908124;11473.082153427706;11522.481488332878;11538.19232653723;11649.47577359021;14919.701605967819;15173.848261517463;15269.389224431121;15290.770638440432;15331.770023449657;8242.505449672919;8284.71003514874;8286.958565207135;8347.874781878276;8363.749087527262;6925.3074692530345;6957.199922009034;7216.639168041577;7252.5648461092505;7626.161122276545;4868.78090485929;4952.133376659071;4962.379702537183;4988.052270068675;5013.849584512471;1812.23158039564;1832.5327041604305;1968.3602829080605;2017.9899100504404;2044.8159665629867;933.8599210118537;986.5067466266867;1042.3537406807827;1106.502074066657;1173.3487914207697;17553.122343882755;17662.381816636356;17802.10989450522;17897.19462624185;18215.08924553767;975.4586204656342;984.7833476635129;1032.9018743219383;1056.0231785598444;1059.9523021464054;10142.137918276881;10250.743731406774;10365.74085647865;10388.42863642507;10393.16854651626;434919;442630;449873;455050;455825;74676;75277;76894;77251.61374193092;78805.60597196977;1013.8023085498404;1049.9317544359592;1050.2753100360726;1059.258519036662;1062.2033474893828;15612.141332226836;15663.7918635965;16282;16398;16945.49163525096;34533;35424.29151417009;35960.64039359573;37410;39095.41356879706;35436.46845297374;46280.30579541377;46549.3017604743;46665.76667116643;46701.29948050714;8385.748427547183;8481.40630155883;8487.236148746642;8595.957020214859;8709.216170544429;11028.22802403824;11991.400429978641;12471.563495277622;13046.673833154247;13435.328233588478;11056.170787190831;11201.15991300672;11205.88794112081;11367.658970230907;11555.942220288845;11040.598365280228;11071.058959988492;11213.775724485628;11433.714157146138;11528.481218345363;10219.693409197736;10703.518341674799;11341.659750207507;11434.313941163557;12037.75924481523;8326.62530186131;8569.957150214459;8700.303975681803;8931.73204803857;8988.775280618036;11210.943945280222;11220.831687524531;11381;11576.594819181288;11882.821757673815 21:10:57 INFO - PROCESS | 13300 | |3;mootools.html;1474.33654855315;1576.5428025872502;1583.1213676409595;1811.8188181181883;1920.936106909479;8399.622017009235;8576.142385761428;8613.483191008543;8618.61216245269;8619.1811777881;8539.359548033892;8698.173673501007;8721.258693011101;8726.694565690203;8727.345449091328;2195.5828392605354;2256.5148493073984;2407.518496300738;2468.6420469031978;2493.252024392675;2506.4736405354897;2518.26970178648;2518.508890766301;2520.7479252074736;2521.369657585604;2407.759224077587;2477;2487.4030232744194;2491.402063504764;2491.6137998610243;2437.0739119134705;2464.9753502465014;2469.3085935937966;2472.5302192583354;2475.616279476684;2431.222008957134;2454.6808914841135;2468.938276543083;2489.128804918282;2492.8628925409093;8748.518831464267;8793.560321983876;8813.250873675745;8826.779330516723;8838.116188381175;5373.328333958255;5509.5041446270025;5560.638558493685;5563.944360556383;5565.777368905239;3181.7454603631654;3228.515722641599;3253.4469140246215;3361.2941282330494;3363.260082781784;990.6532713550272;1006.6879267427048;1007.0936157458273;1950.0834607734341;1996.5607566335384;12001.45993430289;12016.939915300454;12097.758044839142;12105.757884842254;12105.757884842342;4616.446026476777;4736.4316282046375;4795.184818580849;4806.903861922812;4812.951870481321;9589.712308630613;9605.519724013911;9647.614095436104;9656.565454554562;9664.71005869825;5432.972835135878;5459.945400546023;5490.835274941758;5504.642198257181;5505.862353441196;4336.219480493478;4850.733209673432;4937.23472861707;4941.925871111936;4996.7501624918605;3917.1578110706337;3984.143409167043;4010.318245898204;4017.4978127734034;4076.694247931417;1205.7287110400266;1209.848768903887;1209.9879001210052;1215.8966487848454;1220.9389530523438;1403.4456389726001;1422.4452463539228;1428.9714205715827;1429.4710956945996;1453.1716921354937;8495.787605309917;8559.144085591515;8576.742697719079;8584.39909206362;8586.785330366665;547.1355258691258;552.585560829378;558.8882223555224;562.6905202138807;564.6414526775527;6312.4634406076;6437;6498.935010649928;6500.5449618526245;6564.113844630913;10730.94634526838;10891;11008.449577521093;11057.557697692002;11068.501917413736;9874.950625246971;10479.214058945458;10797.190210734227;10827;10851.782964340828;8066.919330806617;8203.630836612367;8225.177482251727;8271.33829293667;8278.875816862752;8161.591920403837;8194.262516373317;8331.541765202972;8348.7912802178;8350.164983501601;9120.771980700536;9351.345405821527;9355;9400.435973841591;9498.335116542052;9818.901810981799;9943.502824858584;10054.89945100569;10062.044105809937;10333.070023697903;7358.66885990121;7587.506812057199;7593.278638529331;7754.340881025176;7779.961100194463;8341.791455213668;8357.749267521984;8377.162283771575;8394.37042221848;8418.536980466133;7276.417886569167;7394.223606521453;7480.187651422113;7668.501547399401;7702.037245344332;7249.456290778318;7472.439567032386;7548;7583.848323033619;7623.65693543803;7640.579768112585;7654.387648988179;7657.195994420728;7688.154303026551;7697.807554811175;6986.406155476841;6995.265497122728;7053;7075.292470752884;7076.540024898571;7439.590822504814;7449.515781474187;7472.887906681295;7476.925230747623;7486 21:10:57 INFO - PROCESS | 13300 | |4;prototype.html;348.8517380113452;349.5618064003577;351.3622774663985;356.25187107075146;363.5800650248963;6066.939330606692;6071.7267722952465;6098.542609304303;6170.197874276338;6180.4746596539235;6047.092936059593;6061.909071363933;6066.908996365047;6071.7267722952465;6076.301225359074;4513.187626227278;4602.654800889946;4647.23320652092;4665.673402861801;4695.859124226278;4670.929936050962;4694.906101877978;4726.220173671357;4737.620990320766;4754.286856971447;4676.672632915697;4681.555252251031;4681.765911704419;4681.812727490897;4685.8594242172785;4509.346144809001;4586.97706511467;4697.107549565571;4697.788599512996;4722.197226471474;4123.876283711494;4131.793410329472;4139.937900931488;4141.855035073788;4142.813573389205;5817.243758311435;5818.359980402152;5823.883522329572;5835.5915085944;5836.182934389189;5475.780968761244;5487.067198576212;5488.506034456878;5490.835274941758;5498.120300751861;6448.258450278231;6454.1609590752905;6460.095586617877;6465.515086368541;6465.74137034518;4524.253498172798;4614.077184563101;4622.699524530894;4624.699394539344;4636;6698.5980841149685;6736.46108311334;6743.258241593421;6745.865082698368;6763.222229443628;4735.455422626374;4748.905021899543;4749.928751068736;4761.4524329701835;4764.047190561832;4820.638452116035;4827.155247831615;4828.903421931542;4832;4835.9360940593015;5488.862778430571;5494.038543254915;5495.120780675153;5497.670139791545;5502.284702988666;6298.433141017331;6437.259715132726;6448.032795080681;6530.444912182423;6538.509611779135;1680.3866588695282;1688.1727953302793;1695.1863105709328;1696.1264948551507;1697.6944150052861;1118.4743170709753;1137.8008848451489;1158.154547180563;1160.651804458676;1213.9575114870938;6118.969405152946;6122.448979591858;6123.84690382744;6130.325664176937;6130.816075517741;6550.050242714875;6552.4102830744505;6562.704678289393;6597.340265973365;6647.368499992493;6200.7519699211525;6203.844903877439;6208.627482350983;6209.782657607052;6212.565120441525;3572.91067723309;3601.1717305019993;3604.765690230179;3606.4770608261656;3606.765560238576;6738.936184837221;6809.863802723918;6882.105326307548;6889.931100688929;6896.241413444517;6787.966060169668;6801.387875091265;6819.659017049227;6822.283660215705;6824.2152152503095;6862.073620061327;6862.313768623198;6867.622280774505;6882.174139103339;6893.551919125241;6615.106960560455;6634.170728658918;6644.4020038196795;6647.368499992493;6653.833654158685;6443.903341449975;6519.054737063194;6521.576097553644;6536.575122617015;6581.045748366556;6816.522843400914;6820;6851.212110607344;6857.794266172023;6866.553674011173;4695.084458530554;4697.694649847749;4701.623870090316;4714.4106986626675;4719.079779442975;6586.407223349922;6588.901166482602;6591.703373348307;6593.3736295051895;6599.637019963948;6363.268224154096;6434.195725534309;6437.774677886251;6441;6444.3233460487845;6397;6431.453326467303;6435.646039467687;6439.967800160969;6443.613383197023;6335.94081923386;6342.556021078664;6348.714307856065;6352.714127864165;6355.809325720235;6456.709448074942;6462.515311351762;6462.967685161544;6465.838354040999;6478.870422591616;6197.938020619736;6272.027835685476;6306.842328941813;6321.431071203614;6397.552171347961 21:10:57 INFO - PROCESS | 13300 | |5;yui.html;735.000399456739;740.3189066059226;740.7074205688754;762.4053238473992;768.9307962283393;12795.296258705768;12807.23156610603;12857.357132143403;12861.54984575539;13130.212187268758;12108.69728256794;12292.877071229284;12316.322602256872;12316.938415307934;12319.876801231985;749.6851322444572;910.6767097680328;935.4480856294784;936.5036530638772;937.8452555328363;926.0461724423855;926.0785518409192;926.5228407370209;931.4597533430594;931.4737173496952;796.0526972902256;966.4587830814731;969.3553786731815;972.6012334942675;974.3033730882453;941.1623654947102;958.9520523973773;959.2661613865398;959.3811991265629;959.4818797849153;701.7543859649134;705.573128257402;705.6718625838959;705.7600415858633;707.1443553300512;12801;12841;12861.807072893915;12867.613971580868;12897.419616117297;11253.156013299036;11508.079353651689;11557.595484158099;11786.469608867535;12359.382030898509;9662.613495460244;9685;9782.902170978341;9803.215742740635;9901.752456188653;3337.916552086217;3339.96660033399;3380.1380647934866;3388.2715216228385;3433.7939723616414;48886.26670599944;49152.50847491515;50937.23594146091;50951.49048509542;51015.744921275524;9004.774880628036;9207.40151890125;9252.722418327461;9265.490398028172;9453.858192127123;16182.676346473005;16188.271527781279;16196.109213993108;16204.513864583845;16206.918965405097;7146.285371462916;7230.710771569184;7328.633568321563;7408.814779630552;7493.288137626917;4183.267928112568;4200.978995105066;4217.873463796091;4330.090680957034;4340.8697739067875;3124.968750312468;3131.9217019574694;3149.700778426046;3157;3157.857896394668;583.0641819879118;585.5052480653841;595.6336852835561;608.8660494691161;630.782380078872;616.4852348289139;618.3723520626568;626.7586979013022;634.9111124442582;635.5942707274692;7848.489848159851;7945.761627151194;7965.402594805297;7976.401769867283;8033.718819841394;498.41685228282995;585.7539833270037;586.9060950248025;615.7352338494401;621.285521650106;3780.7542509736777;3791.3554695701796;3863.517060367454;3892.708046896494;3964.2269757397607;60739.39260607337;61668.383316167165;61700.69149654313;62602.37397626056;63084.36915630785;52368.47631523636;52918.47081529135;53168.20247696288;53557.1966420504;53736.193957090676;48764.2685359727;48841;48845.26732099021;49416.752916235186;49771.50228497669;7704.537727736354;7770.650320735467;7841.490303130278;7902.881456778038;8025.638846252049;36491.270174595826;36503;36628;36929.63070369369;37621.81189094146;44304.11391772211;46158.76920615375;47515.52484475111;47830.760846196936;48285;9106.408083474553;9491.715248542554;9501.857472138061;9535.809283814424;9763.75590610212;9997.600095996078;10302.896971030194;10327.225458090823;10505.474726263808;10537.9473102634;9334.113259240361;9447.574859131219;9686.757831053998;9763.707088787347;9907.306488545733;9856.507174641383;10005.149562287286;10043.949780251345;10083.546240419051;10103.09072183507;9599.664011759554;9666.806663866542;9793.363431376938;10014.849777253492;10047.145992590711;8604.311655067455;8644.956775216335;8840.115988401109;8865.379423440556;8871.423357481743;8395.202455766692;8488.915110848813;8538;8610.956945215234;8629.320856092163 21:10:57 INFO - PROCESS | 13300 | __end_tp_report 21:10:57 INFO - PROCESS | 13300 | __start_cc_report 21:10:57 INFO - PROCESS | 13300 | _x_x_mozilla_cycle_collect,926 21:10:57 INFO - PROCESS | 13300 | __end_cc_report 21:10:57 INFO - PROCESS | 13300 | __startTimestamp1457928657259__endTimestamp 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | ------- Summary: start ------- 21:10:57 INFO - PROCESS | 13300 | Number of tests: 6 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#0] dojo.html Cycles:165 Average:5459.01 Median:5676.15 stddev:593.63 (10.5%) stddev-sans-first:571.19 21:10:57 INFO - PROCESS | 13300 | Values: 3317.6 3346.0 3372.0 3374.8 3409.6 5406.8 5414.1 5417.1 5442.5 5465.8 5418.5 5444.3 5450.8 5452.8 5456.4 4862.9 4943.2 4988.4 5002.8 5046.2 4958.1 5055.2 5055.9 5061.0 5061.2 4957.3 5014.8 5022.8 5024.1 5058.9 5040.9 5064.6 5078.3 5081.8 5105.8 4843.4 4924.3 4995.6 5009.6 5014.6 5210.9 5222.2 5232.2 5239.6 5294.2 5795.9 5822.4 5848.3 5857.8 5859.1 5913.5 5945.9 5970.8 5975.0 5998.5 5513.3 5516.2 5527.7 5528.3 5530.2 5831.0 5923.6 5972.7 6009.5 6010.2 5773.4 5790.7 5792.1 5799.2 5800.9 5857.7 5879.6 5881.4 5888.1 5896.9 5737.2 5803.6 5892.3 5900.9 5926.9 5867.2 5895.9 5905.6 5909.6 5911.3 4372.5 4490.5 4506.7 4507.4 4542.9 4037.2 4063.1 4076.3 4076.9 4099.9 5525.0 5546.5 5549.9 5551.1 5553.3 5770.9 5850.8 5889.9 5902.4 5916.8 5572.2 5573.6 5594.3 5602.4 5637.4 5081.2 5093.2 5102.2 5105.1 5105.3 5920.7 5981.3 6052.4 6118.8 6145.9 5858.2 5866.1 5871.5 5874.3 5880.1 6070.0 6070.1 6089.9 6094.8 6094.8 5711.9 5782.5 5796.0 5840.7 5867.0 5927.1 5944.5 5946.4 5947.4 5947.4 5736.0 5782.4 5809.5 5816.3 5827.3 5599.8 5691.6 5703.4 5746.5 5772.2 5659.4 5668.9 5681.1 5683.5 5689.8 5533.8 5753.0 5761.6 5780.7 5796.1 5491.1 5595.2 5656.1 5676.1 5708.4 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#1] ext.html Cycles:180 Average:50340.01 Median:20297.47 stddev:94536.46 (465.8%) stddev-sans-first:94727.80 21:10:57 INFO - PROCESS | 13300 | Values: 569.0 580.9 587.7 589.5 605.6 31023.0 31504.4 38430.4 38883.2 38951.8 36708.4 37098.3 37146.8 38145.4 38170.8 8665.6 8853.3 8898.1 8906.2 8924.8 8840.3 9011.4 9075.0 9075.6 9080.5 9069.3 9143.2 9162.5 9163.5 9175.7 9034.9 9059.3 9079.5 9082.5 9093.8 8823.6 8973.6 8981.9 8987.6 8997.7 40277.8 40743.2 40747.0 40782.4 40794.8 3575.2 3600.4 3659.1 3681.3 3810.9 31633.2 32165.5 32197.2 32219.4 32687.2 3759.2 3785.3 3811.5 3813.3 3864.1 300285.0 300774.0 301361.0 302103.0 302307.0 44905.0 59465.4 60640.0 60880.3 60987.7 43568.0 43670.1 43679.6 43761.8 43798.3 14429.7 14651.6 14654.5 14657.6 14665.5 12137.0 12189.9 12228.6 12249.2 12271.0 14841.6 14899.9 15228.4 15257.2 15404.5 5774.7 5861.6 5898.6 5950.0 5968.0 936.0 974.3 984.0 1028.4 1095.3 30416.0 30609.7 30767.0 30854.0 31235.7 1139.9 1175.8 1179.4 1213.6 1233.8 15656.8 16506.3 17612.6 18160.5 18281.5 449273.0 451257.0 452113.0 454213.0 454754.0 58393.0 58854.4 58930.0 58938.4 59006.4 1291.1 1418.8 1452.3 1464.0 1468.6 27689.0 27794.6 28201.4 28239.3 28296.0 45281.0 45794.0 45828.8 45904.8 46013.3 259612.0 260254.0 260304.0 261839.0 413367.0 33002.8 33063.3 33242.7 33286.0 33414.2 38957.8 39233.6 39396.4 40341.8 40378.8 33356.0 33547.5 33596.0 33659.0 33798.0 32684.5 33009.5 33601.3 35628.0 35746.8 36152.8 36571.0 36603.8 36913.6 37088.6 31634.2 32253.4 32535.8 32654.8 32957.7 25161.6 25410.6 25423.2 25587.7 25834.2 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#2] jquery.html Cycles:180 Average:25923.89 Median:2277.69 stddev:73460.10 (3225.2%) stddev-sans-first:73641.12 21:10:57 INFO - PROCESS | 13300 | Values: 371.2 391.7 396.5 405.4 409.2 18580.4 18822.0 19019.5 19134.0 19143.2 9949.0 11586.7 11853.3 11865.1 12492.6 5249.9 5364.8 5433.2 5436.1 5440.8 5654.3 5720.8 5768.5 5798.9 5805.9 3987.3 5760.3 5815.1 6029.1 6030.8 5915.0 5965.4 5973.6 5980.3 6005.4 5566.9 5688.4 5692.6 5694.5 5800.8 13885.9 13890.8 13997.4 14005.3 14774.5 2218.6 2336.8 2361.0 2363.9 2370.5 10218.6 10241.2 10252.4 10325.4 10850.6 1903.5 1977.7 1978.7 2003.6 2003.7 66665.7 67930.7 69124.7 70341.6 70541.0 11353.6 11473.1 11522.5 11538.2 11649.5 14919.7 15173.8 15269.4 15290.8 15331.8 8242.5 8284.7 8287.0 8347.9 8363.7 6925.3 6957.2 7216.6 7252.6 7626.2 4868.8 4952.1 4962.4 4988.1 5013.8 1812.2 1832.5 1968.4 2018.0 2044.8 933.9 986.5 1042.4 1106.5 1173.3 17553.1 17662.4 17802.1 17897.2 18215.1 975.5 984.8 1032.9 1056.0 1060.0 10142.1 10250.7 10365.7 10388.4 10393.2 434919.0 442630.0 449873.0 455050.0 455825.0 74676.0 75277.0 76894.0 77251.6 78805.6 1013.8 1049.9 1050.3 1059.3 1062.2 15612.1 15663.8 16282.0 16398.0 16945.5 34533.0 35424.3 35960.6 37410.0 39095.4 35436.5 46280.3 46549.3 46665.8 46701.3 8385.7 8481.4 8487.2 8596.0 8709.2 11028.2 11991.4 12471.6 13046.7 13435.3 11056.2 11201.2 11205.9 11367.7 11555.9 11040.6 11071.1 11213.8 11433.7 11528.5 10219.7 10703.5 11341.7 11434.3 12037.8 8326.6 8570.0 8700.3 8931.7 8988.8 11210.9 11220.8 11381.0 11576.6 11882.8 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#3] mootools.html Cycles:180 Average:6103.06 Median:5562.29 stddev:3221.27 (57.9%) stddev-sans-first:3211.52 21:10:57 INFO - PROCESS | 13300 | Values: 1474.3 1576.5 1583.1 1811.8 1920.9 8399.6 8576.1 8613.5 8618.6 8619.2 8539.4 8698.2 8721.3 8726.7 8727.3 2195.6 2256.5 2407.5 2468.6 2493.3 2506.5 2518.3 2518.5 2520.7 2521.4 2407.8 2477.0 2487.4 2491.4 2491.6 2437.1 2465.0 2469.3 2472.5 2475.6 2431.2 2454.7 2468.9 2489.1 2492.9 8748.5 8793.6 8813.3 8826.8 8838.1 5373.3 5509.5 5560.6 5563.9 5565.8 3181.7 3228.5 3253.4 3361.3 3363.3 990.7 1006.7 1007.1 1950.1 1996.6 12001.5 12016.9 12097.8 12105.8 12105.8 4616.4 4736.4 4795.2 4806.9 4813.0 9589.7 9605.5 9647.6 9656.6 9664.7 5433.0 5459.9 5490.8 5504.6 5505.9 4336.2 4850.7 4937.2 4941.9 4996.8 3917.2 3984.1 4010.3 4017.5 4076.7 1205.7 1209.8 1210.0 1215.9 1220.9 1403.4 1422.4 1429.0 1429.5 1453.2 8495.8 8559.1 8576.7 8584.4 8586.8 547.1 552.6 558.9 562.7 564.6 6312.5 6437.0 6498.9 6500.5 6564.1 10730.9 10891.0 11008.4 11057.6 11068.5 9875.0 10479.2 10797.2 10827.0 10851.8 8066.9 8203.6 8225.2 8271.3 8278.9 8161.6 8194.3 8331.5 8348.8 8350.2 9120.8 9351.3 9355.0 9400.4 9498.3 9818.9 9943.5 10054.9 10062.0 10333.1 7358.7 7587.5 7593.3 7754.3 7780.0 8341.8 8357.7 8377.2 8394.4 8418.5 7276.4 7394.2 7480.2 7668.5 7702.0 7249.5 7472.4 7548.0 7583.8 7623.7 7640.6 7654.4 7657.2 7688.2 7697.8 6986.4 6995.3 7053.0 7075.3 7076.5 7439.6 7449.5 7472.9 7476.9 7486.0 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#4] prototype.html Cycles:180 Average:5420.42 Median:6127.09 stddev:1597.21 (26.1%) stddev-sans-first:1555.67 21:10:57 INFO - PROCESS | 13300 | Values: 348.9 349.6 351.4 356.3 363.6 6066.9 6071.7 6098.5 6170.2 6180.5 6047.1 6061.9 6066.9 6071.7 6076.3 4513.2 4602.7 4647.2 4665.7 4695.9 4670.9 4694.9 4726.2 4737.6 4754.3 4676.7 4681.6 4681.8 4681.8 4685.9 4509.3 4587.0 4697.1 4697.8 4722.2 4123.9 4131.8 4139.9 4141.9 4142.8 5817.2 5818.4 5823.9 5835.6 5836.2 5475.8 5487.1 5488.5 5490.8 5498.1 6448.3 6454.2 6460.1 6465.5 6465.7 4524.3 4614.1 4622.7 4624.7 4636.0 6698.6 6736.5 6743.3 6745.9 6763.2 4735.5 4748.9 4749.9 4761.5 4764.0 4820.6 4827.2 4828.9 4832.0 4835.9 5488.9 5494.0 5495.1 5497.7 5502.3 6298.4 6437.3 6448.0 6530.4 6538.5 1680.4 1688.2 1695.2 1696.1 1697.7 1118.5 1137.8 1158.2 1160.7 1214.0 6119.0 6122.4 6123.8 6130.3 6130.8 6550.1 6552.4 6562.7 6597.3 6647.4 6200.8 6203.8 6208.6 6209.8 6212.6 3572.9 3601.2 3604.8 3606.5 3606.8 6738.9 6809.9 6882.1 6889.9 6896.2 6788.0 6801.4 6819.7 6822.3 6824.2 6862.1 6862.3 6867.6 6882.2 6893.6 6615.1 6634.2 6644.4 6647.4 6653.8 6443.9 6519.1 6521.6 6536.6 6581.0 6816.5 6820.0 6851.2 6857.8 6866.6 4695.1 4697.7 4701.6 4714.4 4719.1 6586.4 6588.9 6591.7 6593.4 6599.6 6363.3 6434.2 6437.8 6441.0 6444.3 6397.0 6431.5 6435.6 6440.0 6443.6 6335.9 6342.6 6348.7 6352.7 6355.8 6456.7 6462.5 6463.0 6465.8 6478.9 6197.9 6272.0 6306.8 6321.4 6397.6 21:10:57 INFO - PROCESS | 13300 | 21:10:57 INFO - PROCESS | 13300 | [#5] yui.html Cycles:180 Average:13730.67 Median:61684.54 stddev:16960.79 (27.5%) stddev-sans-first:16980.29 21:10:57 INFO - PROCESS | 13300 | Values: 735.0 740.3 740.7 762.4 768.9 12795.3 12807.2 12857.4 12861.5 13130.2 12108.7 12292.9 12316.3 12316.9 12319.9 749.7 910.7 935.4 936.5 937.8 926.0 926.1 926.5 931.5 931.5 796.1 966.5 969.4 972.6 974.3 941.2 959.0 959.3 959.4 959.5 701.8 705.6 705.7 705.8 707.1 12801.0 12841.0 12861.8 12867.6 12897.4 11253.2 11508.1 11557.6 11786.5 12359.4 9662.6 9685.0 9782.9 9803.2 9901.8 3337.9 3340.0 3380.1 3388.3 3433.8 48886.3 49152.5 50937.2 50951.5 51015.7 9004.8 9207.4 9252.7 9265.5 9453.9 16182.7 16188.3 16196.1 16204.5 16206.9 7146.3 7230.7 7328.6 7408.8 7493.3 4183.3 4201.0 4217.9 4330.1 4340.9 3125.0 3131.9 3149.7 3157.0 3157.9 583.1 585.5 595.6 608.9 630.8 616.5 618.4 626.8 634.9 635.6 7848.5 7945.8 7965.4 7976.4 8033.7 498.4 585.8 586.9 615.7 621.3 3780.8 3791.4 3863.5 3892.7 3964.2 60739.4 61668.4 61700.7 62602.4 63084.4 52368.5 52918.5 53168.2 53557.2 53736.2 48764.3 48841.0 48845.3 49416.8 49771.5 7704.5 7770.7 7841.5 7902.9 8025.6 36491.3 36503.0 36628.0 36929.6 37621.8 44304.1 46158.8 47515.5 47830.8 48285.0 9106.4 9491.7 9501.9 9535.8 9763.8 9997.6 10302.9 10327.2 10505.5 10537.9 9334.1 9447.6 9686.8 9763.7 9907.3 9856.5 10005.1 10043.9 10083.5 10103.1 9599.7 9666.8 9793.4 10014.8 10047.1 8604.3 8645.0 8840.1 8865.4 8871.4 8395.2 8488.9 8538.0 8611.0 8629.3 21:10:57 INFO - PROCESS | 13300 | -------- Summary: end -------- 21:10:57 INFO - PROCESS | 13300 | 21:10:58 INFO - TEST-INFO | 13300: exit 0 21:10:58 INFO - TEST-OK | dromaeo_css | took 1113306ms 21:10:58 INFO - TEST-START | kraken 21:10:58 INFO - operating with platform_type : linux_ 21:10:58 INFO - Initialising browser for kraken test... 21:10:58 INFO - TEST-INFO | started process 13488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfywA_6/profile http://localhost:36029/getInfo.html) 21:11:03 INFO - PROCESS | 13488 | __metrics Screen width/height:1600/1200 21:11:03 INFO - PROCESS | 13488 | colorDepth:24 21:11:03 INFO - PROCESS | 13488 | Browser inner width/height: 1024/697 21:11:03 INFO - PROCESS | 13488 | __metrics 21:11:04 INFO - PROCESS | 13488 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:11:05 INFO - TEST-INFO | 13488: exit 0 21:11:05 INFO - Browser initialized. 21:11:05 INFO - Running cycle 1/1 for kraken test... 21:11:05 INFO - TEST-INFO | started process 13577 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfywA_6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:11:17 INFO - PROCESS | 13577 | RSS: Main: 143097856 21:11:17 INFO - PROCESS | 13577 | 21:11:19 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36029/tests/kraken/driver.html?testName=audio-beat-detection) 21:11:20 INFO - PROCESS | 13577 | RSS: Main: 178688000 21:11:20 INFO - PROCESS | 13577 | 21:11:22 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36029/tests/kraken/driver.html?testName=audio-dft) 21:11:23 INFO - PROCESS | 13577 | RSS: Main: 176173056 21:11:23 INFO - PROCESS | 13577 | 21:11:26 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36029/tests/kraken/driver.html?testName=audio-fft) 21:11:26 INFO - PROCESS | 13577 | RSS: Main: 174419968 21:11:26 INFO - PROCESS | 13577 | 21:11:28 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36029/tests/kraken/driver.html?testName=audio-oscillator) 21:11:29 INFO - PROCESS | 13577 | RSS: Main: 174710784 21:11:29 INFO - PROCESS | 13577 | 21:11:31 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36029/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:11:32 INFO - PROCESS | 13577 | RSS: Main: 172466176 21:11:32 INFO - PROCESS | 13577 | 21:11:35 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36029/tests/kraken/driver.html?testName=imaging-darkroom) 21:11:35 INFO - PROCESS | 13577 | RSS: Main: 172322816 21:11:35 INFO - PROCESS | 13577 | 21:11:39 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36029/tests/kraken/driver.html?testName=imaging-desaturate) 21:11:39 INFO - PROCESS | 13577 | RSS: Main: 164585472 21:11:39 INFO - PROCESS | 13577 | 21:11:42 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36029/tests/kraken/driver.html?testName=json-parse-financial) 21:11:43 INFO - PROCESS | 13577 | RSS: Main: 166035456 21:11:43 INFO - PROCESS | 13577 | 21:11:44 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36029/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:11:45 INFO - PROCESS | 13577 | RSS: Main: 176635904 21:11:45 INFO - PROCESS | 13577 | 21:11:47 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:11:47 INFO - PROCESS | 13577 | RSS: Main: 173580288 21:11:47 INFO - PROCESS | 13577 | 21:11:49 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:11:50 INFO - PROCESS | 13577 | RSS: Main: 180723712 21:11:50 INFO - PROCESS | 13577 | 21:11:52 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:11:53 INFO - PROCESS | 13577 | RSS: Main: 188174336 21:11:53 INFO - PROCESS | 13577 | 21:11:55 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:11:56 INFO - PROCESS | 13577 | RSS: Main: 188338176 21:11:56 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36029/tests/kraken/driver.html?testName=ai-astar) 21:11:58 INFO - PROCESS | 13577 | RSS: Main: 247828480 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | __start_tp_report 21:11:58 INFO - PROCESS | 13577 | _x_x_mozilla_page_load 21:11:58 INFO - PROCESS | 13577 | _x_x_mozilla_page_load_details 21:11:58 INFO - PROCESS | 13577 | |i|pagename|runs| 21:11:58 INFO - PROCESS | 13577 | |0;ai-astar;109;109;104;109;109;109;99;110;109;108 21:11:58 INFO - PROCESS | 13577 | |1;audio-beat-detection;155;125;148;167;126;146;163;127;163;125 21:11:58 INFO - PROCESS | 13577 | |2;audio-dft;159;160;160;160;160;161;161;163;161;160 21:11:58 INFO - PROCESS | 13577 | |3;audio-fft;75;76;75;165;74;75;75;75;159;76 21:11:58 INFO - PROCESS | 13577 | |4;audio-oscillator;92;93;140;92;93;92;135;93;92;142 21:11:58 INFO - PROCESS | 13577 | |5;imaging-gaussian-blur;117;116;116;117;116;117;116;116;117;116 21:11:58 INFO - PROCESS | 13577 | |6;imaging-darkroom;147;145;145;146;146;145;145;145;146;145 21:11:58 INFO - PROCESS | 13577 | |7;imaging-desaturate;95;95;95;95;95;96;96;95;95;95 21:11:58 INFO - PROCESS | 13577 | |8;json-parse-financial;54;54;53;54;56;55;56;67;52;51 21:11:58 INFO - PROCESS | 13577 | |9;json-stringify-tinderbox;64;66;66;66;66;67;66;66;66;66 21:11:58 INFO - PROCESS | 13577 | |10;stanford-crypto-aes;78;88;78;78;77;78;78;78;79;78 21:11:58 INFO - PROCESS | 13577 | |11;stanford-crypto-ccm;119;110;111;112;117;110;111;111;111;111 21:11:58 INFO - PROCESS | 13577 | |12;stanford-crypto-pbkdf2;146;147;154;144;143;133;145;144;142;142 21:11:58 INFO - PROCESS | 13577 | |13;stanford-crypto-sha256-iterative;66;64;67;69;71;64;67;66;68;65 21:11:58 INFO - PROCESS | 13577 | __end_tp_report 21:11:58 INFO - PROCESS | 13577 | __start_cc_report 21:11:58 INFO - PROCESS | 13577 | _x_x_mozilla_cycle_collect,1038 21:11:58 INFO - PROCESS | 13577 | __end_cc_report 21:11:58 INFO - PROCESS | 13577 | __startTimestamp1457928718313__endTimestamp 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | ------- Summary: start ------- 21:11:58 INFO - PROCESS | 13577 | Number of tests: 14 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:3.41 (3.1%) stddev-sans-first:3.57 21:11:58 INFO - PROCESS | 13577 | Values: 109.0 109.0 104.0 109.0 109.0 109.0 99.0 110.0 109.0 108.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:17.40 (11.5%) stddev-sans-first:18.03 21:11:58 INFO - PROCESS | 13577 | Values: 155.0 125.0 148.0 167.0 126.0 146.0 163.0 127.0 163.0 125.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.00 21:11:58 INFO - PROCESS | 13577 | Values: 159.0 160.0 160.0 160.0 160.0 161.0 161.0 163.0 161.0 160.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:36.66 (48.9%) stddev-sans-first:38.33 21:11:58 INFO - PROCESS | 13577 | Values: 75.0 76.0 75.0 165.0 74.0 75.0 75.0 75.0 159.0 76.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:22.56 (24.5%) stddev-sans-first:23.32 21:11:58 INFO - PROCESS | 13577 | Values: 92.0 93.0 140.0 92.0 93.0 92.0 135.0 93.0 92.0 142.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:11:58 INFO - PROCESS | 13577 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 21:11:58 INFO - PROCESS | 13577 | Values: 147.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:11:58 INFO - PROCESS | 13577 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:4.44 (8.2%) stddev-sans-first:4.69 21:11:58 INFO - PROCESS | 13577 | Values: 54.0 54.0 53.0 54.0 56.0 55.0 56.0 67.0 52.0 51.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.33 21:11:58 INFO - PROCESS | 13577 | Values: 64.0 66.0 66.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:3.20 (4.1%) stddev-sans-first:3.37 21:11:58 INFO - PROCESS | 13577 | Values: 78.0 88.0 78.0 78.0 77.0 78.0 78.0 78.0 79.0 78.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:111.00 stddev:3.09 (2.8%) stddev-sans-first:2.13 21:11:58 INFO - PROCESS | 13577 | Values: 119.0 110.0 111.0 112.0 117.0 110.0 111.0 111.0 111.0 111.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:144.50 stddev:5.21 (3.6%) stddev-sans-first:5.47 21:11:58 INFO - PROCESS | 13577 | Values: 146.0 147.0 154.0 144.0 143.0 133.0 145.0 144.0 142.0 142.0 21:11:58 INFO - PROCESS | 13577 | 21:11:58 INFO - PROCESS | 13577 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:2.21 (3.3%) stddev-sans-first:2.33 21:11:58 INFO - PROCESS | 13577 | Values: 66.0 64.0 67.0 69.0 71.0 64.0 67.0 66.0 68.0 65.0 21:11:58 INFO - PROCESS | 13577 | -------- Summary: end -------- 21:11:58 INFO - PROCESS | 13577 | 21:11:59 INFO - TEST-INFO | 13577: exit 0 21:11:59 INFO - TEST-OK | kraken | took 61304ms 21:11:59 INFO - SUITE-END | took 1174s 21:11:59 INFO - Completed test suite (00:19:34) 21:11:59 INFO - javascript benchmark 21:11:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3317.5853018372704, 3345.9665403345957, 3372.0, 3374.8481318340687, 3409.6419875913034, 5406.756695948682, 5414.0796064669, 5417.079096553585, 5442.537384322328, 5465.808696695616, 5418.458154184579, 5444.265024221729, 5450.809221677242, 5452.83641490755, 5456.372517160517, 4862.854114376574, 4943.233798761189, 4988.376452943382, 5002.799888004475, 5046.243063540462, 4958.107540642683, 5055.191169412895, 5055.9241611375855, 5060.974695126519, 5061.16490779021, 4957.330760347343, 5014.774335154927, 5022.773975171126, 5024.0705469488075, 5058.898822023557, 5040.873978150539, 5064.620153488466, 5078.31442755227, 5081.771320290596, 5105.84682459525, 4843.4187897452175, 4924.261360795874, 4995.625328100371, 5009.574186194178, 5014.648974571782, 5210.895782084375, 5222.242774797671, 5232.241325007891, 5239.607029472805, 5294.205869119624, 5795.88408231833, 5822.446867547576, 5848.2689663792025, 5857.828434313112, 5859.121131830217, 5913.467787899067, 5945.940540594582, 5970.761169553212, 5974.97012514939, 5998.520118390518, 5513.255710479074, 5516.200150978166, 5527.723613819293, 5528.281323427928, 5530.225768392428, 5831.0, 5923.585349025527, 5972.731227094791, 6009.489193418608, 6010.2186715726675, 5773.39379365169, 5790.71046447676, 5792.102224155263, 5799.159121927297, 5800.854978625483, 5857.707114644336, 5879.617824841457, 5881.441263080001, 5888.146218798251, 5896.941030589639, 5737.168110624019, 5803.564732644984, 5892.292924849045, 5900.940990590125, 5926.940730592639, 5867.207926929896, 5895.911561326584, 5905.645661260338, 5909.645421274738, 5911.261092363455, 4372.497162826316, 4490.483594386622, 4506.662000349987, 4507.3689683444345, 4542.931856022163, 4037.152198038445, 4063.146739184745, 4076.286649836267, 4076.857309994136, 4099.877003689894, 5525.033119204123, 5546.528545073714, 5549.944500555023, 5551.056320425538, 5553.333599967949, 5770.913436298459, 5850.765969361178, 5889.911651325234, 5902.439268269508, 5916.763329466773, 5572.192032155314, 5573.554115670737, 5594.300712410949, 5602.439756024365, 5637.436256374412, 5081.23781432788, 5093.2360145977655, 5102.209157580581, 5105.0810854045885, 5105.310783044241, 5920.73356698941, 5981.252343457068, 6052.425019623129, 6118.847028824226, 6145.877082458415, 5858.179854820329, 5866.090755932837, 5871.530277577698, 5874.324452687995, 5880.14737863016, 6069.998450255658, 6070.0591408331775, 6089.878202436015, 6094.75620975156, 6094.8171554853425, 5711.857203569944, 5782.5373970081455, 5796.0, 5840.707964601668, 5867.0, 5927.110933360031, 5944.524438045032, 5946.405359464019, 5947.375525569752, 5947.405259474018, 5735.971320143372, 5782.421757824352, 5809.50619197373, 5816.272965879265, 5827.271591051119, 5599.776008959596, 5691.630044047124, 5703.401142880104, 5746.511546518593, 5772.19189313488, 5659.377468478547, 5668.886622267614, 5681.062624667049, 5683.516901063456, 5689.829305120853, 5533.806316778893, 5753.021986262429, 5761.625494342854, 5780.682062486603, 5796.072628379439, 5491.121420572689, 5595.216669666169, 5656.123300888369, 5676.148577713376, 5708.400617935057], "unit": "score", "name": "dojo.html", "value": 5421.584012154682}, {"lowerIsBetter": false, "replicates": [568.985775355616, 580.904815012365, 587.6914619824591, 589.4812564942849, 605.5639939243742, 31023.0, 31504.369912601735, 38430.42354364683, 38883.22233555334, 38951.80524097382, 36708.44937325942, 37098.25803483935, 37146.8142659287, 38145.42781858274, 38170.8091459543, 8665.566721663923, 8853.291736661084, 8898.065703101178, 8906.153915378029, 8924.821503569925, 8840.292776577891, 9011.369204155711, 9075.0, 9075.591598378089, 9080.500572468512, 9069.274458043341, 9143.222826059793, 9162.541872906362, 9163.450192988408, 9175.72472825813, 9034.909650903473, 9059.320550958671, 9079.546022698905, 9082.500462474562, 9093.772655683595, 8823.647054117828, 8973.641054357819, 8981.910180898172, 8987.55062246885, 8997.685081022133, 40277.79861100676, 40743.185136297405, 40747.0, 40782.388264176065, 40794.796026019976, 3575.1598374382, 3600.4059330210484, 3659.1433803041255, 3681.300552894968, 3810.942835857464, 31633.20916977094, 32165.517517237262, 32197.195070123435, 32219.355612887844, 32687.182820429443, 3759.248150369937, 3785.299719551864, 3811.542614886204, 3813.2564149990762, 3864.111254411473, 300285.0, 300774.0, 301361.0, 302103.0, 302307.0, 44905.0, 59465.40534594685, 60640.0, 60880.26038828264, 60987.695061524406, 43568.0, 43670.126597467875, 43679.56320436818, 43761.78119109384, 43798.34302485465, 14429.711405771826, 14651.560453186421, 14654.48709295191, 14657.633559161106, 14665.48670796517, 12137.0, 12189.939050304869, 12228.633141005785, 12249.203801752858, 12271.0, 14841.554753357417, 14899.851001490064, 15228.390864365523, 15257.237138143048, 15404.537863864101, 5774.711264436762, 5861.648301101863, 5898.557608179403, 5950.0, 5967.9701601491715, 936.0358830404695, 974.2741657465234, 983.9557219924977, 1028.4240825137947, 1095.3482677806692, 30416.0, 30609.69390306113, 30767.0, 30854.0, 31235.687643123732, 1139.9145064120057, 1175.8236264560385, 1179.4397661110904, 1213.5995121609847, 1233.8149277608431, 15656.765148522782, 16506.2572184252, 17612.559686007695, 18160.545986350182, 18281.45155645333, 449273.0, 451257.0, 452113.0, 454213.0, 454754.0, 58393.0, 58854.411455884896, 58930.0, 58938.41061589329, 59006.40993590095, 1291.0639786154964, 1418.829740431155, 1452.3319273134266, 1463.9707205855823, 1468.647524594111, 27689.0, 27794.583081253393, 28201.43597128087, 28239.29401764972, 28296.0, 45281.0, 45794.0, 45828.77085614551, 45904.77047614741, 46013.309800352356, 259612.0, 260254.0, 260304.0, 261839.0, 413367.0, 33002.83498582492, 33063.33873322472, 33242.66757332395, 33286.0, 33414.16464588405, 38957.80521097376, 39233.607663922994, 39396.409053863645, 40341.79829100836, 40378.79810600928, 33356.0, 33547.49678754869, 33596.0, 33659.0, 33798.0, 32684.50973235356, 33009.50485742764, 33601.327973440886, 35628.0, 35746.8212658935, 36152.819235903655, 36571.0, 36603.81698091599, 36913.63086369102, 37088.62911370852, 31634.209144770644, 32253.35493290168, 32535.837320814193, 32654.836725816218, 32957.67042329546, 25161.622575661015, 25410.618840717034, 25423.247895583147, 25587.744122558535, 25834.22497325083], "unit": "score", "name": "ext.html", "value": 18504.28947459992}, {"lowerIsBetter": false, "replicates": [371.2482223497418, 391.68665067945653, 396.5315908469775, 405.40405603762457, 409.22451953548045, 18580.4425867224, 18822.0, 19019.524511887194, 19134.043297835124, 19143.234270629175, 9948.950255248714, 11586.652400428, 11853.288802671846, 11865.110116741236, 12492.562760303392, 5249.921251181226, 5364.785408583652, 5433.212184233284, 5436.075867102602, 5440.782368705247, 5654.264945557072, 5720.79977200798, 5768.538516918637, 5798.9130163047585, 5805.854853628651, 3987.282289187945, 5760.337561180476, 5815.127730840365, 6029.095635654643, 6030.819075427744, 5915.024021036524, 5965.403459654043, 5973.551983601247, 5980.28236611605, 6005.429484198994, 5566.944330556683, 5688.374278829326, 5692.573057020699, 5694.487496125327, 5800.825975220708, 13885.86114138866, 13890.791638125436, 13997.440102395893, 14005.299735013208, 14774.48289309869, 2218.6228341182036, 2336.7663233676667, 2360.9645855312183, 2363.9054437822465, 2370.4784947311564, 10218.591256349811, 10241.23190760696, 10252.384856908535, 10325.380477171393, 10850.565977360897, 1903.5050886769402, 1977.7132315814126, 1978.663627183368, 2003.6393449179143, 2003.6994450832492, 66665.66667166633, 67930.66034669794, 69124.6543767283, 70341.64829175822, 70541.0, 11353.602623908124, 11473.082153427706, 11522.481488332878, 11538.19232653723, 11649.47577359021, 14919.701605967819, 15173.848261517463, 15269.389224431121, 15290.770638440432, 15331.770023449657, 8242.505449672919, 8284.71003514874, 8286.958565207135, 8347.874781878276, 8363.749087527262, 6925.3074692530345, 6957.199922009034, 7216.639168041577, 7252.5648461092505, 7626.161122276545, 4868.78090485929, 4952.133376659071, 4962.379702537183, 4988.052270068675, 5013.849584512471, 1812.23158039564, 1832.5327041604305, 1968.3602829080605, 2017.9899100504404, 2044.8159665629867, 933.8599210118537, 986.5067466266867, 1042.3537406807827, 1106.502074066657, 1173.3487914207697, 17553.122343882755, 17662.381816636356, 17802.10989450522, 17897.19462624185, 18215.08924553767, 975.4586204656342, 984.7833476635129, 1032.9018743219383, 1056.0231785598444, 1059.9523021464054, 10142.137918276881, 10250.743731406774, 10365.74085647865, 10388.42863642507, 10393.16854651626, 434919.0, 442630.0, 449873.0, 455050.0, 455825.0, 74676.0, 75277.0, 76894.0, 77251.61374193092, 78805.60597196977, 1013.8023085498404, 1049.9317544359592, 1050.2753100360726, 1059.258519036662, 1062.2033474893828, 15612.141332226836, 15663.7918635965, 16282.0, 16398.0, 16945.49163525096, 34533.0, 35424.29151417009, 35960.64039359573, 37410.0, 39095.41356879706, 35436.46845297374, 46280.30579541377, 46549.3017604743, 46665.76667116643, 46701.29948050714, 8385.748427547183, 8481.40630155883, 8487.236148746642, 8595.957020214859, 8709.216170544429, 11028.22802403824, 11991.400429978641, 12471.563495277622, 13046.673833154247, 13435.328233588478, 11056.170787190831, 11201.15991300672, 11205.88794112081, 11367.658970230907, 11555.942220288845, 11040.598365280228, 11071.058959988492, 11213.775724485628, 11433.714157146138, 11528.481218345363, 10219.693409197736, 10703.518341674799, 11341.659750207507, 11434.313941163557, 12037.75924481523, 8326.62530186131, 8569.957150214459, 8700.303975681803, 8931.73204803857, 8988.775280618036, 11210.943945280222, 11220.831687524531, 11381.0, 11576.594819181288, 11882.821757673815], "unit": "score", "name": "jquery.html", "value": 8693.572497432884}, {"lowerIsBetter": false, "replicates": [1474.33654855315, 1576.5428025872502, 1583.1213676409595, 1811.8188181181883, 1920.936106909479, 8399.622017009235, 8576.142385761428, 8613.483191008543, 8618.61216245269, 8619.1811777881, 8539.359548033892, 8698.173673501007, 8721.258693011101, 8726.694565690203, 8727.345449091328, 2195.5828392605354, 2256.5148493073984, 2407.518496300738, 2468.6420469031978, 2493.252024392675, 2506.4736405354897, 2518.26970178648, 2518.508890766301, 2520.7479252074736, 2521.369657585604, 2407.759224077587, 2477.0, 2487.4030232744194, 2491.402063504764, 2491.6137998610243, 2437.0739119134705, 2464.9753502465014, 2469.3085935937966, 2472.5302192583354, 2475.616279476684, 2431.222008957134, 2454.6808914841135, 2468.938276543083, 2489.128804918282, 2492.8628925409093, 8748.518831464267, 8793.560321983876, 8813.250873675745, 8826.779330516723, 8838.116188381175, 5373.328333958255, 5509.5041446270025, 5560.638558493685, 5563.944360556383, 5565.777368905239, 3181.7454603631654, 3228.515722641599, 3253.4469140246215, 3361.2941282330494, 3363.260082781784, 990.6532713550272, 1006.6879267427048, 1007.0936157458273, 1950.0834607734341, 1996.5607566335384, 12001.45993430289, 12016.939915300454, 12097.758044839142, 12105.757884842254, 12105.757884842342, 4616.446026476777, 4736.4316282046375, 4795.184818580849, 4806.903861922812, 4812.951870481321, 9589.712308630613, 9605.519724013911, 9647.614095436104, 9656.565454554562, 9664.71005869825, 5432.972835135878, 5459.945400546023, 5490.835274941758, 5504.642198257181, 5505.862353441196, 4336.219480493478, 4850.733209673432, 4937.23472861707, 4941.925871111936, 4996.7501624918605, 3917.1578110706337, 3984.143409167043, 4010.318245898204, 4017.4978127734034, 4076.694247931417, 1205.7287110400266, 1209.848768903887, 1209.9879001210052, 1215.8966487848454, 1220.9389530523438, 1403.4456389726001, 1422.4452463539228, 1428.9714205715827, 1429.4710956945996, 1453.1716921354937, 8495.787605309917, 8559.144085591515, 8576.742697719079, 8584.39909206362, 8586.785330366665, 547.1355258691258, 552.585560829378, 558.8882223555224, 562.6905202138807, 564.6414526775527, 6312.4634406076, 6437.0, 6498.935010649928, 6500.5449618526245, 6564.113844630913, 10730.94634526838, 10891.0, 11008.449577521093, 11057.557697692002, 11068.501917413736, 9874.950625246971, 10479.214058945458, 10797.190210734227, 10827.0, 10851.782964340828, 8066.919330806617, 8203.630836612367, 8225.177482251727, 8271.33829293667, 8278.875816862752, 8161.591920403837, 8194.262516373317, 8331.541765202972, 8348.7912802178, 8350.164983501601, 9120.771980700536, 9351.345405821527, 9355.0, 9400.435973841591, 9498.335116542052, 9818.901810981799, 9943.502824858584, 10054.89945100569, 10062.044105809937, 10333.070023697903, 7358.66885990121, 7587.506812057199, 7593.278638529331, 7754.340881025176, 7779.961100194463, 8341.791455213668, 8357.749267521984, 8377.162283771575, 8394.37042221848, 8418.536980466133, 7276.417886569167, 7394.223606521453, 7480.187651422113, 7668.501547399401, 7702.037245344332, 7249.456290778318, 7472.439567032386, 7548.0, 7583.848323033619, 7623.65693543803, 7640.579768112585, 7654.387648988179, 7657.195994420728, 7688.154303026551, 7697.807554811175, 6986.406155476841, 6995.265497122728, 7053.0, 7075.292470752884, 7076.540024898571, 7439.590822504814, 7449.515781474187, 7472.887906681295, 7476.925230747623, 7486.0], "unit": "score", "name": "mootools.html", "value": 4920.77817710074}, {"lowerIsBetter": false, "replicates": [348.8517380113452, 349.5618064003577, 351.3622774663985, 356.25187107075146, 363.5800650248963, 6066.939330606692, 6071.7267722952465, 6098.542609304303, 6170.197874276338, 6180.4746596539235, 6047.092936059593, 6061.909071363933, 6066.908996365047, 6071.7267722952465, 6076.301225359074, 4513.187626227278, 4602.654800889946, 4647.23320652092, 4665.673402861801, 4695.859124226278, 4670.929936050962, 4694.906101877978, 4726.220173671357, 4737.620990320766, 4754.286856971447, 4676.672632915697, 4681.555252251031, 4681.765911704419, 4681.812727490897, 4685.8594242172785, 4509.346144809001, 4586.97706511467, 4697.107549565571, 4697.788599512996, 4722.197226471474, 4123.876283711494, 4131.793410329472, 4139.937900931488, 4141.855035073788, 4142.813573389205, 5817.243758311435, 5818.359980402152, 5823.883522329572, 5835.5915085944, 5836.182934389189, 5475.780968761244, 5487.067198576212, 5488.506034456878, 5490.835274941758, 5498.120300751861, 6448.258450278231, 6454.1609590752905, 6460.095586617877, 6465.515086368541, 6465.74137034518, 4524.253498172798, 4614.077184563101, 4622.699524530894, 4624.699394539344, 4636.0, 6698.5980841149685, 6736.46108311334, 6743.258241593421, 6745.865082698368, 6763.222229443628, 4735.455422626374, 4748.905021899543, 4749.928751068736, 4761.4524329701835, 4764.047190561832, 4820.638452116035, 4827.155247831615, 4828.903421931542, 4832.0, 4835.9360940593015, 5488.862778430571, 5494.038543254915, 5495.120780675153, 5497.670139791545, 5502.284702988666, 6298.433141017331, 6437.259715132726, 6448.032795080681, 6530.444912182423, 6538.509611779135, 1680.3866588695282, 1688.1727953302793, 1695.1863105709328, 1696.1264948551507, 1697.6944150052861, 1118.4743170709753, 1137.8008848451489, 1158.154547180563, 1160.651804458676, 1213.9575114870938, 6118.969405152946, 6122.448979591858, 6123.84690382744, 6130.325664176937, 6130.816075517741, 6550.050242714875, 6552.4102830744505, 6562.704678289393, 6597.340265973365, 6647.368499992493, 6200.7519699211525, 6203.844903877439, 6208.627482350983, 6209.782657607052, 6212.565120441525, 3572.91067723309, 3601.1717305019993, 3604.765690230179, 3606.4770608261656, 3606.765560238576, 6738.936184837221, 6809.863802723918, 6882.105326307548, 6889.931100688929, 6896.241413444517, 6787.966060169668, 6801.387875091265, 6819.659017049227, 6822.283660215705, 6824.2152152503095, 6862.073620061327, 6862.313768623198, 6867.622280774505, 6882.174139103339, 6893.551919125241, 6615.106960560455, 6634.170728658918, 6644.4020038196795, 6647.368499992493, 6653.833654158685, 6443.903341449975, 6519.054737063194, 6521.576097553644, 6536.575122617015, 6581.045748366556, 6816.522843400914, 6820.0, 6851.212110607344, 6857.794266172023, 6866.553674011173, 4695.084458530554, 4697.694649847749, 4701.623870090316, 4714.4106986626675, 4719.079779442975, 6586.407223349922, 6588.901166482602, 6591.703373348307, 6593.3736295051895, 6599.637019963948, 6363.268224154096, 6434.195725534309, 6437.774677886251, 6441.0, 6444.3233460487845, 6397.0, 6431.453326467303, 6435.646039467687, 6439.967800160969, 6443.613383197023, 6335.94081923386, 6342.556021078664, 6348.714307856065, 6352.714127864165, 6355.809325720235, 6456.709448074942, 6462.515311351762, 6462.967685161544, 6465.838354040999, 6478.870422591616, 6197.938020619736, 6272.027835685476, 6306.842328941813, 6321.431071203614, 6397.552171347961], "unit": "score", "name": "prototype.html", "value": 4908.041228718127}, {"lowerIsBetter": false, "replicates": [735.000399456739, 740.3189066059226, 740.7074205688754, 762.4053238473992, 768.9307962283393, 12795.296258705768, 12807.23156610603, 12857.357132143403, 12861.54984575539, 13130.212187268758, 12108.69728256794, 12292.877071229284, 12316.322602256872, 12316.938415307934, 12319.876801231985, 749.6851322444572, 910.6767097680328, 935.4480856294784, 936.5036530638772, 937.8452555328363, 926.0461724423855, 926.0785518409192, 926.5228407370209, 931.4597533430594, 931.4737173496952, 796.0526972902256, 966.4587830814731, 969.3553786731815, 972.6012334942675, 974.3033730882453, 941.1623654947102, 958.9520523973773, 959.2661613865398, 959.3811991265629, 959.4818797849153, 701.7543859649134, 705.573128257402, 705.6718625838959, 705.7600415858633, 707.1443553300512, 12801.0, 12841.0, 12861.807072893915, 12867.613971580868, 12897.419616117297, 11253.156013299036, 11508.079353651689, 11557.595484158099, 11786.469608867535, 12359.382030898509, 9662.613495460244, 9685.0, 9782.902170978341, 9803.215742740635, 9901.752456188653, 3337.916552086217, 3339.96660033399, 3380.1380647934866, 3388.2715216228385, 3433.7939723616414, 48886.26670599944, 49152.50847491515, 50937.23594146091, 50951.49048509542, 51015.744921275524, 9004.774880628036, 9207.40151890125, 9252.722418327461, 9265.490398028172, 9453.858192127123, 16182.676346473005, 16188.271527781279, 16196.109213993108, 16204.513864583845, 16206.918965405097, 7146.285371462916, 7230.710771569184, 7328.633568321563, 7408.814779630552, 7493.288137626917, 4183.267928112568, 4200.978995105066, 4217.873463796091, 4330.090680957034, 4340.8697739067875, 3124.968750312468, 3131.9217019574694, 3149.700778426046, 3157.0, 3157.857896394668, 583.0641819879118, 585.5052480653841, 595.6336852835561, 608.8660494691161, 630.782380078872, 616.4852348289139, 618.3723520626568, 626.7586979013022, 634.9111124442582, 635.5942707274692, 7848.489848159851, 7945.761627151194, 7965.402594805297, 7976.401769867283, 8033.718819841394, 498.41685228282995, 585.7539833270037, 586.9060950248025, 615.7352338494401, 621.285521650106, 3780.7542509736777, 3791.3554695701796, 3863.517060367454, 3892.708046896494, 3964.2269757397607, 60739.39260607337, 61668.383316167165, 61700.69149654313, 62602.37397626056, 63084.36915630785, 52368.47631523636, 52918.47081529135, 53168.20247696288, 53557.1966420504, 53736.193957090676, 48764.2685359727, 48841.0, 48845.26732099021, 49416.752916235186, 49771.50228497669, 7704.537727736354, 7770.650320735467, 7841.490303130278, 7902.881456778038, 8025.638846252049, 36491.270174595826, 36503.0, 36628.0, 36929.63070369369, 37621.81189094146, 44304.11391772211, 46158.76920615375, 47515.52484475111, 47830.760846196936, 48285.0, 9106.408083474553, 9491.715248542554, 9501.857472138061, 9535.809283814424, 9763.75590610212, 9997.600095996078, 10302.896971030194, 10327.225458090823, 10505.474726263808, 10537.9473102634, 9334.113259240361, 9447.574859131219, 9686.757831053998, 9763.707088787347, 9907.306488545733, 9856.507174641383, 10005.149562287286, 10043.949780251345, 10083.546240419051, 10103.09072183507, 9599.664011759554, 9666.806663866542, 9793.363431376938, 10014.849777253492, 10047.145992590711, 8604.311655067455, 8644.956775216335, 8840.115988401109, 8865.379423440556, 8871.423357481743, 8395.202455766692, 8488.915110848813, 8538.0, 8610.956945215234, 8629.320856092163], "unit": "score", "name": "yui.html", "value": 6137.428874852737}], "name": "dromaeo_css", "value": 7110.934118597506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 109.0, 109.0, 99.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 148.0, 167.0, 126.0, 146.0, 163.0, 127.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 75.0, 165.0, 74.0, 75.0, 75.0, 75.0, 159.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 140.0, 92.0, 93.0, 92.0, 135.0, 93.0, 92.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 53.0, 54.0, 56.0, 55.0, 56.0, 67.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [78.0, 88.0, 78.0, 78.0, 77.0, 78.0, 78.0, 78.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [119.0, 110.0, 111.0, 112.0, 117.0, 110.0, 111.0, 111.0, 111.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 154.0, 144.0, 143.0, 133.0, 145.0, 144.0, 142.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 67.0, 69.0, 71.0, 64.0, 67.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1491.6000000000001}]} 21:11:59 INFO - Return code: 0 21:11:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:11:59 INFO - # TBPL SUCCESS # 21:11:59 INFO - Running post-action listener: _resource_record_post_action 21:11:59 INFO - Running post-run listener: _resource_record_post_run 21:12:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 114688; Write bytes: 500465664; Read time: 448; Write time: 835840 21:12:00 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 256794624; Read time: 0; Write time: 485584 21:12:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 114688; Write bytes: 243671040; Read time: 448; Write time: 350256 21:12:00 INFO - Running post-run listener: _upload_blobber_files 21:12:00 INFO - Blob upload gear active. 21:12:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:12:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:12:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 21:12:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 21:12:01 INFO - (blobuploader) - INFO - Open directory for files ... 21:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 21:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:12:01 INFO - (blobuploader) - INFO - Done attempting. 21:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:12:02 INFO - (blobuploader) - INFO - Done attempting. 21:12:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:12:02 INFO - Return code: 0 21:12:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:12:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:12:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b04f1b13dff33194822497d59aa345d04b3804bdcdb36a074348dff40d0967aedbd1d0498a5173caea8db0bb41cf2d121314c96083447cfb465a6cef09c029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977c58c6858b31aa20f4223b38c325eba37b75d490699ae6e6ba52e2dd4d369a925435bb543ae3ad097f60431b6b9f3b90b87f567a9ba3c7d9bee1a8d0c1207b"} 21:12:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:12:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:12:02 INFO - Contents: 21:12:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b04f1b13dff33194822497d59aa345d04b3804bdcdb36a074348dff40d0967aedbd1d0498a5173caea8db0bb41cf2d121314c96083447cfb465a6cef09c029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977c58c6858b31aa20f4223b38c325eba37b75d490699ae6e6ba52e2dd4d369a925435bb543ae3ad097f60431b6b9f3b90b87f567a9ba3c7d9bee1a8d0c1207b"} 21:12:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:12:02 INFO - Copying logs to upload dir... 21:12:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 21:12:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.968894 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-13 21:12:02.448115) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 21:12:02.454019) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b04f1b13dff33194822497d59aa345d04b3804bdcdb36a074348dff40d0967aedbd1d0498a5173caea8db0bb41cf2d121314c96083447cfb465a6cef09c029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977c58c6858b31aa20f4223b38c325eba37b75d490699ae6e6ba52e2dd4d369a925435bb543ae3ad097f60431b6b9f3b90b87f567a9ba3c7d9bee1a8d0c1207b"} build_url:https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/HYHRQCJVTqqbi61Pjg2p_Q/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b04f1b13dff33194822497d59aa345d04b3804bdcdb36a074348dff40d0967aedbd1d0498a5173caea8db0bb41cf2d121314c96083447cfb465a6cef09c029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977c58c6858b31aa20f4223b38c325eba37b75d490699ae6e6ba52e2dd4d369a925435bb543ae3ad097f60431b6b9f3b90b87f567a9ba3c7d9bee1a8d0c1207b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 21:12:02.483470) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 21:12:02.483795) ========= 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=5cf47e208febbcd81da23b2e0000026f-1457924342.74952-375492643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 21:12:02.566650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 21:12:02.566940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 21:12:02.567223) ========= ========= Total master_lag: 0.30 =========