builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1452740399.46 results: success (0) buildid: 20160113133021 builduid: 52d7106af359473791d44483469beb5d revision: ad1f85f172b7302bef0fa9780df8e2b962780ac6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:59.463292) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:59.463747) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:59.464033) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005931 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:59.601868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 18:59:59.602189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.366967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.367353) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003199 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.414372) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.414679) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.415038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.415326) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 19:00:00-- 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% 64.8M=0s 2016-01-13 19:00:00 (64.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.564427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.564760) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022306 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:00.613490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 19:00:00.613794) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 19:00:00,842 truncating revision to first 12 chars 2016-01-13 19:00:00,842 Setting DEBUG logging. 2016-01-13 19:00:00,842 attempt 1/10 2016-01-13 19:00:00,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad1f85f172b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 19:00:01,497 unpacking tar archive at: mozilla-central-ad1f85f172b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 19:00:01.627753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:01.628337) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:01.645895) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:01.646437) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 19:00:01.647096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 19:00:01.647540) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:01 INFO - MultiFileLogger online at 20160113 19:00:01 in /builds/slave/test-pgo 19:00:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:00:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:00:01 INFO - {'append_to_log': False, 19:00:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:00:01 INFO - 'blob_upload_branch': 'Firefox', 19:00:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:00:01 INFO - 'branch': 'Firefox', 19:00:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:01 INFO - 'config_files': ('talos/linux_config.py',), 19:00:01 INFO - 'default_actions': ('clobber', 19:00:01 INFO - 'read-buildbot-config', 19:00:01 INFO - 'download-and-extract', 19:00:01 INFO - 'populate-webroot', 19:00:01 INFO - 'create-virtualenv', 19:00:01 INFO - 'install', 19:00:01 INFO - 'run-tests'), 19:00:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:01 INFO - 'download_minidump_stackwalk': True, 19:00:01 INFO - 'download_symbols': 'ondemand', 19:00:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:01 INFO - 'installer_path': 'installer.exe', 19:00:01 INFO - 'log_level': 'info', 19:00:01 INFO - 'log_name': 'talos', 19:00:01 INFO - 'log_to_console': True, 19:00:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:01 INFO - 'opt_config_files': (), 19:00:01 INFO - 'pip_index': False, 19:00:01 INFO - 'sps_profile': False, 19:00:01 INFO - 'sps_profile_interval': 0, 19:00:01 INFO - 'suite': 'dromaeojs-e10s', 19:00:01 INFO - 'system_bits': '32', 19:00:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:01 INFO - 'title': 'talos-linux64-ix-066', 19:00:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:01 INFO - 'use_talos_json': True, 19:00:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:00:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:01 INFO - 'work_dir': 'build'} 19:00:01 INFO - ##### 19:00:01 INFO - ##### Running clobber step. 19:00:01 INFO - ##### 19:00:01 INFO - Running pre-action listener: _resource_record_pre_action 19:00:01 INFO - Running main action method: clobber 19:00:01 INFO - rmtree: /builds/slave/test-pgo/build 19:00:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:00:02 INFO - Running post-action listener: _resource_record_post_action 19:00:02 INFO - ##### 19:00:02 INFO - ##### Running read-buildbot-config step. 19:00:02 INFO - ##### 19:00:02 INFO - Running pre-action listener: _resource_record_pre_action 19:00:02 INFO - Running main action method: read_buildbot_config 19:00:02 INFO - Using buildbot properties: 19:00:02 INFO - { 19:00:02 INFO - "project": "", 19:00:02 INFO - "product": "firefox", 19:00:02 INFO - "script_repo_revision": "production", 19:00:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:00:02 INFO - "repository": "", 19:00:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:00:02 INFO - "buildid": "20160113133021", 19:00:02 INFO - "pgo_build": "True", 19:00:02 INFO - "basedir": "/builds/slave/test-pgo", 19:00:02 INFO - "buildnumber": 616, 19:00:02 INFO - "slavename": "talos-linux64-ix-066", 19:00:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:00:02 INFO - "platform": "ubuntu64_hw", 19:00:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:00:02 INFO - "branch": "mozilla-central", 19:00:02 INFO - "repo_path": "mozilla-central", 19:00:02 INFO - "revision": "ad1f85f172b7302bef0fa9780df8e2b962780ac6", 19:00:02 INFO - "stage_platform": "linux64-pgo", 19:00:02 INFO - "builduid": "52d7106af359473791d44483469beb5d", 19:00:02 INFO - "slavebuilddir": "test" 19:00:02 INFO - } 19:00:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:00:02 INFO - Running post-action listener: _resource_record_post_action 19:00:02 INFO - ##### 19:00:02 INFO - ##### Running download-and-extract step. 19:00:02 INFO - ##### 19:00:02 INFO - Running pre-action listener: _resource_record_pre_action 19:00:02 INFO - Running main action method: download_and_extract 19:00:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:02 INFO - https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/test_packages.json 19:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/test_packages.json 19:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:00:03 INFO - Downloaded 1448 bytes. 19:00:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:00:03 INFO - Using the following test package requirements: 19:00:03 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:03 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:03 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:00:03 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'jsshell-linux-x86_64.zip'], 19:00:03 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:03 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:03 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:00:03 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:00:03 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:03 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:00:03 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:00:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:03 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:03 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')]} 19:00:03 INFO - https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:09 INFO - Downloaded 24028993 bytes. 19:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:00:10 INFO - Return code: 0 19:00:10 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:00:10 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')]} 19:00:10 INFO - https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:12 INFO - Downloaded 24028993 bytes. 19:00:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:00:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:00:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:00:13 INFO - Return code: 0 19:00:13 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')]} 19:00:13 INFO - https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:00:15 INFO - Downloaded 11132279 bytes. 19:00:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:00:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:00:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:00:16 INFO - Return code: 0 19:00:16 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')]} 19:00:16 INFO - https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:00:19 INFO - Downloaded 55879455 bytes. 19:00:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:00:19 INFO - mkdir: /builds/slave/test-pgo/properties 19:00:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:00:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:00:19 INFO - Contents: 19:00:19 INFO - build_url:https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:00:19 INFO - Running post-action listener: _resource_record_post_action 19:00:19 INFO - Running post-action listener: set_extra_try_arguments 19:00:19 INFO - ##### 19:00:19 INFO - ##### Running populate-webroot step. 19:00:19 INFO - ##### 19:00:19 INFO - Running pre-action listener: _resource_record_pre_action 19:00:19 INFO - Running main action method: populate_webroot 19:00:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:19 INFO - '--tppagecycles', 19:00:19 INFO - '7'], 19:00:19 INFO - 'tests': ['tsvgm']}}, 19:00:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:00:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:00:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:00:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['damp', 'tps']}, 19:00:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['damp', 'tps']}, 19:00:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:00:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:19 INFO - 'other': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'other_l64': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'other_nol64': {'tests': ['a11yr', 19:00:19 INFO - 'ts_paint', 19:00:19 INFO - 'tpaint', 19:00:19 INFO - 'sessionrestore', 19:00:19 INFO - 'sessionrestore_no_auto_restore']}, 19:00:19 INFO - 'svgr': {'tests': ['tsvgx', 19:00:19 INFO - 'tsvgr_opacity', 19:00:19 INFO - 'tart', 19:00:19 INFO - 'tscrollx', 19:00:19 INFO - 'cart']}, 19:00:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['tsvgx', 19:00:19 INFO - 'tsvgr_opacity', 19:00:19 INFO - 'tart', 19:00:19 INFO - 'tscrollx', 19:00:19 INFO - 'cart']}, 19:00:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'tests': ['tp5o']}, 19:00:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--e10s'], 19:00:19 INFO - 'tests': ['tp5o']}, 19:00:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--xperf_path', 19:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:19 INFO - 'tests': ['tp5n']}, 19:00:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:19 INFO - 'talos_options': ['--e10s', 19:00:19 INFO - '--xperf_path', 19:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:19 INFO - 'tests': ['tp5n']}}, 19:00:19 INFO - 'talos.zip': {'path': '', 19:00:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:19 INFO - Running post-action listener: _resource_record_post_action 19:00:19 INFO - ##### 19:00:19 INFO - ##### Running create-virtualenv step. 19:00:19 INFO - ##### 19:00:19 INFO - Running pre-action listener: _resource_record_pre_action 19:00:19 INFO - Running main action method: create_virtualenv 19:00:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:00:19 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 19:00:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:00:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:19 INFO - Using real prefix '/usr' 19:00:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:00:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:21 INFO - Installing pip.................done. 19:00:21 INFO - Return code: 0 19:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:00:21 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')]} 19:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 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')]} 19:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:21 INFO - Using env: {'DISPLAY': ':0', 19:00:21 INFO - 'HOME': '/home/cltbld', 19:00:21 INFO - 'LANG': 'en_US.UTF-8', 19:00:21 INFO - 'LANGUAGE': 'en_US:en', 19:00:21 INFO - 'LOGNAME': 'cltbld', 19:00:21 INFO - 'MAIL': '/var/mail/cltbld', 19:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:21 INFO - 'MOZ_NO_REMOTE': '1', 19:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:21 INFO - 'NO_EM_RESTART': '1', 19:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:21 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:21 INFO - 'SHELL': '/bin/bash', 19:00:21 INFO - 'SHLVL': '1', 19:00:21 INFO - 'TERM': 'linux', 19:00:21 INFO - 'TMOUT': '86400', 19:00:21 INFO - 'USER': 'cltbld', 19:00:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:21 INFO - '_': '/tools/buildbot/bin/python'} 19:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:21 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 19:00:21 INFO - Cleaning up... 19:00:22 INFO - Return code: 0 19:00:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:00:22 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')]} 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:22 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')]} 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:00:22 INFO - Using env: {'DISPLAY': ':0', 19:00:22 INFO - 'HOME': '/home/cltbld', 19:00:22 INFO - 'LANG': 'en_US.UTF-8', 19:00:22 INFO - 'LANGUAGE': 'en_US:en', 19:00:22 INFO - 'LOGNAME': 'cltbld', 19:00:22 INFO - 'MAIL': '/var/mail/cltbld', 19:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:22 INFO - 'MOZ_NO_REMOTE': '1', 19:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:22 INFO - 'NO_EM_RESTART': '1', 19:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:22 INFO - 'SHELL': '/bin/bash', 19:00:22 INFO - 'SHLVL': '1', 19:00:22 INFO - 'TERM': 'linux', 19:00:22 INFO - 'TMOUT': '86400', 19:00:22 INFO - 'USER': 'cltbld', 19:00:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:22 INFO - '_': '/tools/buildbot/bin/python'} 19:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:22 INFO - Downloading/unpacking psutil>=0.7.1 19:00:22 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 19:00:22 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 19:00:22 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 19:00:22 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 19:00:22 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 19:00:22 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 19:00:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:24 INFO - Installing collected packages: psutil 19:00:24 INFO - Running setup.py install for psutil 19:00:24 INFO - building 'psutil._psutil_linux' extension 19:00:24 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 19:00:24 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 19:00:24 INFO - building 'psutil._psutil_posix' extension 19:00:24 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 19:00:24 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 19:00:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:24 INFO - Successfully installed psutil 19:00:24 INFO - Cleaning up... 19:00:24 INFO - Return code: 0 19:00:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:00:24 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')]} 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 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')]} 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:00:24 INFO - Using env: {'DISPLAY': ':0', 19:00:24 INFO - 'HOME': '/home/cltbld', 19:00:24 INFO - 'LANG': 'en_US.UTF-8', 19:00:24 INFO - 'LANGUAGE': 'en_US:en', 19:00:24 INFO - 'LOGNAME': 'cltbld', 19:00:24 INFO - 'MAIL': '/var/mail/cltbld', 19:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:24 INFO - 'MOZ_NO_REMOTE': '1', 19:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:24 INFO - 'NO_EM_RESTART': '1', 19:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:24 INFO - 'SHELL': '/bin/bash', 19:00:24 INFO - 'SHLVL': '1', 19:00:24 INFO - 'TERM': 'linux', 19:00:24 INFO - 'TMOUT': '86400', 19:00:24 INFO - 'USER': 'cltbld', 19:00:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:24 INFO - '_': '/tools/buildbot/bin/python'} 19:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:00:24 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 19:00:24 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 19:00:24 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 19:00:24 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 19:00:24 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 19:00:24 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 19:00:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:00:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:00:26 INFO - Installing collected packages: mozsystemmonitor 19:00:26 INFO - Running setup.py install for mozsystemmonitor 19:00:26 INFO - Successfully installed mozsystemmonitor 19:00:26 INFO - Cleaning up... 19:00:26 INFO - Return code: 0 19:00:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:26 INFO - Using env: {'DISPLAY': ':0', 19:00:26 INFO - 'HOME': '/home/cltbld', 19:00:26 INFO - 'LANG': 'en_US.UTF-8', 19:00:26 INFO - 'LANGUAGE': 'en_US:en', 19:00:26 INFO - 'LOGNAME': 'cltbld', 19:00:26 INFO - 'MAIL': '/var/mail/cltbld', 19:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:26 INFO - 'MOZ_NO_REMOTE': '1', 19:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:26 INFO - 'NO_EM_RESTART': '1', 19:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:26 INFO - 'SHELL': '/bin/bash', 19:00:26 INFO - 'SHLVL': '1', 19:00:26 INFO - 'TERM': 'linux', 19:00:26 INFO - 'TMOUT': '86400', 19:00:26 INFO - 'USER': 'cltbld', 19:00:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:26 INFO - '_': '/tools/buildbot/bin/python'} 19:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:26 INFO - Downloading/unpacking blobuploader==1.2.4 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:28 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:00:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 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 19:00:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:00:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:00:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 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 19:00:29 INFO - Downloading docopt-0.6.1.tar.gz 19:00:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:00:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:29 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:29 INFO - Running setup.py install for blobuploader 19:00:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:00:29 INFO - Running setup.py install for requests 19:00:29 INFO - Running setup.py install for docopt 19:00:29 INFO - Successfully installed blobuploader requests docopt 19:00:29 INFO - Cleaning up... 19:00:29 INFO - Return code: 0 19:00:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:29 INFO - Using env: {'DISPLAY': ':0', 19:00:29 INFO - 'HOME': '/home/cltbld', 19:00:29 INFO - 'LANG': 'en_US.UTF-8', 19:00:29 INFO - 'LANGUAGE': 'en_US:en', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MAIL': '/var/mail/cltbld', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SHLVL': '1', 19:00:29 INFO - 'TERM': 'linux', 19:00:29 INFO - 'TMOUT': '86400', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - '_': '/tools/buildbot/bin/python'} 19:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:30 INFO - Running setup.py (path:/tmp/pip-NeVjiI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:30 INFO - Running setup.py (path:/tmp/pip-KiCry6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:30 INFO - Running setup.py (path:/tmp/pip-NXSTqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:30 INFO - Running setup.py (path:/tmp/pip-alDtwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:30 INFO - Running setup.py (path:/tmp/pip-U6voPz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:30 INFO - Running setup.py (path:/tmp/pip-utSgKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:30 INFO - Running setup.py (path:/tmp/pip-BS8xht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:30 INFO - Running setup.py (path:/tmp/pip-gRSBR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:30 INFO - Running setup.py (path:/tmp/pip-3m4k8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:30 INFO - Running setup.py (path:/tmp/pip-IhPFxL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:30 INFO - Running setup.py (path:/tmp/pip-RFfTFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:30 INFO - Running setup.py (path:/tmp/pip-muVGeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:30 INFO - Running setup.py (path:/tmp/pip-_bf55Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:31 INFO - Running setup.py (path:/tmp/pip-nGYz2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:31 INFO - Running setup.py (path:/tmp/pip-0Vnhk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:31 INFO - Running setup.py (path:/tmp/pip-wmGoDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:31 INFO - Running setup.py (path:/tmp/pip-PcLnkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:31 INFO - Running setup.py install for manifestparser 19:00:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:00:31 INFO - Running setup.py install for mozcrash 19:00:31 INFO - Running setup.py install for mozdebug 19:00:31 INFO - Running setup.py install for mozdevice 19:00:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:00:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:00:31 INFO - Running setup.py install for mozfile 19:00:31 INFO - Running setup.py install for mozhttpd 19:00:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:00:31 INFO - Running setup.py install for mozinfo 19:00:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for mozInstall 19:00:32 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for mozleak 19:00:32 INFO - Running setup.py install for mozlog 19:00:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for moznetwork 19:00:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for mozprocess 19:00:32 INFO - Running setup.py install for mozprofile 19:00:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for mozrunner 19:00:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:00:32 INFO - Running setup.py install for mozscreenshot 19:00:32 INFO - Running setup.py install for moztest 19:00:33 INFO - Running setup.py install for mozversion 19:00:33 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:00:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:33 INFO - Cleaning up... 19:00:33 INFO - Return code: 0 19:00:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:33 INFO - Using env: {'DISPLAY': ':0', 19:00:33 INFO - 'HOME': '/home/cltbld', 19:00:33 INFO - 'LANG': 'en_US.UTF-8', 19:00:33 INFO - 'LANGUAGE': 'en_US:en', 19:00:33 INFO - 'LOGNAME': 'cltbld', 19:00:33 INFO - 'MAIL': '/var/mail/cltbld', 19:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:33 INFO - 'MOZ_NO_REMOTE': '1', 19:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:33 INFO - 'NO_EM_RESTART': '1', 19:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:33 INFO - 'SHELL': '/bin/bash', 19:00:33 INFO - 'SHLVL': '1', 19:00:33 INFO - 'TERM': 'linux', 19:00:33 INFO - 'TMOUT': '86400', 19:00:33 INFO - 'USER': 'cltbld', 19:00:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:33 INFO - '_': '/tools/buildbot/bin/python'} 19:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:33 INFO - Running setup.py (path:/tmp/pip-CTOXol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:33 INFO - Running setup.py (path:/tmp/pip-IMNBii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:33 INFO - Running setup.py (path:/tmp/pip-1Ojn65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:33 INFO - Running setup.py (path:/tmp/pip-P53Tey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:33 INFO - Running setup.py (path:/tmp/pip-A8dKfk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:33 INFO - Running setup.py (path:/tmp/pip-VwoufV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:33 INFO - Running setup.py (path:/tmp/pip-SECOU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:33 INFO - Running setup.py (path:/tmp/pip-z495Hp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:33 INFO - Running setup.py (path:/tmp/pip-quJ_zs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:00:33 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)) 19:00:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:33 INFO - Running setup.py (path:/tmp/pip-ZRW4CI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:34 INFO - Running setup.py (path:/tmp/pip-M2PvkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:34 INFO - Running setup.py (path:/tmp/pip-uCsupV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:34 INFO - Running setup.py (path:/tmp/pip-jWhr4y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:34 INFO - Running setup.py (path:/tmp/pip-Vth46O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:34 INFO - Running setup.py (path:/tmp/pip-sXJKkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:34 INFO - Running setup.py (path:/tmp/pip-lVzI1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:00:34 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)) 19:00:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:34 INFO - Running setup.py (path:/tmp/pip-MiYpqL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:00:34 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)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:00:34 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)) 19:00:34 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)) 19:00:34 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)) 19:00:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:36 INFO - Downloading blessings-1.5.1.tar.gz 19:00:36 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:36 INFO - Installing collected packages: blessings 19:00:36 INFO - Running setup.py install for blessings 19:00:36 INFO - Successfully installed blessings 19:00:36 INFO - Cleaning up... 19:00:36 INFO - Return code: 0 19:00:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:00:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:36 INFO - Reading from file tmpfile_stdout 19:00:36 INFO - Current package versions: 19:00:36 INFO - argparse == 1.2.1 19:00:36 INFO - blessings == 1.5.1 19:00:36 INFO - blobuploader == 1.2.4 19:00:36 INFO - docopt == 0.6.1 19:00:36 INFO - manifestparser == 1.1 19:00:36 INFO - mozInstall == 1.12 19:00:36 INFO - mozcrash == 0.16 19:00:36 INFO - mozdebug == 0.1 19:00:36 INFO - mozdevice == 0.48 19:00:36 INFO - mozfile == 1.2 19:00:36 INFO - mozhttpd == 0.7 19:00:36 INFO - mozinfo == 0.9 19:00:36 INFO - mozleak == 0.1 19:00:36 INFO - mozlog == 3.1 19:00:36 INFO - moznetwork == 0.27 19:00:36 INFO - mozprocess == 0.22 19:00:36 INFO - mozprofile == 0.28 19:00:36 INFO - mozrunner == 6.11 19:00:36 INFO - mozscreenshot == 0.1 19:00:36 INFO - mozsystemmonitor == 0.0 19:00:36 INFO - moztest == 0.7 19:00:36 INFO - mozversion == 1.4 19:00:36 INFO - psutil == 3.1.1 19:00:36 INFO - requests == 1.2.3 19:00:36 INFO - wsgiref == 0.1.2 19:00:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:00:36 INFO - Using env: {'DISPLAY': ':0', 19:00:36 INFO - 'HOME': '/home/cltbld', 19:00:36 INFO - 'LANG': 'en_US.UTF-8', 19:00:36 INFO - 'LANGUAGE': 'en_US:en', 19:00:36 INFO - 'LOGNAME': 'cltbld', 19:00:36 INFO - 'MAIL': '/var/mail/cltbld', 19:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:36 INFO - 'MOZ_NO_REMOTE': '1', 19:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:36 INFO - 'NO_EM_RESTART': '1', 19:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:36 INFO - 'SHELL': '/bin/bash', 19:00:36 INFO - 'SHLVL': '1', 19:00:36 INFO - 'TERM': 'linux', 19:00:36 INFO - 'TMOUT': '86400', 19:00:36 INFO - 'USER': 'cltbld', 19:00:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:36 INFO - '_': '/tools/buildbot/bin/python'} 19:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 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)) 19:00:36 INFO - Cleaning up... 19:00:36 INFO - Return code: 0 19:00:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:36 INFO - Using env: {'DISPLAY': ':0', 19:00:36 INFO - 'HOME': '/home/cltbld', 19:00:36 INFO - 'LANG': 'en_US.UTF-8', 19:00:36 INFO - 'LANGUAGE': 'en_US:en', 19:00:36 INFO - 'LOGNAME': 'cltbld', 19:00:36 INFO - 'MAIL': '/var/mail/cltbld', 19:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:36 INFO - 'MOZ_NO_REMOTE': '1', 19:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:36 INFO - 'NO_EM_RESTART': '1', 19:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:36 INFO - 'SHELL': '/bin/bash', 19:00:36 INFO - 'SHLVL': '1', 19:00:36 INFO - 'TERM': 'linux', 19:00:36 INFO - 'TMOUT': '86400', 19:00:36 INFO - 'USER': 'cltbld', 19:00:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:36 INFO - '_': '/tools/buildbot/bin/python'} 19:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:37 INFO - Downloading/unpacking jsonschema 19:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:00:38 INFO - Downloading/unpacking functools32 (from jsonschema) 19:00:38 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 19:00:38 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 19:00:38 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 19:00:38 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 19:00:38 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 19:00:38 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 19:00:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:39 INFO - warning: no files found matching '*.txt' 19:00:39 INFO - no previously-included directories found matching 'build' 19:00:39 INFO - no previously-included directories found matching 'dist' 19:00:39 INFO - no previously-included directories found matching '.git*' 19:00:39 INFO - Installing collected packages: jsonschema, functools32 19:00:39 INFO - Running setup.py install for functools32 19:00:39 INFO - warning: no files found matching '*.txt' 19:00:39 INFO - no previously-included directories found matching 'build' 19:00:39 INFO - no previously-included directories found matching 'dist' 19:00:39 INFO - no previously-included directories found matching '.git*' 19:00:39 INFO - Successfully installed jsonschema functools32 19:00:39 INFO - Cleaning up... 19:00:39 INFO - Return code: 0 19:00:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc79830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', '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 19:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:00:39 INFO - Using env: {'DISPLAY': ':0', 19:00:39 INFO - 'HOME': '/home/cltbld', 19:00:39 INFO - 'LANG': 'en_US.UTF-8', 19:00:39 INFO - 'LANGUAGE': 'en_US:en', 19:00:39 INFO - 'LOGNAME': 'cltbld', 19:00:39 INFO - 'MAIL': '/var/mail/cltbld', 19:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:39 INFO - 'MOZ_NO_REMOTE': '1', 19:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:39 INFO - 'NO_EM_RESTART': '1', 19:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:39 INFO - 'SHELL': '/bin/bash', 19:00:39 INFO - 'SHLVL': '1', 19:00:39 INFO - 'TERM': 'linux', 19:00:39 INFO - 'TMOUT': '86400', 19:00:39 INFO - 'USER': 'cltbld', 19:00:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:39 INFO - '_': '/tools/buildbot/bin/python'} 19:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:39 INFO - Downloading/unpacking flake8 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:00:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:00:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:00:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:00:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:00:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:41 INFO - no previously-included directories found matching 'docs/_build' 19:00:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:00:42 INFO - Running setup.py install for pep8 19:00:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:42 INFO - no previously-included directories found matching 'docs/_build' 19:00:42 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:00:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:00:42 INFO - Cleaning up... 19:00:42 INFO - Return code: 0 19:00:42 INFO - Running post-action listener: _resource_record_post_action 19:00:42 INFO - Running post-action listener: _start_resource_monitoring 19:00:42 INFO - Starting resource monitoring. 19:00:42 INFO - ##### 19:00:42 INFO - ##### Running install step. 19:00:42 INFO - ##### 19:00:42 INFO - Running pre-action listener: _resource_record_pre_action 19:00:42 INFO - Running main action method: install 19:00:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:00:42 INFO - Reading from file tmpfile_stdout 19:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:00:42 INFO - Reading from file tmpfile_stdout 19:00:42 INFO - Output received: 19:00:42 INFO - Usage: mozinstall [options] installer 19:00:42 INFO - Options: 19:00:42 INFO - -h, --help show this help message and exit 19:00:42 INFO - -d DEST, --destination=DEST 19:00:42 INFO - Directory to install application into. [default: 19:00:42 INFO - "/builds/slave/test-pgo"] 19:00:42 INFO - --app=APP Application being installed. [default: firefox] 19:00:42 INFO - mkdir: /builds/slave/test-pgo/build/application 19:00:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:00:58 INFO - Reading from file tmpfile_stdout 19:00:58 INFO - Output received: 19:00:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:00:58 INFO - Running post-action listener: _resource_record_post_action 19:00:58 INFO - ##### 19:00:58 INFO - ##### Running run-tests step. 19:00:58 INFO - ##### 19:00:58 INFO - Running pre-action listener: _resource_record_pre_action 19:00:58 INFO - Running main action method: run_tests 19:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:00:58 INFO - Python 2.7.3 19:00:58 INFO - Return code: 0 19:00:58 INFO - grabbing minidump binary from tooltool 19:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:58 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 0xdcc840>, '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 0xd396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd39b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:00:58 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 19:00:58 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 19:00:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:58 INFO - Return code: 0 19:00:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:00:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:00:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:00:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:00:59 INFO - Return code: 0 19:00:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:00:59 INFO - Using env: {'DISPLAY': ':0', 19:00:59 INFO - 'HOME': '/home/cltbld', 19:00:59 INFO - 'LANG': 'en_US.UTF-8', 19:00:59 INFO - 'LANGUAGE': 'en_US:en', 19:00:59 INFO - 'LOGNAME': 'cltbld', 19:00:59 INFO - 'MAIL': '/var/mail/cltbld', 19:00:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:59 INFO - 'MOZ_NO_REMOTE': '1', 19:00:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:59 INFO - 'NO_EM_RESTART': '1', 19:00:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:00:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:00:59 INFO - 'SHELL': '/bin/bash', 19:00:59 INFO - 'SHLVL': '1', 19:00:59 INFO - 'TERM': 'linux', 19:00:59 INFO - 'TMOUT': '86400', 19:00:59 INFO - 'USER': 'cltbld', 19:00:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328', 19:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:59 INFO - '_': '/tools/buildbot/bin/python'} 19:00:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:00:59 INFO - mozversion application_buildid: 20160113133021 19:00:59 INFO - mozversion application_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 19:00:59 INFO - mozversion application_display_name: Nightly 19:00:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:59 INFO - mozversion application_name: Firefox 19:00:59 INFO - mozversion application_remotingname: firefox 19:00:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:59 INFO - mozversion application_vendor: Mozilla 19:00:59 INFO - mozversion application_version: 46.0a1 19:00:59 INFO - mozversion platform_buildid: 20160113133021 19:00:59 INFO - mozversion platform_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 19:00:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:59 INFO - mozversion platform_version: 46.0a1 19:00:59 INFO - using testdate: 1452740459 19:00:59 INFO - actual date: 1452740459 19:00:59 INFO - starting webserver on 'localhost:44732' 19:00:59 INFO - SUITE-START | Running 3 tests 19:00:59 INFO - TEST-START | dromaeo_css 19:00:59 INFO - operating with platform_type : linux_ 19:00:59 INFO - Initialising browser for dromaeo_css test... 19:00:59 INFO - TEST-INFO | started process 13408 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZWVY0_/profile http://localhost:44732/getInfo.html) 19:01:03 INFO - PROCESS | 13408 | 19:01:03 INFO - PROCESS | 13408 | (process:13491): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:04 INFO - PROCESS | 13408 | __metrics Screen width/height:1600/1200 19:01:04 INFO - PROCESS | 13408 | colorDepth:24 19:01:04 INFO - PROCESS | 13408 | Browser inner width/height: 1024/697 19:01:04 INFO - PROCESS | 13408 | __metrics 19:01:05 INFO - PROCESS | 13408 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:01:05 INFO - TEST-INFO | 13408: exit 0 19:01:05 INFO - Browser initialized. 19:01:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:05 INFO - TEST-INFO | started process 13541 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZWVY0_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:07 INFO - PROCESS | 13541 | 19:01:07 INFO - PROCESS | 13541 | (process:13602): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:17 INFO - PROCESS | 13541 | RSS: Main: 150667264 19:01:17 INFO - PROCESS | 13541 | 19:02:07 INFO - PROCESS | 13541 | 1452740527428 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] 19:04:15 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44732/tests/dromaeo/cssquery-ext.html) 19:04:16 INFO - PROCESS | 13541 | RSS: Main: 155537408 19:04:16 INFO - PROCESS | 13541 | 19:07:19 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-ext.html (next: http://localhost:44732/tests/dromaeo/cssquery-jquery.html) 19:07:19 INFO - PROCESS | 13541 | RSS: Main: 150093824 19:07:19 INFO - PROCESS | 13541 | 19:10:21 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44732/tests/dromaeo/cssquery-mootools.html) 19:10:21 INFO - PROCESS | 13541 | RSS: Main: 151568384 19:10:21 INFO - PROCESS | 13541 | 19:13:23 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44732/tests/dromaeo/cssquery-prototype.html) 19:13:24 INFO - PROCESS | 13541 | RSS: Main: 150929408 19:13:24 INFO - PROCESS | 13541 | 19:16:26 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44732/tests/dromaeo/cssquery-yui.html) 19:16:27 INFO - PROCESS | 13541 | RSS: Main: 151379968 19:16:27 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | Cycle 1(1): loaded http://localhost:44732/tests/dromaeo/cssquery-yui.html (next: http://localhost:44732/tests/dromaeo/cssquery-dojo.html) 19:19:29 INFO - PROCESS | 13541 | RSS: Main: 153403392 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | __start_tp_report 19:19:29 INFO - PROCESS | 13541 | _x_x_mozilla_page_load 19:19:29 INFO - PROCESS | 13541 | _x_x_mozilla_page_load_details 19:19:29 INFO - PROCESS | 13541 | |i|pagename|runs| 19:19:29 INFO - PROCESS | 13541 | |0;dojo.html;3154.558361829343;3158.0683698308994;3204;3205.5191721241813;3209.8876539321122;5130.820421285246;5133.61497887659;5184.1705327147665;5187.533122019017;5200.817971371002;5165.30268413764;5285.8942821143555;5291.100512912804;5293.391260005101;5307.52232299093;4494.910101797962;4742.217534106868;4886.584640305578;4895.951040489603;4925.408950925894;4694.929576056362;4822.107910036654;4838.056578967103;4895.339129217564;4897.8040878365;4744.027474367764;4775.928361074587;4791.089692958327;4840.564349208553;4847.200211965039;4776.116418462596;4777.235642297251;4783.784729687172;4812.7352995585225;4820.108279968182;4664.207084795593;4706.952930470686;4760.547747963938;4788.0663270662235;4833.3958255218095;5078.873028174288;5087.720175390352;5099.71951542665;5125.589952803767;5168.534831865112;5636.943630563724;5679.517241034517;5687.317521897357;5709.400512946122;5768.394318596529;5481.260029895953;5565.332160140809;5666.546676265889;5751.1085781703905;5759.337676167211;5230.686158830483;5258.92111618326;5268.841934741964;5269.025230332362;5307;5713.371529131792;5714.571407144397;5724.313082430135;5733.741981610838;5782.566307526952;5449.04641687703;5508.394076651645;5514.228008078872;5570.6657600544095;5632.211490391349;5605.887882242332;5637.379888212294;5659.462351076641;5663.546916246691;5672.064109421899;5616.073347897551;5622.32532096151;5626.071698169838;5635.380108188096;5638.774449021993;5471.835844924659;5499.917501237404;5504.697241651747;5571.052921003439;5606.383297837235;4378.759168245777;4392.07766369066;4393.824247030147;4410.4927933287445;4434.157510073076;3879.689624830007;3950.1902110067367;3950.3679411294056;3953.169834334822;3999.24014437256;5197.194434862527;5274.156135018378;5339.492748188916;5347.946520534822;5408.13469844823;5576.693281869455;5583.330000399897;5590.748416321276;5590.86022849432;5597.80407685729;5225.712585807741;5253.44838791929;5254.842354729364;5273.973630131902;5303.655262408009;4699.412573428322;4749.691270067435;4786.904261914742;4815.566599006106;4843.104025755247;5740.368559458456;5746.310442746813;5802.506786923159;5802.65184088956;5806.44838740319;5461.453854614507;5495.368032676293;5584.636998595079;5602.439756024528;5633.2113504110275;5766.365699772938;5820.592558520862;5827.1841942127285;5827.79602713903;5847.912281315698;5571.498565129158;5576.665400076008;5578.470045345685;5582.944170558405;5583.1904373864745;5449.455054494519;5548.029094908295;5590.2453168821685;5622.156676498558;5643.604947653625;5418.701971391453;5420.512153906167;5468.425815289337;5507.889842203213;5511.614187007031;5509.862253443696;5515.972420137874;5516.696581687886;5529.778808847762;5532.28080349552;5421.484958928895;5461.290032295776;5481.397046324981;5501.944980550144;5548.916766248429;5396.541293990055;5461.371942226695;5518.310211223597;5558.44415558441;5563.304586926634;5328.17413300939;5337.733113344239;5344.091504444176;5349.598780091431;5364.973175134255 19:19:29 INFO - PROCESS | 13541 | |1;ext.html;543.5271313956858;545.4872419925267;566.5835610826044;568.428729127227;585.1369230385183;35228.119297017554;36587;36617.267654646894;36644;36664.45003324946;39593.40609890847;40171.397429038516;40247;40282.59717402825;40401;8206.917930820706;8425.07324194338;8516.87224691627;8517;8534.445261058012;8318.625661845232;8433.114522975091;8459.280961118313;8596.613152408125;8642.049374568793;8508.36187285953;8651.783705407384;8713.041565427799;8722.040575536686;8734.301255899545;8558.61486233121;8625.353098517637;8634.568271586428;8640.65437382504;8698;8423.284020858173;8505.404621676485;8520.360972927056;8558.871616925751;8559.229669329728;38635.613643863486;38972.22055558901;39037.60962390397;39093.41359879604;39177;3085.4291955987987;3092.70619291167;3153.4166179256913;3183.503842674071;3203.8398080095903;28936.42127157466;29354.559681604795;29662.85168574165;29733.10800675983;30130.24674383136;3939.251542207;3981.28336899358;4044.474218351625;4102.462370124252;4127.422160897447;252497.7375113131;254487;254656;255263;255544;54412;54458.72770636121;54501;54622;54624.45375546194;56693.71653141791;65251.67374163099;65863;65937.34062659313;66174;14105.153690778587;14148.292585370691;14210.502632407815;14235.715285694228;14286.85713142876;11409;11439;11448.828267575993;11465.828012579817;11487.655370338904;19828.90085549563;20113.19547218124;20314.18743250283;20331.39005829798;20343.4914127148;8085.676572937016;8135.471194372347;8234.752957411167;8234.812068396872;8296.128906464855;957.0286159548065;995.5072239241622;997.2050309442974;1035.8239099352977;1129.1249281806665;28051.57922631162;28876.27809304784;29126.796052434216;29405.26486837846;29632.851835740683;1052.6263176572359;1061.0821639281965;1081.0270756319376;1125.392288164382;1198.4367347346733;13642.93178534101;13661.248631325174;13740.931295343658;13784.172949623055;13842.238676872666;588960;600590;601471;602567;608170;52676;53367;53393.733031334596;53420.46579534232;53485.1977220342;1335.2789493673502;1351.7296540691705;1357.5384369314284;1386.6394737368357;1390.360434200259;29251.85374073116;30321.24196895095;30478;30770.692293076783;31095.844520777253;45655.77172114118;46176.53823461723;46271.30593041174;46348.768256159856;46367.304490432;285662;287557;289137;289798;291489;40919.1816163681;42101.78949105235;43468.56531434645;43624;43830.561694382646;38906.80546597249;39284;39385;39581;40001.399978999754;35420.822895886384;35665.64334356623;35701;35751.28497429985;36427;36743.897683069554;37511.24977500489;40231.59768402279;40995;41395.172096558505;35416.82291588629;35511;35644;38318.80840595779;38856.41715374215;30271.394572107994;31945.36109277848;32514.187145321557;33081.17297067496;33098.83450582732;24654.137105201233;24789;24898.751012489643;25199.37001574975;25392.746072539037 19:19:29 INFO - PROCESS | 13541 | |2;jquery.html;363.4911124425802;367.76646829263416;368.67924905332364;369.1730523627076;370.43138781969697;15553.766693499607;16794.496165115037;16794.748078778826;17475.213615387307;17733.37933172341;10554.208434367414;10567.1017963473;16469.505914822545;16758.916205418987;16777.66444671106;4745.074710431459;5494.615376923617;5502.5597952163735;5504.366997795245;5538.667679939216;5279.208118782175;5354.41101478837;5447.237386765856;5479.671219726829;5497.340319161706;5061.1143049966295;5243.134882744362;5448.4006759256645;5455.536279416255;5456.836294911159;5197.298364720752;5239.476052394749;5262.4211336753115;5274.604404669646;5275.366955965309;5358.089124848746;5360.356757189163;5363;5365.624406291561;5370.060239458118;12893.484260629657;17904.731429028576;19586;20051.29820456277;20163.89918050415;1981.187713037662;2034.5523984723486;2062.4222469810607;2168.620491413996;2174.1738139507042;9125.178733913914;9168.908310916871;9297.442153470745;9370.390924589949;9516.90483095174;1848.177560985362;1948.6492431362349;2033.7966203379692;2034.9593008139902;2036.1142902837314;54723;56639.43360566424;57199.71400143014;58020.70989645025;58027;10158.746031349276;10263.692089237335;10381.117605003508;10422.947885260524;10435.843462348072;13547.119437236548;13597.04820662544;13643;13650.931745341408;13679.589612311647;7507.436942229246;7561.168271490132;7816.960915195387;7828.373730101578;7847.254510821463;7490.6629201686055;7511.737089201852;7517.774466766005;7587.127480339721;7630.046244219473;4521.570450807168;4527.3435351873795;4530.207213737583;4531.56950089741;4575.748333841604;1851.4908400190056;1894.2044341376654;1918.856085793571;1926.2391355414534;1974.5655955689726;867.2888231650113;914.6570036236411;929.0987741890356;978.9853152202722;1030.9793804123876;15057.472988445352;15342.463013794464;15737.370505179893;15867.841321586868;16190.919045404698;903.7153296711515;949.8575213717997;971.358903123949;977.3988996766938;998.1964518562627;9201.723948281562;9343.2525397968;9416.95291523538;9765.414075155371;9910.851337229804;519749;530017;537197;541016;542473;72834.63582682052;73863.26136738672;76237;77384;77796.61101694568;1106.773111512138;1141.4749215361028;1142.5315620595516;1158.2702897174895;1178.187050934835;15299.541013769605;15352.385904563693;15356;15357.155356455056;15673.294701738221;33826.830865846496;34058.318833623685;34115.14712132217;34708.305833883685;35343;43571.56428435802;44682.3297650542;44758.55241447674;44827.32759008552;44930.10139797251;7098.574085554883;7208;7345.449091318065;7349.412047036331;7357.558546487228;8775.736727898173;10824.24230303871;10961.671149865517;11111.72220694489;11363.318200907972;8116.188381161836;9089.818203635758;9145.908540914772;9633.421994680342;9653.420794752337;2925.5757915102618;3699.944500832436;8196.4426758918;9896.802063958825;10010;9928.702138935843;9982.650607228712;10156.136728378171;10239.590416383558;10286.897131028594;7444.255574442513;7505.699772009277;7605.315521603082;7651.120121186135;7679.116901556393;10006.29955903109;10186.236032297458;10190.541425635716;10296.845547316947;10395.532201050819 19:19:29 INFO - PROCESS | 13541 | |3;mootools.html;1447.3414596358657;1473.1529370611897;1615.3457849570927;1732.4542769027748;1763.9911800440989;7631.656575454104;7803.648835802388;7804.648790804413;7814.7264845730415;7892.605369731519;7744.303012728853;7792.3376512996465;7835;7867.213278672144;7876.133625301212;2318.478342372965;2320.1879342230254;2331.825113116515;2339.1462116327502;2342.543204075206;2311.630139177732;2322.4310044039235;2340.5201933603657;2346.601077816775;2349.5770761262966;2277.6811246425514;2288.2563166970717;2301.5742087713743;2311.225739377302;2348.518553696488;2353.094058787362;2365.562370961378;2380.1550449590404;2381.9761802381927;2386.4391867911027;2388.534235824015;2406.542756876188;2412.16780210827;2423.7212720537186;2427.235420842429;7920.287174154354;7931.603419829044;7949.284564389175;7971.800704982364;7985.680572777082;4731.716097034189;4857.858403275228;4860.975695121501;4863.9513604864205;4879.072976134523;3331.950020749691;3339.5992480902205;3393.932121357559;3427.074689833731;3430.588329400488;1106.9612563560236;1112.2936935046223;1123.0341905960868;1142.046391263296;1154.555496133986;10765.677029689123;10773;10850.457477126112;10865.239433239676;10914.345139291589;4197.811098500514;4298.892527686833;4333.523312435629;4344.47866256045;4349.217140914602;8924.55377231136;8979.506127162938;8980.820383592292;8988.280937524982;8990.190882820447;4842.83050093245;4853.95146048542;4860.343853579792;4869.63477739171;4887;4441.866743997685;4464.486584042812;4473;4488.102379524108;4491.775411229425;3437.8796742113905;3446.6208717041104;3477.8087205203956;3504.4392897136336;3514.648535146516;1074.5862842805577;1076.9353838769698;1084.8318510630866;1094.3597995172913;1102.9558817647364;930.3394589841154;989.5101924547251;1037.8443233514881;1125.1673761416494;1262.1669697999275;7325.04774379338;7348.926510734825;7363.521371110861;7368.226336234726;7377.88933166003;1216.3370962825281;1223.424990254579;1247.1955588645455;1249.9187552809037;1252.1297698099734;5914.852128696817;5924.318703349084;6002.609830361012;6006.789762358297;6007.038873780174;9074.682386116454;9757.853632195523;9781.41311521311;9815.705528834147;9875.555599997873;9563.474008929437;9601.663941762004;9708.417494950185;9760.267979901535;9801.215902727765;7439.479236453504;7677.692892284358;7716.382689384835;7742.535447873146;7745.573993430416;7315.414766818535;7318.451116166415;7334.889976650461;7341.853162936818;7364.153122390993;8742.950845898278;8896.733098007071;8896.866547001671;8949.373543851867;9027.819443611223;8853.69012084574;9122.90877091247;9154.221891139328;9236;9277.814443711222;6935.306469353024;7049.259827718221;7074.3633073023675;7077.1507419107975;7118.430525558047;7286.562806231643;7404.592747398945;7428.405727541675;7436.96281518589;7460.776176714708;6958.8956165658565;7139;7172.354488096096;7209.891851622125;7334.3032411920785;7076.752313668997;7098.219195888345;7099.538529995534;7197.8920316196345;7206.603636800026;6979.441644668313;6987.650617469208;7010.053642758367;7022.754203602849;7058.964705176441;6507.707153178024;6669.83325416849;6673.366030227315;6674.399304062657;6679.265280819203;6515.348465153446;6620.536562440776;6625.933740662532;6631.6684165792485;6631.834204144935 19:19:29 INFO - PROCESS | 13541 | |4;prototype.html;342.5940260790963;346.4456869009585;349.15156170505674;353.2475826489577;356.1381456874365;6184.659843708594;6240.344763799798;6263.655498947567;6266.185395898532;6337.619742815423;6044.576879618428;6218.937810621893;6230.439260466557;6236.438720515152;6270.937290627104;4766.356541866847;4787.640926930477;4788.88027799306;4793.616510679155;4797.544233297831;4789.922267489822;4805.399325084364;4807.78364973577;4814.374131362918;4814.422269327685;4693.342931989524;4780.067886762065;4781.45013323467;4784.306275590037;4786.090642777861;4764.737939413331;4772;4777.355057067286;4784.473707892129;4784.880377990561;4158.875233742992;4164.646005089571;4169.312063509517;4188.706790524665;4200.1179752252065;5969.761209551612;5978.730957106941;5982.521398288127;5990.041593345088;6040.486558642477;5402.621816472849;5562.805301814417;5576.10782274834;5586.804461843856;5595.18869763882;6615.974523948796;6639.269680335159;6644.700988455483;6650.567713098633;6670.566413183127;4666.183417901888;4669.252919532859;4680.087382960324;4684.976575117136;4687.086018226447;6767.154105736783;6979.336962988558;6985.476089293273;6992.1259842519685;6994.965025174893;4779.569838714532;4783.282507623815;4784;4785.59322457588;4789.137955168103;4830.2513110467935;4834.984653222792;4840.15297322967;4852.8301509447;4854.101991131652;5578.386377498472;5583.022970980062;5586.190002449622;5587.664740115606;5591.804286849941;6566.507511936624;6705.09481220029;6728.764493242713;6738.663066846736;6744.561603495855;1641.146603766035;1688.9071101089312;1691.1966815762414;1691.6447546015474;1693.6866679664302;1113.6325012745774;1119.036517494872;1119.6193294279822;1134.5405110930087;1141.9200655954003;6205.100260462208;6238.064290356483;6240.469560087353;6242.438180563771;6266.436020758154;6689.966550167218;6742.49431292655;6744.359285867835;6747.257801641816;6756.966215168893;6095.756169753249;6191.349908259568;6226.937730622726;6235.594686345373;6242.750289988349;3639.563252409675;3657.085728567858;3658.8536458541894;3682.6317368262958;3685.244524872395;7037.4018208451835;7056.717731290691;7078.433725301964;7082.327178917994;7086.716531338792;6899.241083480813;6936.618485983218;6965.164180298397;6965.547239429421;6982.1970473395195;7059.8235044123285;7107.92892071083;7122.679479423438;7132.930060490968;7138.714451421989;6785.864282714417;6793.93206067933;6906.343897329745;6908.965455172692;6910.550814197061;6672.599644021374;6820.181578210448;6866.725330986705;6871.381575658214;6888.345607167512;7096.7516136934955;7182.928170718226;7280.708771649075;7290.906364045436;7298.23368546295;4708.599769019672;4749.430068391815;4756.310335001336;4756.928646070242;4761.809527618995;6779.593224406552;6937.306269373023;6990.196127445409;6990.790276291719;6992.475564332593;6749.73001079971;6769.323067693388;6808.28513006147;6841.008053832266;6848.931510684829;6741.258461569126;6798.52410331272;6808.9659551701925;6820.795376138723;6823.317668233335;6531.444827189742;6642.136522252076;6659.733610655519;6663.433608143362;6681.599104053772;6803.795886123424;6819.659017049028;6821.386075253251;6829.590224586541;6846.691898864663;6574.901376479261;6609.4712423005085;6611.603303801788;6612.702428390638;6626.337366263335 19:19:29 INFO - PROCESS | 13541 | |5;yui.html;803.505843905998;827.5489858027374;831.384775266303;846.7332790171096;852.3947996922185;13320.600381988545;13388.397522111503;13406.66483337917;13416.46334146633;13455.73088538231;12559.434825432854;12608.810867836966;12613.810792838114;12627;12630.115891887548;640.8205702403322;657.336090548547;775.9806004849868;801.2588355770889;808.0949336742856;789.0807209600808;790.6046976511744;796.2913007423398;800.6237068577789;800.8398320335926;836.6486075848159;843.1652663862762;843.4517563583659;845.4293351987415;846.4751853850621;835.2232423845821;837.2213841127749;838.7190291252438;839.3075712537151;843.755310959824;619.9101130336076;622.365187508743;622.5268795715243;622.7913648927615;624.4629618528062;13336.933315333457;13340.19958802475;13345.599632011055;13388.330583470884;13410.597682069456;11975.700607484883;13296;13406.061575689706;13418.565154313426;13516.391762370618;9474.289428292837;9618.278629102846;9629.470379129145;9672.516374181263;9679.806403871884;3535;3559.359315323241;3562.5190599269026;3584.623614520464;3604.1350075981577;49035.75482122602;49652;49727.25409118866;50315.74842125766;50922.23616645753;9325.347225694271;9337.206337461255;9394.812103758024;9523.380980236263;9664.178544823628;15905.137075326322;15968.441104561285;15979.360825567079;15991.520254392386;16200.67598648044;7015.088038555057;7236;7363.079615048119;7363.77908662741;7456.552606843607;4259.9574004260185;4338.240807858612;4352.608265256079;4386.232409328355;4495.123450927038;3076.8307743074347;3123.7969531980348;3130.4208721386617;3131.248500359897;3141.6701246369257;549.7333793110338;561.9943800562024;562.5330975290499;592.3987153039668;592.973316200772;578.5342799046724;582.8979928512493;610.5298919831705;622.3527531367417;632.772202007277;8951.507667078244;9246.26029917605;9572.617095316109;9723.562439690231;9849.45827979468;608.7504123309421;655.7311502284041;657.5824351536713;658.7694306992514;694.833240022391;3905.902352441155;3984.2230765000545;4053.533843608023;4096.344584866407;4132.462779838602;48517;49658.255126173135;50302.49697502978;50342.49657503378;50409.495905041214;46082.539174607824;46350;55009.724951374985;55039.44960550423;56492.43507564954;44804.77597611991;45140.3228951566;46401;46416;46551.30173047407;8270.297024752723;8550.102239264788;8701.47791132534;8959.865602015845;9104.271658267455;33761.66238337585;33908.321833563685;33989;33999.83000084984;34536.82731586326;43706.34440483459;43997.34003990007;44280.33579496374;44582.3312650317;45107.54892451165;10133.13868321201;10561.366318020944;10601.840972385575;11431.542738290374;11654.41727913584;12751.17117387404;12842.165259258118;13073.215607063607;13085.542006029744;13156.934215329245;11381.886181138083;12067.094967877269;12134.150609457252;12577.93711031439;12622.179558328678;11750.29498230109;11774.764504710029;11857.644270671894;12067.637970860536;12150.939245303716;10936.398498082683;10963.671089867317;10978.066864316303;11079.778404432027;11332.64112138341;9402.858957115786;9552.188064014359;9722.951385243312;9831.845918387618;9993.650222242186;9248.121428464285;9362.672306469241;9566.9043309566;9636.518174091127;10086.394816311045 19:19:29 INFO - PROCESS | 13541 | __end_tp_report 19:19:29 INFO - PROCESS | 13541 | __start_cc_report 19:19:29 INFO - PROCESS | 13541 | _x_x_mozilla_cycle_collect,301 19:19:29 INFO - PROCESS | 13541 | __end_cc_report 19:19:29 INFO - PROCESS | 13541 | __startTimestamp1452741569878__endTimestamp 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | ------- Summary: start ------- 19:19:29 INFO - PROCESS | 13541 | Number of tests: 6 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#0] dojo.html Cycles:165 Average:5220.83 Median:5420.51 stddev:561.98 (10.4%) stddev-sans-first:539.82 19:19:29 INFO - PROCESS | 13541 | Values: 3154.6 3158.1 3204.0 3205.5 3209.9 5130.8 5133.6 5184.2 5187.5 5200.8 5165.3 5285.9 5291.1 5293.4 5307.5 4494.9 4742.2 4886.6 4896.0 4925.4 4694.9 4822.1 4838.1 4895.3 4897.8 4744.0 4775.9 4791.1 4840.6 4847.2 4776.1 4777.2 4783.8 4812.7 4820.1 4664.2 4707.0 4760.5 4788.1 4833.4 5078.9 5087.7 5099.7 5125.6 5168.5 5636.9 5679.5 5687.3 5709.4 5768.4 5481.3 5565.3 5666.5 5751.1 5759.3 5230.7 5258.9 5268.8 5269.0 5307.0 5713.4 5714.6 5724.3 5733.7 5782.6 5449.0 5508.4 5514.2 5570.7 5632.2 5605.9 5637.4 5659.5 5663.5 5672.1 5616.1 5622.3 5626.1 5635.4 5638.8 5471.8 5499.9 5504.7 5571.1 5606.4 4378.8 4392.1 4393.8 4410.5 4434.2 3879.7 3950.2 3950.4 3953.2 3999.2 5197.2 5274.2 5339.5 5347.9 5408.1 5576.7 5583.3 5590.7 5590.9 5597.8 5225.7 5253.4 5254.8 5274.0 5303.7 4699.4 4749.7 4786.9 4815.6 4843.1 5740.4 5746.3 5802.5 5802.7 5806.4 5461.5 5495.4 5584.6 5602.4 5633.2 5766.4 5820.6 5827.2 5827.8 5847.9 5571.5 5576.7 5578.5 5582.9 5583.2 5449.5 5548.0 5590.2 5622.2 5643.6 5418.7 5420.5 5468.4 5507.9 5511.6 5509.9 5516.0 5516.7 5529.8 5532.3 5421.5 5461.3 5481.4 5501.9 5548.9 5396.5 5461.4 5518.3 5558.4 5563.3 5328.2 5337.7 5344.1 5349.6 5365.0 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#1] ext.html Cycles:180 Average:53860.96 Median:38939.51 stddev:110095.13 (282.7%) stddev-sans-first:110331.19 19:19:29 INFO - PROCESS | 13541 | Values: 543.5 545.5 566.6 568.4 585.1 35228.1 36587.0 36617.3 36644.0 36664.5 39593.4 40171.4 40247.0 40282.6 40401.0 8206.9 8425.1 8516.9 8517.0 8534.4 8318.6 8433.1 8459.3 8596.6 8642.0 8508.4 8651.8 8713.0 8722.0 8734.3 8558.6 8625.4 8634.6 8640.7 8698.0 8423.3 8505.4 8520.4 8558.9 8559.2 38635.6 38972.2 39037.6 39093.4 39177.0 3085.4 3092.7 3153.4 3183.5 3203.8 28936.4 29354.6 29662.9 29733.1 30130.2 3939.3 3981.3 4044.5 4102.5 4127.4 252497.7 254487.0 254656.0 255263.0 255544.0 54412.0 54458.7 54501.0 54622.0 54624.5 56693.7 65251.7 65863.0 65937.3 66174.0 14105.2 14148.3 14210.5 14235.7 14286.9 11409.0 11439.0 11448.8 11465.8 11487.7 19828.9 20113.2 20314.2 20331.4 20343.5 8085.7 8135.5 8234.8 8234.8 8296.1 957.0 995.5 997.2 1035.8 1129.1 28051.6 28876.3 29126.8 29405.3 29632.9 1052.6 1061.1 1081.0 1125.4 1198.4 13642.9 13661.2 13740.9 13784.2 13842.2 588960.0 600590.0 601471.0 602567.0 608170.0 52676.0 53367.0 53393.7 53420.5 53485.2 1335.3 1351.7 1357.5 1386.6 1390.4 29251.9 30321.2 30478.0 30770.7 31095.8 45655.8 46176.5 46271.3 46348.8 46367.3 285662.0 287557.0 289137.0 289798.0 291489.0 40919.2 42101.8 43468.6 43624.0 43830.6 38906.8 39284.0 39385.0 39581.0 40001.4 35420.8 35665.6 35701.0 35751.3 36427.0 36743.9 37511.2 40231.6 40995.0 41395.2 35416.8 35511.0 35644.0 38318.8 38856.4 30271.4 31945.4 32514.2 33081.2 33098.8 24654.1 24789.0 24898.8 25199.4 25392.7 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#2] jquery.html Cycles:180 Average:27400.35 Median:4660.41 stddev:87337.94 (1874.0%) stddev-sans-first:87559.35 19:19:29 INFO - PROCESS | 13541 | Values: 363.5 367.8 368.7 369.2 370.4 15553.8 16794.5 16794.7 17475.2 17733.4 10554.2 10567.1 16469.5 16758.9 16777.7 4745.1 5494.6 5502.6 5504.4 5538.7 5279.2 5354.4 5447.2 5479.7 5497.3 5061.1 5243.1 5448.4 5455.5 5456.8 5197.3 5239.5 5262.4 5274.6 5275.4 5358.1 5360.4 5363.0 5365.6 5370.1 12893.5 17904.7 19586.0 20051.3 20163.9 1981.2 2034.6 2062.4 2168.6 2174.2 9125.2 9168.9 9297.4 9370.4 9516.9 1848.2 1948.6 2033.8 2035.0 2036.1 54723.0 56639.4 57199.7 58020.7 58027.0 10158.7 10263.7 10381.1 10422.9 10435.8 13547.1 13597.0 13643.0 13650.9 13679.6 7507.4 7561.2 7817.0 7828.4 7847.3 7490.7 7511.7 7517.8 7587.1 7630.0 4521.6 4527.3 4530.2 4531.6 4575.7 1851.5 1894.2 1918.9 1926.2 1974.6 867.3 914.7 929.1 979.0 1031.0 15057.5 15342.5 15737.4 15867.8 16190.9 903.7 949.9 971.4 977.4 998.2 9201.7 9343.3 9417.0 9765.4 9910.9 519749.0 530017.0 537197.0 541016.0 542473.0 72834.6 73863.3 76237.0 77384.0 77796.6 1106.8 1141.5 1142.5 1158.3 1178.2 15299.5 15352.4 15356.0 15357.2 15673.3 33826.8 34058.3 34115.1 34708.3 35343.0 43571.6 44682.3 44758.6 44827.3 44930.1 7098.6 7208.0 7345.4 7349.4 7357.6 8775.7 10824.2 10961.7 11111.7 11363.3 8116.2 9089.8 9145.9 9633.4 9653.4 2925.6 3699.9 8196.4 9896.8 10010.0 9928.7 9982.7 10156.1 10239.6 10286.9 7444.3 7505.7 7605.3 7651.1 7679.1 10006.3 10186.2 10190.5 10296.8 10395.5 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#3] mootools.html Cycles:180 Average:5591.95 Median:6623.24 stddev:2883.75 (43.5%) stddev-sans-first:2875.02 19:19:29 INFO - PROCESS | 13541 | Values: 1447.3 1473.2 1615.3 1732.5 1764.0 7631.7 7803.6 7804.6 7814.7 7892.6 7744.3 7792.3 7835.0 7867.2 7876.1 2318.5 2320.2 2331.8 2339.1 2342.5 2311.6 2322.4 2340.5 2346.6 2349.6 2277.7 2288.3 2301.6 2311.2 2348.5 2353.1 2365.6 2380.2 2382.0 2386.4 2388.5 2406.5 2412.2 2423.7 2427.2 7920.3 7931.6 7949.3 7971.8 7985.7 4731.7 4857.9 4861.0 4864.0 4879.1 3332.0 3339.6 3393.9 3427.1 3430.6 1107.0 1112.3 1123.0 1142.0 1154.6 10765.7 10773.0 10850.5 10865.2 10914.3 4197.8 4298.9 4333.5 4344.5 4349.2 8924.6 8979.5 8980.8 8988.3 8990.2 4842.8 4854.0 4860.3 4869.6 4887.0 4441.9 4464.5 4473.0 4488.1 4491.8 3437.9 3446.6 3477.8 3504.4 3514.6 1074.6 1076.9 1084.8 1094.4 1103.0 930.3 989.5 1037.8 1125.2 1262.2 7325.0 7348.9 7363.5 7368.2 7377.9 1216.3 1223.4 1247.2 1249.9 1252.1 5914.9 5924.3 6002.6 6006.8 6007.0 9074.7 9757.9 9781.4 9815.7 9875.6 9563.5 9601.7 9708.4 9760.3 9801.2 7439.5 7677.7 7716.4 7742.5 7745.6 7315.4 7318.5 7334.9 7341.9 7364.2 8743.0 8896.7 8896.9 8949.4 9027.8 8853.7 9122.9 9154.2 9236.0 9277.8 6935.3 7049.3 7074.4 7077.2 7118.4 7286.6 7404.6 7428.4 7437.0 7460.8 6958.9 7139.0 7172.4 7209.9 7334.3 7076.8 7098.2 7099.5 7197.9 7206.6 6979.4 6987.7 7010.1 7022.8 7059.0 6507.7 6669.8 6673.4 6674.4 6679.3 6515.3 6620.5 6625.9 6631.7 6631.8 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#4] prototype.html Cycles:180 Average:5579.86 Median:6239.20 stddev:1684.86 (27.0%) stddev-sans-first:1643.09 19:19:29 INFO - PROCESS | 13541 | Values: 342.6 346.4 349.2 353.2 356.1 6184.7 6240.3 6263.7 6266.2 6337.6 6044.6 6218.9 6230.4 6236.4 6270.9 4766.4 4787.6 4788.9 4793.6 4797.5 4789.9 4805.4 4807.8 4814.4 4814.4 4693.3 4780.1 4781.5 4784.3 4786.1 4764.7 4772.0 4777.4 4784.5 4784.9 4158.9 4164.6 4169.3 4188.7 4200.1 5969.8 5978.7 5982.5 5990.0 6040.5 5402.6 5562.8 5576.1 5586.8 5595.2 6616.0 6639.3 6644.7 6650.6 6670.6 4666.2 4669.3 4680.1 4685.0 4687.1 6767.2 6979.3 6985.5 6992.1 6995.0 4779.6 4783.3 4784.0 4785.6 4789.1 4830.3 4835.0 4840.2 4852.8 4854.1 5578.4 5583.0 5586.2 5587.7 5591.8 6566.5 6705.1 6728.8 6738.7 6744.6 1641.1 1688.9 1691.2 1691.6 1693.7 1113.6 1119.0 1119.6 1134.5 1141.9 6205.1 6238.1 6240.5 6242.4 6266.4 6690.0 6742.5 6744.4 6747.3 6757.0 6095.8 6191.3 6226.9 6235.6 6242.8 3639.6 3657.1 3658.9 3682.6 3685.2 7037.4 7056.7 7078.4 7082.3 7086.7 6899.2 6936.6 6965.2 6965.5 6982.2 7059.8 7107.9 7122.7 7132.9 7138.7 6785.9 6793.9 6906.3 6909.0 6910.6 6672.6 6820.2 6866.7 6871.4 6888.3 7096.8 7182.9 7280.7 7290.9 7298.2 4708.6 4749.4 4756.3 4756.9 4761.8 6779.6 6937.3 6990.2 6990.8 6992.5 6749.7 6769.3 6808.3 6841.0 6848.9 6741.3 6798.5 6809.0 6820.8 6823.3 6531.4 6642.1 6659.7 6663.4 6681.6 6803.8 6819.7 6821.4 6829.6 6846.7 6574.9 6609.5 6611.6 6612.7 6626.3 19:19:29 INFO - PROCESS | 13541 | 19:19:29 INFO - PROCESS | 13541 | [#5] yui.html Cycles:180 Average:13575.34 Median:49655.13 stddev:15473.19 (31.2%) stddev-sans-first:15486.87 19:19:29 INFO - PROCESS | 13541 | Values: 803.5 827.5 831.4 846.7 852.4 13320.6 13388.4 13406.7 13416.5 13455.7 12559.4 12608.8 12613.8 12627.0 12630.1 640.8 657.3 776.0 801.3 808.1 789.1 790.6 796.3 800.6 800.8 836.6 843.2 843.5 845.4 846.5 835.2 837.2 838.7 839.3 843.8 619.9 622.4 622.5 622.8 624.5 13336.9 13340.2 13345.6 13388.3 13410.6 11975.7 13296.0 13406.1 13418.6 13516.4 9474.3 9618.3 9629.5 9672.5 9679.8 3535.0 3559.4 3562.5 3584.6 3604.1 49035.8 49652.0 49727.3 50315.7 50922.2 9325.3 9337.2 9394.8 9523.4 9664.2 15905.1 15968.4 15979.4 15991.5 16200.7 7015.1 7236.0 7363.1 7363.8 7456.6 4260.0 4338.2 4352.6 4386.2 4495.1 3076.8 3123.8 3130.4 3131.2 3141.7 549.7 562.0 562.5 592.4 593.0 578.5 582.9 610.5 622.4 632.8 8951.5 9246.3 9572.6 9723.6 9849.5 608.8 655.7 657.6 658.8 694.8 3905.9 3984.2 4053.5 4096.3 4132.5 48517.0 49658.3 50302.5 50342.5 50409.5 46082.5 46350.0 55009.7 55039.4 56492.4 44804.8 45140.3 46401.0 46416.0 46551.3 8270.3 8550.1 8701.5 8959.9 9104.3 33761.7 33908.3 33989.0 33999.8 34536.8 43706.3 43997.3 44280.3 44582.3 45107.5 10133.1 10561.4 10601.8 11431.5 11654.4 12751.2 12842.2 13073.2 13085.5 13156.9 11381.9 12067.1 12134.2 12577.9 12622.2 11750.3 11774.8 11857.6 12067.6 12150.9 10936.4 10963.7 10978.1 11079.8 11332.6 9402.9 9552.2 9723.0 9831.8 9993.7 9248.1 9362.7 9566.9 9636.5 10086.4 19:19:29 INFO - PROCESS | 13541 | -------- Summary: end -------- 19:19:29 INFO - PROCESS | 13541 | 19:19:30 INFO - TEST-INFO | 13541: exit 0 19:19:30 INFO - TEST-OK | dromaeo_css | took 1110772ms 19:19:30 INFO - TEST-START | kraken 19:19:30 INFO - operating with platform_type : linux_ 19:19:30 INFO - Initialising browser for kraken test... 19:19:30 INFO - TEST-INFO | started process 13782 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqIzu8/profile http://localhost:44732/getInfo.html) 19:19:34 INFO - PROCESS | 13782 | 19:19:34 INFO - PROCESS | 13782 | (process:13857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:35 INFO - PROCESS | 13782 | __metrics Screen width/height:1600/1200 19:19:35 INFO - PROCESS | 13782 | colorDepth:24 19:19:35 INFO - PROCESS | 13782 | Browser inner width/height: 1024/697 19:19:35 INFO - PROCESS | 13782 | __metrics 19:19:35 INFO - PROCESS | 13782 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:19:36 INFO - TEST-INFO | 13782: exit 0 19:19:36 INFO - Browser initialized. 19:19:36 INFO - Running cycle 1/1 for kraken test... 19:19:36 INFO - TEST-INFO | started process 13906 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqIzu8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:37 INFO - PROCESS | 13906 | 19:19:37 INFO - PROCESS | 13906 | (process:13966): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:48 INFO - PROCESS | 13906 | RSS: Main: 150360064 19:19:48 INFO - PROCESS | 13906 | 19:19:50 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44732/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:51 INFO - PROCESS | 13906 | RSS: Main: 151556096 19:19:51 INFO - PROCESS | 13906 | 19:19:53 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44732/tests/kraken/driver.html?testName=audio-dft) 19:19:54 INFO - PROCESS | 13906 | RSS: Main: 154095616 19:19:54 INFO - PROCESS | 13906 | 19:19:57 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44732/tests/kraken/driver.html?testName=audio-fft) 19:19:57 INFO - PROCESS | 13906 | RSS: Main: 145981440 19:19:57 INFO - PROCESS | 13906 | 19:20:00 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44732/tests/kraken/driver.html?testName=audio-oscillator) 19:20:00 INFO - PROCESS | 13906 | RSS: Main: 147488768 19:20:00 INFO - PROCESS | 13906 | 19:20:02 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:03 INFO - PROCESS | 13906 | RSS: Main: 147058688 19:20:03 INFO - PROCESS | 13906 | 19:20:06 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44732/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:07 INFO - PROCESS | 13906 | RSS: Main: 147505152 19:20:07 INFO - PROCESS | 13906 | 19:20:10 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44732/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:11 INFO - PROCESS | 13906 | RSS: Main: 147464192 19:20:11 INFO - PROCESS | 13906 | 19:20:13 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44732/tests/kraken/driver.html?testName=json-parse-financial) 19:20:14 INFO - PROCESS | 13906 | RSS: Main: 149962752 19:20:14 INFO - PROCESS | 13906 | 19:20:15 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:16 INFO - PROCESS | 13906 | RSS: Main: 149258240 19:20:16 INFO - PROCESS | 13906 | 19:20:18 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:19 INFO - PROCESS | 13906 | RSS: Main: 149807104 19:20:19 INFO - PROCESS | 13906 | 19:20:21 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:21 INFO - PROCESS | 13906 | RSS: Main: 149983232 19:20:21 INFO - PROCESS | 13906 | 19:20:24 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:24 INFO - PROCESS | 13906 | RSS: Main: 150196224 19:20:24 INFO - PROCESS | 13906 | 19:20:27 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:27 INFO - PROCESS | 13906 | RSS: Main: 150134784 19:20:27 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | Cycle 1(1): loaded http://localhost:44732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44732/tests/kraken/driver.html?testName=ai-astar) 19:20:29 INFO - PROCESS | 13906 | RSS: Main: 150814720 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | __start_tp_report 19:20:29 INFO - PROCESS | 13906 | _x_x_mozilla_page_load 19:20:29 INFO - PROCESS | 13906 | _x_x_mozilla_page_load_details 19:20:29 INFO - PROCESS | 13906 | |i|pagename|runs| 19:20:29 INFO - PROCESS | 13906 | |0;ai-astar;112;106;113;112;111;121;111;112;110;112 19:20:29 INFO - PROCESS | 13906 | |1;audio-beat-detection;149;134;155;163;127;154;157;125;168;128 19:20:29 INFO - PROCESS | 13906 | |2;audio-dft;162;164;162;165;161;161;162;165;166;165 19:20:29 INFO - PROCESS | 13906 | |3;audio-fft;71;73;72;72;71;73;73;134;71;71 19:20:29 INFO - PROCESS | 13906 | |4;audio-oscillator;96;96;142;97;98;96;143;95;97;149 19:20:29 INFO - PROCESS | 13906 | |5;imaging-gaussian-blur;109;109;110;110;109;109;111;110;110;110 19:20:29 INFO - PROCESS | 13906 | |6;imaging-darkroom;147;146;146;147;147;148;148;147;147;149 19:20:29 INFO - PROCESS | 13906 | |7;imaging-desaturate;97;97;96;97;97;97;97;96;96;96 19:20:29 INFO - PROCESS | 13906 | |8;json-parse-financial;58;60;60;58;59;58;60;59;59;58 19:20:29 INFO - PROCESS | 13906 | |9;json-stringify-tinderbox;67;72;67;67;67;67;67;68;70;68 19:20:29 INFO - PROCESS | 13906 | |10;stanford-crypto-aes;91;84;84;83;82;85;83;84;84;83 19:20:29 INFO - PROCESS | 13906 | |11;stanford-crypto-ccm;123;128;117;117;124;125;119;119;124;129 19:20:29 INFO - PROCESS | 13906 | |12;stanford-crypto-pbkdf2;137;148;149;147;148;137;146;154;143;147 19:20:29 INFO - PROCESS | 13906 | |13;stanford-crypto-sha256-iterative;69;70;78;71;74;67;67;66;67;69 19:20:29 INFO - PROCESS | 13906 | __end_tp_report 19:20:29 INFO - PROCESS | 13906 | __start_cc_report 19:20:29 INFO - PROCESS | 13906 | _x_x_mozilla_cycle_collect,742 19:20:29 INFO - PROCESS | 13906 | __end_cc_report 19:20:29 INFO - PROCESS | 13906 | __startTimestamp1452741629832__endTimestamp 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | ------- Summary: start ------- 19:20:29 INFO - PROCESS | 13906 | Number of tests: 14 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.94 19:20:29 INFO - PROCESS | 13906 | Values: 112.0 106.0 113.0 112.0 111.0 121.0 111.0 112.0 110.0 112.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:154.50 stddev:16.05 (10.4%) stddev-sans-first:16.99 19:20:29 INFO - PROCESS | 13906 | Values: 149.0 134.0 155.0 163.0 127.0 154.0 157.0 125.0 168.0 128.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#2] audio-dft Cycles:10 Average:163.30 Median:164.50 stddev:1.89 (1.1%) stddev-sans-first:1.94 19:20:29 INFO - PROCESS | 13906 | Values: 162.0 164.0 162.0 165.0 161.0 161.0 162.0 165.0 166.0 165.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#3] audio-fft Cycles:10 Average:78.10 Median:72.00 stddev:19.66 (27.3%) stddev-sans-first:20.68 19:20:29 INFO - PROCESS | 13906 | Values: 71.0 73.0 72.0 72.0 71.0 73.0 73.0 134.0 71.0 71.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:23.38 (24.4%) stddev-sans-first:24.17 19:20:29 INFO - PROCESS | 13906 | Values: 96.0 96.0 142.0 97.0 98.0 96.0 143.0 95.0 97.0 149.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:20:29 INFO - PROCESS | 13906 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 111.0 110.0 110.0 110.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:20:29 INFO - PROCESS | 13906 | Values: 147.0 146.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 149.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:20:29 INFO - PROCESS | 13906 | Values: 97.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 96.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.87 19:20:29 INFO - PROCESS | 13906 | Values: 58.0 60.0 60.0 58.0 59.0 58.0 60.0 59.0 59.0 58.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:1.70 (2.5%) stddev-sans-first:1.76 19:20:29 INFO - PROCESS | 13906 | Values: 67.0 72.0 67.0 67.0 67.0 67.0 67.0 68.0 70.0 68.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:2.50 (3.0%) stddev-sans-first:0.88 19:20:29 INFO - PROCESS | 13906 | Values: 91.0 84.0 84.0 83.0 82.0 85.0 83.0 84.0 84.0 83.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:124.00 stddev:4.33 (3.5%) stddev-sans-first:4.59 19:20:29 INFO - PROCESS | 13906 | Values: 123.0 128.0 117.0 117.0 124.0 125.0 119.0 119.0 124.0 129.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:147.50 stddev:5.30 (3.6%) stddev-sans-first:4.61 19:20:29 INFO - PROCESS | 13906 | Values: 137.0 148.0 149.0 147.0 148.0 137.0 146.0 154.0 143.0 147.0 19:20:29 INFO - PROCESS | 13906 | 19:20:29 INFO - PROCESS | 13906 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:3.74 (5.4%) stddev-sans-first:3.95 19:20:29 INFO - PROCESS | 13906 | Values: 69.0 70.0 78.0 71.0 74.0 67.0 67.0 66.0 67.0 69.0 19:20:29 INFO - PROCESS | 13906 | -------- Summary: end -------- 19:20:29 INFO - PROCESS | 13906 | 19:20:30 INFO - TEST-INFO | 13906: exit 0 19:20:30 INFO - TEST-OK | kraken | took 60176ms 19:20:30 INFO - TEST-START | v8_7 19:20:30 INFO - operating with platform_type : linux_ 19:20:30 INFO - Initialising browser for v8_7 test... 19:20:30 INFO - TEST-INFO | started process 14195 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJczBF6/profile http://localhost:44732/getInfo.html) 19:20:34 INFO - PROCESS | 14195 | 19:20:34 INFO - PROCESS | 14195 | (process:14271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:20:35 INFO - PROCESS | 14195 | __metrics Screen width/height:1600/1200 19:20:35 INFO - PROCESS | 14195 | colorDepth:24 19:20:35 INFO - PROCESS | 14195 | Browser inner width/height: 1024/697 19:20:35 INFO - PROCESS | 14195 | __metrics 19:20:35 INFO - PROCESS | 14195 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:20:36 INFO - TEST-INFO | 14195: exit 0 19:20:36 INFO - Browser initialized. 19:20:36 INFO - Running cycle 1/1 for v8_7 test... 19:20:36 INFO - TEST-INFO | started process 14320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJczBF6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:37 INFO - PROCESS | 14320 | 19:20:37 INFO - PROCESS | 14320 | (process:14381): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:20:48 INFO - PROCESS | 14320 | RSS: Main: 150466560 19:20:48 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | Cycle 1(1): loaded http://localhost:44732/tests/v8_7/run.html (next: http://localhost:44732/tests/v8_7/run.html) 19:21:10 INFO - PROCESS | 14320 | RSS: Main: 147476480 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | __start_tp_report 19:21:10 INFO - PROCESS | 14320 | _x_x_mozilla_page_load 19:21:10 INFO - PROCESS | 14320 | _x_x_mozilla_page_load_details 19:21:10 INFO - PROCESS | 14320 | |i|pagename|runs| 19:21:10 INFO - PROCESS | 14320 | |0;Richards;166.25103906899417 19:21:10 INFO - PROCESS | 14320 | |1;DeltaBlue;188.39487565938205 19:21:10 INFO - PROCESS | 14320 | |2;Encrypt;279.87685418415896 19:21:10 INFO - PROCESS | 14320 | |3;Decrypt;5261.780104712042 19:21:10 INFO - PROCESS | 14320 | |4;RayTrace;1096.4912280701753 19:21:10 INFO - PROCESS | 14320 | |5;Earley;709.2198581560284 19:21:10 INFO - PROCESS | 14320 | |6;Boyer;12370.37037037037 19:21:10 INFO - PROCESS | 14320 | |7;RegExp;41836.73469387755 19:21:10 INFO - PROCESS | 14320 | |8;Splay;599.1611743559017 19:21:10 INFO - PROCESS | 14320 | |9;NavierStokes;4835.748792270531 19:21:10 INFO - PROCESS | 14320 | __end_tp_report 19:21:10 INFO - PROCESS | 14320 | __startTimestamp1452741670981__endTimestamp 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | ------- Summary: start ------- 19:21:10 INFO - PROCESS | 14320 | Number of tests: 10 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 166.3 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 188.4 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 279.9 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#3] Decrypt Cycles:1 Average:5261.78 Median:5261.78 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 5261.8 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#4] RayTrace Cycles:1 Average:1096.49 Median:1096.49 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 1096.5 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 709.2 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 12370.4 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#7] RegExp Cycles:1 Average:41836.73 Median:41836.73 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 41836.7 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#8] Splay Cycles:1 Average:599.16 Median:599.16 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 599.2 19:21:10 INFO - PROCESS | 14320 | 19:21:10 INFO - PROCESS | 14320 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:21:10 INFO - PROCESS | 14320 | Values: 4835.7 19:21:10 INFO - PROCESS | 14320 | -------- Summary: end -------- 19:21:10 INFO - PROCESS | 14320 | 19:21:11 INFO - TEST-INFO | 14320: exit 0 19:21:11 INFO - TEST-OK | v8_7 | took 41185ms 19:21:11 INFO - SUITE-END | took 1212s 19:21:12 INFO - Completed test suite (00:20:12) 19:21:12 INFO - Working with test: dromaeo_css 19:21:12 INFO - Generating results file: dromaeo_css 19:21:12 INFO - Working with test: kraken 19:21:12 INFO - Generating results file: kraken 19:21:12 INFO - javascript benchmark 19:21:12 INFO - Working with test: v8_7 19:21:12 INFO - Generating results file: v8_7 19:21:12 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:21:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 19:21:12 INFO - process_Request line: dromaeo_css 6972.81 graph.html#tests=[[72,1,43]] 19:21:12 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:21:12 INFO - process_Request line: kraken 1512.90 graph.html#tests=[[232,1,43]] 19:21:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:21:12 INFO - process_Request line: v8_7 20280.08 graph.html#tests=[[230,1,43]] 19:21:12 INFO - RETURN: dromaeo_css: 6972.81 19:21:12 INFO - RETURN: kraken: 1512.90 19:21:12 INFO - RETURN: v8_7: 20280.08 19:21:12 INFO - javascript benchmark 19:21:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.558361829343, 3158.0683698308994, 3204.0, 3205.5191721241813, 3209.8876539321122, 5130.820421285246, 5133.61497887659, 5184.1705327147665, 5187.533122019017, 5200.817971371002, 5165.30268413764, 5285.8942821143555, 5291.100512912804, 5293.391260005101, 5307.52232299093, 4494.910101797962, 4742.217534106868, 4886.584640305578, 4895.951040489603, 4925.408950925894, 4694.929576056362, 4822.107910036654, 4838.056578967103, 4895.339129217564, 4897.8040878365, 4744.027474367764, 4775.928361074587, 4791.089692958327, 4840.564349208553, 4847.200211965039, 4776.116418462596, 4777.235642297251, 4783.784729687172, 4812.7352995585225, 4820.108279968182, 4664.207084795593, 4706.952930470686, 4760.547747963938, 4788.0663270662235, 4833.3958255218095, 5078.873028174288, 5087.720175390352, 5099.71951542665, 5125.589952803767, 5168.534831865112, 5636.943630563724, 5679.517241034517, 5687.317521897357, 5709.400512946122, 5768.394318596529, 5481.260029895953, 5565.332160140809, 5666.546676265889, 5751.1085781703905, 5759.337676167211, 5230.686158830483, 5258.92111618326, 5268.841934741964, 5269.025230332362, 5307.0, 5713.371529131792, 5714.571407144397, 5724.313082430135, 5733.741981610838, 5782.566307526952, 5449.04641687703, 5508.394076651645, 5514.228008078872, 5570.6657600544095, 5632.211490391349, 5605.887882242332, 5637.379888212294, 5659.462351076641, 5663.546916246691, 5672.064109421899, 5616.073347897551, 5622.32532096151, 5626.071698169838, 5635.380108188096, 5638.774449021993, 5471.835844924659, 5499.917501237404, 5504.697241651747, 5571.052921003439, 5606.383297837235, 4378.759168245777, 4392.07766369066, 4393.824247030147, 4410.4927933287445, 4434.157510073076, 3879.689624830007, 3950.1902110067367, 3950.3679411294056, 3953.169834334822, 3999.24014437256, 5197.194434862527, 5274.156135018378, 5339.492748188916, 5347.946520534822, 5408.13469844823, 5576.693281869455, 5583.330000399897, 5590.748416321276, 5590.86022849432, 5597.80407685729, 5225.712585807741, 5253.44838791929, 5254.842354729364, 5273.973630131902, 5303.655262408009, 4699.412573428322, 4749.691270067435, 4786.904261914742, 4815.566599006106, 4843.104025755247, 5740.368559458456, 5746.310442746813, 5802.506786923159, 5802.65184088956, 5806.44838740319, 5461.453854614507, 5495.368032676293, 5584.636998595079, 5602.439756024528, 5633.2113504110275, 5766.365699772938, 5820.592558520862, 5827.1841942127285, 5827.79602713903, 5847.912281315698, 5571.498565129158, 5576.665400076008, 5578.470045345685, 5582.944170558405, 5583.1904373864745, 5449.455054494519, 5548.029094908295, 5590.2453168821685, 5622.156676498558, 5643.604947653625, 5418.701971391453, 5420.512153906167, 5468.425815289337, 5507.889842203213, 5511.614187007031, 5509.862253443696, 5515.972420137874, 5516.696581687886, 5529.778808847762, 5532.28080349552, 5421.484958928895, 5461.290032295776, 5481.397046324981, 5501.944980550144, 5548.916766248429, 5396.541293990055, 5461.371942226695, 5518.310211223597, 5558.44415558441, 5563.304586926634, 5328.17413300939, 5337.733113344239, 5344.091504444176, 5349.598780091431, 5364.973175134255], "unit": "score", "name": "dojo.html", "value": 5185.747656233062}, {"lowerIsBetter": false, "replicates": [543.5271313956858, 545.4872419925267, 566.5835610826044, 568.428729127227, 585.1369230385183, 35228.119297017554, 36587.0, 36617.267654646894, 36644.0, 36664.45003324946, 39593.40609890847, 40171.397429038516, 40247.0, 40282.59717402825, 40401.0, 8206.917930820706, 8425.07324194338, 8516.87224691627, 8517.0, 8534.445261058012, 8318.625661845232, 8433.114522975091, 8459.280961118313, 8596.613152408125, 8642.049374568793, 8508.36187285953, 8651.783705407384, 8713.041565427799, 8722.040575536686, 8734.301255899545, 8558.61486233121, 8625.353098517637, 8634.568271586428, 8640.65437382504, 8698.0, 8423.284020858173, 8505.404621676485, 8520.360972927056, 8558.871616925751, 8559.229669329728, 38635.613643863486, 38972.22055558901, 39037.60962390397, 39093.41359879604, 39177.0, 3085.4291955987987, 3092.70619291167, 3153.4166179256913, 3183.503842674071, 3203.8398080095903, 28936.42127157466, 29354.559681604795, 29662.85168574165, 29733.10800675983, 30130.24674383136, 3939.251542207, 3981.28336899358, 4044.474218351625, 4102.462370124252, 4127.422160897447, 252497.7375113131, 254487.0, 254656.0, 255263.0, 255544.0, 54412.0, 54458.72770636121, 54501.0, 54622.0, 54624.45375546194, 56693.71653141791, 65251.67374163099, 65863.0, 65937.34062659313, 66174.0, 14105.153690778587, 14148.292585370691, 14210.502632407815, 14235.715285694228, 14286.85713142876, 11409.0, 11439.0, 11448.828267575993, 11465.828012579817, 11487.655370338904, 19828.90085549563, 20113.19547218124, 20314.18743250283, 20331.39005829798, 20343.4914127148, 8085.676572937016, 8135.471194372347, 8234.752957411167, 8234.812068396872, 8296.128906464855, 957.0286159548065, 995.5072239241622, 997.2050309442974, 1035.8239099352977, 1129.1249281806665, 28051.57922631162, 28876.27809304784, 29126.796052434216, 29405.26486837846, 29632.851835740683, 1052.6263176572359, 1061.0821639281965, 1081.0270756319376, 1125.392288164382, 1198.4367347346733, 13642.93178534101, 13661.248631325174, 13740.931295343658, 13784.172949623055, 13842.238676872666, 588960.0, 600590.0, 601471.0, 602567.0, 608170.0, 52676.0, 53367.0, 53393.733031334596, 53420.46579534232, 53485.1977220342, 1335.2789493673502, 1351.7296540691705, 1357.5384369314284, 1386.6394737368357, 1390.360434200259, 29251.85374073116, 30321.24196895095, 30478.0, 30770.692293076783, 31095.844520777253, 45655.77172114118, 46176.53823461723, 46271.30593041174, 46348.768256159856, 46367.304490432, 285662.0, 287557.0, 289137.0, 289798.0, 291489.0, 40919.1816163681, 42101.78949105235, 43468.56531434645, 43624.0, 43830.561694382646, 38906.80546597249, 39284.0, 39385.0, 39581.0, 40001.399978999754, 35420.822895886384, 35665.64334356623, 35701.0, 35751.28497429985, 36427.0, 36743.897683069554, 37511.24977500489, 40231.59768402279, 40995.0, 41395.172096558505, 35416.82291588629, 35511.0, 35644.0, 38318.80840595779, 38856.41715374215, 30271.394572107994, 31945.36109277848, 32514.187145321557, 33081.17297067496, 33098.83450582732, 24654.137105201233, 24789.0, 24898.751012489643, 25199.37001574975, 25392.746072539037], "unit": "score", "name": "ext.html", "value": 18794.934603214995}, {"lowerIsBetter": false, "replicates": [363.4911124425802, 367.76646829263416, 368.67924905332364, 369.1730523627076, 370.43138781969697, 15553.766693499607, 16794.496165115037, 16794.748078778826, 17475.213615387307, 17733.37933172341, 10554.208434367414, 10567.1017963473, 16469.505914822545, 16758.916205418987, 16777.66444671106, 4745.074710431459, 5494.615376923617, 5502.5597952163735, 5504.366997795245, 5538.667679939216, 5279.208118782175, 5354.41101478837, 5447.237386765856, 5479.671219726829, 5497.340319161706, 5061.1143049966295, 5243.134882744362, 5448.4006759256645, 5455.536279416255, 5456.836294911159, 5197.298364720752, 5239.476052394749, 5262.4211336753115, 5274.604404669646, 5275.366955965309, 5358.089124848746, 5360.356757189163, 5363.0, 5365.624406291561, 5370.060239458118, 12893.484260629657, 17904.731429028576, 19586.0, 20051.29820456277, 20163.89918050415, 1981.187713037662, 2034.5523984723486, 2062.4222469810607, 2168.620491413996, 2174.1738139507042, 9125.178733913914, 9168.908310916871, 9297.442153470745, 9370.390924589949, 9516.90483095174, 1848.177560985362, 1948.6492431362349, 2033.7966203379692, 2034.9593008139902, 2036.1142902837314, 54723.0, 56639.43360566424, 57199.71400143014, 58020.70989645025, 58027.0, 10158.746031349276, 10263.692089237335, 10381.117605003508, 10422.947885260524, 10435.843462348072, 13547.119437236548, 13597.04820662544, 13643.0, 13650.931745341408, 13679.589612311647, 7507.436942229246, 7561.168271490132, 7816.960915195387, 7828.373730101578, 7847.254510821463, 7490.6629201686055, 7511.737089201852, 7517.774466766005, 7587.127480339721, 7630.046244219473, 4521.570450807168, 4527.3435351873795, 4530.207213737583, 4531.56950089741, 4575.748333841604, 1851.4908400190056, 1894.2044341376654, 1918.856085793571, 1926.2391355414534, 1974.5655955689726, 867.2888231650113, 914.6570036236411, 929.0987741890356, 978.9853152202722, 1030.9793804123876, 15057.472988445352, 15342.463013794464, 15737.370505179893, 15867.841321586868, 16190.919045404698, 903.7153296711515, 949.8575213717997, 971.358903123949, 977.3988996766938, 998.1964518562627, 9201.723948281562, 9343.2525397968, 9416.95291523538, 9765.414075155371, 9910.851337229804, 519749.0, 530017.0, 537197.0, 541016.0, 542473.0, 72834.63582682052, 73863.26136738672, 76237.0, 77384.0, 77796.61101694568, 1106.773111512138, 1141.4749215361028, 1142.5315620595516, 1158.2702897174895, 1178.187050934835, 15299.541013769605, 15352.385904563693, 15356.0, 15357.155356455056, 15673.294701738221, 33826.830865846496, 34058.318833623685, 34115.14712132217, 34708.305833883685, 35343.0, 43571.56428435802, 44682.3297650542, 44758.55241447674, 44827.32759008552, 44930.10139797251, 7098.574085554883, 7208.0, 7345.449091318065, 7349.412047036331, 7357.558546487228, 8775.736727898173, 10824.24230303871, 10961.671149865517, 11111.72220694489, 11363.318200907972, 8116.188381161836, 9089.818203635758, 9145.908540914772, 9633.421994680342, 9653.420794752337, 2925.5757915102618, 3699.944500832436, 8196.4426758918, 9896.802063958825, 10010.0, 9928.702138935843, 9982.650607228712, 10156.136728378171, 10239.590416383558, 10286.897131028594, 7444.255574442513, 7505.699772009277, 7605.315521603082, 7651.120121186135, 7679.116901556393, 10006.29955903109, 10186.236032297458, 10190.541425635716, 10296.845547316947, 10395.532201050819], "unit": "score", "name": "jquery.html", "value": 8143.395729066944}, {"lowerIsBetter": false, "replicates": [1447.3414596358657, 1473.1529370611897, 1615.3457849570927, 1732.4542769027748, 1763.9911800440989, 7631.656575454104, 7803.648835802388, 7804.648790804413, 7814.7264845730415, 7892.605369731519, 7744.303012728853, 7792.3376512996465, 7835.0, 7867.213278672144, 7876.133625301212, 2318.478342372965, 2320.1879342230254, 2331.825113116515, 2339.1462116327502, 2342.543204075206, 2311.630139177732, 2322.4310044039235, 2340.5201933603657, 2346.601077816775, 2349.5770761262966, 2277.6811246425514, 2288.2563166970717, 2301.5742087713743, 2311.225739377302, 2348.518553696488, 2353.094058787362, 2365.562370961378, 2380.1550449590404, 2381.9761802381927, 2386.4391867911027, 2388.534235824015, 2406.542756876188, 2412.16780210827, 2423.7212720537186, 2427.235420842429, 7920.287174154354, 7931.603419829044, 7949.284564389175, 7971.800704982364, 7985.680572777082, 4731.716097034189, 4857.858403275228, 4860.975695121501, 4863.9513604864205, 4879.072976134523, 3331.950020749691, 3339.5992480902205, 3393.932121357559, 3427.074689833731, 3430.588329400488, 1106.9612563560236, 1112.2936935046223, 1123.0341905960868, 1142.046391263296, 1154.555496133986, 10765.677029689123, 10773.0, 10850.457477126112, 10865.239433239676, 10914.345139291589, 4197.811098500514, 4298.892527686833, 4333.523312435629, 4344.47866256045, 4349.217140914602, 8924.55377231136, 8979.506127162938, 8980.820383592292, 8988.280937524982, 8990.190882820447, 4842.83050093245, 4853.95146048542, 4860.343853579792, 4869.63477739171, 4887.0, 4441.866743997685, 4464.486584042812, 4473.0, 4488.102379524108, 4491.775411229425, 3437.8796742113905, 3446.6208717041104, 3477.8087205203956, 3504.4392897136336, 3514.648535146516, 1074.5862842805577, 1076.9353838769698, 1084.8318510630866, 1094.3597995172913, 1102.9558817647364, 930.3394589841154, 989.5101924547251, 1037.8443233514881, 1125.1673761416494, 1262.1669697999275, 7325.04774379338, 7348.926510734825, 7363.521371110861, 7368.226336234726, 7377.88933166003, 1216.3370962825281, 1223.424990254579, 1247.1955588645455, 1249.9187552809037, 1252.1297698099734, 5914.852128696817, 5924.318703349084, 6002.609830361012, 6006.789762358297, 6007.038873780174, 9074.682386116454, 9757.853632195523, 9781.41311521311, 9815.705528834147, 9875.555599997873, 9563.474008929437, 9601.663941762004, 9708.417494950185, 9760.267979901535, 9801.215902727765, 7439.479236453504, 7677.692892284358, 7716.382689384835, 7742.535447873146, 7745.573993430416, 7315.414766818535, 7318.451116166415, 7334.889976650461, 7341.853162936818, 7364.153122390993, 8742.950845898278, 8896.733098007071, 8896.866547001671, 8949.373543851867, 9027.819443611223, 8853.69012084574, 9122.90877091247, 9154.221891139328, 9236.0, 9277.814443711222, 6935.306469353024, 7049.259827718221, 7074.3633073023675, 7077.1507419107975, 7118.430525558047, 7286.562806231643, 7404.592747398945, 7428.405727541675, 7436.96281518589, 7460.776176714708, 6958.8956165658565, 7139.0, 7172.354488096096, 7209.891851622125, 7334.3032411920785, 7076.752313668997, 7098.219195888345, 7099.538529995534, 7197.8920316196345, 7206.603636800026, 6979.441644668313, 6987.650617469208, 7010.053642758367, 7022.754203602849, 7058.964705176441, 6507.707153178024, 6669.83325416849, 6673.366030227315, 6674.399304062657, 6679.265280819203, 6515.348465153446, 6620.536562440776, 6625.933740662532, 6631.6684165792485, 6631.834204144935], "unit": "score", "name": "mootools.html", "value": 4600.382562811935}, {"lowerIsBetter": false, "replicates": [342.5940260790963, 346.4456869009585, 349.15156170505674, 353.2475826489577, 356.1381456874365, 6184.659843708594, 6240.344763799798, 6263.655498947567, 6266.185395898532, 6337.619742815423, 6044.576879618428, 6218.937810621893, 6230.439260466557, 6236.438720515152, 6270.937290627104, 4766.356541866847, 4787.640926930477, 4788.88027799306, 4793.616510679155, 4797.544233297831, 4789.922267489822, 4805.399325084364, 4807.78364973577, 4814.374131362918, 4814.422269327685, 4693.342931989524, 4780.067886762065, 4781.45013323467, 4784.306275590037, 4786.090642777861, 4764.737939413331, 4772.0, 4777.355057067286, 4784.473707892129, 4784.880377990561, 4158.875233742992, 4164.646005089571, 4169.312063509517, 4188.706790524665, 4200.1179752252065, 5969.761209551612, 5978.730957106941, 5982.521398288127, 5990.041593345088, 6040.486558642477, 5402.621816472849, 5562.805301814417, 5576.10782274834, 5586.804461843856, 5595.18869763882, 6615.974523948796, 6639.269680335159, 6644.700988455483, 6650.567713098633, 6670.566413183127, 4666.183417901888, 4669.252919532859, 4680.087382960324, 4684.976575117136, 4687.086018226447, 6767.154105736783, 6979.336962988558, 6985.476089293273, 6992.1259842519685, 6994.965025174893, 4779.569838714532, 4783.282507623815, 4784.0, 4785.59322457588, 4789.137955168103, 4830.2513110467935, 4834.984653222792, 4840.15297322967, 4852.8301509447, 4854.101991131652, 5578.386377498472, 5583.022970980062, 5586.190002449622, 5587.664740115606, 5591.804286849941, 6566.507511936624, 6705.09481220029, 6728.764493242713, 6738.663066846736, 6744.561603495855, 1641.146603766035, 1688.9071101089312, 1691.1966815762414, 1691.6447546015474, 1693.6866679664302, 1113.6325012745774, 1119.036517494872, 1119.6193294279822, 1134.5405110930087, 1141.9200655954003, 6205.100260462208, 6238.064290356483, 6240.469560087353, 6242.438180563771, 6266.436020758154, 6689.966550167218, 6742.49431292655, 6744.359285867835, 6747.257801641816, 6756.966215168893, 6095.756169753249, 6191.349908259568, 6226.937730622726, 6235.594686345373, 6242.750289988349, 3639.563252409675, 3657.085728567858, 3658.8536458541894, 3682.6317368262958, 3685.244524872395, 7037.4018208451835, 7056.717731290691, 7078.433725301964, 7082.327178917994, 7086.716531338792, 6899.241083480813, 6936.618485983218, 6965.164180298397, 6965.547239429421, 6982.1970473395195, 7059.8235044123285, 7107.92892071083, 7122.679479423438, 7132.930060490968, 7138.714451421989, 6785.864282714417, 6793.93206067933, 6906.343897329745, 6908.965455172692, 6910.550814197061, 6672.599644021374, 6820.181578210448, 6866.725330986705, 6871.381575658214, 6888.345607167512, 7096.7516136934955, 7182.928170718226, 7280.708771649075, 7290.906364045436, 7298.23368546295, 4708.599769019672, 4749.430068391815, 4756.310335001336, 4756.928646070242, 4761.809527618995, 6779.593224406552, 6937.306269373023, 6990.196127445409, 6990.790276291719, 6992.475564332593, 6749.73001079971, 6769.323067693388, 6808.28513006147, 6841.008053832266, 6848.931510684829, 6741.258461569126, 6798.52410331272, 6808.9659551701925, 6820.795376138723, 6823.317668233335, 6531.444827189742, 6642.136522252076, 6659.733610655519, 6663.433608143362, 6681.599104053772, 6803.795886123424, 6819.659017049028, 6821.386075253251, 6829.590224586541, 6846.691898864663, 6574.901376479261, 6609.4712423005085, 6611.603303801788, 6612.702428390638, 6626.337366263335], "unit": "score", "name": "prototype.html", "value": 5029.618958772587}, {"lowerIsBetter": false, "replicates": [803.505843905998, 827.5489858027374, 831.384775266303, 846.7332790171096, 852.3947996922185, 13320.600381988545, 13388.397522111503, 13406.66483337917, 13416.46334146633, 13455.73088538231, 12559.434825432854, 12608.810867836966, 12613.810792838114, 12627.0, 12630.115891887548, 640.8205702403322, 657.336090548547, 775.9806004849868, 801.2588355770889, 808.0949336742856, 789.0807209600808, 790.6046976511744, 796.2913007423398, 800.6237068577789, 800.8398320335926, 836.6486075848159, 843.1652663862762, 843.4517563583659, 845.4293351987415, 846.4751853850621, 835.2232423845821, 837.2213841127749, 838.7190291252438, 839.3075712537151, 843.755310959824, 619.9101130336076, 622.365187508743, 622.5268795715243, 622.7913648927615, 624.4629618528062, 13336.933315333457, 13340.19958802475, 13345.599632011055, 13388.330583470884, 13410.597682069456, 11975.700607484883, 13296.0, 13406.061575689706, 13418.565154313426, 13516.391762370618, 9474.289428292837, 9618.278629102846, 9629.470379129145, 9672.516374181263, 9679.806403871884, 3535.0, 3559.359315323241, 3562.5190599269026, 3584.623614520464, 3604.1350075981577, 49035.75482122602, 49652.0, 49727.25409118866, 50315.74842125766, 50922.23616645753, 9325.347225694271, 9337.206337461255, 9394.812103758024, 9523.380980236263, 9664.178544823628, 15905.137075326322, 15968.441104561285, 15979.360825567079, 15991.520254392386, 16200.67598648044, 7015.088038555057, 7236.0, 7363.079615048119, 7363.77908662741, 7456.552606843607, 4259.9574004260185, 4338.240807858612, 4352.608265256079, 4386.232409328355, 4495.123450927038, 3076.8307743074347, 3123.7969531980348, 3130.4208721386617, 3131.248500359897, 3141.6701246369257, 549.7333793110338, 561.9943800562024, 562.5330975290499, 592.3987153039668, 592.973316200772, 578.5342799046724, 582.8979928512493, 610.5298919831705, 622.3527531367417, 632.772202007277, 8951.507667078244, 9246.26029917605, 9572.617095316109, 9723.562439690231, 9849.45827979468, 608.7504123309421, 655.7311502284041, 657.5824351536713, 658.7694306992514, 694.833240022391, 3905.902352441155, 3984.2230765000545, 4053.533843608023, 4096.344584866407, 4132.462779838602, 48517.0, 49658.255126173135, 50302.49697502978, 50342.49657503378, 50409.495905041214, 46082.539174607824, 46350.0, 55009.724951374985, 55039.44960550423, 56492.43507564954, 44804.77597611991, 45140.3228951566, 46401.0, 46416.0, 46551.30173047407, 8270.297024752723, 8550.102239264788, 8701.47791132534, 8959.865602015845, 9104.271658267455, 33761.66238337585, 33908.321833563685, 33989.0, 33999.83000084984, 34536.82731586326, 43706.34440483459, 43997.34003990007, 44280.33579496374, 44582.3312650317, 45107.54892451165, 10133.13868321201, 10561.366318020944, 10601.840972385575, 11431.542738290374, 11654.41727913584, 12751.17117387404, 12842.165259258118, 13073.215607063607, 13085.542006029744, 13156.934215329245, 11381.886181138083, 12067.094967877269, 12134.150609457252, 12577.93711031439, 12622.179558328678, 11750.29498230109, 11774.764504710029, 11857.644270671894, 12067.637970860536, 12150.939245303716, 10936.398498082683, 10963.671089867317, 10978.066864316303, 11079.778404432027, 11332.64112138341, 9402.858957115786, 9552.188064014359, 9722.951385243312, 9831.845918387618, 9993.650222242186, 9248.121428464285, 9362.672306469241, 9566.9043309566, 9636.518174091127, 10086.394816311045], "unit": "score", "name": "yui.html", "value": 6257.844634904643}], "name": "dromaeo_css", "value": 6972.813166554512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 113.0, 112.0, 111.0, 121.0, 111.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [149.0, 134.0, 155.0, 163.0, 127.0, 154.0, 157.0, 125.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 165.0, 161.0, 161.0, 162.0, 165.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 72.0, 71.0, 73.0, 73.0, 134.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 97.0, 98.0, 96.0, 143.0, 95.0, 97.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 60.0, 58.0, 59.0, 58.0, 60.0, 59.0, 59.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 84.0, 83.0, 82.0, 85.0, 83.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 117.0, 117.0, 124.0, 125.0, 119.0, 119.0, 124.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 149.0, 147.0, 148.0, 137.0, 146.0, 154.0, 143.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 78.0, 71.0, 74.0, 67.0, 67.0, 66.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1512.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5261.780104712042], "unit": "score", "name": "Decrypt", "value": 50.58763283582091}, {"lowerIsBetter": false, "replicates": [1096.4912280701753], "unit": "score", "name": "RayTrace", "value": 674.869968}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [41836.73469387755], "unit": "score", "name": "RegExp", "value": 21.77476341463416}, {"lowerIsBetter": false, "replicates": [599.1611743559017], "unit": "score", "name": "Splay", "value": 136.00847899999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20280.080151638176}]} 19:21:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20280.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1512.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6972.81"}}} 19:21:12 INFO - Return code: 0 19:21:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:21:12 INFO - # TBPL SUCCESS # 19:21:12 INFO - Running post-action listener: _resource_record_post_action 19:21:12 INFO - Running post-run listener: _resource_record_post_run 19:21:13 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 553857024; Read time: 0; Write time: 577052 19:21:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238473216; Read time: 0; Write time: 313384 19:21:13 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 314507264; Read time: 0; Write time: 263624 19:21:13 INFO - Running post-run listener: _upload_blobber_files 19:21:13 INFO - Blob upload gear active. 19:21:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:21:13 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 19:21:13 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:21:13 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:21:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:14 INFO - (blobuploader) - INFO - Done attempting. 19:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:21:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:15 INFO - (blobuploader) - INFO - Done attempting. 19:21:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:15 INFO - Return code: 0 19:21:15 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:21:15 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5efe82ebf057a7d3c3cde785a54fdc678a6f6b0b4dfa91cdcc7197f74ff97e355a32d0dc5294daf67e7147d467b5693af7206d42396b32f12ff7f0c64d11aaaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece5fd2fe0d0d66981258f23759b9d193947f6f9b98f7b33b97d6d6e8945db75a873ed7fb6d593c0783baaf413b240d0f0f0bdc4f3e2bfb10f514ade8956f6e7"} 19:21:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:21:15 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:21:15 INFO - Contents: 19:21:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5efe82ebf057a7d3c3cde785a54fdc678a6f6b0b4dfa91cdcc7197f74ff97e355a32d0dc5294daf67e7147d467b5693af7206d42396b32f12ff7f0c64d11aaaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece5fd2fe0d0d66981258f23759b9d193947f6f9b98f7b33b97d6d6e8945db75a873ed7fb6d593c0783baaf413b240d0f0f0bdc4f3e2bfb10f514ade8956f6e7"} 19:21:15 INFO - Copying logs to upload dir... 19:21:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.946519 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-13 19:21:15.589818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:21:15.592914) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5efe82ebf057a7d3c3cde785a54fdc678a6f6b0b4dfa91cdcc7197f74ff97e355a32d0dc5294daf67e7147d467b5693af7206d42396b32f12ff7f0c64d11aaaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece5fd2fe0d0d66981258f23759b9d193947f6f9b98f7b33b97d6d6e8945db75a873ed7fb6d593c0783baaf413b240d0f0f0bdc4f3e2bfb10f514ade8956f6e7"} build_url:https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/J7pnx-QKRse1fHpec0wXGg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5efe82ebf057a7d3c3cde785a54fdc678a6f6b0b4dfa91cdcc7197f74ff97e355a32d0dc5294daf67e7147d467b5693af7206d42396b32f12ff7f0c64d11aaaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece5fd2fe0d0d66981258f23759b9d193947f6f9b98f7b33b97d6d6e8945db75a873ed7fb6d593c0783baaf413b240d0f0f0bdc4f3e2bfb10f514ade8956f6e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 19:21:15.617355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:21:15.617744) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452740392.452232-1976662328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 19:21:15.702601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:21:15.702997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 19:21:15.703378) ========= ========= Total master_lag: 0.32 =========