builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1452955812.55 results: success (0) buildid: 20160116043001 builduid: 726771494c5e4542b0f5b33443871ec0 revision: 5644818538de2413cce52551e32b025e6c7e352e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.549998) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.550422) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.550760) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006360 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.594795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.595103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.677932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.678221) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.752682) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.752984) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.753361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.753694) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-16 06:50:13-- 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% 222M=0s 2016-01-16 06:50:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.932113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.932872) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019385 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.988195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:12.988857) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5644818538de2413cce52551e32b025e6c7e352e --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 5644818538de2413cce52551e32b025e6c7e352e --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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-16 06:50:13,721 truncating revision to first 12 chars 2016-01-16 06:50:13,721 Setting DEBUG logging. 2016-01-16 06:50:13,721 attempt 1/10 2016-01-16 06:50:13,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5644818538de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-16 06:50:14,115 unpacking tar archive at: mozilla-central-5644818538de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.735153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.735782) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004865 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.794992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.795316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.818819) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.819089) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-16 06:50:13.819479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-16 06:50:13.819817) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:14 INFO - MultiFileLogger online at 20160116 06:50:14 in /builds/slave/test-pgo 06:50:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:50:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:50:14 INFO - {'append_to_log': False, 06:50:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:50:14 INFO - 'blob_upload_branch': 'Firefox', 06:50:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:50:14 INFO - 'branch': 'Firefox', 06:50:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:14 INFO - 'config_files': ('talos/linux_config.py',), 06:50:14 INFO - 'default_actions': ('clobber', 06:50:14 INFO - 'read-buildbot-config', 06:50:14 INFO - 'download-and-extract', 06:50:14 INFO - 'populate-webroot', 06:50:14 INFO - 'create-virtualenv', 06:50:14 INFO - 'install', 06:50:14 INFO - 'run-tests'), 06:50:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:14 INFO - 'download_minidump_stackwalk': True, 06:50:14 INFO - 'download_symbols': 'ondemand', 06:50:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:14 INFO - 'installer_path': 'installer.exe', 06:50:14 INFO - 'log_level': 'info', 06:50:14 INFO - 'log_name': 'talos', 06:50:14 INFO - 'log_to_console': True, 06:50:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:14 INFO - 'opt_config_files': (), 06:50:14 INFO - 'pip_index': False, 06:50:14 INFO - 'sps_profile': False, 06:50:14 INFO - 'sps_profile_interval': 0, 06:50:14 INFO - 'suite': 'dromaeojs', 06:50:14 INFO - 'system_bits': '32', 06:50:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:14 INFO - 'title': 'talos-linux64-ix-069', 06:50:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:14 INFO - 'use_talos_json': True, 06:50:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:50:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:14 INFO - 'work_dir': 'build'} 06:50:14 INFO - ##### 06:50:14 INFO - ##### Running clobber step. 06:50:14 INFO - ##### 06:50:14 INFO - Running pre-action listener: _resource_record_pre_action 06:50:14 INFO - Running main action method: clobber 06:50:14 INFO - rmtree: /builds/slave/test-pgo/build 06:50:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:50:15 INFO - Running post-action listener: _resource_record_post_action 06:50:15 INFO - ##### 06:50:15 INFO - ##### Running read-buildbot-config step. 06:50:15 INFO - ##### 06:50:15 INFO - Running pre-action listener: _resource_record_pre_action 06:50:15 INFO - Running main action method: read_buildbot_config 06:50:15 INFO - Using buildbot properties: 06:50:15 INFO - { 06:50:15 INFO - "project": "", 06:50:15 INFO - "product": "firefox", 06:50:15 INFO - "script_repo_revision": "production", 06:50:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:50:15 INFO - "repository": "", 06:50:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:50:15 INFO - "buildid": "20160116043001", 06:50:15 INFO - "pgo_build": "True", 06:50:15 INFO - "basedir": "/builds/slave/test-pgo", 06:50:15 INFO - "buildnumber": 308, 06:50:15 INFO - "slavename": "talos-linux64-ix-069", 06:50:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:50:15 INFO - "platform": "ubuntu64_hw", 06:50:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:50:15 INFO - "branch": "mozilla-central", 06:50:15 INFO - "repo_path": "mozilla-central", 06:50:15 INFO - "revision": "5644818538de2413cce52551e32b025e6c7e352e", 06:50:15 INFO - "stage_platform": "linux64-pgo", 06:50:15 INFO - "builduid": "726771494c5e4542b0f5b33443871ec0", 06:50:15 INFO - "slavebuilddir": "test" 06:50:15 INFO - } 06:50:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:50:15 INFO - Running post-action listener: _resource_record_post_action 06:50:15 INFO - ##### 06:50:15 INFO - ##### Running download-and-extract step. 06:50:15 INFO - ##### 06:50:15 INFO - Running pre-action listener: _resource_record_pre_action 06:50:15 INFO - Running main action method: download_and_extract 06:50:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:15 INFO - https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/test_packages.json 06:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/test_packages.json 06:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:50:22 INFO - Downloaded 1448 bytes. 06:50:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:50:22 INFO - Using the following test package requirements: 06:50:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:22 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:50:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'jsshell-linux-x86_64.zip'], 06:50:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:50:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:50:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50: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')]} 06:50:22 INFO - https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:35 INFO - Downloaded 22440657 bytes. 06:50:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:50:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:50:36 INFO - Return code: 0 06:50:36 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 06:50: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')]} 06:50:36 INFO - https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:39 INFO - Downloaded 22440657 bytes. 06:50:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:50:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:50:41 INFO - Return code: 0 06:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:41 INFO - https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:43 INFO - Downloaded 11132144 bytes. 06:50:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:50:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:50:43 INFO - Return code: 0 06:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:43 INFO - https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/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 06:50:47 INFO - Downloaded 55890987 bytes. 06:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:47 INFO - mkdir: /builds/slave/test-pgo/properties 06:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:50:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:50:47 INFO - Contents: 06:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:47 INFO - Running post-action listener: _resource_record_post_action 06:50:47 INFO - Running post-action listener: set_extra_try_arguments 06:50:47 INFO - ##### 06:50:47 INFO - ##### Running populate-webroot step. 06:50:47 INFO - ##### 06:50:47 INFO - Running pre-action listener: _resource_record_pre_action 06:50:47 INFO - Running main action method: populate_webroot 06:50:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:47 INFO - '--tppagecycles', 06:50:47 INFO - '7'], 06:50:47 INFO - 'tests': ['tsvgm']}}, 06:50:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:50:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'tests': ['damp', 'tps']}, 06:50:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['damp', 'tps']}, 06:50:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:47 INFO - 'other': {'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'other_l64': {'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'other_nol64': {'tests': ['a11yr', 06:50:47 INFO - 'ts_paint', 06:50:47 INFO - 'tpaint', 06:50:47 INFO - 'sessionrestore', 06:50:47 INFO - 'sessionrestore_no_auto_restore']}, 06:50:47 INFO - 'svgr': {'tests': ['tsvgx', 06:50:47 INFO - 'tsvgr_opacity', 06:50:47 INFO - 'tart', 06:50:47 INFO - 'tscrollx', 06:50:47 INFO - 'cart']}, 06:50:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['tsvgx', 06:50:47 INFO - 'tsvgr_opacity', 06:50:47 INFO - 'tart', 06:50:47 INFO - 'tscrollx', 06:50:47 INFO - 'cart']}, 06:50:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'tests': ['tp5o']}, 06:50:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'talos_options': ['--e10s'], 06:50:47 INFO - 'tests': ['tp5o']}, 06:50:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'talos_options': ['--xperf_path', 06:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:47 INFO - 'tests': ['tp5n']}, 06:50:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:47 INFO - 'talos_options': ['--e10s', 06:50:47 INFO - '--xperf_path', 06:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:47 INFO - 'tests': ['tp5n']}}, 06:50:47 INFO - 'talos.zip': {'path': '', 06:50:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:47 INFO - Running post-action listener: _resource_record_post_action 06:50:47 INFO - ##### 06:50:47 INFO - ##### Running create-virtualenv step. 06:50:47 INFO - ##### 06:50:47 INFO - Running pre-action listener: _resource_record_pre_action 06:50:47 INFO - Running main action method: create_virtualenv 06:50:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:50:47 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 06:50:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:47 INFO - Using real prefix '/usr' 06:50:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:49 INFO - Installing pip.................done. 06:50:49 INFO - Return code: 0 06:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:50:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:50:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:50:49 INFO - Using env: {'DISPLAY': ':0', 06:50:49 INFO - 'HOME': '/home/cltbld', 06:50:49 INFO - 'LANG': 'en_US.UTF-8', 06:50:49 INFO - 'LANGUAGE': 'en_US:en', 06:50:49 INFO - 'LOGNAME': 'cltbld', 06:50:49 INFO - 'MAIL': '/var/mail/cltbld', 06:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:49 INFO - 'MOZ_NO_REMOTE': '1', 06:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:49 INFO - 'NO_EM_RESTART': '1', 06:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:49 INFO - 'SHELL': '/bin/bash', 06:50:49 INFO - 'SHLVL': '1', 06:50:49 INFO - 'TERM': 'linux', 06:50:49 INFO - 'TMOUT': '86400', 06:50:49 INFO - 'USER': 'cltbld', 06:50:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:49 INFO - '_': '/tools/buildbot/bin/python'} 06:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:49 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 06:50:49 INFO - Cleaning up... 06:50:49 INFO - Return code: 0 06:50:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:50:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:50:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:50:49 INFO - Using env: {'DISPLAY': ':0', 06:50:49 INFO - 'HOME': '/home/cltbld', 06:50:49 INFO - 'LANG': 'en_US.UTF-8', 06:50:49 INFO - 'LANGUAGE': 'en_US:en', 06:50:49 INFO - 'LOGNAME': 'cltbld', 06:50:49 INFO - 'MAIL': '/var/mail/cltbld', 06:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:49 INFO - 'MOZ_NO_REMOTE': '1', 06:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:49 INFO - 'NO_EM_RESTART': '1', 06:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:49 INFO - 'SHELL': '/bin/bash', 06:50:49 INFO - 'SHLVL': '1', 06:50:49 INFO - 'TERM': 'linux', 06:50:49 INFO - 'TMOUT': '86400', 06:50:49 INFO - 'USER': 'cltbld', 06:50:49 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:49 INFO - '_': '/tools/buildbot/bin/python'} 06:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:50 INFO - Downloading/unpacking psutil>=0.7.1 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:50:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:51 INFO - Installing collected packages: psutil 06:50:51 INFO - Running setup.py install for psutil 06:50:51 INFO - building 'psutil._psutil_linux' extension 06:50:51 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 06:50:52 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 06:50:52 INFO - building 'psutil._psutil_posix' extension 06:50:52 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 06:50:52 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 06:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:52 INFO - Successfully installed psutil 06:50:52 INFO - Cleaning up... 06:50:52 INFO - Return code: 0 06:50:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:50:52 INFO - Using env: {'DISPLAY': ':0', 06:50:52 INFO - 'HOME': '/home/cltbld', 06:50:52 INFO - 'LANG': 'en_US.UTF-8', 06:50:52 INFO - 'LANGUAGE': 'en_US:en', 06:50:52 INFO - 'LOGNAME': 'cltbld', 06:50:52 INFO - 'MAIL': '/var/mail/cltbld', 06:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:52 INFO - 'MOZ_NO_REMOTE': '1', 06:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:52 INFO - 'NO_EM_RESTART': '1', 06:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:52 INFO - 'SHELL': '/bin/bash', 06:50:52 INFO - 'SHLVL': '1', 06:50:52 INFO - 'TERM': 'linux', 06:50:52 INFO - 'TMOUT': '86400', 06:50:52 INFO - 'USER': 'cltbld', 06:50:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:52 INFO - '_': '/tools/buildbot/bin/python'} 06:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:54 INFO - Installing collected packages: mozsystemmonitor 06:50:54 INFO - Running setup.py install for mozsystemmonitor 06:50:54 INFO - Successfully installed mozsystemmonitor 06:50:54 INFO - Cleaning up... 06:50:54 INFO - Return code: 0 06:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:50:54 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 06:50:54 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 06:50:54 INFO - Using env: {'DISPLAY': ':0', 06:50:54 INFO - 'HOME': '/home/cltbld', 06:50:54 INFO - 'LANG': 'en_US.UTF-8', 06:50:54 INFO - 'LANGUAGE': 'en_US:en', 06:50:54 INFO - 'LOGNAME': 'cltbld', 06:50:54 INFO - 'MAIL': '/var/mail/cltbld', 06:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:54 INFO - 'MOZ_NO_REMOTE': '1', 06:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:54 INFO - 'NO_EM_RESTART': '1', 06:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:54 INFO - 'SHELL': '/bin/bash', 06:50:54 INFO - 'SHLVL': '1', 06:50:54 INFO - 'TERM': 'linux', 06:50:54 INFO - 'TMOUT': '86400', 06:50:54 INFO - 'USER': 'cltbld', 06:50:54 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:54 INFO - '_': '/tools/buildbot/bin/python'} 06:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:54 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:57 INFO - Downloading docopt-0.6.1.tar.gz 06:50:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:57 INFO - Running setup.py install for blobuploader 06:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:57 INFO - Running setup.py install for requests 06:50:57 INFO - Running setup.py install for docopt 06:50:57 INFO - Successfully installed blobuploader requests docopt 06:50:57 INFO - Cleaning up... 06:50:57 INFO - Return code: 0 06:50:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:57 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')]} 06:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:57 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')]} 06:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:57 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:50:57 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 06:50:57 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 06:50:57 INFO - Using env: {'DISPLAY': ':0', 06:50:57 INFO - 'HOME': '/home/cltbld', 06:50:57 INFO - 'LANG': 'en_US.UTF-8', 06:50:57 INFO - 'LANGUAGE': 'en_US:en', 06:50:57 INFO - 'LOGNAME': 'cltbld', 06:50:57 INFO - 'MAIL': '/var/mail/cltbld', 06:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:57 INFO - 'MOZ_NO_REMOTE': '1', 06:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:57 INFO - 'NO_EM_RESTART': '1', 06:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:57 INFO - 'SHELL': '/bin/bash', 06:50:57 INFO - 'SHLVL': '1', 06:50:57 INFO - 'TERM': 'linux', 06:50:57 INFO - 'TMOUT': '86400', 06:50:57 INFO - 'USER': 'cltbld', 06:50:57 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:57 INFO - '_': '/tools/buildbot/bin/python'} 06:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:57 INFO - Running setup.py (path:/tmp/pip-tk4mei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:58 INFO - Running setup.py (path:/tmp/pip-fDCtUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:58 INFO - Running setup.py (path:/tmp/pip-Bx8h2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:58 INFO - Running setup.py (path:/tmp/pip-u1NmEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:58 INFO - Running setup.py (path:/tmp/pip-Hfha92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:58 INFO - Running setup.py (path:/tmp/pip-8oXwJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:58 INFO - Running setup.py (path:/tmp/pip-8r7yrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:58 INFO - Running setup.py (path:/tmp/pip-zImafl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:58 INFO - Running setup.py (path:/tmp/pip-rNkl_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:58 INFO - Running setup.py (path:/tmp/pip-6vFHzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:58 INFO - Running setup.py (path:/tmp/pip-7ZSnZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:58 INFO - Running setup.py (path:/tmp/pip-rQpnI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:58 INFO - Running setup.py (path:/tmp/pip-MtK6w8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:58 INFO - Running setup.py (path:/tmp/pip-4he9AW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:58 INFO - Running setup.py (path:/tmp/pip-hmYgdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:59 INFO - Running setup.py (path:/tmp/pip-E4u_H5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:59 INFO - Running setup.py (path:/tmp/pip-WAbPwa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:59 INFO - Running setup.py install for manifestparser 06:50:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozcrash 06:50:59 INFO - Running setup.py install for mozdebug 06:50:59 INFO - Running setup.py install for mozdevice 06:50:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozfile 06:50:59 INFO - Running setup.py install for mozhttpd 06:50:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozinfo 06:50:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozInstall 06:50:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Running setup.py install for mozleak 06:51:00 INFO - Running setup.py install for mozlog 06:51:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for moznetwork 06:51:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for mozprocess 06:51:00 INFO - Running setup.py install for mozprofile 06:51:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for mozrunner 06:51:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Running setup.py install for mozscreenshot 06:51:00 INFO - Running setup.py install for moztest 06:51:00 INFO - Running setup.py install for mozversion 06:51:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:51:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:51:00 INFO - Cleaning up... 06:51:00 INFO - Return code: 0 06:51:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:00 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:51:00 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 06:51:00 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 06:51:00 INFO - Using env: {'DISPLAY': ':0', 06:51:00 INFO - 'HOME': '/home/cltbld', 06:51:00 INFO - 'LANG': 'en_US.UTF-8', 06:51:00 INFO - 'LANGUAGE': 'en_US:en', 06:51:00 INFO - 'LOGNAME': 'cltbld', 06:51:00 INFO - 'MAIL': '/var/mail/cltbld', 06:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:00 INFO - 'MOZ_NO_REMOTE': '1', 06:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:00 INFO - 'NO_EM_RESTART': '1', 06:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:00 INFO - 'SHELL': '/bin/bash', 06:51:00 INFO - 'SHLVL': '1', 06:51:00 INFO - 'TERM': 'linux', 06:51:00 INFO - 'TMOUT': '86400', 06:51:00 INFO - 'USER': 'cltbld', 06:51:00 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:00 INFO - '_': '/tools/buildbot/bin/python'} 06:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:01 INFO - Running setup.py (path:/tmp/pip-VGzS8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:01 INFO - Running setup.py (path:/tmp/pip-esG6fh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:01 INFO - Running setup.py (path:/tmp/pip-JXeDIW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:01 INFO - Running setup.py (path:/tmp/pip-QXl6Zt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:01 INFO - Running setup.py (path:/tmp/pip-0sWR9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:01 INFO - Running setup.py (path:/tmp/pip-qRAT2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:01 INFO - Running setup.py (path:/tmp/pip-myKKLW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:01 INFO - Running setup.py (path:/tmp/pip-UY6CKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:01 INFO - Running setup.py (path:/tmp/pip-9HMBMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:01 INFO - Running setup.py (path:/tmp/pip-oC0Q0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:01 INFO - Running setup.py (path:/tmp/pip-6cbUNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:51:01 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)) 06:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:01 INFO - Running setup.py (path:/tmp/pip-kRYXhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:51:02 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)) 06:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:02 INFO - Running setup.py (path:/tmp/pip-jPB_hr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:51:02 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)) 06:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:02 INFO - Running setup.py (path:/tmp/pip-CFPVc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:51:02 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)) 06:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:02 INFO - Running setup.py (path:/tmp/pip-iSNrCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:51:02 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)) 06:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:02 INFO - Running setup.py (path:/tmp/pip-dUVJuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:51:02 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)) 06:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:02 INFO - Running setup.py (path:/tmp/pip-SDTHid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:51:02 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)) 06:51:02 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)) 06:51:02 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)) 06:51:02 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)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:51:02 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)) 06:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:04 INFO - Downloading blessings-1.5.1.tar.gz 06:51:04 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 06:51:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:04 INFO - Installing collected packages: blessings 06:51:04 INFO - Running setup.py install for blessings 06:51:04 INFO - Successfully installed blessings 06:51:04 INFO - Cleaning up... 06:51:04 INFO - Return code: 0 06:51:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:51:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:04 INFO - Reading from file tmpfile_stdout 06:51:04 INFO - Current package versions: 06:51:04 INFO - argparse == 1.2.1 06:51:04 INFO - blessings == 1.5.1 06:51:04 INFO - blobuploader == 1.2.4 06:51:04 INFO - docopt == 0.6.1 06:51:04 INFO - manifestparser == 1.1 06:51:04 INFO - mozInstall == 1.12 06:51:04 INFO - mozcrash == 0.16 06:51:04 INFO - mozdebug == 0.1 06:51:04 INFO - mozdevice == 0.48 06:51:04 INFO - mozfile == 1.2 06:51:04 INFO - mozhttpd == 0.7 06:51:04 INFO - mozinfo == 0.9 06:51:04 INFO - mozleak == 0.1 06:51:04 INFO - mozlog == 3.1 06:51:04 INFO - moznetwork == 0.27 06:51:04 INFO - mozprocess == 0.22 06:51:04 INFO - mozprofile == 0.28 06:51:04 INFO - mozrunner == 6.11 06:51:04 INFO - mozscreenshot == 0.1 06:51:04 INFO - mozsystemmonitor == 0.0 06:51:04 INFO - moztest == 0.7 06:51:04 INFO - mozversion == 1.4 06:51:04 INFO - psutil == 3.1.1 06:51:04 INFO - requests == 1.2.3 06:51:04 INFO - wsgiref == 0.1.2 06:51:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:04 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:51:04 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 06:51:04 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 06:51:04 INFO - Using env: {'DISPLAY': ':0', 06:51:04 INFO - 'HOME': '/home/cltbld', 06:51:04 INFO - 'LANG': 'en_US.UTF-8', 06:51:04 INFO - 'LANGUAGE': 'en_US:en', 06:51:04 INFO - 'LOGNAME': 'cltbld', 06:51:04 INFO - 'MAIL': '/var/mail/cltbld', 06:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:04 INFO - 'MOZ_NO_REMOTE': '1', 06:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:04 INFO - 'NO_EM_RESTART': '1', 06:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:04 INFO - 'SHELL': '/bin/bash', 06:51:04 INFO - 'SHLVL': '1', 06:51:04 INFO - 'TERM': 'linux', 06:51:04 INFO - 'TMOUT': '86400', 06:51:04 INFO - 'USER': 'cltbld', 06:51:04 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:04 INFO - '_': '/tools/buildbot/bin/python'} 06:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 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)) 06:51:04 INFO - Cleaning up... 06:51:04 INFO - Return code: 0 06:51:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:04 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:51:04 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 06:51:04 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 06:51:04 INFO - Using env: {'DISPLAY': ':0', 06:51:04 INFO - 'HOME': '/home/cltbld', 06:51:04 INFO - 'LANG': 'en_US.UTF-8', 06:51:04 INFO - 'LANGUAGE': 'en_US:en', 06:51:04 INFO - 'LOGNAME': 'cltbld', 06:51:04 INFO - 'MAIL': '/var/mail/cltbld', 06:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:04 INFO - 'MOZ_NO_REMOTE': '1', 06:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:04 INFO - 'NO_EM_RESTART': '1', 06:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:04 INFO - 'SHELL': '/bin/bash', 06:51:04 INFO - 'SHLVL': '1', 06:51:04 INFO - 'TERM': 'linux', 06:51:04 INFO - 'TMOUT': '86400', 06:51:04 INFO - 'USER': 'cltbld', 06:51:04 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:04 INFO - '_': '/tools/buildbot/bin/python'} 06:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:04 INFO - Downloading/unpacking jsonschema 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:06 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 06:51:06 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:51:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:06 INFO - warning: no files found matching '*.txt' 06:51:06 INFO - no previously-included directories found matching 'build' 06:51:06 INFO - no previously-included directories found matching 'dist' 06:51:06 INFO - no previously-included directories found matching '.git*' 06:51:06 INFO - Installing collected packages: jsonschema, functools32 06:51:06 INFO - Running setup.py install for functools32 06:51:07 INFO - warning: no files found matching '*.txt' 06:51:07 INFO - no previously-included directories found matching 'build' 06:51:07 INFO - no previously-included directories found matching 'dist' 06:51:07 INFO - no previously-included directories found matching '.git*' 06:51:07 INFO - Successfully installed jsonschema functools32 06:51:07 INFO - Cleaning up... 06:51:07 INFO - Return code: 0 06:51:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:51:07 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')]} 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:07 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')]} 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:07 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 0x7fca0598af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, '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': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', '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 06:51:07 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 06:51:07 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 06:51:07 INFO - Using env: {'DISPLAY': ':0', 06:51:07 INFO - 'HOME': '/home/cltbld', 06:51:07 INFO - 'LANG': 'en_US.UTF-8', 06:51:07 INFO - 'LANGUAGE': 'en_US:en', 06:51:07 INFO - 'LOGNAME': 'cltbld', 06:51:07 INFO - 'MAIL': '/var/mail/cltbld', 06:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:07 INFO - 'MOZ_NO_REMOTE': '1', 06:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:07 INFO - 'NO_EM_RESTART': '1', 06:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:07 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:07 INFO - 'SHELL': '/bin/bash', 06:51:07 INFO - 'SHLVL': '1', 06:51:07 INFO - 'TERM': 'linux', 06:51:07 INFO - 'TMOUT': '86400', 06:51:07 INFO - 'USER': 'cltbld', 06:51:07 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:07 INFO - '_': '/tools/buildbot/bin/python'} 06:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:07 INFO - Downloading/unpacking flake8 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:09 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 06:51:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:09 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 06:51:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 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 06:51:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:09 INFO - no previously-included directories found matching 'docs/_build' 06:51:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:09 INFO - Running setup.py install for pep8 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:09 INFO - no previously-included directories found matching 'docs/_build' 06:51:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:51:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:09 INFO - Cleaning up... 06:51:09 INFO - Return code: 0 06:51:09 INFO - Running post-action listener: _resource_record_post_action 06:51:09 INFO - Running post-action listener: _start_resource_monitoring 06:51:09 INFO - Starting resource monitoring. 06:51:09 INFO - ##### 06:51:09 INFO - ##### Running install step. 06:51:09 INFO - ##### 06:51:09 INFO - Running pre-action listener: _resource_record_pre_action 06:51:09 INFO - Running main action method: install 06:51:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:51:10 INFO - Reading from file tmpfile_stdout 06:51:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:51:10 INFO - Reading from file tmpfile_stdout 06:51:10 INFO - Output received: 06:51:10 INFO - Usage: mozinstall [options] installer 06:51:10 INFO - Options: 06:51:10 INFO - -h, --help show this help message and exit 06:51:10 INFO - -d DEST, --destination=DEST 06:51:10 INFO - Directory to install application into. [default: 06:51:10 INFO - "/builds/slave/test-pgo"] 06:51:10 INFO - --app=APP Application being installed. [default: firefox] 06:51:10 INFO - mkdir: /builds/slave/test-pgo/build/application 06:51:10 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'] 06:51:10 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 06:51:26 INFO - Reading from file tmpfile_stdout 06:51:26 INFO - Output received: 06:51:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:51:26 INFO - Running post-action listener: _resource_record_post_action 06:51:26 INFO - ##### 06:51:26 INFO - ##### Running run-tests step. 06:51:26 INFO - ##### 06:51:26 INFO - Running pre-action listener: _resource_record_pre_action 06:51:26 INFO - Running main action method: run_tests 06:51:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:51:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:51:26 INFO - Python 2.7.3 06:51:26 INFO - Return code: 0 06:51:26 INFO - grabbing minidump binary from tooltool 06:51: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')]} 06:51:26 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 0x2098660>, '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 0x2099560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2099a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:51:26 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 06:51:26 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 06:51:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:26 INFO - Return code: 0 06:51:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:51:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:51:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:51:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:51:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:51:27 INFO - Return code: 0 06:51:27 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:51:27 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:51:27 INFO - Using env: {'DISPLAY': ':0', 06:51:27 INFO - 'HOME': '/home/cltbld', 06:51:27 INFO - 'LANG': 'en_US.UTF-8', 06:51:27 INFO - 'LANGUAGE': 'en_US:en', 06:51:27 INFO - 'LOGNAME': 'cltbld', 06:51:27 INFO - 'MAIL': '/var/mail/cltbld', 06:51:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:27 INFO - 'MOZ_NO_REMOTE': '1', 06:51:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:27 INFO - 'NO_EM_RESTART': '1', 06:51:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:27 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:51:27 INFO - 'SHELL': '/bin/bash', 06:51:27 INFO - 'SHLVL': '1', 06:51:27 INFO - 'TERM': 'linux', 06:51:27 INFO - 'TMOUT': '86400', 06:51:27 INFO - 'USER': 'cltbld', 06:51:27 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1452953134.527430-565397017', 06:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:27 INFO - '_': '/tools/buildbot/bin/python'} 06:51:27 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:51:27 INFO - mozversion application_buildid: 20160116043001 06:51:27 INFO - mozversion application_changeset: 5644818538de2413cce52551e32b025e6c7e352e 06:51:27 INFO - mozversion application_display_name: Nightly 06:51:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:27 INFO - mozversion application_name: Firefox 06:51:27 INFO - mozversion application_remotingname: firefox 06:51:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:51:27 INFO - mozversion application_vendor: Mozilla 06:51:27 INFO - mozversion application_version: 46.0a1 06:51:27 INFO - mozversion platform_buildid: 20160116043001 06:51:27 INFO - mozversion platform_changeset: 5644818538de2413cce52551e32b025e6c7e352e 06:51:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:51:27 INFO - mozversion platform_version: 46.0a1 06:51:27 INFO - using testdate: 1452955887 06:51:27 INFO - actual date: 1452955887 06:51:27 INFO - starting webserver on 'localhost:54677' 06:51:27 INFO - SUITE-START | Running 3 tests 06:51:27 INFO - TEST-START | dromaeo_css 06:51:27 INFO - operating with platform_type : linux_ 06:51:27 INFO - Initialising browser for dromaeo_css test... 06:51:27 INFO - TEST-INFO | started process 18639 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUjyJJm/profile http://localhost:54677/getInfo.html) 06:51:32 INFO - PROCESS | 18639 | __metrics Screen width/height:1600/1200 06:51:32 INFO - PROCESS | 18639 | colorDepth:24 06:51:32 INFO - PROCESS | 18639 | Browser inner width/height: 1024/697 06:51:32 INFO - PROCESS | 18639 | __metrics 06:51:32 INFO - PROCESS | 18639 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:51:33 INFO - PROCESS | 18639 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:51:34 INFO - TEST-INFO | 18639: exit 0 06:51:34 INFO - Browser initialized. 06:51:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:34 INFO - TEST-INFO | started process 18735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUjyJJm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:46 INFO - PROCESS | 18735 | RSS: Main: 150614016 06:51:46 INFO - PROCESS | 18735 | 06:52:37 INFO - PROCESS | 18735 | 1452955957306 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] 06:54:45 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54677/tests/dromaeo/cssquery-ext.html) 06:54:46 INFO - PROCESS | 18735 | RSS: Main: 267264000 06:54:46 INFO - PROCESS | 18735 | 06:57:48 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-ext.html (next: http://localhost:54677/tests/dromaeo/cssquery-jquery.html) 06:57:49 INFO - PROCESS | 18735 | RSS: Main: 231305216 06:57:49 INFO - PROCESS | 18735 | 07:00:51 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54677/tests/dromaeo/cssquery-mootools.html) 07:00:51 INFO - PROCESS | 18735 | RSS: Main: 218517504 07:00:51 INFO - PROCESS | 18735 | 07:03:53 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54677/tests/dromaeo/cssquery-prototype.html) 07:03:54 INFO - PROCESS | 18735 | RSS: Main: 208412672 07:03:54 INFO - PROCESS | 18735 | 07:06:56 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54677/tests/dromaeo/cssquery-yui.html) 07:06:57 INFO - PROCESS | 18735 | RSS: Main: 214171648 07:06:57 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | Cycle 1(1): loaded http://localhost:54677/tests/dromaeo/cssquery-yui.html (next: http://localhost:54677/tests/dromaeo/cssquery-dojo.html) 07:10:00 INFO - PROCESS | 18735 | RSS: Main: 282021888 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | __start_tp_report 07:10:00 INFO - PROCESS | 18735 | _x_x_mozilla_page_load 07:10:00 INFO - PROCESS | 18735 | _x_x_mozilla_page_load_details 07:10:00 INFO - PROCESS | 18735 | |i|pagename|runs| 07:10:00 INFO - PROCESS | 18735 | |0;dojo.html;3081.3991271702025;3090.4900691385924;3115.3769246150746;3146.748260139189;3160.0361889623664;4793;4847.612191024718;4906.190478571036;4975.502449755028;5031.899362012762;5005.0990821652085;5071.264666623338;5077.822276220324;5115.872103197413;5120.820771273006;4399.5820397062225;4536.773161341936;4561.52104029078;4666.463356713971;4773.355596994396;4492.955070449303;4663.953360466403;4711.151992641323;4711.811527538895;4743.715377077387;4535.546445355471;4556.794944227501;4561.657875659339;4592.724436533818;4606.585407313324;4599.770011499411;4602.470715867651;4608.976955115203;4628.39830821991;4667.416572928384;4456.777161141962;4605.4933957264675;4608.4930657627965;4628.722276663411;4629.86110416688;4929.704217746911;4943.505649435064;4991.700497970133;4995.500449955011;5016.297718319438;5309.5752339812725;5311.123664595337;5317.46825317469;5317.840464786024;5350.411454739976;5194.71429071401;5263.44733802949;5352.785888564453;5355.1699486579255;5357.946420535784;5006.424261209971;5038.874028149326;5053.242013697901;5097.515736005073;5104;5506.146547285177;5559.444055594408;5560.388357280696;5562.082256427725;5564.33228012641;5270.868228294324;5332.5467335276935;5342.813001544927;5367.75845086972;5371.167469042305;5287.70917599528;5334.5732341412595;5336.786528538815;5338.839834804962;5388.515033646912;5276.92084618731;5278.366596008504;5282.286891269629;5288.312519372457;5334.893302133935;5071;5209.088409528317;5281.15501519755;5284.048871203144;5305.4164041955355;4206.179794939957;4230.598093181143;4252.55348188442;4258.723182993095;4268.637165840876;3760.605136460687;3760.7668314646576;3774.7168962327387;3795.582485926546;3798.4492248623797;4883.145449546315;4929.975350123298;4934.235193545006;4940.333055037596;4968.254761785761;5306;5331.173668081454;5340.279062326614;5363.329583802025;5436.130219164915;4918.631102667314;4919.4834542373255;4929.876753081202;4932.161532539477;4970.602351811846;4536.954630453719;4587.632989360844;4594.770261486912;4609.746463944448;4636.884077898012;5475.780968761284;5500.7524661390335;5601.439856014366;5606.131049687305;5611.382747897728;5290.920636190383;5299.5230429261555;5301.628885977944;5307.9734601326745;5309.123994540858;5481.917771233355;5489.204065410573;5492.972535137299;5493.038718224375;5540.972295138498;5239.502247286654;5271.683698978073;5286.629935904603;5311.840644780663;5324.8136315228785;5362.570994320367;5398.78404863801;5416.729163541729;5419.593530485308;5421.457854214705;5124.9743751281;5278.287431196739;5279.076161671769;5280.656757310762;5306.708131052829;5165.173572228426;5192.610554208374;5246.895062098813;5264.289320941624;5295.470452954673;5086.160783470834;5089.465606111305;5090.567301779391;5092.6435149539175;5137.306463627362;5164.638475306692;5187.19598462239;5188.55897248723;5193.013327467769;5228.607854410859;5154.8969020620125;5187.403448603308;5235.60732945023;5247.422783493889;5267.2889159962915 07:10:00 INFO - PROCESS | 18735 | |1;ext.html;527.9181726832343;556.1463154058521;565.5419110520478;588.8792797476518;604.6885853785301;28187;28821.135365939004;28837.13488595343;35723.4641480378;36215.63784362162;39405;39752.602473975254;39895.601043989554;39912.401313980314;39922;8367.707130250443;8607.526586037766;8610.268127209163;8611.655533778641;8614.44006139599;8341.54121523316;8458.577071146417;8471.195236452528;8473.618687159062;8474.491530508158;8703.260222881063;8710.21608055275;8766.430182038179;8777.517236551987;8778.166074222938;8598.097199793994;8679.132086791271;8686.522241276727;8690.39167258289;8694;8550.315974722007;8680.045195028542;8698.869516957251;8700;8703.086175951497;37427.81286093552;37738;37829.243415131816;37910;38040.42939355912;3094.8916787912317;3192.6074282654768;3296;3301.96698033019;3477.3219222251673;29665.406691866257;30408.239794005105;30470.84764576163;30476.085717428512;30763.538546921813;3474.4961980512935;3538.221591249921;3571.732120090978;3633.909152271188;3730.552333719944;258292;259650;259885.70057149781;260191;260586;54639.45360546423;55967.44032559704;56630.43369566334;58453.70773146107;60073.399266007655;53893;53965.73017134968;54159;54205.45794542083;54289.45710542923;13314.800277995837;13495.460181592627;13529.86470135286;13553.39009744564;13591.524296649768;9472.431654100776;10040.447775372279;10093.343932644355;10122.746931326628;10162.542685579167;16335.428260010842;19318.227270909007;19576.314828980918;19688.28627341352;20120.29578964729;7574.848503029909;7886.171951944963;7907.209279072162;7997.7600671979935;8050.718224862218;890.6259371064168;928.7028150991617;970.3886551472527;1051.8948105189572;1059.8728152621734;28003;28215.71784282131;28238.71761282402;28366.43267134687;28414.573781393297;1001.7245257554085;1008.6469735592484;1027.0961553832728;1060.55986765493;1101.9779604407868;12750.362481875869;13091.476340946256;13104.80342794859;13159.078864479587;13192.20846749198;259077;261213;262229;262231;263583;44806;44831.55168448339;44837.551624483334;44864.775676122066;44907;687.9312068793081;1046.534292239946;1333.3666508408621;1352.1008529328083;1358.8369395672385;24902.37744056413;25743.613845791955;25914.611280830424;25950.22149335523;26007.739922600533;41676.58323416727;41749.58250417457;41765.37351939663;42153.156936861706;42154;288216;292154;293022;293039;293051;31407.84296078505;31655;32148.35703285968;32243;32246.677533224367;41393.58606413897;41738.37392439055;42449.151016980104;42463.57536424596;43031.7848410756;35486.290274194886;36559.63440365669;37138.44292335563;37291.44062839005;37570.624293757806;34726;35854;36045;36589.81705091458;37039;32500.349992999534;36050.63949360473;36685.26629467342;36728.816355919116;36731.26537469289;27082.32294192661;29035.274118147216;29448.705512944598;30997.380052399276;31263;23888.52222955566;24367.878160609085;24401.51196976086;24496.51006979886;24832.627510586994 07:10:00 INFO - PROCESS | 18735 | |2;jquery.html;346.5217999161157;356.3621118198425;360.922401683638;362.3152242262125;363.5927760907783;12118.81821772673;15892.443764468246;16967.406140785075;17974.370897018605;18004.909975450137;15101.395944162248;15120.546383608482;15171;15541;15560.221988900566;3994.8801535953967;4146.232946904817;5131.794728210867;5333.146696528556;5642.153676948449;5554.50009499145;5754.82735517933;5781.306243250816;5795.2466179396615;5826.242588463494;5706.201131841545;5708.372079071299;5711.257536520267;5715.942840571583;5729.684867332316;5529.364123125852;5651.745671444774;5662.575306851982;5811.970940145272;5824.689444874869;5157.045946499909;5166;5166.560842328407;5168.61235407346;5168.819091331823;19291.61416771657;19683.212671493122;19692;19907.701384479245;19916.302929397403;2020.464576887126;2092.372288313515;2122.405726396596;2129.520857806981;2157.9533926045856;12419.254844709347;12770.61688149357;13012;13132.540361087411;13191;1694.1952572528073;1705.0196137221149;1717.562021684475;1734.7831521059868;1839.9172037258356;52257.73871130658;53107.73446132745;53456.19815702768;54338.45661543374;54790;8681.782955426039;8875.689350872688;9719.416834989923;9735.951320243496;9770.902290977;12849.164804287691;12866.614001579968;12881.16272442307;12888.677783055311;12899.93550032244;7094.077769889881;7149.785506434815;7165.749198778122;7205.207427183006;7218.530795498275;6802.65986700663;6806;6862.416694580917;6870.587764734032;6872.484563657746;5334.59990500714;5604.607677462538;5612.494875461228;5881.647101173943;5889.646621202742;1716.416418417744;1738.1830539646346;1762.1453595006412;1767.098779622402;1768.9027103509172;763.9809004774925;864.4337958637103;910.7996240827008;959.52023988006;998.8601595776597;14029.368678409495;15567.61080972962;15806.68386632261;15835.366585336458;16212.189390530426;891.777055736066;904.6291020681489;919.388606576619;944.187998321443;997.1673652500243;8084.231997960184;8911.73264802057;9019.77450563728;9601.423914565008;9689.90310096904;375690;379911;410412;546203;547318;45169.32246016312;45920.08159836785;53026;67784.32215677878;72356;1108.0526150141513;1125.763589646167;1131.3777422417802;1139.0773473486338;1142.1548054439654;13663.38514766818;14297.857021429652;14330.713385732435;14674.192919389536;14970.401183952956;32796.83601581977;32847;32940.83529582433;33206.66793332036;33415.49876751899;39346.40980385354;39914;40548.59451405448;41139.38290925699;41442.1711565761;6752.662366881538;6938.826529336807;6952.617606031717;7062.258462861531;7376.7418140364825;9865.704028879145;9961.203103751537;10717.14262858985;10958.178136639943;11032.834507482234;9053.084220061075;9360.297977651568;9374.625014999323;9434.716958491255;9443.527823608929;9428.905710942803;9827.11555959967;9846;9977.650782222587;9999.602677950415;9518.524073796421;9669.854952175863;9830.115289623967;9838.163756080527;10131.240156988108;5770.798022069207;7093.07789987319;7173.5337203081635;7257.201707812242;7293.562386256842;8637.524936128322;9196.264298855942;9237.953810230905;9319.16127548524;9388.436693798394 07:10:00 INFO - PROCESS | 18735 | |3;mootools.html;1279.2516377918917;1415.5045733993102;1432.240912316472;1571.8585327320538;1795.344699184798;6776.525643204977;7310.744123955663;7521.473496855222;7531.359834414081;7532.284432978872;7297.489175757699;7389.334959853612;7438.9256107438905;7479.962600187005;7481.6259187040705;1929.0740444586606;1977.2288807365067;1980.2178139634836;2205.426589086833;2231.297141400462;2168.2627906511784;2224.443889027743;2226.599212141814;2227.0201111510883;2229.3646310801423;2161.189553917281;2177.564487102578;2179.2372669565602;2184.0499382768467;2194.890255487227;2159.211887661008;2160.827133829298;2165.675148727688;2166.1443729726825;2220.200727738029;2237.9216727414464;2244.655463359599;2257.356653353803;2263.366257447901;2264.3433404312727;7490.25097490252;7504.8123796904965;7533.54798712079;7534.698612055511;7538.585377804218;4622.075584883003;4741.739204343759;4750.144973904696;4750.61995040396;4753.453352864431;2887.3359127400604;3024.3195281061803;3084.6915308469197;3127.718505334508;3131.6085489313837;950.325269058969;951.5004622573205;977.4330888084894;980.127686359141;989.569537251298;10421.218408619385;10486.737831554196;10488.947555262175;10496.317739346918;10500.737481562946;4050.331695270306;4143.233501802176;4189.413482112506;4193.97903010483;4198.055437526532;8603.31173506118;8605.096464871098;8613.78465538354;8620.094890036456;8631.482111073356;4660.207764680013;4665.85686506808;4683.437987441529;4699.835505757282;4707.599854012379;4295.355696645528;4345.978270108692;4346.195953748566;4350.412694286231;4352.521222665504;3338.1821453743987;3404.8467818948207;3426.417509023472;3522.5772907251294;3536.6109727929907;1093.4150229627112;1129.5312445335258;1133.2067552713133;1138.1975707126455;1143.0512674480328;1304.530369067135;1305.4712841299288;1332.3404914567157;1341.2489006156584;1351.2703140304125;7065.89401158983;7165.390941769903;7200.171980222237;7217.783466496014;7218.314260145278;1088.9618863339745;1102.1403305421784;1103.4537903737541;1108.534415545473;1116.2298014370222;5658.85852853682;5750.281214848144;5760.94239057604;5762.020456522401;5767.942320576824;8918.821623567492;9077;9202.447853128833;9206.493642849708;9353.532323383804;9093.31800114994;9156.6795162169;9240.630374784932;9257;9275.953620231856;6833.555818871758;7012.754553590702;7013.649317534103;7161.820954476179;7229.09636295463;7106.893396598952;7185.856282874418;7196.460265480006;7202.063731714844;7207.171175314906;7757.26306000929;8024.799380015313;8050.47671901348;8161.714339998071;8199.95900020496;8208.384371172067;8465.111163327761;8467.322614190727;8631.050584435581;8660.307175425825;6186.288576813544;6343.9682801585695;6855.108835851307;6934.271901450275;6941.548799328028;6255.186825712628;6368.172137622265;6948.895766563607;7142.142942846892;7240.674169662272;6599.373059559334;6719.596824190564;6760.391564759196;6842.213145488333;7126.216116227107;6704.6982885769285;6819.249882513019;6828.453723702191;6971.093757811452;6979.930200697928;6623.801285961429;6651.268360480247;6662.83342916431;6665.133532640726;6682.665866706742;6093.6039157454625;6281.685915704288;6387.489000879826;6488.2538508072175;6504.15445992018;6387.297397286387;6394.104825324552;6413.454856337264;6442.967785161044;6453.935460645521 07:10:00 INFO - PROCESS | 18735 | |4;prototype.html;319.75378958202185;327.28324968319384;327.85410492330925;334.9045522026222;335.2105790862517;5633.295838020247;5793.739281732322;5796.188533605294;5815.534757219423;5843.79546715865;5610.579206559504;5745.482906538411;5753.683547404891;5755.827325180251;5778.075507918734;4493.573110554508;4496.595306422413;4497.280435130379;4500.527444618317;4501.594856462918;4313.568643135693;4405.163019026375;4409.140217657558;4474.060447306069;4500.617447516965;4439;4443.666724995622;4447.888802779924;4462.040661257829;4464.3080322549895;4452.0873220989615;4455.509893911667;4462.241418958769;4464.441944756905;4467.3299005149165;3933.449317095609;3936.9567064727585;3940.960590394088;3942.2706799242233;3945.171513982067;5367.570594352443;5505.449455054502;5511.53151982082;5516.3380394352935;5531.778728850841;5061.038402703512;5078.492150784892;5080.060188865072;5082.33929589151;5114.872128196787;5853.824385268449;6129.724162412702;6134.650376917071;6141.01743721007;6150.077488376779;4173.853915112987;4183.184279065584;4239.554846741079;4244.639205667522;4248.808803603845;6235.719392627343;6366.77716279928;6369.076483909854;6378.425941665226;6381.393767592025;4321.935170972438;4356.455443069616;4359.106383191438;4360.563943605614;4364.934525982113;4294.141171765659;4416.359627854007;4420.845270415584;4420.977895110568;4467.419235499365;5127.820526281562;5137.049645815536;5138.332016837862;5138.665986710852;5139.922901156486;6152.446279834837;6153.630782153085;6155.938440615537;6156.507479401637;6159.291681456601;1549.43445642342;1569.2075501871482;1570.9371625134866;1572.536101849957;1574.039835700222;1051.1958351860833;1052.0478966535297;1052.7157667429751;1054.4253381906879;1081.9242653014214;5742.339630942495;5746.281714785652;5757.280339957505;5763.164341170507;5765.221695071112;6257.561970662101;6272.686365681698;6274.215723034621;6277.18396608438;6307.053941908659;5748.109043098327;5751.252337196138;5751.482366587027;5760.337561180434;5761.740721667535;3288.9506657400157;3386.9322613547592;3389.7627166098137;3395.5076513905346;3397.490376443553;6508.544401891917;6525.1517302750335;6537.934620653828;6549.443297319781;6553.475721942234;6384.6169229846355;6417.294097649255;6422.518311126684;6439.356064393523;6453.741850325934;6356.682165891687;6530.477561795045;6541.934580654228;6543.018547218051;6543.705533251015;6087;6191.783287585093;6274.372562743689;6274.780382686584;6279.968600157153;6146.692665366803;6253.499720022296;6261.279952805304;6287.654179020198;6296.874062518816;6541.345865413611;6584.242812076673;6591.209054913441;6593.406593406617;6596.637184954681;4321.481422229353;4401.471823381215;4404.185225733249;4405.889852753707;4411;6331.0819931110655;6333.303336632875;6342.39747224013;6345.238571371465;6346.619202847844;6150.138980542817;6159.96920015415;6160.229971253593;6164.47601953839;6171.59884607499;5983.670898100472;6138.416850399205;6138.693065346804;6142.692865356804;6148.938510615016;6023.819285421444;6028.547858910511;6038.969805150946;6041.758329666764;6046;6176.474999625082;6183.3816618337805;6185.84535386619;6188.195534580475;6191.9690401547705;5912.645241285537;6036.154938308552;6036.7585296589405;6036.7887123952205;6042.244719410074 07:10:00 INFO - PROCESS | 18735 | |5;yui.html;685.3728838113127;722.9024081748966;777.2499537945881;842.6460886427701;866.2939704141122;12204.32876191809;12295.754084918297;12312.261264324135;12312.692182695437;12363.258204507736;11420.486078126483;11423.885761142386;11534.192606517547;11760.294382337066;11894.345810980392;810.4893916832402;823.7075838077486;824.0153017144514;824.7031068815222;825.1830687619243;809.6882700160422;810.6919370639149;813.9470934389245;814.8248126652768;814.8248126652768;843.4812590257009;844.932405407566;845.7293666026874;846.196113691992;847.5380917400001;851.3402113362132;853.4452605806214;854.086127843208;854.1885209051426;854.4531499840107;622.5797586629053;624.7344878426651;624.7906951171364;624.9218847644045;625.6683957502531;12134.514619415213;12171.817422738666;12176.391180440942;12218.450169742295;12236.877631223662;10626;10768.78462430755;10808.945955270174;10960.123190144848;11248;9409.623615055458;9411.529423528797;9463.479508627022;9490.810183796355;9608.855867161998;3388.4578467445335;3415.641357657435;3454.9481757773656;3476.28736109097;3500.3699334119847;43002;43424.565754342366;43472.78263608662;46576.30135547969;47000.52999469996;9224;9264.11990860867;9408.811823763486;9413.623455061721;9450.716478505656;17532.824671753373;17620.20709068095;17658.5585360367;17697.115144242736;17860.464186074438;6911.550749201286;7099.538529995534;7162.46281528877;7240.348368646847;7257.237990011078;4133.627973482401;4146.067134894624;4212.262854000599;4228.4080228768;4292.5492823253735;3041.1180757580055;3058.2813038935833;3063.2801291696433;3096.241420851906;3099.0392978176837;566.9744861481161;574.333772823531;579.7970710251462;580.1529766540898;602.9728662210123;485.1679369880601;505.4061477763613;515.3352175693313;600.6336134957672;685.324954919404;8359.122292159358;8513.531755753493;8581.184787445183;8746.737597872074;8906.242969347548;521.5085153335384;545.5744519274972;610.2585358789004;617.4998251416367;648.063548172895;3862.864799731996;3984.3687852995267;4000.959990400059;4042.9797851010558;4052.3516237402464;50698.746506267235;51075.23387149196;51303.743481282356;55002.724986374815;55384.44615553793;42972.355414668804;44117.33823992643;44489.33266001013;44722.32916506255;44944;40895.38656920149;42191;42655.57344426578;42728.14543709109;43350.99999999937;8558.101399353227;8842.823143536965;8883.600237989176;8903.465792052497;9048.728538143867;30572.541411879283;30581;32062.839685802355;32780.1804954878;33304.666953330154;47441.52558474371;48869;49108.263376050105;49380.753096234286;49752.50247497624;10634.946825265824;10718.410487423267;10764.623238186627;10780.29928054674;10978.396188209406;11744.236624619372;12057.397130143634;12065.336406497727;12159.966402855502;12561.87438125607;10867.673969780919;11097.167712421762;11505.252158609663;11593;11621.302721836717;11221.382823944761;11316.547338106713;11443.370614616277;11640.53437862476;11743.88256117428;11605.129615279056;11635.709107272385;11930.164888457724;11990.520379184734;12038.097142714156;9498.287628427757;9623.606751847532;9796.510174491104;9810.313278070753;9820.754481138028;8796.780080498038;9038.457692538468;9348.906510935076;9375.390599611277;10066.647667331608 07:10:00 INFO - PROCESS | 18735 | __end_tp_report 07:10:00 INFO - PROCESS | 18735 | __start_cc_report 07:10:00 INFO - PROCESS | 18735 | _x_x_mozilla_cycle_collect,919 07:10:00 INFO - PROCESS | 18735 | __end_cc_report 07:10:00 INFO - PROCESS | 18735 | __startTimestamp1452957000684__endTimestamp 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | ------- Summary: start ------- 07:10:00 INFO - PROCESS | 18735 | Number of tests: 6 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#0] dojo.html Cycles:165 Average:4982.73 Median:5154.90 stddev:516.46 (10.0%) stddev-sans-first:496.04 07:10:00 INFO - PROCESS | 18735 | Values: 3081.4 3090.5 3115.4 3146.7 3160.0 4793.0 4847.6 4906.2 4975.5 5031.9 5005.1 5071.3 5077.8 5115.9 5120.8 4399.6 4536.8 4561.5 4666.5 4773.4 4493.0 4664.0 4711.2 4711.8 4743.7 4535.5 4556.8 4561.7 4592.7 4606.6 4599.8 4602.5 4609.0 4628.4 4667.4 4456.8 4605.5 4608.5 4628.7 4629.9 4929.7 4943.5 4991.7 4995.5 5016.3 5309.6 5311.1 5317.5 5317.8 5350.4 5194.7 5263.4 5352.8 5355.2 5357.9 5006.4 5038.9 5053.2 5097.5 5104.0 5506.1 5559.4 5560.4 5562.1 5564.3 5270.9 5332.5 5342.8 5367.8 5371.2 5287.7 5334.6 5336.8 5338.8 5388.5 5276.9 5278.4 5282.3 5288.3 5334.9 5071.0 5209.1 5281.2 5284.0 5305.4 4206.2 4230.6 4252.6 4258.7 4268.6 3760.6 3760.8 3774.7 3795.6 3798.4 4883.1 4930.0 4934.2 4940.3 4968.3 5306.0 5331.2 5340.3 5363.3 5436.1 4918.6 4919.5 4929.9 4932.2 4970.6 4537.0 4587.6 4594.8 4609.7 4636.9 5475.8 5500.8 5601.4 5606.1 5611.4 5290.9 5299.5 5301.6 5308.0 5309.1 5481.9 5489.2 5493.0 5493.0 5541.0 5239.5 5271.7 5286.6 5311.8 5324.8 5362.6 5398.8 5416.7 5419.6 5421.5 5125.0 5278.3 5279.1 5280.7 5306.7 5165.2 5192.6 5246.9 5264.3 5295.5 5086.2 5089.5 5090.6 5092.6 5137.3 5164.6 5187.2 5188.6 5193.0 5228.6 5154.9 5187.4 5235.6 5247.4 5267.3 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#1] ext.html Cycles:180 Average:43293.34 Median:35949.50 stddev:70811.28 (197.0%) stddev-sans-first:70937.12 07:10:00 INFO - PROCESS | 18735 | Values: 527.9 556.1 565.5 588.9 604.7 28187.0 28821.1 28837.1 35723.5 36215.6 39405.0 39752.6 39895.6 39912.4 39922.0 8367.7 8607.5 8610.3 8611.7 8614.4 8341.5 8458.6 8471.2 8473.6 8474.5 8703.3 8710.2 8766.4 8777.5 8778.2 8598.1 8679.1 8686.5 8690.4 8694.0 8550.3 8680.0 8698.9 8700.0 8703.1 37427.8 37738.0 37829.2 37910.0 38040.4 3094.9 3192.6 3296.0 3302.0 3477.3 29665.4 30408.2 30470.8 30476.1 30763.5 3474.5 3538.2 3571.7 3633.9 3730.6 258292.0 259650.0 259885.7 260191.0 260586.0 54639.5 55967.4 56630.4 58453.7 60073.4 53893.0 53965.7 54159.0 54205.5 54289.5 13314.8 13495.5 13529.9 13553.4 13591.5 9472.4 10040.4 10093.3 10122.7 10162.5 16335.4 19318.2 19576.3 19688.3 20120.3 7574.8 7886.2 7907.2 7997.8 8050.7 890.6 928.7 970.4 1051.9 1059.9 28003.0 28215.7 28238.7 28366.4 28414.6 1001.7 1008.6 1027.1 1060.6 1102.0 12750.4 13091.5 13104.8 13159.1 13192.2 259077.0 261213.0 262229.0 262231.0 263583.0 44806.0 44831.6 44837.6 44864.8 44907.0 687.9 1046.5 1333.4 1352.1 1358.8 24902.4 25743.6 25914.6 25950.2 26007.7 41676.6 41749.6 41765.4 42153.2 42154.0 288216.0 292154.0 293022.0 293039.0 293051.0 31407.8 31655.0 32148.4 32243.0 32246.7 41393.6 41738.4 42449.2 42463.6 43031.8 35486.3 36559.6 37138.4 37291.4 37570.6 34726.0 35854.0 36045.0 36589.8 37039.0 32500.3 36050.6 36685.3 36728.8 36731.3 27082.3 29035.3 29448.7 30997.4 31263.0 23888.5 24367.9 24401.5 24496.5 24832.6 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#2] jquery.html Cycles:180 Average:24428.65 Median:5333.87 stddev:74845.03 (1403.2%) stddev-sans-first:75033.15 07:10:00 INFO - PROCESS | 18735 | Values: 346.5 356.4 360.9 362.3 363.6 12118.8 15892.4 16967.4 17974.4 18004.9 15101.4 15120.5 15171.0 15541.0 15560.2 3994.9 4146.2 5131.8 5333.1 5642.2 5554.5 5754.8 5781.3 5795.2 5826.2 5706.2 5708.4 5711.3 5715.9 5729.7 5529.4 5651.7 5662.6 5812.0 5824.7 5157.0 5166.0 5166.6 5168.6 5168.8 19291.6 19683.2 19692.0 19907.7 19916.3 2020.5 2092.4 2122.4 2129.5 2158.0 12419.3 12770.6 13012.0 13132.5 13191.0 1694.2 1705.0 1717.6 1734.8 1839.9 52257.7 53107.7 53456.2 54338.5 54790.0 8681.8 8875.7 9719.4 9736.0 9770.9 12849.2 12866.6 12881.2 12888.7 12899.9 7094.1 7149.8 7165.7 7205.2 7218.5 6802.7 6806.0 6862.4 6870.6 6872.5 5334.6 5604.6 5612.5 5881.6 5889.6 1716.4 1738.2 1762.1 1767.1 1768.9 764.0 864.4 910.8 959.5 998.9 14029.4 15567.6 15806.7 15835.4 16212.2 891.8 904.6 919.4 944.2 997.2 8084.2 8911.7 9019.8 9601.4 9689.9 375690.0 379911.0 410412.0 546203.0 547318.0 45169.3 45920.1 53026.0 67784.3 72356.0 1108.1 1125.8 1131.4 1139.1 1142.2 13663.4 14297.9 14330.7 14674.2 14970.4 32796.8 32847.0 32940.8 33206.7 33415.5 39346.4 39914.0 40548.6 41139.4 41442.2 6752.7 6938.8 6952.6 7062.3 7376.7 9865.7 9961.2 10717.1 10958.2 11032.8 9053.1 9360.3 9374.6 9434.7 9443.5 9428.9 9827.1 9846.0 9977.7 9999.6 9518.5 9669.9 9830.1 9838.2 10131.2 5770.8 7093.1 7173.5 7257.2 7293.6 8637.5 9196.3 9238.0 9319.2 9388.4 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#3] mootools.html Cycles:180 Average:5312.28 Median:6377.73 stddev:2731.81 (42.8%) stddev-sans-first:2722.65 07:10:00 INFO - PROCESS | 18735 | Values: 1279.3 1415.5 1432.2 1571.9 1795.3 6776.5 7310.7 7521.5 7531.4 7532.3 7297.5 7389.3 7438.9 7480.0 7481.6 1929.1 1977.2 1980.2 2205.4 2231.3 2168.3 2224.4 2226.6 2227.0 2229.4 2161.2 2177.6 2179.2 2184.0 2194.9 2159.2 2160.8 2165.7 2166.1 2220.2 2237.9 2244.7 2257.4 2263.4 2264.3 7490.3 7504.8 7533.5 7534.7 7538.6 4622.1 4741.7 4750.1 4750.6 4753.5 2887.3 3024.3 3084.7 3127.7 3131.6 950.3 951.5 977.4 980.1 989.6 10421.2 10486.7 10488.9 10496.3 10500.7 4050.3 4143.2 4189.4 4194.0 4198.1 8603.3 8605.1 8613.8 8620.1 8631.5 4660.2 4665.9 4683.4 4699.8 4707.6 4295.4 4346.0 4346.2 4350.4 4352.5 3338.2 3404.8 3426.4 3522.6 3536.6 1093.4 1129.5 1133.2 1138.2 1143.1 1304.5 1305.5 1332.3 1341.2 1351.3 7065.9 7165.4 7200.2 7217.8 7218.3 1089.0 1102.1 1103.5 1108.5 1116.2 5658.9 5750.3 5760.9 5762.0 5767.9 8918.8 9077.0 9202.4 9206.5 9353.5 9093.3 9156.7 9240.6 9257.0 9276.0 6833.6 7012.8 7013.6 7161.8 7229.1 7106.9 7185.9 7196.5 7202.1 7207.2 7757.3 8024.8 8050.5 8161.7 8200.0 8208.4 8465.1 8467.3 8631.1 8660.3 6186.3 6344.0 6855.1 6934.3 6941.5 6255.2 6368.2 6948.9 7142.1 7240.7 6599.4 6719.6 6760.4 6842.2 7126.2 6704.7 6819.2 6828.5 6971.1 6979.9 6623.8 6651.3 6662.8 6665.1 6682.7 6093.6 6281.7 6387.5 6488.3 6504.2 6387.3 6394.1 6413.5 6443.0 6453.9 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#4] prototype.html Cycles:180 Average:5122.26 Median:5758.81 stddev:1531.24 (26.6%) stddev-sans-first:1492.50 07:10:00 INFO - PROCESS | 18735 | Values: 319.8 327.3 327.9 334.9 335.2 5633.3 5793.7 5796.2 5815.5 5843.8 5610.6 5745.5 5753.7 5755.8 5778.1 4493.6 4496.6 4497.3 4500.5 4501.6 4313.6 4405.2 4409.1 4474.1 4500.6 4439.0 4443.7 4447.9 4462.0 4464.3 4452.1 4455.5 4462.2 4464.4 4467.3 3933.4 3937.0 3941.0 3942.3 3945.2 5367.6 5505.4 5511.5 5516.3 5531.8 5061.0 5078.5 5080.1 5082.3 5114.9 5853.8 6129.7 6134.7 6141.0 6150.1 4173.9 4183.2 4239.6 4244.6 4248.8 6235.7 6366.8 6369.1 6378.4 6381.4 4321.9 4356.5 4359.1 4360.6 4364.9 4294.1 4416.4 4420.8 4421.0 4467.4 5127.8 5137.0 5138.3 5138.7 5139.9 6152.4 6153.6 6155.9 6156.5 6159.3 1549.4 1569.2 1570.9 1572.5 1574.0 1051.2 1052.0 1052.7 1054.4 1081.9 5742.3 5746.3 5757.3 5763.2 5765.2 6257.6 6272.7 6274.2 6277.2 6307.1 5748.1 5751.3 5751.5 5760.3 5761.7 3289.0 3386.9 3389.8 3395.5 3397.5 6508.5 6525.2 6537.9 6549.4 6553.5 6384.6 6417.3 6422.5 6439.4 6453.7 6356.7 6530.5 6541.9 6543.0 6543.7 6087.0 6191.8 6274.4 6274.8 6280.0 6146.7 6253.5 6261.3 6287.7 6296.9 6541.3 6584.2 6591.2 6593.4 6596.6 4321.5 4401.5 4404.2 4405.9 4411.0 6331.1 6333.3 6342.4 6345.2 6346.6 6150.1 6160.0 6160.2 6164.5 6171.6 5983.7 6138.4 6138.7 6142.7 6148.9 6023.8 6028.5 6039.0 6041.8 6046.0 6176.5 6183.4 6185.8 6188.2 6192.0 5912.6 6036.2 6036.8 6036.8 6042.2 07:10:00 INFO - PROCESS | 18735 | 07:10:00 INFO - PROCESS | 18735 | [#5] yui.html Cycles:180 Average:13072.37 Median:47221.03 stddev:14895.75 (31.5%) stddev-sans-first:14908.49 07:10:00 INFO - PROCESS | 18735 | Values: 685.4 722.9 777.2 842.6 866.3 12204.3 12295.8 12312.3 12312.7 12363.3 11420.5 11423.9 11534.2 11760.3 11894.3 810.5 823.7 824.0 824.7 825.2 809.7 810.7 813.9 814.8 814.8 843.5 844.9 845.7 846.2 847.5 851.3 853.4 854.1 854.2 854.5 622.6 624.7 624.8 624.9 625.7 12134.5 12171.8 12176.4 12218.5 12236.9 10626.0 10768.8 10808.9 10960.1 11248.0 9409.6 9411.5 9463.5 9490.8 9608.9 3388.5 3415.6 3454.9 3476.3 3500.4 43002.0 43424.6 43472.8 46576.3 47000.5 9224.0 9264.1 9408.8 9413.6 9450.7 17532.8 17620.2 17658.6 17697.1 17860.5 6911.6 7099.5 7162.5 7240.3 7257.2 4133.6 4146.1 4212.3 4228.4 4292.5 3041.1 3058.3 3063.3 3096.2 3099.0 567.0 574.3 579.8 580.2 603.0 485.2 505.4 515.3 600.6 685.3 8359.1 8513.5 8581.2 8746.7 8906.2 521.5 545.6 610.3 617.5 648.1 3862.9 3984.4 4001.0 4043.0 4052.4 50698.7 51075.2 51303.7 55002.7 55384.4 42972.4 44117.3 44489.3 44722.3 44944.0 40895.4 42191.0 42655.6 42728.1 43351.0 8558.1 8842.8 8883.6 8903.5 9048.7 30572.5 30581.0 32062.8 32780.2 33304.7 47441.5 48869.0 49108.3 49380.8 49752.5 10634.9 10718.4 10764.6 10780.3 10978.4 11744.2 12057.4 12065.3 12160.0 12561.9 10867.7 11097.2 11505.3 11593.0 11621.3 11221.4 11316.5 11443.4 11640.5 11743.9 11605.1 11635.7 11930.2 11990.5 12038.1 9498.3 9623.6 9796.5 9810.3 9820.8 8796.8 9038.5 9348.9 9375.4 10066.6 07:10:00 INFO - PROCESS | 18735 | -------- Summary: end -------- 07:10:00 INFO - PROCESS | 18735 | 07:10:01 INFO - TEST-INFO | 18735: exit 0 07:10:01 INFO - TEST-OK | dromaeo_css | took 1113854ms 07:10:01 INFO - TEST-START | kraken 07:10:01 INFO - operating with platform_type : linux_ 07:10:01 INFO - Initialising browser for kraken test... 07:10:01 INFO - TEST-INFO | started process 18937 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUynDOg/profile http://localhost:54677/getInfo.html) 07:10:06 INFO - PROCESS | 18937 | __metrics Screen width/height:1600/1200 07:10:06 INFO - PROCESS | 18937 | colorDepth:24 07:10:06 INFO - PROCESS | 18937 | Browser inner width/height: 1024/697 07:10:06 INFO - PROCESS | 18937 | __metrics 07:10:06 INFO - PROCESS | 18937 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:06 INFO - PROCESS | 18937 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:10:06 INFO - TEST-INFO | 18937: exit 0 07:10:06 INFO - Browser initialized. 07:10:06 INFO - Running cycle 1/1 for kraken test... 07:10:06 INFO - TEST-INFO | started process 19027 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUynDOg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:18 INFO - PROCESS | 19027 | RSS: Main: 150724608 07:10:18 INFO - PROCESS | 19027 | 07:10:21 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54677/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:21 INFO - PROCESS | 19027 | RSS: Main: 188682240 07:10:21 INFO - PROCESS | 19027 | 07:10:24 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54677/tests/kraken/driver.html?testName=audio-dft) 07:10:24 INFO - PROCESS | 19027 | RSS: Main: 178053120 07:10:24 INFO - PROCESS | 19027 | 07:10:27 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54677/tests/kraken/driver.html?testName=audio-fft) 07:10:28 INFO - PROCESS | 19027 | RSS: Main: 161595392 07:10:28 INFO - PROCESS | 19027 | 07:10:30 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54677/tests/kraken/driver.html?testName=audio-oscillator) 07:10:30 INFO - PROCESS | 19027 | RSS: Main: 165040128 07:10:30 INFO - PROCESS | 19027 | 07:10:33 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54677/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:33 INFO - PROCESS | 19027 | RSS: Main: 167325696 07:10:33 INFO - PROCESS | 19027 | 07:10:36 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54677/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:37 INFO - PROCESS | 19027 | RSS: Main: 165740544 07:10:37 INFO - PROCESS | 19027 | 07:10:40 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54677/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:41 INFO - PROCESS | 19027 | RSS: Main: 166260736 07:10:41 INFO - PROCESS | 19027 | 07:10:43 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54677/tests/kraken/driver.html?testName=json-parse-financial) 07:10:44 INFO - PROCESS | 19027 | RSS: Main: 165548032 07:10:44 INFO - PROCESS | 19027 | 07:10:45 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54677/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:46 INFO - PROCESS | 19027 | RSS: Main: 175505408 07:10:46 INFO - PROCESS | 19027 | 07:10:48 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:48 INFO - PROCESS | 19027 | RSS: Main: 173285376 07:10:48 INFO - PROCESS | 19027 | 07:10:51 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:51 INFO - PROCESS | 19027 | RSS: Main: 184582144 07:10:51 INFO - PROCESS | 19027 | 07:10:53 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:54 INFO - PROCESS | 19027 | RSS: Main: 190140416 07:10:54 INFO - PROCESS | 19027 | 07:10:57 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:57 INFO - PROCESS | 19027 | RSS: Main: 185729024 07:10:57 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | Cycle 1(1): loaded http://localhost:54677/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54677/tests/kraken/driver.html?testName=ai-astar) 07:10:59 INFO - PROCESS | 19027 | RSS: Main: 244363264 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | __start_tp_report 07:10:59 INFO - PROCESS | 19027 | _x_x_mozilla_page_load 07:10:59 INFO - PROCESS | 19027 | _x_x_mozilla_page_load_details 07:10:59 INFO - PROCESS | 19027 | |i|pagename|runs| 07:10:59 INFO - PROCESS | 19027 | |0;ai-astar;110;110;106;110;112;111;99;109;110;110 07:10:59 INFO - PROCESS | 19027 | |1;audio-beat-detection;145;125;150;168;127;157;168;127;161;125 07:10:59 INFO - PROCESS | 19027 | |2;audio-dft;161;159;160;160;162;161;162;164;161;162 07:10:59 INFO - PROCESS | 19027 | |3;audio-fft;71;71;95;94;72;71;72;124;95;71 07:10:59 INFO - PROCESS | 19027 | |4;audio-oscillator;96;96;151;96;97;96;145;97;98;138 07:10:59 INFO - PROCESS | 19027 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;110;109;109 07:10:59 INFO - PROCESS | 19027 | |6;imaging-darkroom;145;147;145;146;146;146;145;145;145;146 07:10:59 INFO - PROCESS | 19027 | |7;imaging-desaturate;96;95;95;97;96;97;96;97;96;96 07:10:59 INFO - PROCESS | 19027 | |8;json-parse-financial;57;58;56;56;58;57;59;66;55;55 07:10:59 INFO - PROCESS | 19027 | |9;json-stringify-tinderbox;68;69;68;68;68;68;69;68;68;68 07:10:59 INFO - PROCESS | 19027 | |10;stanford-crypto-aes;81;81;83;82;81;82;81;82;85;82 07:10:59 INFO - PROCESS | 19027 | |11;stanford-crypto-ccm;115;118;127;112;114;116;117;113;116;118 07:10:59 INFO - PROCESS | 19027 | |12;stanford-crypto-pbkdf2;142;128;141;140;141;134;141;141;141;146 07:10:59 INFO - PROCESS | 19027 | |13;stanford-crypto-sha256-iterative;65;67;66;68;69;66;66;69;64;66 07:10:59 INFO - PROCESS | 19027 | __end_tp_report 07:10:59 INFO - PROCESS | 19027 | __start_cc_report 07:10:59 INFO - PROCESS | 19027 | _x_x_mozilla_cycle_collect,961 07:10:59 INFO - PROCESS | 19027 | __end_cc_report 07:10:59 INFO - PROCESS | 19027 | __startTimestamp1452957059534__endTimestamp 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | ------- Summary: start ------- 07:10:59 INFO - PROCESS | 19027 | Number of tests: 14 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.94 07:10:59 INFO - PROCESS | 19027 | Values: 110.0 110.0 106.0 110.0 112.0 111.0 99.0 109.0 110.0 110.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:153.50 stddev:18.04 (11.8%) stddev-sans-first:19.14 07:10:59 INFO - PROCESS | 19027 | Values: 145.0 125.0 150.0 168.0 127.0 157.0 168.0 127.0 161.0 125.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 07:10:59 INFO - PROCESS | 19027 | Values: 161.0 159.0 160.0 160.0 162.0 161.0 162.0 164.0 161.0 162.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#3] audio-fft Cycles:10 Average:83.60 Median:72.00 stddev:17.96 (25.0%) stddev-sans-first:18.47 07:10:59 INFO - PROCESS | 19027 | Values: 71.0 71.0 95.0 94.0 72.0 71.0 72.0 124.0 95.0 71.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:96.00 stddev:23.44 (24.4%) stddev-sans-first:24.23 07:10:59 INFO - PROCESS | 19027 | Values: 96.0 96.0 151.0 96.0 97.0 96.0 145.0 97.0 98.0 138.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:10:59 INFO - PROCESS | 19027 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:10:59 INFO - PROCESS | 19027 | Values: 145.0 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 07:10:59 INFO - PROCESS | 19027 | Values: 96.0 95.0 95.0 97.0 96.0 97.0 96.0 97.0 96.0 96.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:3.20 (5.6%) stddev-sans-first:3.38 07:10:59 INFO - PROCESS | 19027 | Values: 57.0 58.0 56.0 56.0 58.0 57.0 59.0 66.0 55.0 55.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:10:59 INFO - PROCESS | 19027 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 07:10:59 INFO - PROCESS | 19027 | Values: 81.0 81.0 83.0 82.0 81.0 82.0 81.0 82.0 85.0 82.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:116.50 stddev:4.17 (3.6%) stddev-sans-first:4.38 07:10:59 INFO - PROCESS | 19027 | Values: 115.0 118.0 127.0 112.0 114.0 116.0 117.0 113.0 116.0 118.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:141.00 stddev:4.97 (3.5%) stddev-sans-first:5.19 07:10:59 INFO - PROCESS | 19027 | Values: 142.0 128.0 141.0 140.0 141.0 134.0 141.0 141.0 141.0 146.0 07:10:59 INFO - PROCESS | 19027 | 07:10:59 INFO - PROCESS | 19027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.65 (2.5%) stddev-sans-first:1.64 07:10:59 INFO - PROCESS | 19027 | Values: 65.0 67.0 66.0 68.0 69.0 66.0 66.0 69.0 64.0 66.0 07:10:59 INFO - PROCESS | 19027 | -------- Summary: end -------- 07:10:59 INFO - PROCESS | 19027 | 07:11:00 INFO - TEST-INFO | 19027: exit 0 07:11:00 INFO - TEST-OK | kraken | took 59155ms 07:11:00 INFO - TEST-START | v8_7 07:11:00 INFO - operating with platform_type : linux_ 07:11:00 INFO - Initialising browser for v8_7 test... 07:11:00 INFO - TEST-INFO | started process 19276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpebbApo/profile http://localhost:54677/getInfo.html) 07:11:05 INFO - PROCESS | 19276 | __metrics Screen width/height:1600/1200 07:11:05 INFO - PROCESS | 19276 | colorDepth:24 07:11:05 INFO - PROCESS | 19276 | Browser inner width/height: 1024/697 07:11:05 INFO - PROCESS | 19276 | __metrics 07:11:05 INFO - PROCESS | 19276 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:11:05 INFO - PROCESS | 19276 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:06 INFO - TEST-INFO | 19276: exit 0 07:11:06 INFO - Browser initialized. 07:11:06 INFO - Running cycle 1/1 for v8_7 test... 07:11:06 INFO - TEST-INFO | started process 19360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpebbApo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:17 INFO - PROCESS | 19360 | RSS: Main: 150020096 07:11:17 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | Cycle 1(1): loaded http://localhost:54677/tests/v8_7/run.html (next: http://localhost:54677/tests/v8_7/run.html) 07:11:40 INFO - PROCESS | 19360 | RSS: Main: 568520704 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | __start_tp_report 07:11:40 INFO - PROCESS | 19360 | _x_x_mozilla_page_load 07:11:40 INFO - PROCESS | 19360 | _x_x_mozilla_page_load_details 07:11:40 INFO - PROCESS | 19360 | |i|pagename|runs| 07:11:40 INFO - PROCESS | 19360 | |0;Richards;167.50418760469012 07:11:40 INFO - PROCESS | 19360 | |1;DeltaBlue;189.7173211914248 07:11:40 INFO - PROCESS | 19360 | |2;Encrypt;280.662363177098 07:11:40 INFO - PROCESS | 19360 | |3;Decrypt;5175.257731958763 07:11:40 INFO - PROCESS | 19360 | |4;RayTrace;2032.520325203252 07:11:40 INFO - PROCESS | 19360 | |5;Earley;798.0845969672786 07:11:40 INFO - PROCESS | 19360 | |6;Boyer;12358.024691358025 07:11:40 INFO - PROCESS | 19360 | |7;RegExp;42729.166666666664 07:11:40 INFO - PROCESS | 19360 | |8;Splay;584.4535359438925 07:11:40 INFO - PROCESS | 19360 | |9;NavierStokes;4859.223300970873 07:11:40 INFO - PROCESS | 19360 | __end_tp_report 07:11:40 INFO - PROCESS | 19360 | __startTimestamp1452957100673__endTimestamp 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | ------- Summary: start ------- 07:11:40 INFO - PROCESS | 19360 | Number of tests: 10 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 167.5 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#1] DeltaBlue Cycles:1 Average:189.72 Median:189.72 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 189.7 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 280.7 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 5175.3 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 2032.5 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 798.1 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 12358.0 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 42729.2 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#8] Splay Cycles:1 Average:584.45 Median:584.45 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 584.5 07:11:40 INFO - PROCESS | 19360 | 07:11:40 INFO - PROCESS | 19360 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 07:11:40 INFO - PROCESS | 19360 | Values: 4859.2 07:11:40 INFO - PROCESS | 19360 | -------- Summary: end -------- 07:11:40 INFO - PROCESS | 19360 | 07:11:41 INFO - TEST-INFO | 19360: exit 0 07:11:41 INFO - TEST-OK | v8_7 | took 41014ms 07:11:41 INFO - SUITE-END | took 1214s 07:11:41 INFO - Completed test suite (00:20:14) 07:11:41 INFO - Working with test: dromaeo_css 07:11:41 INFO - Generating results file: dromaeo_css 07:11:41 INFO - Working with test: kraken 07:11:41 INFO - Generating results file: kraken 07:11:41 INFO - javascript benchmark 07:11:41 INFO - Working with test: v8_7 07:11:41 INFO - Generating results file: v8_7 07:11:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:11:41 INFO - process_Request line: dromaeo_css 6636.36 graph.html#tests=[[72,1,35]] 07:11:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:41 INFO - process_Request line: kraken 1491.30 graph.html#tests=[[232,1,35]] 07:11:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:41 INFO - process_Request line: v8_7 18837.49 graph.html#tests=[[230,1,35]] 07:11:41 INFO - RETURN: dromaeo_css: 6636.36 07:11:41 INFO - RETURN: kraken: 1491.30 07:11:41 INFO - RETURN: v8_7: 18837.49 07:11:41 INFO - javascript benchmark 07:11:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.3991271702025, 3090.4900691385924, 3115.3769246150746, 3146.748260139189, 3160.0361889623664, 4793.0, 4847.612191024718, 4906.190478571036, 4975.502449755028, 5031.899362012762, 5005.0990821652085, 5071.264666623338, 5077.822276220324, 5115.872103197413, 5120.820771273006, 4399.5820397062225, 4536.773161341936, 4561.52104029078, 4666.463356713971, 4773.355596994396, 4492.955070449303, 4663.953360466403, 4711.151992641323, 4711.811527538895, 4743.715377077387, 4535.546445355471, 4556.794944227501, 4561.657875659339, 4592.724436533818, 4606.585407313324, 4599.770011499411, 4602.470715867651, 4608.976955115203, 4628.39830821991, 4667.416572928384, 4456.777161141962, 4605.4933957264675, 4608.4930657627965, 4628.722276663411, 4629.86110416688, 4929.704217746911, 4943.505649435064, 4991.700497970133, 4995.500449955011, 5016.297718319438, 5309.5752339812725, 5311.123664595337, 5317.46825317469, 5317.840464786024, 5350.411454739976, 5194.71429071401, 5263.44733802949, 5352.785888564453, 5355.1699486579255, 5357.946420535784, 5006.424261209971, 5038.874028149326, 5053.242013697901, 5097.515736005073, 5104.0, 5506.146547285177, 5559.444055594408, 5560.388357280696, 5562.082256427725, 5564.33228012641, 5270.868228294324, 5332.5467335276935, 5342.813001544927, 5367.75845086972, 5371.167469042305, 5287.70917599528, 5334.5732341412595, 5336.786528538815, 5338.839834804962, 5388.515033646912, 5276.92084618731, 5278.366596008504, 5282.286891269629, 5288.312519372457, 5334.893302133935, 5071.0, 5209.088409528317, 5281.15501519755, 5284.048871203144, 5305.4164041955355, 4206.179794939957, 4230.598093181143, 4252.55348188442, 4258.723182993095, 4268.637165840876, 3760.605136460687, 3760.7668314646576, 3774.7168962327387, 3795.582485926546, 3798.4492248623797, 4883.145449546315, 4929.975350123298, 4934.235193545006, 4940.333055037596, 4968.254761785761, 5306.0, 5331.173668081454, 5340.279062326614, 5363.329583802025, 5436.130219164915, 4918.631102667314, 4919.4834542373255, 4929.876753081202, 4932.161532539477, 4970.602351811846, 4536.954630453719, 4587.632989360844, 4594.770261486912, 4609.746463944448, 4636.884077898012, 5475.780968761284, 5500.7524661390335, 5601.439856014366, 5606.131049687305, 5611.382747897728, 5290.920636190383, 5299.5230429261555, 5301.628885977944, 5307.9734601326745, 5309.123994540858, 5481.917771233355, 5489.204065410573, 5492.972535137299, 5493.038718224375, 5540.972295138498, 5239.502247286654, 5271.683698978073, 5286.629935904603, 5311.840644780663, 5324.8136315228785, 5362.570994320367, 5398.78404863801, 5416.729163541729, 5419.593530485308, 5421.457854214705, 5124.9743751281, 5278.287431196739, 5279.076161671769, 5280.656757310762, 5306.708131052829, 5165.173572228426, 5192.610554208374, 5246.895062098813, 5264.289320941624, 5295.470452954673, 5086.160783470834, 5089.465606111305, 5090.567301779391, 5092.6435149539175, 5137.306463627362, 5164.638475306692, 5187.19598462239, 5188.55897248723, 5193.013327467769, 5228.607854410859, 5154.8969020620125, 5187.403448603308, 5235.60732945023, 5247.422783493889, 5267.2889159962915], "unit": "score", "name": "dojo.html", "value": 4951.9326134882285}, {"lowerIsBetter": false, "replicates": [527.9181726832343, 556.1463154058521, 565.5419110520478, 588.8792797476518, 604.6885853785301, 28187.0, 28821.135365939004, 28837.13488595343, 35723.4641480378, 36215.63784362162, 39405.0, 39752.602473975254, 39895.601043989554, 39912.401313980314, 39922.0, 8367.707130250443, 8607.526586037766, 8610.268127209163, 8611.655533778641, 8614.44006139599, 8341.54121523316, 8458.577071146417, 8471.195236452528, 8473.618687159062, 8474.491530508158, 8703.260222881063, 8710.21608055275, 8766.430182038179, 8777.517236551987, 8778.166074222938, 8598.097199793994, 8679.132086791271, 8686.522241276727, 8690.39167258289, 8694.0, 8550.315974722007, 8680.045195028542, 8698.869516957251, 8700.0, 8703.086175951497, 37427.81286093552, 37738.0, 37829.243415131816, 37910.0, 38040.42939355912, 3094.8916787912317, 3192.6074282654768, 3296.0, 3301.96698033019, 3477.3219222251673, 29665.406691866257, 30408.239794005105, 30470.84764576163, 30476.085717428512, 30763.538546921813, 3474.4961980512935, 3538.221591249921, 3571.732120090978, 3633.909152271188, 3730.552333719944, 258292.0, 259650.0, 259885.70057149781, 260191.0, 260586.0, 54639.45360546423, 55967.44032559704, 56630.43369566334, 58453.70773146107, 60073.399266007655, 53893.0, 53965.73017134968, 54159.0, 54205.45794542083, 54289.45710542923, 13314.800277995837, 13495.460181592627, 13529.86470135286, 13553.39009744564, 13591.524296649768, 9472.431654100776, 10040.447775372279, 10093.343932644355, 10122.746931326628, 10162.542685579167, 16335.428260010842, 19318.227270909007, 19576.314828980918, 19688.28627341352, 20120.29578964729, 7574.848503029909, 7886.171951944963, 7907.209279072162, 7997.7600671979935, 8050.718224862218, 890.6259371064168, 928.7028150991617, 970.3886551472527, 1051.8948105189572, 1059.8728152621734, 28003.0, 28215.71784282131, 28238.71761282402, 28366.43267134687, 28414.573781393297, 1001.7245257554085, 1008.6469735592484, 1027.0961553832728, 1060.55986765493, 1101.9779604407868, 12750.362481875869, 13091.476340946256, 13104.80342794859, 13159.078864479587, 13192.20846749198, 259077.0, 261213.0, 262229.0, 262231.0, 263583.0, 44806.0, 44831.55168448339, 44837.551624483334, 44864.775676122066, 44907.0, 687.9312068793081, 1046.534292239946, 1333.3666508408621, 1352.1008529328083, 1358.8369395672385, 24902.37744056413, 25743.613845791955, 25914.611280830424, 25950.22149335523, 26007.739922600533, 41676.58323416727, 41749.58250417457, 41765.37351939663, 42153.156936861706, 42154.0, 288216.0, 292154.0, 293022.0, 293039.0, 293051.0, 31407.84296078505, 31655.0, 32148.35703285968, 32243.0, 32246.677533224367, 41393.58606413897, 41738.37392439055, 42449.151016980104, 42463.57536424596, 43031.7848410756, 35486.290274194886, 36559.63440365669, 37138.44292335563, 37291.44062839005, 37570.624293757806, 34726.0, 35854.0, 36045.0, 36589.81705091458, 37039.0, 32500.349992999534, 36050.63949360473, 36685.26629467342, 36728.816355919116, 36731.26537469289, 27082.32294192661, 29035.274118147216, 29448.705512944598, 30997.380052399276, 31263.0, 23888.52222955566, 24367.878160609085, 24401.51196976086, 24496.51006979886, 24832.627510586994], "unit": "score", "name": "ext.html", "value": 17490.36084118614}, {"lowerIsBetter": false, "replicates": [346.5217999161157, 356.3621118198425, 360.922401683638, 362.3152242262125, 363.5927760907783, 12118.81821772673, 15892.443764468246, 16967.406140785075, 17974.370897018605, 18004.909975450137, 15101.395944162248, 15120.546383608482, 15171.0, 15541.0, 15560.221988900566, 3994.8801535953967, 4146.232946904817, 5131.794728210867, 5333.146696528556, 5642.153676948449, 5554.50009499145, 5754.82735517933, 5781.306243250816, 5795.2466179396615, 5826.242588463494, 5706.201131841545, 5708.372079071299, 5711.257536520267, 5715.942840571583, 5729.684867332316, 5529.364123125852, 5651.745671444774, 5662.575306851982, 5811.970940145272, 5824.689444874869, 5157.045946499909, 5166.0, 5166.560842328407, 5168.61235407346, 5168.819091331823, 19291.61416771657, 19683.212671493122, 19692.0, 19907.701384479245, 19916.302929397403, 2020.464576887126, 2092.372288313515, 2122.405726396596, 2129.520857806981, 2157.9533926045856, 12419.254844709347, 12770.61688149357, 13012.0, 13132.540361087411, 13191.0, 1694.1952572528073, 1705.0196137221149, 1717.562021684475, 1734.7831521059868, 1839.9172037258356, 52257.73871130658, 53107.73446132745, 53456.19815702768, 54338.45661543374, 54790.0, 8681.782955426039, 8875.689350872688, 9719.416834989923, 9735.951320243496, 9770.902290977, 12849.164804287691, 12866.614001579968, 12881.16272442307, 12888.677783055311, 12899.93550032244, 7094.077769889881, 7149.785506434815, 7165.749198778122, 7205.207427183006, 7218.530795498275, 6802.65986700663, 6806.0, 6862.416694580917, 6870.587764734032, 6872.484563657746, 5334.59990500714, 5604.607677462538, 5612.494875461228, 5881.647101173943, 5889.646621202742, 1716.416418417744, 1738.1830539646346, 1762.1453595006412, 1767.098779622402, 1768.9027103509172, 763.9809004774925, 864.4337958637103, 910.7996240827008, 959.52023988006, 998.8601595776597, 14029.368678409495, 15567.61080972962, 15806.68386632261, 15835.366585336458, 16212.189390530426, 891.777055736066, 904.6291020681489, 919.388606576619, 944.187998321443, 997.1673652500243, 8084.231997960184, 8911.73264802057, 9019.77450563728, 9601.423914565008, 9689.90310096904, 375690.0, 379911.0, 410412.0, 546203.0, 547318.0, 45169.32246016312, 45920.08159836785, 53026.0, 67784.32215677878, 72356.0, 1108.0526150141513, 1125.763589646167, 1131.3777422417802, 1139.0773473486338, 1142.1548054439654, 13663.38514766818, 14297.857021429652, 14330.713385732435, 14674.192919389536, 14970.401183952956, 32796.83601581977, 32847.0, 32940.83529582433, 33206.66793332036, 33415.49876751899, 39346.40980385354, 39914.0, 40548.59451405448, 41139.38290925699, 41442.1711565761, 6752.662366881538, 6938.826529336807, 6952.617606031717, 7062.258462861531, 7376.7418140364825, 9865.704028879145, 9961.203103751537, 10717.14262858985, 10958.178136639943, 11032.834507482234, 9053.084220061075, 9360.297977651568, 9374.625014999323, 9434.716958491255, 9443.527823608929, 9428.905710942803, 9827.11555959967, 9846.0, 9977.650782222587, 9999.602677950415, 9518.524073796421, 9669.854952175863, 9830.115289623967, 9838.163756080527, 10131.240156988108, 5770.798022069207, 7093.07789987319, 7173.5337203081635, 7257.201707812242, 7293.562386256842, 8637.524936128322, 9196.264298855942, 9237.953810230905, 9319.16127548524, 9388.436693798394], "unit": "score", "name": "jquery.html", "value": 8007.450881858489}, {"lowerIsBetter": false, "replicates": [1279.2516377918917, 1415.5045733993102, 1432.240912316472, 1571.8585327320538, 1795.344699184798, 6776.525643204977, 7310.744123955663, 7521.473496855222, 7531.359834414081, 7532.284432978872, 7297.489175757699, 7389.334959853612, 7438.9256107438905, 7479.962600187005, 7481.6259187040705, 1929.0740444586606, 1977.2288807365067, 1980.2178139634836, 2205.426589086833, 2231.297141400462, 2168.2627906511784, 2224.443889027743, 2226.599212141814, 2227.0201111510883, 2229.3646310801423, 2161.189553917281, 2177.564487102578, 2179.2372669565602, 2184.0499382768467, 2194.890255487227, 2159.211887661008, 2160.827133829298, 2165.675148727688, 2166.1443729726825, 2220.200727738029, 2237.9216727414464, 2244.655463359599, 2257.356653353803, 2263.366257447901, 2264.3433404312727, 7490.25097490252, 7504.8123796904965, 7533.54798712079, 7534.698612055511, 7538.585377804218, 4622.075584883003, 4741.739204343759, 4750.144973904696, 4750.61995040396, 4753.453352864431, 2887.3359127400604, 3024.3195281061803, 3084.6915308469197, 3127.718505334508, 3131.6085489313837, 950.325269058969, 951.5004622573205, 977.4330888084894, 980.127686359141, 989.569537251298, 10421.218408619385, 10486.737831554196, 10488.947555262175, 10496.317739346918, 10500.737481562946, 4050.331695270306, 4143.233501802176, 4189.413482112506, 4193.97903010483, 4198.055437526532, 8603.31173506118, 8605.096464871098, 8613.78465538354, 8620.094890036456, 8631.482111073356, 4660.207764680013, 4665.85686506808, 4683.437987441529, 4699.835505757282, 4707.599854012379, 4295.355696645528, 4345.978270108692, 4346.195953748566, 4350.412694286231, 4352.521222665504, 3338.1821453743987, 3404.8467818948207, 3426.417509023472, 3522.5772907251294, 3536.6109727929907, 1093.4150229627112, 1129.5312445335258, 1133.2067552713133, 1138.1975707126455, 1143.0512674480328, 1304.530369067135, 1305.4712841299288, 1332.3404914567157, 1341.2489006156584, 1351.2703140304125, 7065.89401158983, 7165.390941769903, 7200.171980222237, 7217.783466496014, 7218.314260145278, 1088.9618863339745, 1102.1403305421784, 1103.4537903737541, 1108.534415545473, 1116.2298014370222, 5658.85852853682, 5750.281214848144, 5760.94239057604, 5762.020456522401, 5767.942320576824, 8918.821623567492, 9077.0, 9202.447853128833, 9206.493642849708, 9353.532323383804, 9093.31800114994, 9156.6795162169, 9240.630374784932, 9257.0, 9275.953620231856, 6833.555818871758, 7012.754553590702, 7013.649317534103, 7161.820954476179, 7229.09636295463, 7106.893396598952, 7185.856282874418, 7196.460265480006, 7202.063731714844, 7207.171175314906, 7757.26306000929, 8024.799380015313, 8050.47671901348, 8161.714339998071, 8199.95900020496, 8208.384371172067, 8465.111163327761, 8467.322614190727, 8631.050584435581, 8660.307175425825, 6186.288576813544, 6343.9682801585695, 6855.108835851307, 6934.271901450275, 6941.548799328028, 6255.186825712628, 6368.172137622265, 6948.895766563607, 7142.142942846892, 7240.674169662272, 6599.373059559334, 6719.596824190564, 6760.391564759196, 6842.213145488333, 7126.216116227107, 6704.6982885769285, 6819.249882513019, 6828.453723702191, 6971.093757811452, 6979.930200697928, 6623.801285961429, 6651.268360480247, 6662.83342916431, 6665.133532640726, 6682.665866706742, 6093.6039157454625, 6281.685915704288, 6387.489000879826, 6488.2538508072175, 6504.15445992018, 6387.297397286387, 6394.104825324552, 6413.454856337264, 6442.967785161044, 6453.935460645521], "unit": "score", "name": "mootools.html", "value": 4380.935653876818}, {"lowerIsBetter": false, "replicates": [319.75378958202185, 327.28324968319384, 327.85410492330925, 334.9045522026222, 335.2105790862517, 5633.295838020247, 5793.739281732322, 5796.188533605294, 5815.534757219423, 5843.79546715865, 5610.579206559504, 5745.482906538411, 5753.683547404891, 5755.827325180251, 5778.075507918734, 4493.573110554508, 4496.595306422413, 4497.280435130379, 4500.527444618317, 4501.594856462918, 4313.568643135693, 4405.163019026375, 4409.140217657558, 4474.060447306069, 4500.617447516965, 4439.0, 4443.666724995622, 4447.888802779924, 4462.040661257829, 4464.3080322549895, 4452.0873220989615, 4455.509893911667, 4462.241418958769, 4464.441944756905, 4467.3299005149165, 3933.449317095609, 3936.9567064727585, 3940.960590394088, 3942.2706799242233, 3945.171513982067, 5367.570594352443, 5505.449455054502, 5511.53151982082, 5516.3380394352935, 5531.778728850841, 5061.038402703512, 5078.492150784892, 5080.060188865072, 5082.33929589151, 5114.872128196787, 5853.824385268449, 6129.724162412702, 6134.650376917071, 6141.01743721007, 6150.077488376779, 4173.853915112987, 4183.184279065584, 4239.554846741079, 4244.639205667522, 4248.808803603845, 6235.719392627343, 6366.77716279928, 6369.076483909854, 6378.425941665226, 6381.393767592025, 4321.935170972438, 4356.455443069616, 4359.106383191438, 4360.563943605614, 4364.934525982113, 4294.141171765659, 4416.359627854007, 4420.845270415584, 4420.977895110568, 4467.419235499365, 5127.820526281562, 5137.049645815536, 5138.332016837862, 5138.665986710852, 5139.922901156486, 6152.446279834837, 6153.630782153085, 6155.938440615537, 6156.507479401637, 6159.291681456601, 1549.43445642342, 1569.2075501871482, 1570.9371625134866, 1572.536101849957, 1574.039835700222, 1051.1958351860833, 1052.0478966535297, 1052.7157667429751, 1054.4253381906879, 1081.9242653014214, 5742.339630942495, 5746.281714785652, 5757.280339957505, 5763.164341170507, 5765.221695071112, 6257.561970662101, 6272.686365681698, 6274.215723034621, 6277.18396608438, 6307.053941908659, 5748.109043098327, 5751.252337196138, 5751.482366587027, 5760.337561180434, 5761.740721667535, 3288.9506657400157, 3386.9322613547592, 3389.7627166098137, 3395.5076513905346, 3397.490376443553, 6508.544401891917, 6525.1517302750335, 6537.934620653828, 6549.443297319781, 6553.475721942234, 6384.6169229846355, 6417.294097649255, 6422.518311126684, 6439.356064393523, 6453.741850325934, 6356.682165891687, 6530.477561795045, 6541.934580654228, 6543.018547218051, 6543.705533251015, 6087.0, 6191.783287585093, 6274.372562743689, 6274.780382686584, 6279.968600157153, 6146.692665366803, 6253.499720022296, 6261.279952805304, 6287.654179020198, 6296.874062518816, 6541.345865413611, 6584.242812076673, 6591.209054913441, 6593.406593406617, 6596.637184954681, 4321.481422229353, 4401.471823381215, 4404.185225733249, 4405.889852753707, 4411.0, 6331.0819931110655, 6333.303336632875, 6342.39747224013, 6345.238571371465, 6346.619202847844, 6150.138980542817, 6159.96920015415, 6160.229971253593, 6164.47601953839, 6171.59884607499, 5983.670898100472, 6138.416850399205, 6138.693065346804, 6142.692865356804, 6148.938510615016, 6023.819285421444, 6028.547858910511, 6038.969805150946, 6041.758329666764, 6046.0, 6176.474999625082, 6183.3816618337805, 6185.84535386619, 6188.195534580475, 6191.9690401547705, 5912.645241285537, 6036.154938308552, 6036.7585296589405, 6036.7887123952205, 6042.244719410074], "unit": "score", "name": "prototype.html", "value": 4626.977481963664}, {"lowerIsBetter": false, "replicates": [685.3728838113127, 722.9024081748966, 777.2499537945881, 842.6460886427701, 866.2939704141122, 12204.32876191809, 12295.754084918297, 12312.261264324135, 12312.692182695437, 12363.258204507736, 11420.486078126483, 11423.885761142386, 11534.192606517547, 11760.294382337066, 11894.345810980392, 810.4893916832402, 823.7075838077486, 824.0153017144514, 824.7031068815222, 825.1830687619243, 809.6882700160422, 810.6919370639149, 813.9470934389245, 814.8248126652768, 814.8248126652768, 843.4812590257009, 844.932405407566, 845.7293666026874, 846.196113691992, 847.5380917400001, 851.3402113362132, 853.4452605806214, 854.086127843208, 854.1885209051426, 854.4531499840107, 622.5797586629053, 624.7344878426651, 624.7906951171364, 624.9218847644045, 625.6683957502531, 12134.514619415213, 12171.817422738666, 12176.391180440942, 12218.450169742295, 12236.877631223662, 10626.0, 10768.78462430755, 10808.945955270174, 10960.123190144848, 11248.0, 9409.623615055458, 9411.529423528797, 9463.479508627022, 9490.810183796355, 9608.855867161998, 3388.4578467445335, 3415.641357657435, 3454.9481757773656, 3476.28736109097, 3500.3699334119847, 43002.0, 43424.565754342366, 43472.78263608662, 46576.30135547969, 47000.52999469996, 9224.0, 9264.11990860867, 9408.811823763486, 9413.623455061721, 9450.716478505656, 17532.824671753373, 17620.20709068095, 17658.5585360367, 17697.115144242736, 17860.464186074438, 6911.550749201286, 7099.538529995534, 7162.46281528877, 7240.348368646847, 7257.237990011078, 4133.627973482401, 4146.067134894624, 4212.262854000599, 4228.4080228768, 4292.5492823253735, 3041.1180757580055, 3058.2813038935833, 3063.2801291696433, 3096.241420851906, 3099.0392978176837, 566.9744861481161, 574.333772823531, 579.7970710251462, 580.1529766540898, 602.9728662210123, 485.1679369880601, 505.4061477763613, 515.3352175693313, 600.6336134957672, 685.324954919404, 8359.122292159358, 8513.531755753493, 8581.184787445183, 8746.737597872074, 8906.242969347548, 521.5085153335384, 545.5744519274972, 610.2585358789004, 617.4998251416367, 648.063548172895, 3862.864799731996, 3984.3687852995267, 4000.959990400059, 4042.9797851010558, 4052.3516237402464, 50698.746506267235, 51075.23387149196, 51303.743481282356, 55002.724986374815, 55384.44615553793, 42972.355414668804, 44117.33823992643, 44489.33266001013, 44722.32916506255, 44944.0, 40895.38656920149, 42191.0, 42655.57344426578, 42728.14543709109, 43350.99999999937, 8558.101399353227, 8842.823143536965, 8883.600237989176, 8903.465792052497, 9048.728538143867, 30572.541411879283, 30581.0, 32062.839685802355, 32780.1804954878, 33304.666953330154, 47441.52558474371, 48869.0, 49108.263376050105, 49380.753096234286, 49752.50247497624, 10634.946825265824, 10718.410487423267, 10764.623238186627, 10780.29928054674, 10978.396188209406, 11744.236624619372, 12057.397130143634, 12065.336406497727, 12159.966402855502, 12561.87438125607, 10867.673969780919, 11097.167712421762, 11505.252158609663, 11593.0, 11621.302721836717, 11221.382823944761, 11316.547338106713, 11443.370614616277, 11640.53437862476, 11743.88256117428, 11605.129615279056, 11635.709107272385, 11930.164888457724, 11990.520379184734, 12038.097142714156, 9498.287628427757, 9623.606751847532, 9796.510174491104, 9810.313278070753, 9820.754481138028, 8796.780080498038, 9038.457692538468, 9348.906510935076, 9375.390599611277, 10066.647667331608], "unit": "score", "name": "yui.html", "value": 6075.875331026391}], "name": "dromaeo_css", "value": 6636.359623591365}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 110.0, 112.0, 111.0, 99.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [145.0, 125.0, 150.0, 168.0, 127.0, 157.0, 168.0, 127.0, 161.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 160.0, 162.0, 161.0, 162.0, 164.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 95.0, 94.0, 72.0, 71.0, 72.0, 124.0, 95.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 151.0, 96.0, 97.0, 96.0, 145.0, 97.0, 98.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 58.0, 57.0, 59.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 82.0, 81.0, 82.0, 81.0, 82.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 127.0, 112.0, 114.0, 116.0, 117.0, 113.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [142.0, 128.0, 141.0, 140.0, 141.0, 134.0, 141.0, 141.0, 141.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 68.0, 69.0, 66.0, 66.0, 69.0, 64.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1491.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [189.7173211914248], "unit": "score", "name": "DeltaBlue", "value": 348.507978}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [584.4535359438925], "unit": "score", "name": "Splay", "value": 139.43110099999998}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 18837.4872934419}]} 07:11:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18837.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1491.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6636.36"}}} 07:11:42 INFO - Return code: 0 07:11:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:42 INFO - # TBPL SUCCESS # 07:11:42 INFO - Running post-action listener: _resource_record_post_action 07:11:42 INFO - Running post-run listener: _resource_record_post_run 07:11:43 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551825408; Read time: 8; Write time: 751292 07:11:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237379584; Read time: 0; Write time: 400548 07:11:43 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314445824; Read time: 8; Write time: 350744 07:11:43 INFO - Running post-run listener: _upload_blobber_files 07:11:43 INFO - Blob upload gear active. 07:11:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:11:43 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 07:11:43 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'] 07:11:43 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 07:11:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:44 INFO - (blobuploader) - INFO - Done attempting. 07:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:45 INFO - (blobuploader) - INFO - Done attempting. 07:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:45 INFO - Return code: 0 07:11:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b32fe7db4e7d0dd670b9b3562c35d122b76f383f07b76a1a46ab7d30337e1ddb58a3df94ad86a5cd8e70ed006d57aee292cbf7c4f0884d38337c6348415dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a032ca8e30787ad43e6576bcde11af1674f493ec3c16834932b8dba6f11a25120edb2c3fac895d82a5e423c1ee55e5fb793a4ada44871ce0db20ab6ac326271c"} 07:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:11:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:11:45 INFO - Contents: 07:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b32fe7db4e7d0dd670b9b3562c35d122b76f383f07b76a1a46ab7d30337e1ddb58a3df94ad86a5cd8e70ed006d57aee292cbf7c4f0884d38337c6348415dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a032ca8e30787ad43e6576bcde11af1674f493ec3c16834932b8dba6f11a25120edb2c3fac895d82a5e423c1ee55e5fb793a4ada44871ce0db20ab6ac326271c"} 07:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:45 INFO - Copying logs to upload dir... 07:11:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.921588 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-16 07:11:44.732515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 07:11:44.735933) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b32fe7db4e7d0dd670b9b3562c35d122b76f383f07b76a1a46ab7d30337e1ddb58a3df94ad86a5cd8e70ed006d57aee292cbf7c4f0884d38337c6348415dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a032ca8e30787ad43e6576bcde11af1674f493ec3c16834932b8dba6f11a25120edb2c3fac895d82a5e423c1ee55e5fb793a4ada44871ce0db20ab6ac326271c"} build_url:https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011494 build_url: 'https://queue.taskcluster.net/v1/task/DI1K_p9TRiqX6Re4yJpqvQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d58b32fe7db4e7d0dd670b9b3562c35d122b76f383f07b76a1a46ab7d30337e1ddb58a3df94ad86a5cd8e70ed006d57aee292cbf7c4f0884d38337c6348415dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a032ca8e30787ad43e6576bcde11af1674f493ec3c16834932b8dba6f11a25120edb2c3fac895d82a5e423c1ee55e5fb793a4ada44871ce0db20ab6ac326271c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-16 07:11:44.760342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 07:11:44.760651) ========= 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=1861a34ebfea852630dec091000001fa-1452953134.527430-565397017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-16 07:11:44.845442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 07:11:44.845761) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-16 07:11:44.846057) ========= ========= Total master_lag: 0.32 =========