builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1460031280.97 results: success (0) buildid: 20160406205952 builduid: 802fb4da4f694f48964711c616cb8edc revision: 2355485d9a8e09c7cfe47063bd192b72ec34d286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:40.970165) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:40.971220) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:40.971976) ========= 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004486 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.16 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.140684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.141442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.472983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.473919) ========= 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.686202) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.686576) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.687030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:41.687342) ========= 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 05:14:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 93.4M=0s 2016-04-07 05:14:42 (93.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.590822 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:42.397337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:42.397724) ========= 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018843 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:42.635361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:14:42.636173) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --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 2355485d9a8e09c7cfe47063bd192b72ec34d286 --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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 05:14:42,778 truncating revision to first 12 chars 2016-04-07 05:14:42,778 Setting DEBUG logging. 2016-04-07 05:14:42,778 attempt 1/10 2016-04-07 05:14:42,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2355485d9a8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 05:14:43,710 unpacking tar archive at: mozilla-aurora-2355485d9a8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.217217 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:14:43.964634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:43.965390) ========= echo 2355485d9a8e09c7cfe47063bd192b72ec34d286 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2355485d9a8e09c7cfe47063bd192b72ec34d286'] 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2355485d9a8e09c7cfe47063bd192b72ec34d286 program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: '2355485d9a8e09c7cfe47063bd192b72ec34d286' ========= master_lag: 0.24 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:44.206638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:44.206996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:14:44.556384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-07 05:14:44.556842) ========= /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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:14:44 INFO - MultiFileLogger online at 20160407 05:14:44 in /builds/slave/test-pgo 05:14:44 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 05:14:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:14:44 INFO - {'append_to_log': False, 05:14:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:14:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:14:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:14:44 INFO - 'branch': 'Mozilla-Aurora', 05:14:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:44 INFO - 'config_files': ('talos/linux_config.py',), 05:14:44 INFO - 'default_actions': ('clobber', 05:14:44 INFO - 'read-buildbot-config', 05:14:44 INFO - 'download-and-extract', 05:14:44 INFO - 'populate-webroot', 05:14:44 INFO - 'create-virtualenv', 05:14:44 INFO - 'install', 05:14:44 INFO - 'run-tests'), 05:14:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:44 INFO - 'download_minidump_stackwalk': True, 05:14:44 INFO - 'download_symbols': 'ondemand', 05:14:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:44 INFO - 'installer_path': 'installer.exe', 05:14:44 INFO - 'log_level': 'info', 05:14:44 INFO - 'log_name': 'talos', 05:14:44 INFO - 'log_to_console': True, 05:14:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:14:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:14:44 INFO - 'opt_config_files': (), 05:14:44 INFO - 'pip_index': False, 05:14:44 INFO - 'sps_profile': False, 05:14:44 INFO - 'sps_profile_interval': 0, 05:14:44 INFO - 'suite': 'dromaeojs', 05:14:44 INFO - 'system_bits': '32', 05:14:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:44 INFO - 'title': 'talos-linux64-ix-011', 05:14:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:44 INFO - 'use_talos_json': True, 05:14:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:14:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:44 INFO - 'work_dir': 'build'} 05:14:44 INFO - ##### 05:14:44 INFO - ##### Running clobber step. 05:14:44 INFO - ##### 05:14:44 INFO - Running pre-action listener: _resource_record_pre_action 05:14:44 INFO - Running main action method: clobber 05:14:44 INFO - rmtree: /builds/slave/test-pgo/build 05:14:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:14:45 INFO - Running post-action listener: _resource_record_post_action 05:14:45 INFO - ##### 05:14:45 INFO - ##### Running read-buildbot-config step. 05:14:45 INFO - ##### 05:14:45 INFO - Running pre-action listener: _resource_record_pre_action 05:14:45 INFO - Running main action method: read_buildbot_config 05:14:45 INFO - Using buildbot properties: 05:14:45 INFO - { 05:14:45 INFO - "project": "", 05:14:45 INFO - "product": "firefox", 05:14:45 INFO - "script_repo_revision": "production", 05:14:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:14:45 INFO - "repository": "", 05:14:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:14:45 INFO - "buildid": "20160406205952", 05:14:45 INFO - "pgo_build": "True", 05:14:45 INFO - "basedir": "/builds/slave/test-pgo", 05:14:45 INFO - "buildnumber": 414, 05:14:45 INFO - "slavename": "talos-linux64-ix-011", 05:14:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:14:45 INFO - "platform": "ubuntu64_hw", 05:14:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:14:45 INFO - "branch": "mozilla-aurora", 05:14:45 INFO - "repo_path": "releases/mozilla-aurora", 05:14:45 INFO - "revision": "2355485d9a8e09c7cfe47063bd192b72ec34d286", 05:14:45 INFO - "stage_platform": "linux64-pgo", 05:14:45 INFO - "builduid": "802fb4da4f694f48964711c616cb8edc", 05:14:45 INFO - "slavebuilddir": "test" 05:14:45 INFO - } 05:14:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 05:14:45 INFO - Running post-action listener: _resource_record_post_action 05:14:45 INFO - ##### 05:14:45 INFO - ##### Running download-and-extract step. 05:14:45 INFO - ##### 05:14:45 INFO - Running pre-action listener: _resource_record_pre_action 05:14:45 INFO - Running main action method: download_and_extract 05:14:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:45 INFO - https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:46 INFO - Downloaded 1448 bytes. 05:14:46 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:14:46 INFO - Using the following test package requirements: 05:14:46 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:14:46 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:14:46 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:14:46 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'jsshell-linux-x86_64.zip'], 05:14:46 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:14:46 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:14:46 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:14:46 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:14:46 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:14:46 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:14:46 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:14:46 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:14:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:14: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')]} 05:14:46 INFO - https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:49 INFO - Downloaded 23345428 bytes. 05:14:49 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'] 05:14:49 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 05:14:50 INFO - Return code: 0 05:14:50 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 05:14:50 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')]} 05:14:50 INFO - https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:14:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:14:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:14:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:51 INFO - Downloaded 23345428 bytes. 05:14:51 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'] 05:14:51 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 05:14:53 INFO - Return code: 0 05:14:53 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')]} 05:14:53 INFO - https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:14:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:14:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:14:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:54 INFO - Downloaded 10845168 bytes. 05:14:54 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'] 05:14:54 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 05:14:54 INFO - Return code: 0 05:14:54 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')]} 05:14:54 INFO - https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:14:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:14:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:14:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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 05:14:56 INFO - Downloaded 60559106 bytes. 05:14:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:14:56 INFO - mkdir: /builds/slave/test-pgo/properties 05:14:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:14:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:14:56 INFO - Contents: 05:14:56 INFO - build_url:https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:14:57 INFO - Running post-action listener: _resource_record_post_action 05:14:57 INFO - Running post-action listener: set_extra_try_arguments 05:14:57 INFO - ##### 05:14:57 INFO - ##### Running populate-webroot step. 05:14:57 INFO - ##### 05:14:57 INFO - Running pre-action listener: _resource_record_pre_action 05:14:57 INFO - Running main action method: populate_webroot 05:14:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:57 INFO - '--tppagecycles', 05:14:57 INFO - '7'], 05:14:57 INFO - 'tests': ['tsvgm']}}, 05:14:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:14:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:14:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'tests': ['damp', 'tps']}, 05:14:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['damp', 'tps']}, 05:14:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:14:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:57 INFO - 'other': {'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'other_l64': {'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'other_nol64': {'tests': ['a11yr', 05:14:57 INFO - 'ts_paint', 05:14:57 INFO - 'tpaint', 05:14:57 INFO - 'sessionrestore', 05:14:57 INFO - 'sessionrestore_no_auto_restore', 05:14:57 INFO - 'tabpaint']}, 05:14:57 INFO - 'svgr': {'tests': ['tsvgx', 05:14:57 INFO - 'tsvgr_opacity', 05:14:57 INFO - 'tart', 05:14:57 INFO - 'tscrollx', 05:14:57 INFO - 'cart']}, 05:14:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['tsvgx', 05:14:57 INFO - 'tsvgr_opacity', 05:14:57 INFO - 'tart', 05:14:57 INFO - 'tscrollx', 05:14:57 INFO - 'cart']}, 05:14:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'tests': ['tp5o']}, 05:14:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'talos_options': ['--e10s'], 05:14:57 INFO - 'tests': ['tp5o']}, 05:14:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'talos_options': ['--xperf_path', 05:14:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:57 INFO - 'tests': ['tp5n']}, 05:14:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:57 INFO - 'talos_options': ['--e10s', 05:14:57 INFO - '--xperf_path', 05:14:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:57 INFO - 'tests': ['tp5n']}}, 05:14:57 INFO - 'talos.zip': {'path': '', 05:14:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:57 INFO - Running post-action listener: _resource_record_post_action 05:14:57 INFO - ##### 05:14:57 INFO - ##### Running create-virtualenv step. 05:14:57 INFO - ##### 05:14:57 INFO - Running pre-action listener: _resource_record_pre_action 05:14:57 INFO - Running main action method: create_virtualenv 05:14:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:14:57 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 05:14:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:14:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:57 INFO - Using real prefix '/usr' 05:14:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:14:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:00 INFO - Installing pip.................done. 05:15:00 INFO - Return code: 0 05:15:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:15:00 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')]} 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 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')]} 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:00 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 05:15:00 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 05:15:00 INFO - Using env: {'DISPLAY': ':0', 05:15:00 INFO - 'HOME': '/home/cltbld', 05:15:00 INFO - 'LANG': 'en_US.UTF-8', 05:15:00 INFO - 'LANGUAGE': 'en_US:en', 05:15:00 INFO - 'LOGNAME': 'cltbld', 05:15:00 INFO - 'MAIL': '/var/mail/cltbld', 05:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:00 INFO - 'MOZ_NO_REMOTE': '1', 05:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:00 INFO - 'NO_EM_RESTART': '1', 05:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:00 INFO - 'SHELL': '/bin/bash', 05:15:00 INFO - 'SHLVL': '1', 05:15:00 INFO - 'TERM': 'linux', 05:15:00 INFO - 'TMOUT': '86400', 05:15:00 INFO - 'USER': 'cltbld', 05:15:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:00 INFO - '_': '/tools/buildbot/bin/python'} 05:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:00 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 05:15:00 INFO - Cleaning up... 05:15:00 INFO - Return code: 0 05:15:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:15:00 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')]} 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 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')]} 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:00 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:00 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 05:15:00 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 05:15:00 INFO - Using env: {'DISPLAY': ':0', 05:15:00 INFO - 'HOME': '/home/cltbld', 05:15:00 INFO - 'LANG': 'en_US.UTF-8', 05:15:00 INFO - 'LANGUAGE': 'en_US:en', 05:15:00 INFO - 'LOGNAME': 'cltbld', 05:15:00 INFO - 'MAIL': '/var/mail/cltbld', 05:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:00 INFO - 'MOZ_NO_REMOTE': '1', 05:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:00 INFO - 'NO_EM_RESTART': '1', 05:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:00 INFO - 'SHELL': '/bin/bash', 05:15:00 INFO - 'SHLVL': '1', 05:15:00 INFO - 'TERM': 'linux', 05:15:00 INFO - 'TMOUT': '86400', 05:15:00 INFO - 'USER': 'cltbld', 05:15:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:00 INFO - '_': '/tools/buildbot/bin/python'} 05:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:00 INFO - Downloading/unpacking psutil>=0.7.1 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:03 INFO - Installing collected packages: psutil 05:15:03 INFO - Running setup.py install for psutil 05:15:03 INFO - building 'psutil._psutil_linux' extension 05:15:03 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 05:15:03 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 05:15:03 INFO - building 'psutil._psutil_posix' extension 05:15:03 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 05:15:03 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 05:15:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:04 INFO - Successfully installed psutil 05:15:04 INFO - Cleaning up... 05:15:04 INFO - Return code: 0 05:15:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:15: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')]} 05:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:15: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 mozsystemmonitor==0.0.0 05:15:04 INFO - Using env: {'DISPLAY': ':0', 05:15:04 INFO - 'HOME': '/home/cltbld', 05:15:04 INFO - 'LANG': 'en_US.UTF-8', 05:15:04 INFO - 'LANGUAGE': 'en_US:en', 05:15:04 INFO - 'LOGNAME': 'cltbld', 05:15:04 INFO - 'MAIL': '/var/mail/cltbld', 05:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:04 INFO - 'MOZ_NO_REMOTE': '1', 05:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:04 INFO - 'NO_EM_RESTART': '1', 05:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:04 INFO - 'SHELL': '/bin/bash', 05:15:04 INFO - 'SHLVL': '1', 05:15:04 INFO - 'TERM': 'linux', 05:15:04 INFO - 'TMOUT': '86400', 05:15:04 INFO - 'USER': 'cltbld', 05:15:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:04 INFO - '_': '/tools/buildbot/bin/python'} 05:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:15:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:15:08 INFO - Installing collected packages: mozsystemmonitor 05:15:08 INFO - Running setup.py install for mozsystemmonitor 05:15:08 INFO - Successfully installed mozsystemmonitor 05:15:08 INFO - Cleaning up... 05:15:08 INFO - Return code: 0 05:15:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:15:08 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')]} 05:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:08 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')]} 05:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:08 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:08 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 05:15:08 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 05:15:08 INFO - Using env: {'DISPLAY': ':0', 05:15:08 INFO - 'HOME': '/home/cltbld', 05:15:08 INFO - 'LANG': 'en_US.UTF-8', 05:15:08 INFO - 'LANGUAGE': 'en_US:en', 05:15:08 INFO - 'LOGNAME': 'cltbld', 05:15:08 INFO - 'MAIL': '/var/mail/cltbld', 05:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:08 INFO - 'MOZ_NO_REMOTE': '1', 05:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:08 INFO - 'NO_EM_RESTART': '1', 05:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:08 INFO - 'SHELL': '/bin/bash', 05:15:08 INFO - 'SHLVL': '1', 05:15:08 INFO - 'TERM': 'linux', 05:15:08 INFO - 'TMOUT': '86400', 05:15:08 INFO - 'USER': 'cltbld', 05:15:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:08 INFO - '_': '/tools/buildbot/bin/python'} 05:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:08 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 05:15:08 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 05:15:08 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 05:15:08 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 05:15:08 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 05:15:08 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 05:15:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:10 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 05:15:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:15:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:11 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 05:15:11 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 05:15:11 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 05:15:11 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 05:15:11 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 05:15:11 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 05:15:11 INFO - Downloading docopt-0.6.1.tar.gz 05:15:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:11 INFO - Running setup.py install for blobuploader 05:15:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:15:11 INFO - Running setup.py install for requests 05:15:12 INFO - Running setup.py install for docopt 05:15:12 INFO - Successfully installed blobuploader requests docopt 05:15:12 INFO - Cleaning up... 05:15:12 INFO - Return code: 0 05:15:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:15:12 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')]} 05:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:12 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')]} 05:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:12 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:12 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 05:15:12 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 05:15:12 INFO - Using env: {'DISPLAY': ':0', 05:15:12 INFO - 'HOME': '/home/cltbld', 05:15:12 INFO - 'LANG': 'en_US.UTF-8', 05:15:12 INFO - 'LANGUAGE': 'en_US:en', 05:15:12 INFO - 'LOGNAME': 'cltbld', 05:15:12 INFO - 'MAIL': '/var/mail/cltbld', 05:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:12 INFO - 'MOZ_NO_REMOTE': '1', 05:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:12 INFO - 'NO_EM_RESTART': '1', 05:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:12 INFO - 'SHELL': '/bin/bash', 05:15:12 INFO - 'SHLVL': '1', 05:15:12 INFO - 'TERM': 'linux', 05:15:12 INFO - 'TMOUT': '86400', 05:15:12 INFO - 'USER': 'cltbld', 05:15:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:12 INFO - '_': '/tools/buildbot/bin/python'} 05:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:15:12 INFO - Running setup.py (path:/tmp/pip-2A9lge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:15:12 INFO - Running setup.py (path:/tmp/pip-xqpXyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:15:12 INFO - Running setup.py (path:/tmp/pip-U9pYza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:15:12 INFO - Running setup.py (path:/tmp/pip-_JKVMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:15:12 INFO - Running setup.py (path:/tmp/pip-4RpXcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:15:12 INFO - Running setup.py (path:/tmp/pip-Qz13TW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:15:12 INFO - Running setup.py (path:/tmp/pip-AhGnrN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:15:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:15:12 INFO - Running setup.py (path:/tmp/pip-YxvC9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:15:13 INFO - Running setup.py (path:/tmp/pip-pV95WY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:15:13 INFO - Running setup.py (path:/tmp/pip-Si3ukM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:15:13 INFO - Running setup.py (path:/tmp/pip-qhyITa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:15:13 INFO - Running setup.py (path:/tmp/pip-6vkV6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:15:13 INFO - Running setup.py (path:/tmp/pip-2OT_xa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:15:13 INFO - Running setup.py (path:/tmp/pip-MQkWSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:15:13 INFO - Running setup.py (path:/tmp/pip-9U7BZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:15:13 INFO - Running setup.py (path:/tmp/pip-BhPcN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:15:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:15:13 INFO - Running setup.py (path:/tmp/pip-TdDIRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:15:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:13 INFO - Running setup.py install for manifestparser 05:15:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:15:13 INFO - Running setup.py install for mozcrash 05:15:13 INFO - Running setup.py install for mozdebug 05:15:13 INFO - Running setup.py install for mozdevice 05:15:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for mozfile 05:15:14 INFO - Running setup.py install for mozhttpd 05:15:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for mozinfo 05:15:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for mozInstall 05:15:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for mozleak 05:15:14 INFO - Running setup.py install for mozlog 05:15:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for moznetwork 05:15:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:15:14 INFO - Running setup.py install for mozprocess 05:15:14 INFO - Running setup.py install for mozprofile 05:15:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:15:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:15:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:15:15 INFO - Running setup.py install for mozrunner 05:15:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:15:15 INFO - Running setup.py install for mozscreenshot 05:15:15 INFO - Running setup.py install for moztest 05:15:15 INFO - Running setup.py install for mozversion 05:15:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:15:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:15 INFO - Cleaning up... 05:15:15 INFO - Return code: 0 05:15:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:15 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:15 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 05:15:15 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 05:15:15 INFO - Using env: {'DISPLAY': ':0', 05:15:15 INFO - 'HOME': '/home/cltbld', 05:15:15 INFO - 'LANG': 'en_US.UTF-8', 05:15:15 INFO - 'LANGUAGE': 'en_US:en', 05:15:15 INFO - 'LOGNAME': 'cltbld', 05:15:15 INFO - 'MAIL': '/var/mail/cltbld', 05:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:15 INFO - 'MOZ_NO_REMOTE': '1', 05:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:15 INFO - 'NO_EM_RESTART': '1', 05:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:15 INFO - 'SHELL': '/bin/bash', 05:15:15 INFO - 'SHLVL': '1', 05:15:15 INFO - 'TERM': 'linux', 05:15:15 INFO - 'TMOUT': '86400', 05:15:15 INFO - 'USER': 'cltbld', 05:15:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:15 INFO - '_': '/tools/buildbot/bin/python'} 05:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:15:15 INFO - Running setup.py (path:/tmp/pip-BWbCv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:15:15 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)) 05:15:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:15:15 INFO - Running setup.py (path:/tmp/pip-U6SUat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:15:15 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)) 05:15:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:15:15 INFO - Running setup.py (path:/tmp/pip-F723pN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:15:15 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)) 05:15:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:15:15 INFO - Running setup.py (path:/tmp/pip-h6J_m2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:15:16 INFO - Running setup.py (path:/tmp/pip-8wwzlQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:15:16 INFO - Running setup.py (path:/tmp/pip-ZdIw_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:15:16 INFO - Running setup.py (path:/tmp/pip-cJdK3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:15:16 INFO - Running setup.py (path:/tmp/pip-6wxow6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:15:16 INFO - Running setup.py (path:/tmp/pip-nJLco4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:15:16 INFO - Running setup.py (path:/tmp/pip-gRH2y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:15:16 INFO - Running setup.py (path:/tmp/pip-fuDwU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:15:16 INFO - Running setup.py (path:/tmp/pip-2CgqOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:15:16 INFO - Running setup.py (path:/tmp/pip-qIYYps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:15:16 INFO - Running setup.py (path:/tmp/pip-n7R4AX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:15:16 INFO - Running setup.py (path:/tmp/pip-9ql64F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:15:16 INFO - Running setup.py (path:/tmp/pip-nLLSdk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:15:16 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)) 05:15:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:15:16 INFO - Running setup.py (path:/tmp/pip-AgOiD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:15:16 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)) 05:15:16 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)) 05:15:16 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)) 05:15:16 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)) 05:15:16 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)) 05:15:16 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)) 05:15:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:16 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 05:15:19 INFO - Downloading blessings-1.6.tar.gz 05:15:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:19 INFO - Installing collected packages: blessings 05:15:19 INFO - Running setup.py install for blessings 05:15:19 INFO - Successfully installed blessings 05:15:19 INFO - Cleaning up... 05:15:19 INFO - Return code: 0 05:15:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:15:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:15:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:15:20 INFO - Reading from file tmpfile_stdout 05:15:20 INFO - Current package versions: 05:15:20 INFO - argparse == 1.2.1 05:15:20 INFO - blessings == 1.6 05:15:20 INFO - blobuploader == 1.2.4 05:15:20 INFO - docopt == 0.6.1 05:15:20 INFO - manifestparser == 1.1 05:15:20 INFO - mozInstall == 1.12 05:15:20 INFO - mozcrash == 0.17 05:15:20 INFO - mozdebug == 0.1 05:15:20 INFO - mozdevice == 0.48 05:15:20 INFO - mozfile == 1.2 05:15:20 INFO - mozhttpd == 0.7 05:15:20 INFO - mozinfo == 0.9 05:15:20 INFO - mozleak == 0.1 05:15:20 INFO - mozlog == 3.1 05:15:20 INFO - moznetwork == 0.27 05:15:20 INFO - mozprocess == 0.22 05:15:20 INFO - mozprofile == 0.28 05:15:20 INFO - mozrunner == 6.11 05:15:20 INFO - mozscreenshot == 0.1 05:15:20 INFO - mozsystemmonitor == 0.0 05:15:20 INFO - moztest == 0.7 05:15:20 INFO - mozversion == 1.4 05:15:20 INFO - psutil == 3.1.1 05:15:20 INFO - requests == 1.2.3 05:15:20 INFO - wsgiref == 0.1.2 05:15:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:15:20 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')]} 05:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:20 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')]} 05:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:20 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:20 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 05:15:20 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 05:15:20 INFO - Using env: {'DISPLAY': ':0', 05:15:20 INFO - 'HOME': '/home/cltbld', 05:15:20 INFO - 'LANG': 'en_US.UTF-8', 05:15:20 INFO - 'LANGUAGE': 'en_US:en', 05:15:20 INFO - 'LOGNAME': 'cltbld', 05:15:20 INFO - 'MAIL': '/var/mail/cltbld', 05:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:20 INFO - 'MOZ_NO_REMOTE': '1', 05:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:20 INFO - 'NO_EM_RESTART': '1', 05:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:20 INFO - 'SHELL': '/bin/bash', 05:15:20 INFO - 'SHLVL': '1', 05:15:20 INFO - 'TERM': 'linux', 05:15:20 INFO - 'TMOUT': '86400', 05:15:20 INFO - 'USER': 'cltbld', 05:15:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:20 INFO - '_': '/tools/buildbot/bin/python'} 05:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 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)) 05:15:20 INFO - Cleaning up... 05:15:20 INFO - Return code: 0 05:15:20 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:15:20 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')]} 05:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:20 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')]} 05:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:20 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:20 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 05:15:20 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 05:15:20 INFO - Using env: {'DISPLAY': ':0', 05:15:20 INFO - 'HOME': '/home/cltbld', 05:15:20 INFO - 'LANG': 'en_US.UTF-8', 05:15:20 INFO - 'LANGUAGE': 'en_US:en', 05:15:20 INFO - 'LOGNAME': 'cltbld', 05:15:20 INFO - 'MAIL': '/var/mail/cltbld', 05:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:20 INFO - 'MOZ_NO_REMOTE': '1', 05:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:20 INFO - 'NO_EM_RESTART': '1', 05:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:20 INFO - 'SHELL': '/bin/bash', 05:15:20 INFO - 'SHLVL': '1', 05:15:20 INFO - 'TERM': 'linux', 05:15:20 INFO - 'TMOUT': '86400', 05:15:20 INFO - 'USER': 'cltbld', 05:15:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:20 INFO - '_': '/tools/buildbot/bin/python'} 05:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:20 INFO - Downloading/unpacking jsonschema 05:15:20 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 05:15:20 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 05:15:20 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 05:15:20 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 05:15:20 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 05:15:20 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 05:15:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:23 INFO - Downloading/unpacking functools32 (from jsonschema) 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:23 INFO - warning: no files found matching '*.txt' 05:15:23 INFO - no previously-included directories found matching 'build' 05:15:23 INFO - no previously-included directories found matching 'dist' 05:15:23 INFO - no previously-included directories found matching '.git*' 05:15:23 INFO - Installing collected packages: jsonschema, functools32 05:15:23 INFO - Running setup.py install for functools32 05:15:23 INFO - warning: no files found matching '*.txt' 05:15:23 INFO - no previously-included directories found matching 'build' 05:15:23 INFO - no previously-included directories found matching 'dist' 05:15:23 INFO - no previously-included directories found matching '.git*' 05:15:23 INFO - Successfully installed jsonschema functools32 05:15:23 INFO - Cleaning up... 05:15:23 INFO - Return code: 0 05:15:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:15: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')]} 05:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:23 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 0x7f51d3524f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ee6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, '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-1460031279.167479-1358916420', '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 05:15:23 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 05:15:23 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 05:15:23 INFO - Using env: {'DISPLAY': ':0', 05:15:23 INFO - 'HOME': '/home/cltbld', 05:15:23 INFO - 'LANG': 'en_US.UTF-8', 05:15:23 INFO - 'LANGUAGE': 'en_US:en', 05:15:23 INFO - 'LOGNAME': 'cltbld', 05:15:23 INFO - 'MAIL': '/var/mail/cltbld', 05:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:23 INFO - 'MOZ_NO_REMOTE': '1', 05:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:23 INFO - 'NO_EM_RESTART': '1', 05:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:23 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:23 INFO - 'SHELL': '/bin/bash', 05:15:23 INFO - 'SHLVL': '1', 05:15:23 INFO - 'TERM': 'linux', 05:15:23 INFO - 'TMOUT': '86400', 05:15:23 INFO - 'USER': 'cltbld', 05:15:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:23 INFO - '_': '/tools/buildbot/bin/python'} 05:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:23 INFO - Downloading/unpacking flake8 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:23 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 05:15:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:25 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 05:15:25 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 05:15:25 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 05:15:25 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 05:15:25 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 05:15:25 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 05:15:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 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 05:15:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:26 INFO - no previously-included directories found matching 'docs/_build' 05:15:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:26 INFO - Running setup.py install for pep8 05:15:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:26 INFO - no previously-included directories found matching 'docs/_build' 05:15:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:15:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:26 INFO - Cleaning up... 05:15:27 INFO - Return code: 0 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - Running post-action listener: _start_resource_monitoring 05:15:27 INFO - Starting resource monitoring. 05:15:27 INFO - ##### 05:15:27 INFO - ##### Running install step. 05:15:27 INFO - ##### 05:15:27 INFO - Running pre-action listener: _resource_record_pre_action 05:15:27 INFO - Running main action method: install 05:15:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:15:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:15:27 INFO - Reading from file tmpfile_stdout 05:15:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:15:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:15:27 INFO - Reading from file tmpfile_stdout 05:15:27 INFO - Output received: 05:15:27 INFO - Usage: mozinstall [options] installer 05:15:27 INFO - Options: 05:15:27 INFO - -h, --help show this help message and exit 05:15:27 INFO - -d DEST, --destination=DEST 05:15:27 INFO - Directory to install application into. [default: 05:15:27 INFO - "/builds/slave/test-pgo"] 05:15:27 INFO - --app=APP Application being installed. [default: firefox] 05:15:27 INFO - mkdir: /builds/slave/test-pgo/build/application 05:15:27 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'] 05:15:27 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 05:15:42 INFO - Reading from file tmpfile_stdout 05:15:42 INFO - Output received: 05:15:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:15:42 INFO - Running post-action listener: _resource_record_post_action 05:15:42 INFO - ##### 05:15:42 INFO - ##### Running run-tests step. 05:15:42 INFO - ##### 05:15:42 INFO - Running pre-action listener: _resource_record_pre_action 05:15:42 INFO - Running main action method: run_tests 05:15:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:15:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:15:42 INFO - Python 2.7.3 05:15:42 INFO - Return code: 0 05:15:42 INFO - grabbing minidump binary from tooltool 05:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:42 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 0x267d920>, '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 0x267e820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267ecb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:15:42 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 05:15:42 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 05:15:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:42 INFO - Return code: 0 05:15:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:15:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:15:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:15:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:15:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:15:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:15:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:15:43 INFO - Return code: 0 05:15:43 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/LAZJeSH7TB6l-uq_wgDKcA/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 05:15:43 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/LAZJeSH7TB6l-uq_wgDKcA/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 05:15:43 INFO - Using env: {'DISPLAY': ':0', 05:15:43 INFO - 'HOME': '/home/cltbld', 05:15:43 INFO - 'LANG': 'en_US.UTF-8', 05:15:43 INFO - 'LANGUAGE': 'en_US:en', 05:15:43 INFO - 'LOGNAME': 'cltbld', 05:15:43 INFO - 'MAIL': '/var/mail/cltbld', 05:15:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:15:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:43 INFO - 'MOZ_NO_REMOTE': '1', 05:15:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:15:43 INFO - 'NO_EM_RESTART': '1', 05:15:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:15:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:15:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:15:43 INFO - 'SHELL': '/bin/bash', 05:15:43 INFO - 'SHLVL': '1', 05:15:43 INFO - 'TERM': 'linux', 05:15:43 INFO - 'TMOUT': '86400', 05:15:43 INFO - 'USER': 'cltbld', 05:15:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460031279.167479-1358916420', 05:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:43 INFO - '_': '/tools/buildbot/bin/python'} 05:15:43 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/LAZJeSH7TB6l-uq_wgDKcA/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 05:15:43 INFO - mozversion application_buildid: 20160406205952 05:15:43 INFO - mozversion application_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:15:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:15:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:43 INFO - mozversion application_name: Firefox 05:15:43 INFO - mozversion application_remotingname: firefox-dev 05:15:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:15:43 INFO - mozversion application_vendor: Mozilla 05:15:43 INFO - mozversion application_version: 47.0a2 05:15:43 INFO - mozversion platform_buildid: 20160406205952 05:15:43 INFO - mozversion platform_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:15:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:15:43 INFO - mozversion platform_version: 47.0a2 05:15:43 INFO - using testdate: 1460031343 05:15:43 INFO - actual date: 1460031343 05:15:43 INFO - starting webserver on 'localhost:46617' 05:15:43 INFO - SUITE-START | Running 2 tests 05:15:43 INFO - TEST-START | dromaeo_css 05:15:43 INFO - operating with platform_type : linux_ 05:15:43 INFO - Initialising browser for dromaeo_css test... 05:15:43 INFO - TEST-INFO | started process 26624 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPGFIv5/profile http://localhost:46617/getInfo.html) 05:15:48 INFO - PROCESS | 26624 | __metrics Screen width/height:1600/1200 05:15:48 INFO - PROCESS | 26624 | colorDepth:24 05:15:48 INFO - PROCESS | 26624 | Browser inner width/height: 1024/697 05:15:48 INFO - PROCESS | 26624 | __metrics 05:15:50 INFO - PROCESS | 26624 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:51 INFO - TEST-INFO | 26624: exit 0 05:15:51 INFO - Browser initialized. 05:15:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:51 INFO - TEST-INFO | started process 26714 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPGFIv5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:03 INFO - PROCESS | 26714 | RSS: Main: 141877248 05:16:03 INFO - PROCESS | 26714 | 05:16:54 INFO - PROCESS | 26714 | 1460031414445 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] 05:19:02 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46617/tests/dromaeo/cssquery-ext.html) 05:19:03 INFO - PROCESS | 26714 | RSS: Main: 255500288 05:19:03 INFO - PROCESS | 26714 | 05:22:05 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-ext.html (next: http://localhost:46617/tests/dromaeo/cssquery-jquery.html) 05:22:05 INFO - PROCESS | 26714 | RSS: Main: 227753984 05:22:05 INFO - PROCESS | 26714 | 05:25:07 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46617/tests/dromaeo/cssquery-mootools.html) 05:25:08 INFO - PROCESS | 26714 | RSS: Main: 217513984 05:25:08 INFO - PROCESS | 26714 | 05:28:10 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46617/tests/dromaeo/cssquery-prototype.html) 05:28:10 INFO - PROCESS | 26714 | RSS: Main: 208453632 05:28:10 INFO - PROCESS | 26714 | 05:31:13 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46617/tests/dromaeo/cssquery-yui.html) 05:31:13 INFO - PROCESS | 26714 | RSS: Main: 211161088 05:31:13 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | Cycle 1(1): loaded http://localhost:46617/tests/dromaeo/cssquery-yui.html (next: http://localhost:46617/tests/dromaeo/cssquery-dojo.html) 05:34:16 INFO - PROCESS | 26714 | RSS: Main: 255062016 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | __start_tp_report 05:34:16 INFO - PROCESS | 26714 | _x_x_mozilla_page_load 05:34:16 INFO - PROCESS | 26714 | _x_x_mozilla_page_load_details 05:34:16 INFO - PROCESS | 26714 | |i|pagename|runs| 05:34:16 INFO - PROCESS | 26714 | |0;dojo.html;3258.0877354340782;3340.2317466982577;3353.0779035765163;3359.1770016346;3385.5429517015205;5354.250404943311;5362.061639213137;5370.812021579245;5376.301080859493;5407.864803379917;5353.973230133854;5360.758765855536;5381.058314794905;5385.272988146599;5387.838364849061;4761.833335833247;4904.1908085166;4910.828121015765;4958.975205123969;5005;4855.198892182786;4871.683340582868;4932.482089380617;4934;4936.06214819185;4915.680480768757;4929.852104436873;4964.15609346412;5006.674566153207;5012.273220383042;4940.061388336223;4958.132326842788;4963.503649635044;4986.700797952134;5007.048660754445;4726.527347265281;4780.737059461728;4865.318855360252;4889.3643826302705;4890.3642526471685;5143.742812859342;5148.948510514884;5154.845354639367;5166.302549155854;5197.974010129925;5679.176519404663;5679.630823996468;5698.800541981011;5722.799702010409;5724.885502289931;5715.714214289269;5772.220750198711;5807.30312362515;5812.738426770806;5826.067829147316;5369.463053694639;5421.647592906448;5424.728763561806;5443.455654434564;5461.208124821878;5754.079347304411;5879.470847623735;5889.882202356014;5942.910856337158;5966.731497082642;5625.831225063254;5653.406392328829;5657.57568182388;5657.858553536194;5660.5471562274915;5743.913841292384;5744.965906136936;5748.683822389725;5749.1663708762;5758.740856661377;5599.552035837123;5681.17622944679;5754;5760.279965004374;5770.855728606734;5747.3677895431465;5765.221695071195;5769.480746732815;5783.103618939072;5785.4793068623185;4412.117576484652;4417.514073451917;4418.315161150027;4436.578525040116;4458.353538736865;3909.980450097788;3949.2101579684177;3972.1261322509004;3986.880393588197;4010.558838527818;5464.28964234647;5488.231647569343;5488.259085023471;5492.670439773547;5523.751431185607;5690.061139911951;5721.656700597978;5802.796902108406;5825.4174582542255;5827.621204621771;5416.566674666017;5445.591580631469;5446.101393270066;5460.372057213392;5510.5316048135555;4979.900401992012;4987.226979818134;4988.700677959334;4989.501049894981;4992.051510213048;5841.94158058414;5844.211031510692;5933.465988061009;5944.227250457413;5947.583669143205;5814.098814683731;5868.5305175585;5893.941060589511;5896.764129434775;5900.940990590039;6044.123602077586;6052.636841789506;6063.090536419572;6063.787767428119;6066.272047354346;5600.131979543177;5620.297462817148;5643.802466913638;5793.797217097382;5796.0436527972415;5854.765809367577;5862.12068189775;5869.941300586939;5870.442307980735;5877.4122587740885;5683.516901063291;5708.115242137475;5709.600327977002;5711.371749107678;5716.256886604715;5538.695371754592;5595.496405323541;5660.405657405913;5693.601447898607;5693.772249109989;5594.664320140804;5616.1014237721765;5636.070048442125;5636.379998200113;5636.549076073986;5669.829905102853;5715.228444159985;5715.771369145187;5733.512651424676;5737.225474560881;5408.540274076748;5498.890022199614;5615.326160860723;5679.375268720355;5693.743781529758 05:34:16 INFO - PROCESS | 26714 | |1;ext.html;553.3995614757987;561.1918836874897;573.2891214893532;609.0255591054314;619.569399267509;31400.371992560165;39284.60715392845;39534.20931581366;39581;39667.60332396675;42710.35934460978;43034.784826075906;43124;43133.568664313345;43219.3517097243;8888.200061994436;9102.590383432762;9109.3168012399;9110.77223069422;9111.635534578641;8853.955730221373;9006.32452566057;9009.234215091725;9013.729588112366;9277.025912279214;9202.40184388016;9274.768130796716;9318.021607731192;9321.254299656046;9342.159205671489;9197.540122993856;9226.907730922672;9232.353735238536;9283.628654853797;9295.953520232355;9096.63613455461;9264;9267.814643707088;9269.490178040205;9270.814583708356;42604;42974.57025429737;42994.785026074984;43012.78493607512;43039;3712.3874560697723;3973.324534829086;4110.609492098276;4326.8269269229195;4345.478542574911;32544.186395340068;32683.6731632683;32699.6730032699;32934.176645583815;33048.6695133048;4214.936775948363;4289.399484072233;4294.398784170218;4312.870613881589;4331.870043898688;309017.45491272624;309242;310056;310267;311112;62484.687576561824;62594.37405625977;62847;63211.367886321466;63283.68358158272;67585.3241467579;67903.66048169727;67933.66033169802;74411.62794185994;75544;15979.280932358071;16148.35406583747;16150.75773863393;16177.514674559781;16193;12046.277223366626;12135.089868259916;12166.695832604255;12213.328266945404;12223.0832687547;22773.31680049568;23365.130789536797;23369.182078627167;23390.298291051295;23392.64911026336;8282.378821588405;8441;8469.66121355139;8515.787105322417;8555.743327700178;1078.8327809189589;1080.7892460970193;1090.2095980414135;1122.046260678433;1150.8503894493663;29591;29692.960746373774;30373.544396834066;30703.846480767454;31287.530687039714;1192.1374745823468;1214.1015648420282;1235.5057976809169;1248.993755031219;1258.3205069262679;15650.843491564938;16041.518754437386;16176;16253.187340632921;16438.342466301216;176798;177284.02221900044;177523;177896;328057;56943;57013.42986570164;57061.42938570644;57445;57490;1330.7138965122351;1383.9584812455641;1429.921354325522;1444.3283872999107;1464.3703207620613;27157.456850863266;27998;28347.716522834507;28743.71256287494;28841;42266;43093.13813723771;43165.136697266506;43195.78402107969;43205.783971079945;196904;201085;201486;201958;202359;30017.099487015425;33877.322453550296;34005.319893601496;34078.318433630695;35133.82433087818;41642;41912.790436047624;41925.37111943385;42588.787056064524;42718;38788.6121138785;40810.59189408068;41042.38436423516;41920;42093.36859947042;36431.635683642824;36780.632193677724;36961.26077478382;37009.629903701694;37100.25799483941;38697;38995.805020974716;39488.802555988186;40041.998950026486;40146;34784.652153479154;36093.27813443769;36256.45615315825;36505.81747091247;36618.45072323971;27286.863565682044;27468.725312747418;27557.173284801487;27616.171514854588;27704.86147569249 05:34:16 INFO - PROCESS | 26714 | |2;jquery.html;368.3369934118586;375.9943600845988;379.48579674541;382.9540455145382;384.1586924635051;17664;17706.82293177068;18328.175232114554;18393.080345982682;18456;15383.153926534063;15873.761893571576;15878.285477153528;15888.443904463345;15893.887427880052;5077.213031980049;5797.942020579803;5799.681017544033;5805.477507024367;5808.767649294024;4211.599898009684;4365.759883206422;5645.8588535286535;5977.372375900533;6198.039303907879;6094.055421409688;6140.140380346755;6160.630362178261;6162.291336496293;6171.7531298748;5850.795222167225;6141.1095391168255;6158.7228574714245;6159.81520554384;6163.044728067157;3775.2260786538695;5284.392294886099;5369.758360873731;5507.972460137674;5522.0336441123045;20630.17479300826;20651.483712907146;20725.89637051805;20957;20967.266145684982;2446.2905757330354;2635.235781623327;2746.0388863897474;2755.655543057118;3130.4521708700886;13173.802392964113;13753.656158596015;13833.446662133503;13948.093373930764;14049.016568840185;1904.8761830480973;1926.7109933509946;1963.8821670699804;2003.0885946894273;2065.514604068058;59540.40459595392;60819.39180608182;60921.39078609246;61110.38889611091;61562.69218653878;9273.907260927439;9441.291903107294;9874.901250987397;9929;10153.441560714084;14182.14907105577;14195.503157389649;14293.85706142946;14294.785578216335;14304.28478576067;7153.856922861618;7243.167035790952;7627.923720762832;7728.420368472387;7732.6520306586335;7242.818929526804;7250.601216933014;7257.092863392076;7279.45404094695;7322.048133742686;6092.573519853568;6204.255489341308;6204.751809927642;6217.813465596039;6235.127082208403;1702.174445393983;1724.637826056517;1736.0278244183298;1756.7277072053596;1835.8072402397556;1018.7198520406799;1018.8675472188568;1049.8635177427038;1128.1651577832345;1143.9370834604176;16501;16601.50195494137;17271.3955011574;17507;17735.46793596194;953.5041778275258;959.3284700709391;1009.1541851977354;1044.5821671331528;1059.8410238464292;9939.55272012761;10442.373457592568;10479.476026198812;10492.475376231157;10499.370037797604;440269;447937;456500;457662;459067;55377;66546;66979;68224.31775682278;69521.65239173872;1081;1082.6373164989816;1098.8022156011834;1107.7839821234782;1112.1380929779486;15798.131102788997;15966.042037477788;16025.118618476095;16139.112348820927;16232.107234101766;22534.4366390835;28941.710582893902;32116.67883321137;32868.671313287516;33169.83415083006;42683.57316426796;43933.78033109814;44063.33904991364;44163.55836441723;44774;7547.811304717426;7749.380049596131;8175.182481751777;8196.385271104571;8549.658013679384;10957.83563246568;11577.884221158018;11680.94159529197;11705.648830535098;11838.230515016496;10492.527836247235;10804.24370294072;10878.510467028844;10995.34027958325;11067.391293478937;10328.173746100143;10554.313969591953;10578.312409693654;10601.310914790514;10626.681199564026;10487.947560262455;10656.84014739795;10818.29681070728;10822;10868.56663537794;7613.771586852404;7678.616069196406;8063.758087257392;8117.918820811717;8262;10113.29206955506;10143;10263.538140783832;10774;10896.073833724222 05:34:16 INFO - PROCESS | 26714 | |3;mootools.html;1477.6379786952198;1568.2942675795894;1568.8117425908888;1827.524843540679;1939.4763413878254;7845.80385490363;8018.438709290352;8029.919700802998;8031.718889838857;8043.11525732169;7774.922250777505;7910.485818421813;7925.128235894047;7945.165757595441;7945.841083178333;2014.8488863335308;2068.4932191613075;2309.0994512140237;2344.8475849069755;2347.366211122996;2411.4212588978608;2427.2354208424376;2427.672264244331;2429.149797570854;2429.586970215059;2354.3290162303747;2356.634721618152;2368.1829768729845;2404.63930410439;2404.8076153907646;2335.439494521311;2340.555294494049;2342.6251799711963;2347.1080989224156;2411.131992482705;2340.9297721068397;2352.3060697094397;2356.5404746074523;2361.2798096580536;2363.3855197648563;8053.959730201312;8121.30968867647;8132.105468398471;8143.796405089861;8145;5007.649464537484;5078.46676099008;5116.590672746172;5122.129238029506;5124.666896651705;2965.510690736026;2992.9700702993127;3021.7884748067645;3026.9394612107853;3117.392108538836;952.8427809411439;954.4798085043668;968.0464742228899;997.3666721631744;1010.888802231754;10813.026827585476;10902.5093870776;10921.508532116073;10925.99999999992;10937.726556836064;4111.342185250345;4277.593628605277;4284.207421627009;4337.50118736343;4351.06452112791;8819.559022049;9014.729558113268;9078.636854525877;9085;9095.272378209727;4961.305417241589;5017.1721665924715;5017.598592112622;5020.723860187652;5024.397072351268;4093.7543747375253;4185.372194170899;4451.332300154938;4570.65720070996;4632.119897219585;3490.528778614905;3571.767835090711;3573.9642603574152;3600.765950213228;3610.4403817408343;1111.838783376406;1117.4245263689206;1143.1826244235413;1144.8511693479795;1145.335705290946;1077.7790552936629;1102.702270387007;1109.7669489407315;1331.766940785378;1455.083297522575;7602.420671258453;7686.730964416219;7690.846183076419;7761.6119194040075;7802.492837965628;529.6160283794219;536.0271107939078;539.4524557574066;549.9037668408013;560.7084316155576;6072.271327440735;6084.908726369108;6136.202293701879;6155.415235552616;6178.814635560941;9705.466199358962;9934.80130397388;9943.353682010791;10086;10090.344127631828;9656.806863862683;9914.504274786232;9938.652147174815;10003.099721024997;10017.14854237398;7697.692092316357;7795.103563090203;7825.060992680915;7863.095743989515;7866.567338796421;7481.625918703934;7496.812579685551;7550;7570.9242907570215;7571.167171611229;8853.778655533406;8940;9011.954940225258;9060;9065.77335566616;8803.691870784492;8979.685711000084;9003.54982250898;9098.59056342453;9208.03315651847;6169.383061693795;6308.211473565804;6617.66911654425;6742.359475849787;6829.248782634006;7368.300011498899;7407.8148046299275;7434.851302973802;7440.107187137578;7493.213212612597;6548.345165483413;6787.854574510706;6787.966060169668;6797.388235058868;6943.548669336477;6659.53383263167;6718.8320291993095;6747;6785.898211526733;6802.183737951477;7171.282871712787;7311.597862117635;7319.487635865651;7330.413566914527;7378.262173782578;6585.539012269095;6640.734370625314;6657.101291325803;6665.200175978914;6674.332566743286;6602.438792702674;6607.108040414482;6627.602343859384;6647.800565983028;6648.434883034996 05:34:16 INFO - PROCESS | 26714 | |4;prototype.html;361.28826212361645;362.1905042230614;363.21726679006736;363.8144546281396;369;6014.699265036747;6022.6687532185715;6026.276846778393;6030.728617212225;6040.456358927696;5888.352281249059;5974.701264936757;6009.038553831388;6023.819285421444;6030.216071910645;4494.415725955621;4545.250033744428;4590.885227869297;4702;4712.410948631421;4664.5102264262105;4687.2969054641735;4707.482176960531;4714.222153344694;4719.716816990975;4659.930101048487;4660.4174478190225;4660.557247061523;4669.953300466986;4683.250679891218;4466.910661786762;4528.886777830531;4654;4670.229412146991;4690.038542098861;4125.195586860564;4139.627433530996;4140.109876376593;4143.7720925349095;4147.274227010292;5704.942950570524;5725.599208055438;5741.024025915604;5742.942570574324;5748.109043098327;5464.23500709901;5478.780848766045;5480.890382192334;5486.807961721361;5509.972450137764;6394.488440924715;6405.167328247298;6405.871882562369;6426.164598602152;6427.389398007229;4326.588974047492;4428.557144285578;4442.067165895166;4448.243798554254;4621.260598304289;6526.314736952647;6695;6711.228208756007;6720.798376048678;6723.327667233287;4606.055758569485;4636.4436267647425;4640.976795116003;4644.233701439292;4647.55848194421;4672.95327046732;4690.976545117321;4708.340832283483;4716.221823399169;4719.221328480831;5422.40353561108;5425.972870135624;5440.102383106822;5440.265564148868;5449.237106805051;6317.96841015792;6448.387403196689;6464.612123272619;6468.320826313169;6484.513661475408;1624.9106299153423;1640.491447651232;1644.1121794231221;1650.4635993302225;1653.6196674764872;1046.7487802927242;1071;1072.2172813845937;1094.316052467208;1109.4674556213063;6072.392760723892;6201.937980620136;6211.751529938751;6217.440430361289;6223;6593.076969224312;6611.801645950629;6613.60318380889;6617.503687223478;6620.933790662032;6110;6133.785317513865;6138.938610613926;6146.078088286793;6150.292716337589;3528.523649307362;3567.0369000369756;3569.7858128511853;3573.8749143780365;3576.660217279354;6643.40209381158;6761.4590832733265;6792.388685018372;6793.45652347811;6803.353681400259;6735.696893639798;6742.595444273359;6743.5953842769595;6749.6962636681465;6753;6764.627945463047;6784.151981002375;6792.049113124167;6798.796036118924;6806.081179040766;6593;6659.467242620482;6693.431058360094;6705.161854768154;6713.328667133248;6370.90443643355;6474.805755827333;6494.6103233806125;6496.642684652389;6508.642024688687;6753.054572359972;6765.357291057342;6787.423069039187;6800.489963252677;6817.522773405814;4599.379083823641;4599.4710608280475;4607.5622815833785;4608.700434471749;4619.122366750306;6537.738490460519;6561.442277406474;6591.703373348115;6594.043863639649;6597.2742998271115;6282.623042617458;6358.618482891041;6399.456046236122;6420.390062944013;6426.518011149276;6390.840228994312;6404.839879003062;6406.423421892052;6414.166158399378;6427.421532062137;6231.875362492816;6289.433950944437;6314.242290925118;6316.399942005502;6318.8736225274315;6434.227892652912;6438.581492202992;6445.967770161119;6449.645269510222;6454.838629034311;6016.398360163948;6114.5414093942245;6288.528360373082;6315.5894866833505;6392.20097487814 05:34:16 INFO - PROCESS | 26714 | |5;yui.html;756.9205233450491;809.4172196018866;854.9700760473385;867.7960679240377;917.7476194046636;14184.929075354621;14226.217558034305;14373;14373.281335933214;14401.567952961415;14258.144511329327;14359.210243436606;14368.425262989467;14407.855921440783;14414.135151890894;782.084960596101;903.4037535226752;917.8347897378469;922.1424075609681;922.1608336413865;919.4069824962895;934.9672761453351;939.2626787971444;940.0881145289059;941.8022215334788;984.6504490905733;984.7291994701443;985.2265971212599;985.3398223190444;986.8223719730446;797.6410615223144;939.2579861909084;965.5558443116175;975.8292298847708;981.9754506137332;697.7557854750847;702.3748863511479;707.1019804847866;708.6846353372752;710.641126231255;14664.120152790867;14716.926415367961;14757.483488077865;14764;14769.40922363115;13753.449862005507;13903.582892513139;14085.85914140866;14182;14632;11042.944785276022;11243.775124497464;11320.886791132065;11358.886411135865;11654.359010254433;3854.8650797222244;3895.1235971906376;3911.941320880189;3971.5631280559114;3988.162485877969;51600.48399515994;51693.22460163101;51747.96504069935;52060.73969630166;52263.73868130635;10872.238943274053;10971.780564388668;11227.66317010491;11251.324920504632;11420.086393088533;20354.28759993423;20393.898030509754;20394.69407958882;20435.897820511098;20447.38657840267;7854.72508462201;7957.562334071682;8130.349572034342;8163.591820409075;8287.95856020716;4619.930701039487;4681.204195286809;4756.857294281177;4771.9522804772205;4776.331313616097;3329.0179397077436;3367.6800703933086;3368.528406023159;3372.561566996324;3374.5613070301197;592.4135106244787;593.3532449629924;593.7535922592076;595.1251660059705;596.1028651878981;616.0276665090954;716.4279397014743;733.6515155301189;746.1344839985591;762.4472257613297;9028;9328.860067098998;9344.532773361441;9430.528473576294;9478.431294122374;555.6693767208504;676.4824908944661;703.9753608623776;717.6519388096768;718.9934092270863;3744.3260213161348;3864.42033694948;3916.804159791999;3975.078931586003;4123.0310876943895;56761.43238567644;57656;57828.421715783144;58359;59315.70342148262;50783.49216507788;50993.74503127461;51889.48110518847;52233;52340.47659523432;48515;49260.50739492631;49354.75322623364;49419.75290123526;49688.75155624199;9118.680846170351;9242.953785231031;9290.256779457492;9296.488693121943;9538.85691714611;35083.122921927155;35657.46513802243;35788.28423431465;36493.45259821158;36835;41009.17981640291;43307;43756.78121609499;44621;45678.54321456743;11227.943860280973;11320.436089105353;11333.773324533628;11651.067914566645;11666.941665291619;12110.697232569257;12982.221066735648;13133.868661313265;13456.730865382833;13512.93243533776;11706.297622142358;11820.645380638594;12001.699957501132;12367.69080772988;12428.37858107109;11825.82261266099;11903.82144267854;11942.462589183333;12000.63998080059;12298.139130260795;11473.13951453661;11747.177697561088;11975.401229938294;12038.157328987238;12311.261324320569;8856.07011263808;9089.272858171198;9752.317337786571;9850.704478865646;9924.603015879284;9931.553080111267;10070.496475176065;10097.343672661253;10107.444090575089;10234 05:34:16 INFO - PROCESS | 26714 | __end_tp_report 05:34:16 INFO - PROCESS | 26714 | __start_cc_report 05:34:16 INFO - PROCESS | 26714 | _x_x_mozilla_cycle_collect,885 05:34:16 INFO - PROCESS | 26714 | __end_cc_report 05:34:16 INFO - PROCESS | 26714 | __startTimestamp1460032456315__endTimestamp 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | ------- Summary: start ------- 05:34:16 INFO - PROCESS | 26714 | Number of tests: 6 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#0] dojo.html Cycles:165 Average:5371.76 Median:5615.33 stddev:586.65 (10.4%) stddev-sans-first:564.52 05:34:16 INFO - PROCESS | 26714 | Values: 3258.1 3340.2 3353.1 3359.2 3385.5 5354.3 5362.1 5370.8 5376.3 5407.9 5354.0 5360.8 5381.1 5385.3 5387.8 4761.8 4904.2 4910.8 4959.0 5005.0 4855.2 4871.7 4932.5 4934.0 4936.1 4915.7 4929.9 4964.2 5006.7 5012.3 4940.1 4958.1 4963.5 4986.7 5007.0 4726.5 4780.7 4865.3 4889.4 4890.4 5143.7 5148.9 5154.8 5166.3 5198.0 5679.2 5679.6 5698.8 5722.8 5724.9 5715.7 5772.2 5807.3 5812.7 5826.1 5369.5 5421.6 5424.7 5443.5 5461.2 5754.1 5879.5 5889.9 5942.9 5966.7 5625.8 5653.4 5657.6 5657.9 5660.5 5743.9 5745.0 5748.7 5749.2 5758.7 5599.6 5681.2 5754.0 5760.3 5770.9 5747.4 5765.2 5769.5 5783.1 5785.5 4412.1 4417.5 4418.3 4436.6 4458.4 3910.0 3949.2 3972.1 3986.9 4010.6 5464.3 5488.2 5488.3 5492.7 5523.8 5690.1 5721.7 5802.8 5825.4 5827.6 5416.6 5445.6 5446.1 5460.4 5510.5 4979.9 4987.2 4988.7 4989.5 4992.1 5841.9 5844.2 5933.5 5944.2 5947.6 5814.1 5868.5 5893.9 5896.8 5900.9 6044.1 6052.6 6063.1 6063.8 6066.3 5600.1 5620.3 5643.8 5793.8 5796.0 5854.8 5862.1 5869.9 5870.4 5877.4 5683.5 5708.1 5709.6 5711.4 5716.3 5538.7 5595.5 5660.4 5693.6 5693.8 5594.7 5616.1 5636.1 5636.4 5636.5 5669.8 5715.2 5715.8 5733.5 5737.2 5408.5 5498.9 5615.3 5679.4 5693.7 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#1] ext.html Cycles:180 Average:43284.63 Median:39386.70 stddev:64496.57 (163.8%) stddev-sans-first:64597.69 05:34:16 INFO - PROCESS | 26714 | Values: 553.4 561.2 573.3 609.0 619.6 31400.4 39284.6 39534.2 39581.0 39667.6 42710.4 43034.8 43124.0 43133.6 43219.4 8888.2 9102.6 9109.3 9110.8 9111.6 8854.0 9006.3 9009.2 9013.7 9277.0 9202.4 9274.8 9318.0 9321.3 9342.2 9197.5 9226.9 9232.4 9283.6 9296.0 9096.6 9264.0 9267.8 9269.5 9270.8 42604.0 42974.6 42994.8 43012.8 43039.0 3712.4 3973.3 4110.6 4326.8 4345.5 32544.2 32683.7 32699.7 32934.2 33048.7 4214.9 4289.4 4294.4 4312.9 4331.9 309017.5 309242.0 310056.0 310267.0 311112.0 62484.7 62594.4 62847.0 63211.4 63283.7 67585.3 67903.7 67933.7 74411.6 75544.0 15979.3 16148.4 16150.8 16177.5 16193.0 12046.3 12135.1 12166.7 12213.3 12223.1 22773.3 23365.1 23369.2 23390.3 23392.6 8282.4 8441.0 8469.7 8515.8 8555.7 1078.8 1080.8 1090.2 1122.0 1150.9 29591.0 29693.0 30373.5 30703.8 31287.5 1192.1 1214.1 1235.5 1249.0 1258.3 15650.8 16041.5 16176.0 16253.2 16438.3 176798.0 177284.0 177523.0 177896.0 328057.0 56943.0 57013.4 57061.4 57445.0 57490.0 1330.7 1384.0 1429.9 1444.3 1464.4 27157.5 27998.0 28347.7 28743.7 28841.0 42266.0 43093.1 43165.1 43195.8 43205.8 196904.0 201085.0 201486.0 201958.0 202359.0 30017.1 33877.3 34005.3 34078.3 35133.8 41642.0 41912.8 41925.4 42588.8 42718.0 38788.6 40810.6 41042.4 41920.0 42093.4 36431.6 36780.6 36961.3 37009.6 37100.3 38697.0 38995.8 39488.8 40042.0 40146.0 34784.7 36093.3 36256.5 36505.8 36618.5 27286.9 27468.7 27557.2 27616.2 27704.9 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#2] jquery.html Cycles:180 Average:25487.42 Median:2690.64 stddev:73851.84 (2744.8%) stddev-sans-first:74034.93 05:34:16 INFO - PROCESS | 26714 | Values: 368.3 376.0 379.5 383.0 384.2 17664.0 17706.8 18328.2 18393.1 18456.0 15383.2 15873.8 15878.3 15888.4 15893.9 5077.2 5797.9 5799.7 5805.5 5808.8 4211.6 4365.8 5645.9 5977.4 6198.0 6094.1 6140.1 6160.6 6162.3 6171.8 5850.8 6141.1 6158.7 6159.8 6163.0 3775.2 5284.4 5369.8 5508.0 5522.0 20630.2 20651.5 20725.9 20957.0 20967.3 2446.3 2635.2 2746.0 2755.7 3130.5 13173.8 13753.7 13833.4 13948.1 14049.0 1904.9 1926.7 1963.9 2003.1 2065.5 59540.4 60819.4 60921.4 61110.4 61562.7 9273.9 9441.3 9874.9 9929.0 10153.4 14182.1 14195.5 14293.9 14294.8 14304.3 7153.9 7243.2 7627.9 7728.4 7732.7 7242.8 7250.6 7257.1 7279.5 7322.0 6092.6 6204.3 6204.8 6217.8 6235.1 1702.2 1724.6 1736.0 1756.7 1835.8 1018.7 1018.9 1049.9 1128.2 1143.9 16501.0 16601.5 17271.4 17507.0 17735.5 953.5 959.3 1009.2 1044.6 1059.8 9939.6 10442.4 10479.5 10492.5 10499.4 440269.0 447937.0 456500.0 457662.0 459067.0 55377.0 66546.0 66979.0 68224.3 69521.7 1081.0 1082.6 1098.8 1107.8 1112.1 15798.1 15966.0 16025.1 16139.1 16232.1 22534.4 28941.7 32116.7 32868.7 33169.8 42683.6 43933.8 44063.3 44163.6 44774.0 7547.8 7749.4 8175.2 8196.4 8549.7 10957.8 11577.9 11680.9 11705.6 11838.2 10492.5 10804.2 10878.5 10995.3 11067.4 10328.2 10554.3 10578.3 10601.3 10626.7 10487.9 10656.8 10818.3 10822.0 10868.6 7613.8 7678.6 8063.8 8117.9 8262.0 10113.3 10143.0 10263.5 10774.0 10896.1 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#3] mootools.html Cycles:180 Average:5601.39 Median:6243.51 stddev:2954.42 (47.3%) stddev-sans-first:2946.45 05:34:16 INFO - PROCESS | 26714 | Values: 1477.6 1568.3 1568.8 1827.5 1939.5 7845.8 8018.4 8029.9 8031.7 8043.1 7774.9 7910.5 7925.1 7945.2 7945.8 2014.8 2068.5 2309.1 2344.8 2347.4 2411.4 2427.2 2427.7 2429.1 2429.6 2354.3 2356.6 2368.2 2404.6 2404.8 2335.4 2340.6 2342.6 2347.1 2411.1 2340.9 2352.3 2356.5 2361.3 2363.4 8054.0 8121.3 8132.1 8143.8 8145.0 5007.6 5078.5 5116.6 5122.1 5124.7 2965.5 2993.0 3021.8 3026.9 3117.4 952.8 954.5 968.0 997.4 1010.9 10813.0 10902.5 10921.5 10926.0 10937.7 4111.3 4277.6 4284.2 4337.5 4351.1 8819.6 9014.7 9078.6 9085.0 9095.3 4961.3 5017.2 5017.6 5020.7 5024.4 4093.8 4185.4 4451.3 4570.7 4632.1 3490.5 3571.8 3574.0 3600.8 3610.4 1111.8 1117.4 1143.2 1144.9 1145.3 1077.8 1102.7 1109.8 1331.8 1455.1 7602.4 7686.7 7690.8 7761.6 7802.5 529.6 536.0 539.5 549.9 560.7 6072.3 6084.9 6136.2 6155.4 6178.8 9705.5 9934.8 9943.4 10086.0 10090.3 9656.8 9914.5 9938.7 10003.1 10017.1 7697.7 7795.1 7825.1 7863.1 7866.6 7481.6 7496.8 7550.0 7570.9 7571.2 8853.8 8940.0 9012.0 9060.0 9065.8 8803.7 8979.7 9003.5 9098.6 9208.0 6169.4 6308.2 6617.7 6742.4 6829.2 7368.3 7407.8 7434.9 7440.1 7493.2 6548.3 6787.9 6788.0 6797.4 6943.5 6659.5 6718.8 6747.0 6785.9 6802.2 7171.3 7311.6 7319.5 7330.4 7378.3 6585.5 6640.7 6657.1 6665.2 6674.3 6602.4 6607.1 6627.6 6647.8 6648.4 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#4] prototype.html Cycles:180 Average:5373.01 Median:6056.42 stddev:1598.32 (26.4%) stddev-sans-first:1557.91 05:34:16 INFO - PROCESS | 26714 | Values: 361.3 362.2 363.2 363.8 369.0 6014.7 6022.7 6026.3 6030.7 6040.5 5888.4 5974.7 6009.0 6023.8 6030.2 4494.4 4545.3 4590.9 4702.0 4712.4 4664.5 4687.3 4707.5 4714.2 4719.7 4659.9 4660.4 4660.6 4670.0 4683.3 4466.9 4528.9 4654.0 4670.2 4690.0 4125.2 4139.6 4140.1 4143.8 4147.3 5704.9 5725.6 5741.0 5742.9 5748.1 5464.2 5478.8 5480.9 5486.8 5510.0 6394.5 6405.2 6405.9 6426.2 6427.4 4326.6 4428.6 4442.1 4448.2 4621.3 6526.3 6695.0 6711.2 6720.8 6723.3 4606.1 4636.4 4641.0 4644.2 4647.6 4673.0 4691.0 4708.3 4716.2 4719.2 5422.4 5426.0 5440.1 5440.3 5449.2 6318.0 6448.4 6464.6 6468.3 6484.5 1624.9 1640.5 1644.1 1650.5 1653.6 1046.7 1071.0 1072.2 1094.3 1109.5 6072.4 6201.9 6211.8 6217.4 6223.0 6593.1 6611.8 6613.6 6617.5 6620.9 6110.0 6133.8 6138.9 6146.1 6150.3 3528.5 3567.0 3569.8 3573.9 3576.7 6643.4 6761.5 6792.4 6793.5 6803.4 6735.7 6742.6 6743.6 6749.7 6753.0 6764.6 6784.2 6792.0 6798.8 6806.1 6593.0 6659.5 6693.4 6705.2 6713.3 6370.9 6474.8 6494.6 6496.6 6508.6 6753.1 6765.4 6787.4 6800.5 6817.5 4599.4 4599.5 4607.6 4608.7 4619.1 6537.7 6561.4 6591.7 6594.0 6597.3 6282.6 6358.6 6399.5 6420.4 6426.5 6390.8 6404.8 6406.4 6414.2 6427.4 6231.9 6289.4 6314.2 6316.4 6318.9 6434.2 6438.6 6446.0 6449.6 6454.8 6016.4 6114.5 6288.5 6315.6 6392.2 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - PROCESS | 26714 | [#5] yui.html Cycles:180 Average:14464.72 Median:4719.03 stddev:16332.34 (346.1%) stddev-sans-first:16345.72 05:34:16 INFO - PROCESS | 26714 | Values: 756.9 809.4 855.0 867.8 917.7 14184.9 14226.2 14373.0 14373.3 14401.6 14258.1 14359.2 14368.4 14407.9 14414.1 782.1 903.4 917.8 922.1 922.2 919.4 935.0 939.3 940.1 941.8 984.7 984.7 985.2 985.3 986.8 797.6 939.3 965.6 975.8 982.0 697.8 702.4 707.1 708.7 710.6 14664.1 14716.9 14757.5 14764.0 14769.4 13753.4 13903.6 14085.9 14182.0 14632.0 11042.9 11243.8 11320.9 11358.9 11654.4 3854.9 3895.1 3911.9 3971.6 3988.2 51600.5 51693.2 51748.0 52060.7 52263.7 10872.2 10971.8 11227.7 11251.3 11420.1 20354.3 20393.9 20394.7 20435.9 20447.4 7854.7 7957.6 8130.3 8163.6 8288.0 4619.9 4681.2 4756.9 4772.0 4776.3 3329.0 3367.7 3368.5 3372.6 3374.6 592.4 593.4 593.8 595.1 596.1 616.0 716.4 733.7 746.1 762.4 9028.0 9328.9 9344.5 9430.5 9478.4 555.7 676.5 704.0 717.7 719.0 3744.3 3864.4 3916.8 3975.1 4123.0 56761.4 57656.0 57828.4 58359.0 59315.7 50783.5 50993.7 51889.5 52233.0 52340.5 48515.0 49260.5 49354.8 49419.8 49688.8 9118.7 9243.0 9290.3 9296.5 9538.9 35083.1 35657.5 35788.3 36493.5 36835.0 41009.2 43307.0 43756.8 44621.0 45678.5 11227.9 11320.4 11333.8 11651.1 11666.9 12110.7 12982.2 13133.9 13456.7 13512.9 11706.3 11820.6 12001.7 12367.7 12428.4 11825.8 11903.8 11942.5 12000.6 12298.1 11473.1 11747.2 11975.4 12038.2 12311.3 8856.1 9089.3 9752.3 9850.7 9924.6 9931.6 10070.5 10097.3 10107.4 10234.0 05:34:16 INFO - PROCESS | 26714 | -------- Summary: end -------- 05:34:16 INFO - PROCESS | 26714 | 05:34:16 INFO - TEST-INFO | 26714: exit 0 05:34:17 INFO - TEST-OK | dromaeo_css | took 1113184ms 05:34:17 INFO - TEST-START | kraken 05:34:17 INFO - operating with platform_type : linux_ 05:34:17 INFO - Initialising browser for kraken test... 05:34:17 INFO - TEST-INFO | started process 26910 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp12jPpR/profile http://localhost:46617/getInfo.html) 05:34:22 INFO - PROCESS | 26910 | __metrics Screen width/height:1600/1200 05:34:22 INFO - PROCESS | 26910 | colorDepth:24 05:34:22 INFO - PROCESS | 26910 | Browser inner width/height: 1024/697 05:34:22 INFO - PROCESS | 26910 | __metrics 05:34:23 INFO - PROCESS | 26910 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:24 INFO - TEST-INFO | 26910: exit 0 05:34:24 INFO - Browser initialized. 05:34:24 INFO - Running cycle 1/1 for kraken test... 05:34:24 INFO - TEST-INFO | started process 27003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp12jPpR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:36 INFO - PROCESS | 27003 | RSS: Main: 141746176 05:34:36 INFO - PROCESS | 27003 | 05:34:38 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:39 INFO - PROCESS | 27003 | RSS: Main: 177242112 05:34:39 INFO - PROCESS | 27003 | 05:34:41 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-dft) 05:34:42 INFO - PROCESS | 27003 | RSS: Main: 175947776 05:34:42 INFO - PROCESS | 27003 | 05:34:45 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-fft) 05:34:45 INFO - PROCESS | 27003 | RSS: Main: 172986368 05:34:45 INFO - PROCESS | 27003 | 05:34:48 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46617/tests/kraken/driver.html?testName=audio-oscillator) 05:34:48 INFO - PROCESS | 27003 | RSS: Main: 173735936 05:34:48 INFO - PROCESS | 27003 | 05:34:50 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:51 INFO - PROCESS | 27003 | RSS: Main: 171761664 05:34:51 INFO - PROCESS | 27003 | 05:34:54 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:54 INFO - PROCESS | 27003 | RSS: Main: 171556864 05:34:54 INFO - PROCESS | 27003 | 05:34:58 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46617/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:58 INFO - PROCESS | 27003 | RSS: Main: 170885120 05:34:58 INFO - PROCESS | 27003 | 05:35:01 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46617/tests/kraken/driver.html?testName=json-parse-financial) 05:35:02 INFO - PROCESS | 27003 | RSS: Main: 170491904 05:35:02 INFO - PROCESS | 27003 | 05:35:03 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:04 INFO - PROCESS | 27003 | RSS: Main: 175992832 05:35:04 INFO - PROCESS | 27003 | 05:35:06 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:06 INFO - PROCESS | 27003 | RSS: Main: 173809664 05:35:06 INFO - PROCESS | 27003 | 05:35:08 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:09 INFO - PROCESS | 27003 | RSS: Main: 184053760 05:35:09 INFO - PROCESS | 27003 | 05:35:11 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:12 INFO - PROCESS | 27003 | RSS: Main: 187924480 05:35:12 INFO - PROCESS | 27003 | 05:35:14 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:15 INFO - PROCESS | 27003 | RSS: Main: 186650624 05:35:15 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | Cycle 1(1): loaded http://localhost:46617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46617/tests/kraken/driver.html?testName=ai-astar) 05:35:17 INFO - PROCESS | 27003 | RSS: Main: 248201216 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | __start_tp_report 05:35:17 INFO - PROCESS | 27003 | _x_x_mozilla_page_load 05:35:17 INFO - PROCESS | 27003 | _x_x_mozilla_page_load_details 05:35:17 INFO - PROCESS | 27003 | |i|pagename|runs| 05:35:17 INFO - PROCESS | 27003 | |0;ai-astar;109;110;105;110;110;110;99;111;109;109 05:35:17 INFO - PROCESS | 27003 | |1;audio-beat-detection;155;124;150;171;127;159;157;129;180;127 05:35:17 INFO - PROCESS | 27003 | |2;audio-dft;159;161;160;161;159;159;160;162;160;160 05:35:17 INFO - PROCESS | 27003 | |3;audio-fft;76;76;75;160;76;73;77;76;166;76 05:35:17 INFO - PROCESS | 27003 | |4;audio-oscillator;92;94;145;91;94;93;147;92;91;146 05:35:17 INFO - PROCESS | 27003 | |5;imaging-gaussian-blur;117;116;117;118;116;117;116;117;117;117 05:35:17 INFO - PROCESS | 27003 | |6;imaging-darkroom;147;145;146;146;146;145;146;145;145;145 05:35:17 INFO - PROCESS | 27003 | |7;imaging-desaturate;96;96;96;95;95;96;95;95;96;96 05:35:17 INFO - PROCESS | 27003 | |8;json-parse-financial;55;56;57;56;55;56;55;65;54;55 05:35:17 INFO - PROCESS | 27003 | |9;json-stringify-tinderbox;65;65;64;64;65;64;65;65;65;64 05:35:17 INFO - PROCESS | 27003 | |10;stanford-crypto-aes;78;79;76;81;88;79;80;80;79;78 05:35:17 INFO - PROCESS | 27003 | |11;stanford-crypto-ccm;113;111;110;115;123;119;111;112;116;113 05:35:17 INFO - PROCESS | 27003 | |12;stanford-crypto-pbkdf2;151;136;144;139;148;137;145;144;147;152 05:35:17 INFO - PROCESS | 27003 | |13;stanford-crypto-sha256-iterative;70;66;67;65;67;66;68;67;65;64 05:35:17 INFO - PROCESS | 27003 | __end_tp_report 05:35:17 INFO - PROCESS | 27003 | __start_cc_report 05:35:17 INFO - PROCESS | 27003 | _x_x_mozilla_cycle_collect,1085 05:35:17 INFO - PROCESS | 27003 | __end_cc_report 05:35:17 INFO - PROCESS | 27003 | __startTimestamp1460032517386__endTimestamp 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | ------- Summary: start ------- 05:35:17 INFO - PROCESS | 27003 | Number of tests: 14 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.61 (3.3%) stddev-sans-first:3.82 05:35:17 INFO - PROCESS | 27003 | Values: 109.0 110.0 105.0 110.0 110.0 110.0 99.0 111.0 109.0 109.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.00 stddev:20.07 (12.9%) stddev-sans-first:21.13 05:35:17 INFO - PROCESS | 27003 | Values: 155.0 124.0 150.0 171.0 127.0 159.0 157.0 129.0 180.0 127.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 05:35:17 INFO - PROCESS | 27003 | Values: 159.0 161.0 160.0 161.0 159.0 159.0 160.0 162.0 160.0 160.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.88 (48.5%) stddev-sans-first:38.60 05:35:17 INFO - PROCESS | 27003 | Values: 76.0 76.0 75.0 160.0 76.0 73.0 77.0 76.0 166.0 76.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:92.00 stddev:25.90 (28.2%) stddev-sans-first:26.78 05:35:17 INFO - PROCESS | 27003 | Values: 92.0 94.0 145.0 91.0 94.0 93.0 147.0 92.0 91.0 146.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 05:35:17 INFO - PROCESS | 27003 | Values: 117.0 116.0 117.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:35:17 INFO - PROCESS | 27003 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:35:17 INFO - PROCESS | 27003 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.13 (5.6%) stddev-sans-first:3.28 05:35:17 INFO - PROCESS | 27003 | Values: 55.0 56.0 57.0 56.0 55.0 56.0 55.0 65.0 54.0 55.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:35:17 INFO - PROCESS | 27003 | Values: 65.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:3.19 (4.0%) stddev-sans-first:3.32 05:35:17 INFO - PROCESS | 27003 | Values: 78.0 79.0 76.0 81.0 88.0 79.0 80.0 80.0 79.0 78.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.00 stddev:4.08 (3.6%) stddev-sans-first:4.30 05:35:17 INFO - PROCESS | 27003 | Values: 113.0 111.0 110.0 115.0 123.0 119.0 111.0 112.0 116.0 113.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.00 stddev:5.54 (3.8%) stddev-sans-first:5.32 05:35:17 INFO - PROCESS | 27003 | Values: 151.0 136.0 144.0 139.0 148.0 137.0 145.0 144.0 147.0 152.0 05:35:17 INFO - PROCESS | 27003 | 05:35:17 INFO - PROCESS | 27003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.72 (2.6%) stddev-sans-first:1.27 05:35:17 INFO - PROCESS | 27003 | Values: 70.0 66.0 67.0 65.0 67.0 66.0 68.0 67.0 65.0 64.0 05:35:17 INFO - PROCESS | 27003 | -------- Summary: end -------- 05:35:17 INFO - PROCESS | 27003 | 05:35:18 INFO - TEST-INFO | 27003: exit 0 05:35:18 INFO - TEST-OK | kraken | took 61425ms 05:35:18 INFO - SUITE-END | took 1174s 05:35:18 INFO - Completed test suite (00:19:34) 05:35:18 INFO - javascript benchmark 05:35:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3258.0877354340782, 3340.2317466982577, 3353.0779035765163, 3359.1770016346, 3385.5429517015205, 5354.250404943311, 5362.061639213137, 5370.812021579245, 5376.301080859493, 5407.864803379917, 5353.973230133854, 5360.758765855536, 5381.058314794905, 5385.272988146599, 5387.838364849061, 4761.833335833247, 4904.1908085166, 4910.828121015765, 4958.975205123969, 5005.0, 4855.198892182786, 4871.683340582868, 4932.482089380617, 4934.0, 4936.06214819185, 4915.680480768757, 4929.852104436873, 4964.15609346412, 5006.674566153207, 5012.273220383042, 4940.061388336223, 4958.132326842788, 4963.503649635044, 4986.700797952134, 5007.048660754445, 4726.527347265281, 4780.737059461728, 4865.318855360252, 4889.3643826302705, 4890.3642526471685, 5143.742812859342, 5148.948510514884, 5154.845354639367, 5166.302549155854, 5197.974010129925, 5679.176519404663, 5679.630823996468, 5698.800541981011, 5722.799702010409, 5724.885502289931, 5715.714214289269, 5772.220750198711, 5807.30312362515, 5812.738426770806, 5826.067829147316, 5369.463053694639, 5421.647592906448, 5424.728763561806, 5443.455654434564, 5461.208124821878, 5754.079347304411, 5879.470847623735, 5889.882202356014, 5942.910856337158, 5966.731497082642, 5625.831225063254, 5653.406392328829, 5657.57568182388, 5657.858553536194, 5660.5471562274915, 5743.913841292384, 5744.965906136936, 5748.683822389725, 5749.1663708762, 5758.740856661377, 5599.552035837123, 5681.17622944679, 5754.0, 5760.279965004374, 5770.855728606734, 5747.3677895431465, 5765.221695071195, 5769.480746732815, 5783.103618939072, 5785.4793068623185, 4412.117576484652, 4417.514073451917, 4418.315161150027, 4436.578525040116, 4458.353538736865, 3909.980450097788, 3949.2101579684177, 3972.1261322509004, 3986.880393588197, 4010.558838527818, 5464.28964234647, 5488.231647569343, 5488.259085023471, 5492.670439773547, 5523.751431185607, 5690.061139911951, 5721.656700597978, 5802.796902108406, 5825.4174582542255, 5827.621204621771, 5416.566674666017, 5445.591580631469, 5446.101393270066, 5460.372057213392, 5510.5316048135555, 4979.900401992012, 4987.226979818134, 4988.700677959334, 4989.501049894981, 4992.051510213048, 5841.94158058414, 5844.211031510692, 5933.465988061009, 5944.227250457413, 5947.583669143205, 5814.098814683731, 5868.5305175585, 5893.941060589511, 5896.764129434775, 5900.940990590039, 6044.123602077586, 6052.636841789506, 6063.090536419572, 6063.787767428119, 6066.272047354346, 5600.131979543177, 5620.297462817148, 5643.802466913638, 5793.797217097382, 5796.0436527972415, 5854.765809367577, 5862.12068189775, 5869.941300586939, 5870.442307980735, 5877.4122587740885, 5683.516901063291, 5708.115242137475, 5709.600327977002, 5711.371749107678, 5716.256886604715, 5538.695371754592, 5595.496405323541, 5660.405657405913, 5693.601447898607, 5693.772249109989, 5594.664320140804, 5616.1014237721765, 5636.070048442125, 5636.379998200113, 5636.549076073986, 5669.829905102853, 5715.228444159985, 5715.771369145187, 5733.512651424676, 5737.225474560881, 5408.540274076748, 5498.890022199614, 5615.326160860723, 5679.375268720355, 5693.743781529758], "unit": "score", "name": "dojo.html", "value": 5334.775846194858}, {"lowerIsBetter": false, "replicates": [553.3995614757987, 561.1918836874897, 573.2891214893532, 609.0255591054314, 619.569399267509, 31400.371992560165, 39284.60715392845, 39534.20931581366, 39581.0, 39667.60332396675, 42710.35934460978, 43034.784826075906, 43124.0, 43133.568664313345, 43219.3517097243, 8888.200061994436, 9102.590383432762, 9109.3168012399, 9110.77223069422, 9111.635534578641, 8853.955730221373, 9006.32452566057, 9009.234215091725, 9013.729588112366, 9277.025912279214, 9202.40184388016, 9274.768130796716, 9318.021607731192, 9321.254299656046, 9342.159205671489, 9197.540122993856, 9226.907730922672, 9232.353735238536, 9283.628654853797, 9295.953520232355, 9096.63613455461, 9264.0, 9267.814643707088, 9269.490178040205, 9270.814583708356, 42604.0, 42974.57025429737, 42994.785026074984, 43012.78493607512, 43039.0, 3712.3874560697723, 3973.324534829086, 4110.609492098276, 4326.8269269229195, 4345.478542574911, 32544.186395340068, 32683.6731632683, 32699.6730032699, 32934.176645583815, 33048.6695133048, 4214.936775948363, 4289.399484072233, 4294.398784170218, 4312.870613881589, 4331.870043898688, 309017.45491272624, 309242.0, 310056.0, 310267.0, 311112.0, 62484.687576561824, 62594.37405625977, 62847.0, 63211.367886321466, 63283.68358158272, 67585.3241467579, 67903.66048169727, 67933.66033169802, 74411.62794185994, 75544.0, 15979.280932358071, 16148.35406583747, 16150.75773863393, 16177.514674559781, 16193.0, 12046.277223366626, 12135.089868259916, 12166.695832604255, 12213.328266945404, 12223.0832687547, 22773.31680049568, 23365.130789536797, 23369.182078627167, 23390.298291051295, 23392.64911026336, 8282.378821588405, 8441.0, 8469.66121355139, 8515.787105322417, 8555.743327700178, 1078.8327809189589, 1080.7892460970193, 1090.2095980414135, 1122.046260678433, 1150.8503894493663, 29591.0, 29692.960746373774, 30373.544396834066, 30703.846480767454, 31287.530687039714, 1192.1374745823468, 1214.1015648420282, 1235.5057976809169, 1248.993755031219, 1258.3205069262679, 15650.843491564938, 16041.518754437386, 16176.0, 16253.187340632921, 16438.342466301216, 176798.0, 177284.02221900044, 177523.0, 177896.0, 328057.0, 56943.0, 57013.42986570164, 57061.42938570644, 57445.0, 57490.0, 1330.7138965122351, 1383.9584812455641, 1429.921354325522, 1444.3283872999107, 1464.3703207620613, 27157.456850863266, 27998.0, 28347.716522834507, 28743.71256287494, 28841.0, 42266.0, 43093.13813723771, 43165.136697266506, 43195.78402107969, 43205.783971079945, 196904.0, 201085.0, 201486.0, 201958.0, 202359.0, 30017.099487015425, 33877.322453550296, 34005.319893601496, 34078.318433630695, 35133.82433087818, 41642.0, 41912.790436047624, 41925.37111943385, 42588.787056064524, 42718.0, 38788.6121138785, 40810.59189408068, 41042.38436423516, 41920.0, 42093.36859947042, 36431.635683642824, 36780.632193677724, 36961.26077478382, 37009.629903701694, 37100.25799483941, 38697.0, 38995.805020974716, 39488.802555988186, 40041.998950026486, 40146.0, 34784.652153479154, 36093.27813443769, 36256.45615315825, 36505.81747091247, 36618.45072323971, 27286.863565682044, 27468.725312747418, 27557.173284801487, 27616.171514854588, 27704.86147569249], "unit": "score", "name": "ext.html", "value": 19279.562287154018}, {"lowerIsBetter": false, "replicates": [368.3369934118586, 375.9943600845988, 379.48579674541, 382.9540455145382, 384.1586924635051, 17664.0, 17706.82293177068, 18328.175232114554, 18393.080345982682, 18456.0, 15383.153926534063, 15873.761893571576, 15878.285477153528, 15888.443904463345, 15893.887427880052, 5077.213031980049, 5797.942020579803, 5799.681017544033, 5805.477507024367, 5808.767649294024, 4211.599898009684, 4365.759883206422, 5645.8588535286535, 5977.372375900533, 6198.039303907879, 6094.055421409688, 6140.140380346755, 6160.630362178261, 6162.291336496293, 6171.7531298748, 5850.795222167225, 6141.1095391168255, 6158.7228574714245, 6159.81520554384, 6163.044728067157, 3775.2260786538695, 5284.392294886099, 5369.758360873731, 5507.972460137674, 5522.0336441123045, 20630.17479300826, 20651.483712907146, 20725.89637051805, 20957.0, 20967.266145684982, 2446.2905757330354, 2635.235781623327, 2746.0388863897474, 2755.655543057118, 3130.4521708700886, 13173.802392964113, 13753.656158596015, 13833.446662133503, 13948.093373930764, 14049.016568840185, 1904.8761830480973, 1926.7109933509946, 1963.8821670699804, 2003.0885946894273, 2065.514604068058, 59540.40459595392, 60819.39180608182, 60921.39078609246, 61110.38889611091, 61562.69218653878, 9273.907260927439, 9441.291903107294, 9874.901250987397, 9929.0, 10153.441560714084, 14182.14907105577, 14195.503157389649, 14293.85706142946, 14294.785578216335, 14304.28478576067, 7153.856922861618, 7243.167035790952, 7627.923720762832, 7728.420368472387, 7732.6520306586335, 7242.818929526804, 7250.601216933014, 7257.092863392076, 7279.45404094695, 7322.048133742686, 6092.573519853568, 6204.255489341308, 6204.751809927642, 6217.813465596039, 6235.127082208403, 1702.174445393983, 1724.637826056517, 1736.0278244183298, 1756.7277072053596, 1835.8072402397556, 1018.7198520406799, 1018.8675472188568, 1049.8635177427038, 1128.1651577832345, 1143.9370834604176, 16501.0, 16601.50195494137, 17271.3955011574, 17507.0, 17735.46793596194, 953.5041778275258, 959.3284700709391, 1009.1541851977354, 1044.5821671331528, 1059.8410238464292, 9939.55272012761, 10442.373457592568, 10479.476026198812, 10492.475376231157, 10499.370037797604, 440269.0, 447937.0, 456500.0, 457662.0, 459067.0, 55377.0, 66546.0, 66979.0, 68224.31775682278, 69521.65239173872, 1081.0, 1082.6373164989816, 1098.8022156011834, 1107.7839821234782, 1112.1380929779486, 15798.131102788997, 15966.042037477788, 16025.118618476095, 16139.112348820927, 16232.107234101766, 22534.4366390835, 28941.710582893902, 32116.67883321137, 32868.671313287516, 33169.83415083006, 42683.57316426796, 43933.78033109814, 44063.33904991364, 44163.55836441723, 44774.0, 7547.811304717426, 7749.380049596131, 8175.182481751777, 8196.385271104571, 8549.658013679384, 10957.83563246568, 11577.884221158018, 11680.94159529197, 11705.648830535098, 11838.230515016496, 10492.527836247235, 10804.24370294072, 10878.510467028844, 10995.34027958325, 11067.391293478937, 10328.173746100143, 10554.313969591953, 10578.312409693654, 10601.310914790514, 10626.681199564026, 10487.947560262455, 10656.84014739795, 10818.29681070728, 10822.0, 10868.56663537794, 7613.771586852404, 7678.616069196406, 8063.758087257392, 8117.918820811717, 8262.0, 10113.29206955506, 10143.0, 10263.538140783832, 10774.0, 10896.073833724222], "unit": "score", "name": "jquery.html", "value": 8671.091843627028}, {"lowerIsBetter": false, "replicates": [1477.6379786952198, 1568.2942675795894, 1568.8117425908888, 1827.524843540679, 1939.4763413878254, 7845.80385490363, 8018.438709290352, 8029.919700802998, 8031.718889838857, 8043.11525732169, 7774.922250777505, 7910.485818421813, 7925.128235894047, 7945.165757595441, 7945.841083178333, 2014.8488863335308, 2068.4932191613075, 2309.0994512140237, 2344.8475849069755, 2347.366211122996, 2411.4212588978608, 2427.2354208424376, 2427.672264244331, 2429.149797570854, 2429.586970215059, 2354.3290162303747, 2356.634721618152, 2368.1829768729845, 2404.63930410439, 2404.8076153907646, 2335.439494521311, 2340.555294494049, 2342.6251799711963, 2347.1080989224156, 2411.131992482705, 2340.9297721068397, 2352.3060697094397, 2356.5404746074523, 2361.2798096580536, 2363.3855197648563, 8053.959730201312, 8121.30968867647, 8132.105468398471, 8143.796405089861, 8145.0, 5007.649464537484, 5078.46676099008, 5116.590672746172, 5122.129238029506, 5124.666896651705, 2965.510690736026, 2992.9700702993127, 3021.7884748067645, 3026.9394612107853, 3117.392108538836, 952.8427809411439, 954.4798085043668, 968.0464742228899, 997.3666721631744, 1010.888802231754, 10813.026827585476, 10902.5093870776, 10921.508532116073, 10925.99999999992, 10937.726556836064, 4111.342185250345, 4277.593628605277, 4284.207421627009, 4337.50118736343, 4351.06452112791, 8819.559022049, 9014.729558113268, 9078.636854525877, 9085.0, 9095.272378209727, 4961.305417241589, 5017.1721665924715, 5017.598592112622, 5020.723860187652, 5024.397072351268, 4093.7543747375253, 4185.372194170899, 4451.332300154938, 4570.65720070996, 4632.119897219585, 3490.528778614905, 3571.767835090711, 3573.9642603574152, 3600.765950213228, 3610.4403817408343, 1111.838783376406, 1117.4245263689206, 1143.1826244235413, 1144.8511693479795, 1145.335705290946, 1077.7790552936629, 1102.702270387007, 1109.7669489407315, 1331.766940785378, 1455.083297522575, 7602.420671258453, 7686.730964416219, 7690.846183076419, 7761.6119194040075, 7802.492837965628, 529.6160283794219, 536.0271107939078, 539.4524557574066, 549.9037668408013, 560.7084316155576, 6072.271327440735, 6084.908726369108, 6136.202293701879, 6155.415235552616, 6178.814635560941, 9705.466199358962, 9934.80130397388, 9943.353682010791, 10086.0, 10090.344127631828, 9656.806863862683, 9914.504274786232, 9938.652147174815, 10003.099721024997, 10017.14854237398, 7697.692092316357, 7795.103563090203, 7825.060992680915, 7863.095743989515, 7866.567338796421, 7481.625918703934, 7496.812579685551, 7550.0, 7570.9242907570215, 7571.167171611229, 8853.778655533406, 8940.0, 9011.954940225258, 9060.0, 9065.77335566616, 8803.691870784492, 8979.685711000084, 9003.54982250898, 9098.59056342453, 9208.03315651847, 6169.383061693795, 6308.211473565804, 6617.66911654425, 6742.359475849787, 6829.248782634006, 7368.300011498899, 7407.8148046299275, 7434.851302973802, 7440.107187137578, 7493.213212612597, 6548.345165483413, 6787.854574510706, 6787.966060169668, 6797.388235058868, 6943.548669336477, 6659.53383263167, 6718.8320291993095, 6747.0, 6785.898211526733, 6802.183737951477, 7171.282871712787, 7311.597862117635, 7319.487635865651, 7330.413566914527, 7378.262173782578, 6585.539012269095, 6640.734370625314, 6657.101291325803, 6665.200175978914, 6674.332566743286, 6602.438792702674, 6607.108040414482, 6627.602343859384, 6647.800565983028, 6648.434883034996], "unit": "score", "name": "mootools.html", "value": 4511.096367661722}, {"lowerIsBetter": false, "replicates": [361.28826212361645, 362.1905042230614, 363.21726679006736, 363.8144546281396, 369.0, 6014.699265036747, 6022.6687532185715, 6026.276846778393, 6030.728617212225, 6040.456358927696, 5888.352281249059, 5974.701264936757, 6009.038553831388, 6023.819285421444, 6030.216071910645, 4494.415725955621, 4545.250033744428, 4590.885227869297, 4702.0, 4712.410948631421, 4664.5102264262105, 4687.2969054641735, 4707.482176960531, 4714.222153344694, 4719.716816990975, 4659.930101048487, 4660.4174478190225, 4660.557247061523, 4669.953300466986, 4683.250679891218, 4466.910661786762, 4528.886777830531, 4654.0, 4670.229412146991, 4690.038542098861, 4125.195586860564, 4139.627433530996, 4140.109876376593, 4143.7720925349095, 4147.274227010292, 5704.942950570524, 5725.599208055438, 5741.024025915604, 5742.942570574324, 5748.109043098327, 5464.23500709901, 5478.780848766045, 5480.890382192334, 5486.807961721361, 5509.972450137764, 6394.488440924715, 6405.167328247298, 6405.871882562369, 6426.164598602152, 6427.389398007229, 4326.588974047492, 4428.557144285578, 4442.067165895166, 4448.243798554254, 4621.260598304289, 6526.314736952647, 6695.0, 6711.228208756007, 6720.798376048678, 6723.327667233287, 4606.055758569485, 4636.4436267647425, 4640.976795116003, 4644.233701439292, 4647.55848194421, 4672.95327046732, 4690.976545117321, 4708.340832283483, 4716.221823399169, 4719.221328480831, 5422.40353561108, 5425.972870135624, 5440.102383106822, 5440.265564148868, 5449.237106805051, 6317.96841015792, 6448.387403196689, 6464.612123272619, 6468.320826313169, 6484.513661475408, 1624.9106299153423, 1640.491447651232, 1644.1121794231221, 1650.4635993302225, 1653.6196674764872, 1046.7487802927242, 1071.0, 1072.2172813845937, 1094.316052467208, 1109.4674556213063, 6072.392760723892, 6201.937980620136, 6211.751529938751, 6217.440430361289, 6223.0, 6593.076969224312, 6611.801645950629, 6613.60318380889, 6617.503687223478, 6620.933790662032, 6110.0, 6133.785317513865, 6138.938610613926, 6146.078088286793, 6150.292716337589, 3528.523649307362, 3567.0369000369756, 3569.7858128511853, 3573.8749143780365, 3576.660217279354, 6643.40209381158, 6761.4590832733265, 6792.388685018372, 6793.45652347811, 6803.353681400259, 6735.696893639798, 6742.595444273359, 6743.5953842769595, 6749.6962636681465, 6753.0, 6764.627945463047, 6784.151981002375, 6792.049113124167, 6798.796036118924, 6806.081179040766, 6593.0, 6659.467242620482, 6693.431058360094, 6705.161854768154, 6713.328667133248, 6370.90443643355, 6474.805755827333, 6494.6103233806125, 6496.642684652389, 6508.642024688687, 6753.054572359972, 6765.357291057342, 6787.423069039187, 6800.489963252677, 6817.522773405814, 4599.379083823641, 4599.4710608280475, 4607.5622815833785, 4608.700434471749, 4619.122366750306, 6537.738490460519, 6561.442277406474, 6591.703373348115, 6594.043863639649, 6597.2742998271115, 6282.623042617458, 6358.618482891041, 6399.456046236122, 6420.390062944013, 6426.518011149276, 6390.840228994312, 6404.839879003062, 6406.423421892052, 6414.166158399378, 6427.421532062137, 6231.875362492816, 6289.433950944437, 6314.242290925118, 6316.399942005502, 6318.8736225274315, 6434.227892652912, 6438.581492202992, 6445.967770161119, 6449.645269510222, 6454.838629034311, 6016.398360163948, 6114.5414093942245, 6288.528360373082, 6315.5894866833505, 6392.20097487814], "unit": "score", "name": "prototype.html", "value": 4859.0860306958875}, {"lowerIsBetter": false, "replicates": [756.9205233450491, 809.4172196018866, 854.9700760473385, 867.7960679240377, 917.7476194046636, 14184.929075354621, 14226.217558034305, 14373.0, 14373.281335933214, 14401.567952961415, 14258.144511329327, 14359.210243436606, 14368.425262989467, 14407.855921440783, 14414.135151890894, 782.084960596101, 903.4037535226752, 917.8347897378469, 922.1424075609681, 922.1608336413865, 919.4069824962895, 934.9672761453351, 939.2626787971444, 940.0881145289059, 941.8022215334788, 984.6504490905733, 984.7291994701443, 985.2265971212599, 985.3398223190444, 986.8223719730446, 797.6410615223144, 939.2579861909084, 965.5558443116175, 975.8292298847708, 981.9754506137332, 697.7557854750847, 702.3748863511479, 707.1019804847866, 708.6846353372752, 710.641126231255, 14664.120152790867, 14716.926415367961, 14757.483488077865, 14764.0, 14769.40922363115, 13753.449862005507, 13903.582892513139, 14085.85914140866, 14182.0, 14632.0, 11042.944785276022, 11243.775124497464, 11320.886791132065, 11358.886411135865, 11654.359010254433, 3854.8650797222244, 3895.1235971906376, 3911.941320880189, 3971.5631280559114, 3988.162485877969, 51600.48399515994, 51693.22460163101, 51747.96504069935, 52060.73969630166, 52263.73868130635, 10872.238943274053, 10971.780564388668, 11227.66317010491, 11251.324920504632, 11420.086393088533, 20354.28759993423, 20393.898030509754, 20394.69407958882, 20435.897820511098, 20447.38657840267, 7854.72508462201, 7957.562334071682, 8130.349572034342, 8163.591820409075, 8287.95856020716, 4619.930701039487, 4681.204195286809, 4756.857294281177, 4771.9522804772205, 4776.331313616097, 3329.0179397077436, 3367.6800703933086, 3368.528406023159, 3372.561566996324, 3374.5613070301197, 592.4135106244787, 593.3532449629924, 593.7535922592076, 595.1251660059705, 596.1028651878981, 616.0276665090954, 716.4279397014743, 733.6515155301189, 746.1344839985591, 762.4472257613297, 9028.0, 9328.860067098998, 9344.532773361441, 9430.528473576294, 9478.431294122374, 555.6693767208504, 676.4824908944661, 703.9753608623776, 717.6519388096768, 718.9934092270863, 3744.3260213161348, 3864.42033694948, 3916.804159791999, 3975.078931586003, 4123.0310876943895, 56761.43238567644, 57656.0, 57828.421715783144, 58359.0, 59315.70342148262, 50783.49216507788, 50993.74503127461, 51889.48110518847, 52233.0, 52340.47659523432, 48515.0, 49260.50739492631, 49354.75322623364, 49419.75290123526, 49688.75155624199, 9118.680846170351, 9242.953785231031, 9290.256779457492, 9296.488693121943, 9538.85691714611, 35083.122921927155, 35657.46513802243, 35788.28423431465, 36493.45259821158, 36835.0, 41009.17981640291, 43307.0, 43756.78121609499, 44621.0, 45678.54321456743, 11227.943860280973, 11320.436089105353, 11333.773324533628, 11651.067914566645, 11666.941665291619, 12110.697232569257, 12982.221066735648, 13133.868661313265, 13456.730865382833, 13512.93243533776, 11706.297622142358, 11820.645380638594, 12001.699957501132, 12367.69080772988, 12428.37858107109, 11825.82261266099, 11903.82144267854, 11942.462589183333, 12000.63998080059, 12298.139130260795, 11473.13951453661, 11747.177697561088, 11975.401229938294, 12038.157328987238, 12311.261324320569, 8856.07011263808, 9089.272858171198, 9752.317337786571, 9850.704478865646, 9924.603015879284, 9931.553080111267, 10070.496475176065, 10097.343672661253, 10107.444090575089, 10234.0], "unit": "score", "name": "yui.html", "value": 6753.86783518034}], "name": "dromaeo_css", "value": 7135.962038149309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 110.0, 110.0, 99.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 150.0, 171.0, 127.0, 159.0, 157.0, 129.0, 180.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 161.0, 159.0, 159.0, 160.0, 162.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 160.0, 76.0, 73.0, 77.0, 76.0, 166.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 145.0, 91.0, 94.0, 93.0, 147.0, 92.0, 91.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 56.0, 55.0, 56.0, 55.0, 65.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 76.0, 81.0, 88.0, 79.0, 80.0, 80.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [113.0, 111.0, 110.0, 115.0, 123.0, 119.0, 111.0, 112.0, 116.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [151.0, 136.0, 144.0, 139.0, 148.0, 137.0, 145.0, 144.0, 147.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 67.0, 65.0, 67.0, 66.0, 68.0, 67.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1501.6999999999998}]} 05:35:18 INFO - Return code: 0 05:35:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:35:18 INFO - # TBPL SUCCESS # 05:35:18 INFO - Running post-action listener: _resource_record_post_action 05:35:18 INFO - Running post-run listener: _resource_record_post_run 05:35:19 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 328683520; Read time: 28; Write time: 371188 05:35:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 85344256; Read time: 0; Write time: 122716 05:35:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 243339264; Read time: 28; Write time: 248472 05:35:19 INFO - Running post-run listener: _upload_blobber_files 05:35:19 INFO - Blob upload gear active. 05:35:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:35:19 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 05:35:19 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'] 05:35:19 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 05:35:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:21 INFO - (blobuploader) - INFO - Done attempting. 05:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:21 INFO - (blobuploader) - INFO - Done attempting. 05:35:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:21 INFO - Return code: 0 05:35:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:35:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7256604f1448569d3c226da40db8a5036a9ef6605811188568dd65bf6907335cb163a1ba85f0008d4e71f5af517310a58d13f676cc006db53775d00ee825e4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a405f0e03bb5ac832f77c1cabc29523aeb72262541ca6b0034baa3c87baf6e026356febb3b2889983e0f28f7b16fc406a54ccd803a3b976e888a5db39758b5"} 05:35:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:35:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:35:21 INFO - Contents: 05:35:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7256604f1448569d3c226da40db8a5036a9ef6605811188568dd65bf6907335cb163a1ba85f0008d4e71f5af517310a58d13f676cc006db53775d00ee825e4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a405f0e03bb5ac832f77c1cabc29523aeb72262541ca6b0034baa3c87baf6e026356febb3b2889983e0f28f7b16fc406a54ccd803a3b976e888a5db39758b5"} 05:35:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:21 INFO - Copying logs to upload dir... 05:35:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:35:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.254248 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-07 05:35:21.878580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:35:21.882139) ========= 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-1460031279.167479-1358916420 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/7256604f1448569d3c226da40db8a5036a9ef6605811188568dd65bf6907335cb163a1ba85f0008d4e71f5af517310a58d13f676cc006db53775d00ee825e4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a405f0e03bb5ac832f77c1cabc29523aeb72262541ca6b0034baa3c87baf6e026356febb3b2889983e0f28f7b16fc406a54ccd803a3b976e888a5db39758b5"} build_url:https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/LAZJeSH7TB6l-uq_wgDKcA/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/7256604f1448569d3c226da40db8a5036a9ef6605811188568dd65bf6907335cb163a1ba85f0008d4e71f5af517310a58d13f676cc006db53775d00ee825e4f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13a405f0e03bb5ac832f77c1cabc29523aeb72262541ca6b0034baa3c87baf6e026356febb3b2889983e0f28f7b16fc406a54ccd803a3b976e888a5db39758b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:35:21.907462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:35:21.907823) ========= 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-1460031279.167479-1358916420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:35:21.991509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:35:21.991893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:35:21.992252) ========= ========= Total master_lag: 1.22 =========