builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1452913274.93 results: success (0) buildid: 20160115163011 builduid: 9b423e6589484f7c9cdac680cb4f60cc revision: 9879757aa0d4f88df8c79cde4a777ac7eff0152f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.926452) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.927042) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.927313) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.958687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.958951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.988892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:14.989167) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.038491) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.038833) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.039258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.039595) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 19:01:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.6M=0s 2016-01-15 19:01:15 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171452 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.223449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.223782) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016594 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.272960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.273263) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9879757aa0d4f88df8c79cde4a777ac7eff0152f --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 9879757aa0d4f88df8c79cde4a777ac7eff0152f --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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 19:01:15,666 truncating revision to first 12 chars 2016-01-15 19:01:15,666 Setting DEBUG logging. 2016-01-15 19:01:15,666 attempt 1/10 2016-01-15 19:01:15,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9879757aa0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 19:01:15,937 unpacking tar archive at: mozilla-central-9879757aa0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581943 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.867226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.867495) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004680 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.917731) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.918005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.927733) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.928037) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:01:15.928430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 19:01:15.928721) ========= /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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:16 INFO - MultiFileLogger online at 20160115 19:01:16 in /builds/slave/test-pgo 19:01:16 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 19:01:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:01:16 INFO - {'append_to_log': False, 19:01:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:01:16 INFO - 'blob_upload_branch': 'Firefox', 19:01:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:01:16 INFO - 'branch': 'Firefox', 19:01:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:16 INFO - 'config_files': ('talos/linux_config.py',), 19:01:16 INFO - 'default_actions': ('clobber', 19:01:16 INFO - 'read-buildbot-config', 19:01:16 INFO - 'download-and-extract', 19:01:16 INFO - 'populate-webroot', 19:01:16 INFO - 'create-virtualenv', 19:01:16 INFO - 'install', 19:01:16 INFO - 'run-tests'), 19:01:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:16 INFO - 'download_minidump_stackwalk': True, 19:01:16 INFO - 'download_symbols': 'ondemand', 19:01:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:16 INFO - 'installer_path': 'installer.exe', 19:01:16 INFO - 'log_level': 'info', 19:01:16 INFO - 'log_name': 'talos', 19:01:16 INFO - 'log_to_console': True, 19:01:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:16 INFO - 'opt_config_files': (), 19:01:16 INFO - 'pip_index': False, 19:01:16 INFO - 'sps_profile': False, 19:01:16 INFO - 'sps_profile_interval': 0, 19:01:16 INFO - 'suite': 'dromaeojs', 19:01:16 INFO - 'system_bits': '32', 19:01:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:16 INFO - 'title': 'talos-linux64-ix-036', 19:01:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:16 INFO - 'use_talos_json': True, 19:01:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:01:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:16 INFO - 'work_dir': 'build'} 19:01:16 INFO - ##### 19:01:16 INFO - ##### Running clobber step. 19:01:16 INFO - ##### 19:01:16 INFO - Running pre-action listener: _resource_record_pre_action 19:01:16 INFO - Running main action method: clobber 19:01:16 INFO - rmtree: /builds/slave/test-pgo/build 19:01:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:01:16 INFO - Running post-action listener: _resource_record_post_action 19:01:16 INFO - ##### 19:01:16 INFO - ##### Running read-buildbot-config step. 19:01:16 INFO - ##### 19:01:16 INFO - Running pre-action listener: _resource_record_pre_action 19:01:16 INFO - Running main action method: read_buildbot_config 19:01:16 INFO - Using buildbot properties: 19:01:16 INFO - { 19:01:16 INFO - "project": "", 19:01:16 INFO - "product": "firefox", 19:01:16 INFO - "script_repo_revision": "production", 19:01:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:01:16 INFO - "repository": "", 19:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:01:16 INFO - "buildid": "20160115163011", 19:01:16 INFO - "pgo_build": "True", 19:01:16 INFO - "basedir": "/builds/slave/test-pgo", 19:01:16 INFO - "buildnumber": 307, 19:01:16 INFO - "slavename": "talos-linux64-ix-036", 19:01:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:01:16 INFO - "platform": "ubuntu64_hw", 19:01:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:01:16 INFO - "branch": "mozilla-central", 19:01:16 INFO - "repo_path": "mozilla-central", 19:01:16 INFO - "revision": "9879757aa0d4f88df8c79cde4a777ac7eff0152f", 19:01:16 INFO - "stage_platform": "linux64-pgo", 19:01:16 INFO - "builduid": "9b423e6589484f7c9cdac680cb4f60cc", 19:01:16 INFO - "slavebuilddir": "test" 19:01:16 INFO - } 19:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:01:16 INFO - Running post-action listener: _resource_record_post_action 19:01:16 INFO - ##### 19:01:16 INFO - ##### Running download-and-extract step. 19:01:16 INFO - ##### 19:01:16 INFO - Running pre-action listener: _resource_record_pre_action 19:01:16 INFO - Running main action method: download_and_extract 19:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:16 INFO - https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/test_packages.json 19:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/test_packages.json 19:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:01:19 INFO - Downloaded 1448 bytes. 19:01:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:01:19 INFO - Using the following test package requirements: 19:01:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:01:19 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:01:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'jsshell-linux-x86_64.zip'], 19:01:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:01:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:01:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:01:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:01:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:01:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:19 INFO - https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:23 INFO - Downloaded 22440657 bytes. 19:01:23 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'] 19:01:23 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 19:01:25 INFO - Return code: 0 19:01:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:25 INFO - https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:32 INFO - Downloaded 22440657 bytes. 19:01:32 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'] 19:01:32 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 19:01:34 INFO - Return code: 0 19:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:34 INFO - https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:01:35 INFO - Downloaded 11132144 bytes. 19:01:35 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'] 19:01:35 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 19:01:36 INFO - Return code: 0 19:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:36 INFO - https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:01:38 INFO - Downloaded 55879974 bytes. 19:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:01:38 INFO - mkdir: /builds/slave/test-pgo/properties 19:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:01:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:01:38 INFO - Contents: 19:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:01:38 INFO - Running post-action listener: _resource_record_post_action 19:01:38 INFO - Running post-action listener: set_extra_try_arguments 19:01:38 INFO - ##### 19:01:38 INFO - ##### Running populate-webroot step. 19:01:38 INFO - ##### 19:01:38 INFO - Running pre-action listener: _resource_record_pre_action 19:01:38 INFO - Running main action method: populate_webroot 19:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:38 INFO - '--tppagecycles', 19:01:38 INFO - '7'], 19:01:38 INFO - 'tests': ['tsvgm']}}, 19:01:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:01:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:01:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'tests': ['damp', 'tps']}, 19:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['damp', 'tps']}, 19:01:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:38 INFO - 'other': {'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'other_l64': {'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'other_nol64': {'tests': ['a11yr', 19:01:38 INFO - 'ts_paint', 19:01:38 INFO - 'tpaint', 19:01:38 INFO - 'sessionrestore', 19:01:38 INFO - 'sessionrestore_no_auto_restore']}, 19:01:38 INFO - 'svgr': {'tests': ['tsvgx', 19:01:38 INFO - 'tsvgr_opacity', 19:01:38 INFO - 'tart', 19:01:38 INFO - 'tscrollx', 19:01:38 INFO - 'cart']}, 19:01:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['tsvgx', 19:01:38 INFO - 'tsvgr_opacity', 19:01:38 INFO - 'tart', 19:01:38 INFO - 'tscrollx', 19:01:38 INFO - 'cart']}, 19:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'tests': ['tp5o']}, 19:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'talos_options': ['--e10s'], 19:01:38 INFO - 'tests': ['tp5o']}, 19:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'talos_options': ['--xperf_path', 19:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:38 INFO - 'tests': ['tp5n']}, 19:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:38 INFO - 'talos_options': ['--e10s', 19:01:38 INFO - '--xperf_path', 19:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:38 INFO - 'tests': ['tp5n']}}, 19:01:38 INFO - 'talos.zip': {'path': '', 19:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:38 INFO - Running post-action listener: _resource_record_post_action 19:01:38 INFO - ##### 19:01:38 INFO - ##### Running create-virtualenv step. 19:01:38 INFO - ##### 19:01:38 INFO - Running pre-action listener: _resource_record_pre_action 19:01:38 INFO - Running main action method: create_virtualenv 19:01:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:01:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:39 INFO - Using real prefix '/usr' 19:01:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:41 INFO - Installing pip.................done. 19:01:41 INFO - Return code: 0 19:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:01: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')]} 19:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:41 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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:01:41 INFO - Using env: {'DISPLAY': ':0', 19:01:41 INFO - 'HOME': '/home/cltbld', 19:01:41 INFO - 'LANG': 'en_US.UTF-8', 19:01:41 INFO - 'LANGUAGE': 'en_US:en', 19:01:41 INFO - 'LOGNAME': 'cltbld', 19:01:41 INFO - 'MAIL': '/var/mail/cltbld', 19:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:41 INFO - 'MOZ_NO_REMOTE': '1', 19:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:41 INFO - 'NO_EM_RESTART': '1', 19:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:41 INFO - 'SHELL': '/bin/bash', 19:01:41 INFO - 'SHLVL': '1', 19:01:41 INFO - 'TERM': 'linux', 19:01:41 INFO - 'TMOUT': '86400', 19:01:41 INFO - 'USER': 'cltbld', 19:01:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:41 INFO - '_': '/tools/buildbot/bin/python'} 19:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:01:41 INFO - Cleaning up... 19:01:41 INFO - Return code: 0 19:01:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:01: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')]} 19:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:41 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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:01:41 INFO - Using env: {'DISPLAY': ':0', 19:01:41 INFO - 'HOME': '/home/cltbld', 19:01:41 INFO - 'LANG': 'en_US.UTF-8', 19:01:41 INFO - 'LANGUAGE': 'en_US:en', 19:01:41 INFO - 'LOGNAME': 'cltbld', 19:01:41 INFO - 'MAIL': '/var/mail/cltbld', 19:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:41 INFO - 'MOZ_NO_REMOTE': '1', 19:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:41 INFO - 'NO_EM_RESTART': '1', 19:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:41 INFO - 'SHELL': '/bin/bash', 19:01:41 INFO - 'SHLVL': '1', 19:01:41 INFO - 'TERM': 'linux', 19:01:41 INFO - 'TMOUT': '86400', 19:01:41 INFO - 'USER': 'cltbld', 19:01:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:41 INFO - '_': '/tools/buildbot/bin/python'} 19:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:41 INFO - Downloading/unpacking psutil>=0.7.1 19:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:43 INFO - Installing collected packages: psutil 19:01:43 INFO - Running setup.py install for psutil 19:01:43 INFO - building 'psutil._psutil_linux' extension 19:01:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:01:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:01:44 INFO - building 'psutil._psutil_posix' extension 19:01:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:01:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:01:44 INFO - Successfully installed psutil 19:01:44 INFO - Cleaning up... 19:01:44 INFO - Return code: 0 19:01:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:01:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:01:44 INFO - Using env: {'DISPLAY': ':0', 19:01:44 INFO - 'HOME': '/home/cltbld', 19:01:44 INFO - 'LANG': 'en_US.UTF-8', 19:01:44 INFO - 'LANGUAGE': 'en_US:en', 19:01:44 INFO - 'LOGNAME': 'cltbld', 19:01:44 INFO - 'MAIL': '/var/mail/cltbld', 19:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:44 INFO - 'MOZ_NO_REMOTE': '1', 19:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:44 INFO - 'NO_EM_RESTART': '1', 19:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:44 INFO - 'SHELL': '/bin/bash', 19:01:44 INFO - 'SHLVL': '1', 19:01:44 INFO - 'TERM': 'linux', 19:01:44 INFO - 'TMOUT': '86400', 19:01:44 INFO - 'USER': 'cltbld', 19:01:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:44 INFO - '_': '/tools/buildbot/bin/python'} 19:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:01:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:01:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:01:46 INFO - Installing collected packages: mozsystemmonitor 19:01:46 INFO - Running setup.py install for mozsystemmonitor 19:01:46 INFO - Successfully installed mozsystemmonitor 19:01:46 INFO - Cleaning up... 19:01:46 INFO - Return code: 0 19:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:01:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:01:46 INFO - Using env: {'DISPLAY': ':0', 19:01:46 INFO - 'HOME': '/home/cltbld', 19:01:46 INFO - 'LANG': 'en_US.UTF-8', 19:01:46 INFO - 'LANGUAGE': 'en_US:en', 19:01:46 INFO - 'LOGNAME': 'cltbld', 19:01:46 INFO - 'MAIL': '/var/mail/cltbld', 19:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:46 INFO - 'MOZ_NO_REMOTE': '1', 19:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:46 INFO - 'NO_EM_RESTART': '1', 19:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:46 INFO - 'SHELL': '/bin/bash', 19:01:46 INFO - 'SHLVL': '1', 19:01:46 INFO - 'TERM': 'linux', 19:01:46 INFO - 'TMOUT': '86400', 19:01:46 INFO - 'USER': 'cltbld', 19:01:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:46 INFO - '_': '/tools/buildbot/bin/python'} 19:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:48 INFO - Downloading docopt-0.6.1.tar.gz 19:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:49 INFO - Running setup.py install for blobuploader 19:01:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:01:49 INFO - Running setup.py install for requests 19:01:49 INFO - Running setup.py install for docopt 19:01:49 INFO - Successfully installed blobuploader requests docopt 19:01:49 INFO - Cleaning up... 19:01:49 INFO - Return code: 0 19:01:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:01: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')]} 19:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:49 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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:01:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:49 INFO - Using env: {'DISPLAY': ':0', 19:01:49 INFO - 'HOME': '/home/cltbld', 19:01:49 INFO - 'LANG': 'en_US.UTF-8', 19:01:49 INFO - 'LANGUAGE': 'en_US:en', 19:01:49 INFO - 'LOGNAME': 'cltbld', 19:01:49 INFO - 'MAIL': '/var/mail/cltbld', 19:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:49 INFO - 'MOZ_NO_REMOTE': '1', 19:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:49 INFO - 'NO_EM_RESTART': '1', 19:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:49 INFO - 'SHELL': '/bin/bash', 19:01:49 INFO - 'SHLVL': '1', 19:01:49 INFO - 'TERM': 'linux', 19:01:49 INFO - 'TMOUT': '86400', 19:01:49 INFO - 'USER': 'cltbld', 19:01:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:49 INFO - '_': '/tools/buildbot/bin/python'} 19:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:01:49 INFO - Running setup.py (path:/tmp/pip-KCOLv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:01:49 INFO - Running setup.py (path:/tmp/pip-3sTWLW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:01:49 INFO - Running setup.py (path:/tmp/pip-VVc2lR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:01:50 INFO - Running setup.py (path:/tmp/pip-i0Z2Fo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:01:50 INFO - Running setup.py (path:/tmp/pip-0AVUIE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:01:50 INFO - Running setup.py (path:/tmp/pip-jcvhMl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:01:50 INFO - Running setup.py (path:/tmp/pip-BXPhl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:01:50 INFO - Running setup.py (path:/tmp/pip-HzqoUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:01:50 INFO - Running setup.py (path:/tmp/pip-OaYLe8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:01:50 INFO - Running setup.py (path:/tmp/pip-xbJerF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:01:50 INFO - Running setup.py (path:/tmp/pip-oki6TT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:01:50 INFO - Running setup.py (path:/tmp/pip-gLNTvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:01:50 INFO - Running setup.py (path:/tmp/pip-Fb7RC5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:01:50 INFO - Running setup.py (path:/tmp/pip-avt34H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:01:50 INFO - Running setup.py (path:/tmp/pip-pCk7ky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:01:50 INFO - Running setup.py (path:/tmp/pip-fcmDG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:01:50 INFO - Running setup.py (path:/tmp/pip-QIp0P2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:01:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:01:51 INFO - Running setup.py install for manifestparser 19:01:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Running setup.py install for mozcrash 19:01:51 INFO - Running setup.py install for mozdebug 19:01:51 INFO - Running setup.py install for mozdevice 19:01:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Running setup.py install for mozfile 19:01:51 INFO - Running setup.py install for mozhttpd 19:01:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Running setup.py install for mozinfo 19:01:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Running setup.py install for mozInstall 19:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:01:51 INFO - Running setup.py install for mozleak 19:01:51 INFO - Running setup.py install for mozlog 19:01:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Running setup.py install for moznetwork 19:01:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Running setup.py install for mozprocess 19:01:52 INFO - Running setup.py install for mozprofile 19:01:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Running setup.py install for mozrunner 19:01:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Running setup.py install for mozscreenshot 19:01:52 INFO - Running setup.py install for moztest 19:01:52 INFO - Running setup.py install for mozversion 19:01:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:52 INFO - Cleaning up... 19:01:52 INFO - Return code: 0 19:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:01: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')]} 19:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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', '-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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:01:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:52 INFO - Using env: {'DISPLAY': ':0', 19:01:52 INFO - 'HOME': '/home/cltbld', 19:01:52 INFO - 'LANG': 'en_US.UTF-8', 19:01:52 INFO - 'LANGUAGE': 'en_US:en', 19:01:52 INFO - 'LOGNAME': 'cltbld', 19:01:52 INFO - 'MAIL': '/var/mail/cltbld', 19:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:52 INFO - 'MOZ_NO_REMOTE': '1', 19:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:52 INFO - 'NO_EM_RESTART': '1', 19:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:52 INFO - 'SHELL': '/bin/bash', 19:01:52 INFO - 'SHLVL': '1', 19:01:52 INFO - 'TERM': 'linux', 19:01:52 INFO - 'TMOUT': '86400', 19:01:52 INFO - 'USER': 'cltbld', 19:01:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:52 INFO - '_': '/tools/buildbot/bin/python'} 19:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:01:53 INFO - Running setup.py (path:/tmp/pip-2Hb7IH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:01:53 INFO - Running setup.py (path:/tmp/pip-PDp7wn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:01:53 INFO - Running setup.py (path:/tmp/pip-wtcqPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:01:53 INFO - Running setup.py (path:/tmp/pip-cm2CsO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:01:53 INFO - Running setup.py (path:/tmp/pip-KeUZjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:01:53 INFO - Running setup.py (path:/tmp/pip-lcxVjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:01:53 INFO - Running setup.py (path:/tmp/pip-_GzJkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:01:53 INFO - Running setup.py (path:/tmp/pip-HkXrC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:01:53 INFO - Running setup.py (path:/tmp/pip-kIsegF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:01:53 INFO - Running setup.py (path:/tmp/pip-qMmwMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:01:53 INFO - Running setup.py (path:/tmp/pip-b2qjYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:01:53 INFO - Running setup.py (path:/tmp/pip-GWuPwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:01:53 INFO - Running setup.py (path:/tmp/pip-qJTfTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:01:54 INFO - Running setup.py (path:/tmp/pip-cZrepU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:01:54 INFO - Running setup.py (path:/tmp/pip-S7vYwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:01:54 INFO - Running setup.py (path:/tmp/pip-N02QmK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:01:54 INFO - Running setup.py (path:/tmp/pip-gmNs16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:56 INFO - Downloading blessings-1.5.1.tar.gz 19:01:56 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:56 INFO - Installing collected packages: blessings 19:01:56 INFO - Running setup.py install for blessings 19:01:56 INFO - Successfully installed blessings 19:01:56 INFO - Cleaning up... 19:01:56 INFO - Return code: 0 19:01:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:01:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:01:56 INFO - Reading from file tmpfile_stdout 19:01:56 INFO - Current package versions: 19:01:56 INFO - argparse == 1.2.1 19:01:56 INFO - blessings == 1.5.1 19:01:56 INFO - blobuploader == 1.2.4 19:01:56 INFO - docopt == 0.6.1 19:01:56 INFO - manifestparser == 1.1 19:01:56 INFO - mozInstall == 1.12 19:01:56 INFO - mozcrash == 0.16 19:01:56 INFO - mozdebug == 0.1 19:01:56 INFO - mozdevice == 0.48 19:01:56 INFO - mozfile == 1.2 19:01:56 INFO - mozhttpd == 0.7 19:01:56 INFO - mozinfo == 0.9 19:01:56 INFO - mozleak == 0.1 19:01:56 INFO - mozlog == 3.1 19:01:56 INFO - moznetwork == 0.27 19:01:56 INFO - mozprocess == 0.22 19:01:56 INFO - mozprofile == 0.28 19:01:56 INFO - mozrunner == 6.11 19:01:56 INFO - mozscreenshot == 0.1 19:01:56 INFO - mozsystemmonitor == 0.0 19:01:56 INFO - moztest == 0.7 19:01:56 INFO - mozversion == 1.4 19:01:56 INFO - psutil == 3.1.1 19:01:56 INFO - requests == 1.2.3 19:01:56 INFO - wsgiref == 0.1.2 19:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:01:56 INFO - Cleaning up... 19:01:56 INFO - Return code: 0 19:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:56 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 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:01:56 INFO - Using env: {'DISPLAY': ':0', 19:01:56 INFO - 'HOME': '/home/cltbld', 19:01:56 INFO - 'LANG': 'en_US.UTF-8', 19:01:56 INFO - 'LANGUAGE': 'en_US:en', 19:01:56 INFO - 'LOGNAME': 'cltbld', 19:01:56 INFO - 'MAIL': '/var/mail/cltbld', 19:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:56 INFO - 'MOZ_NO_REMOTE': '1', 19:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:56 INFO - 'NO_EM_RESTART': '1', 19:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:56 INFO - 'SHELL': '/bin/bash', 19:01:56 INFO - 'SHLVL': '1', 19:01:56 INFO - 'TERM': 'linux', 19:01:56 INFO - 'TMOUT': '86400', 19:01:56 INFO - 'USER': 'cltbld', 19:01:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:56 INFO - '_': '/tools/buildbot/bin/python'} 19:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:56 INFO - Downloading/unpacking jsonschema 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:01:58 INFO - Downloading/unpacking functools32 (from jsonschema) 19:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:58 INFO - warning: no files found matching '*.txt' 19:01:58 INFO - no previously-included directories found matching 'build' 19:01:58 INFO - no previously-included directories found matching 'dist' 19:01:58 INFO - no previously-included directories found matching '.git*' 19:01:58 INFO - Installing collected packages: jsonschema, functools32 19:01:58 INFO - Running setup.py install for functools32 19:01:59 INFO - warning: no files found matching '*.txt' 19:01:59 INFO - no previously-included directories found matching 'build' 19:01:59 INFO - no previously-included directories found matching 'dist' 19:01:59 INFO - no previously-included directories found matching '.git*' 19:01:59 INFO - Successfully installed jsonschema functools32 19:01:59 INFO - Cleaning up... 19:01:59 INFO - Return code: 0 19:01:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d4f73df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2299480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, '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': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:01:59 INFO - Using env: {'DISPLAY': ':0', 19:01:59 INFO - 'HOME': '/home/cltbld', 19:01:59 INFO - 'LANG': 'en_US.UTF-8', 19:01:59 INFO - 'LANGUAGE': 'en_US:en', 19:01:59 INFO - 'LOGNAME': 'cltbld', 19:01:59 INFO - 'MAIL': '/var/mail/cltbld', 19:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:59 INFO - 'MOZ_NO_REMOTE': '1', 19:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:59 INFO - 'NO_EM_RESTART': '1', 19:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:01:59 INFO - 'SHELL': '/bin/bash', 19:01:59 INFO - 'SHLVL': '1', 19:01:59 INFO - 'TERM': 'linux', 19:01:59 INFO - 'TMOUT': '86400', 19:01:59 INFO - 'USER': 'cltbld', 19:01:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:59 INFO - '_': '/tools/buildbot/bin/python'} 19:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:59 INFO - Downloading/unpacking flake8 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:02:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:02:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:02:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:01 INFO - no previously-included directories found matching 'docs/_build' 19:02:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:02:01 INFO - Running setup.py install for pep8 19:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:01 INFO - no previously-included directories found matching 'docs/_build' 19:02:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:02:01 INFO - Cleaning up... 19:02:02 INFO - Return code: 0 19:02:02 INFO - Running post-action listener: _resource_record_post_action 19:02:02 INFO - Running post-action listener: _start_resource_monitoring 19:02:02 INFO - Starting resource monitoring. 19:02:02 INFO - ##### 19:02:02 INFO - ##### Running install step. 19:02:02 INFO - ##### 19:02:02 INFO - Running pre-action listener: _resource_record_pre_action 19:02:02 INFO - Running main action method: install 19:02:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:02:02 INFO - Reading from file tmpfile_stdout 19:02:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:02:02 INFO - Reading from file tmpfile_stdout 19:02:02 INFO - Output received: 19:02:02 INFO - Usage: mozinstall [options] installer 19:02:02 INFO - Options: 19:02:02 INFO - -h, --help show this help message and exit 19:02:02 INFO - -d DEST, --destination=DEST 19:02:02 INFO - Directory to install application into. [default: 19:02:02 INFO - "/builds/slave/test-pgo"] 19:02:02 INFO - --app=APP Application being installed. [default: firefox] 19:02:02 INFO - mkdir: /builds/slave/test-pgo/build/application 19:02:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:02:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:02:18 INFO - Reading from file tmpfile_stdout 19:02:18 INFO - Output received: 19:02:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:02:18 INFO - Running post-action listener: _resource_record_post_action 19:02:18 INFO - ##### 19:02:18 INFO - ##### Running run-tests step. 19:02:18 INFO - ##### 19:02:18 INFO - Running pre-action listener: _resource_record_pre_action 19:02:18 INFO - Running main action method: run_tests 19:02:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:02:18 INFO - Python 2.7.3 19:02:18 INFO - Return code: 0 19:02:18 INFO - grabbing minidump binary from tooltool 19:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:18 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 0x2328660>, '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 0x2329560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2329a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:02:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:02:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:02:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:18 INFO - Return code: 0 19:02:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:02:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:02:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:02:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:02:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:02:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:02:19 INFO - Return code: 0 19:02:19 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/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 19:02:19 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/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 19:02:19 INFO - Using env: {'DISPLAY': ':0', 19:02:19 INFO - 'HOME': '/home/cltbld', 19:02:19 INFO - 'LANG': 'en_US.UTF-8', 19:02:19 INFO - 'LANGUAGE': 'en_US:en', 19:02:19 INFO - 'LOGNAME': 'cltbld', 19:02:19 INFO - 'MAIL': '/var/mail/cltbld', 19:02:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:02:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:19 INFO - 'MOZ_NO_REMOTE': '1', 19:02:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:19 INFO - 'NO_EM_RESTART': '1', 19:02:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:02:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:02:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:02:19 INFO - 'SHELL': '/bin/bash', 19:02:19 INFO - 'SHLVL': '1', 19:02:19 INFO - 'TERM': 'linux', 19:02:19 INFO - 'TMOUT': '86400', 19:02:19 INFO - 'USER': 'cltbld', 19:02:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323', 19:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:19 INFO - '_': '/tools/buildbot/bin/python'} 19:02:19 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/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 19:02:19 INFO - mozversion application_buildid: 20160115163011 19:02:19 INFO - mozversion application_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 19:02:19 INFO - mozversion application_display_name: Nightly 19:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:19 INFO - mozversion application_name: Firefox 19:02:19 INFO - mozversion application_remotingname: firefox 19:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:02:19 INFO - mozversion application_vendor: Mozilla 19:02:19 INFO - mozversion application_version: 46.0a1 19:02:19 INFO - mozversion platform_buildid: 20160115163011 19:02:19 INFO - mozversion platform_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 19:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:02:19 INFO - mozversion platform_version: 46.0a1 19:02:19 INFO - using testdate: 1452913339 19:02:19 INFO - actual date: 1452913339 19:02:19 INFO - starting webserver on 'localhost:35015' 19:02:19 INFO - SUITE-START | Running 3 tests 19:02:19 INFO - TEST-START | dromaeo_css 19:02:19 INFO - operating with platform_type : linux_ 19:02:19 INFO - Initialising browser for dromaeo_css test... 19:02:19 INFO - TEST-INFO | started process 15726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr5GKOb/profile http://localhost:35015/getInfo.html) 19:02:23 INFO - PROCESS | 15726 | __metrics Screen width/height:1600/1200 19:02:23 INFO - PROCESS | 15726 | colorDepth:24 19:02:23 INFO - PROCESS | 15726 | Browser inner width/height: 1024/697 19:02:23 INFO - PROCESS | 15726 | __metrics 19:02:23 INFO - PROCESS | 15726 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:02:23 INFO - PROCESS | 15726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:25 INFO - TEST-INFO | 15726: exit 0 19:02:25 INFO - Browser initialized. 19:02:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:25 INFO - TEST-INFO | started process 15818 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr5GKOb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:36 INFO - PROCESS | 15818 | RSS: Main: 151121920 19:02:36 INFO - PROCESS | 15818 | 19:03:28 INFO - PROCESS | 15818 | 1452913408246 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:05:36 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35015/tests/dromaeo/cssquery-ext.html) 19:05:37 INFO - PROCESS | 15818 | RSS: Main: 235606016 19:05:37 INFO - PROCESS | 15818 | 19:08:39 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-ext.html (next: http://localhost:35015/tests/dromaeo/cssquery-jquery.html) 19:08:40 INFO - PROCESS | 15818 | RSS: Main: 228028416 19:08:40 INFO - PROCESS | 15818 | 19:11:42 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35015/tests/dromaeo/cssquery-mootools.html) 19:11:42 INFO - PROCESS | 15818 | RSS: Main: 235536384 19:11:42 INFO - PROCESS | 15818 | 19:14:44 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35015/tests/dromaeo/cssquery-prototype.html) 19:14:45 INFO - PROCESS | 15818 | RSS: Main: 207073280 19:14:45 INFO - PROCESS | 15818 | 19:17:47 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35015/tests/dromaeo/cssquery-yui.html) 19:17:48 INFO - PROCESS | 15818 | RSS: Main: 190554112 19:17:48 INFO - PROCESS | 15818 | 19:20:50 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:35015/tests/dromaeo/cssquery-yui.html (next: http://localhost:35015/tests/dromaeo/cssquery-dojo.html) 19:20:51 INFO - PROCESS | 15818 | RSS: Main: 291151872 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | __start_tp_report 19:20:51 INFO - PROCESS | 15818 | _x_x_mozilla_page_load 19:20:51 INFO - PROCESS | 15818 | _x_x_mozilla_page_load_details 19:20:51 INFO - PROCESS | 15818 | |i|pagename|runs| 19:20:51 INFO - PROCESS | 15818 | |0;dojo.html;3116.065180445867;3129.8591563379646;3146.386454641346;3161.399334126516;3171.3657268546294;4908.705477671342;4977.427595826481;5040.546350828425;5046.54581087702;5061.417936937253;5048.545630893219;5079.898402031957;5092.898142037157;5168.767405466753;5231.895362092765;4596.885077873047;4651.093036857814;4652.348671186037;4675.836345727883;4754.690945088575;4697.624190064804;4706.882327941795;4707.411573553306;4766.666333356667;4798.040391921612;4521.5930566249035;4615.723056616614;4683.508231635663;4751.192297309466;4761.166795810719;4637;4642.094791515656;4644;4653.604443622262;4676.579107880273;4638.489766125724;4641.466231383401;4645.581897629229;4647.60495357895;4674.228752255874;4818.662693611449;4905.23968784839;4987.47631498691;5056;5058.949410505885;5457.836264912059;5459.344878614552;5463.562914966793;5466.699331536764;5475.151351540518;5424.105022671254;5496.670199787985;5499.972500137514;5507.834764957058;5510.8071217507195;5094.083065048327;5107.591392688613;5135.563477104413;5167.3282473278605;5171.50870667286;5607.943920560824;5623.381428042912;5626.521745651666;5630.493255606933;5633.633813802172;5202.2456743771945;5282.286891269629;5395.892082158335;5397.001554712391;5399.70301633414;5463.48096930791;5531.778728850882;5562.97218513913;5569.331680198402;5590.413006634326;5422.674639521641;5501.037318469252;5515.834524964257;5516.641418307878;5527.419620939824;5402;5442.6462279951675;5491.121420572769;5506.944930550643;5512.145617429305;4270.274053410928;4280.464941882203;4284.014676624394;4289.678274129453;4315.331123675835;3771.17034252464;3845.692344612424;3846.8845934622004;3868.787216703052;3870.729048966545;5019.272205530177;5091.719955402488;5108.744562771846;5126;5128.3333166688835;5423.376311724202;5429.375621803543;5447.237386765856;5450.8909821803345;5493.478119578634;5082.872928176751;5083.69497830124;5088.618353623493;5099.388073431212;5128.666636668605;4632.72203667781;4664.323673067386;4681.227597446451;4684.672072954861;4779.378680771478;5676.971615141898;5677.971610141923;5713.342965558931;5716.628419152658;5720;5499.312585926759;5526.50261476469;5527.723613819373;5531;5577.888442231214;5537.36320323168;5540.196671482532;5584.301962254718;5610.242617246783;5643.238162847963;5394.919076213781;5419.918701219406;5440.156775699773;5448.45515448452;5473.589480788877;5337.386200586827;5524.723763811713;5556.638818476786;5562.16567514876;5609.186667933045;5284.365876094893;5324.627276090791;5340.813071542478;5341.7062061586985;5384.515393614593;5367.946320536901;5459.863503412446;5463.153211252262;5463.890722185613;5467.45325467466;5103.795848166032;5180.963807238492;5370.3287089113865;5370.758315875873;5384.730763461889;5316.734163291742;5353.866153346197;5376.408595054619;5398.46015398457;5426.511613954763;5259.8422047338645;5284.735763211901;5284.81503147388;5286.682799032071;5288.206768984683 19:20:51 INFO - PROCESS | 15818 | |1;ext.html;524.5200641413107;526.9288646032787;581.4272941152965;582.5252419278289;592.2241863159262;27845.72154278459;28232.43535129299;28290.858545707244;36598.63401365985;36710.8164459178;39157.41263881044;39552.60447395525;39628.80185599075;39654.80172599133;39678.40482392767;8274.875876861866;8447.23974842264;8459.11179326171;8464.534450605213;8473.788155296104;7511.511751736147;7675.194104619019;7678.308952194301;9770.755731106708;10011.749706257366;9757.365771224882;9840.114389704926;9841.360311579725;9843.655472058479;9846.212303015742;9804.166645835077;9868.161206297473;9899.505024748734;9900.45547494884;9903.90096099037;9741.659041933499;9849.950750246275;9871.40771553702;9874.802503949953;9874.802503949953;36319.4552081719;36863.81568092143;36925.63074369276;40170.79060651663;40213;3169.6196456425378;3257.7068063874367;3301.554290170844;3346.380919529895;3355.697987181141;29651;29991.70008299911;30023;30084.24789380261;30826.229344266347;3928.1750832325247;3928.5482169550583;3928.666063384616;4005.499312585927;4106.240345536055;263495;265836;266899;266918;266971;53489.46510534923;54633.1805022925;60261.39738602645;61378.69310653507;61949.07076393858;60329;60403.69798150981;60770.392296076476;60786.696066519384;60880.391196087476;14063.437462501386;14262.57212283633;14284.928575357264;14372.35324410404;14376.137431754129;10776;10821.188410869216;10827.187960902964;10831.2959657622;10855.45722713877;20268.391948241577;20498.487537811376;20689.58620827605;20726;20727.79272207289;8012.399070069651;8192.877106843402;8243.216894395024;8305.211004954519;8310;889.3996552327153;985.8619793228954;997.9122756195782;1025.779457416659;1070.577122036791;27924.860375698398;28167.859160704065;28575.428491430055;28654.85672571624;28702.569461458093;983.8819341678901;1024.9846252306222;1029.8146333660013;1059.5338051257422;1107.6566264458045;13779.379927903268;16139.354425822836;16198.838011619968;16270.26783794732;16566.66866662684;383046;389218;389628;390131;391358;54951.450485495436;55346.44653553413;55634;55683.72158139183;55703.442965569826;1299.7660421124099;1318.413306078805;1323.0341850449033;1324.9337533123305;1326.5025615394227;28881;30329.69670303269;30627.693723062483;30633.09870420722;31044.844775775975;42467;43411.131777364906;43436.34845477383;48334.516654833;49225.261621075;290960;292819;295585;296355;296378;37489;37771.62228377681;38250.23499529938;38329;38920.6107938917;45010;45232;45932.7703361481;45983.54016459793;46240.53759462362;37466.625333747405;38076.809615951744;38090.80954595209;38227.80886095663;39657;38087;38688.41967370548;38856.337239531436;39133.21733565256;39372.60627393689;36727.81636091803;36996.630033699315;37684.05789855275;38202.23595528129;38252.2349553013;29271.414571708872;31746.365072698878;33575;33577;33664.49503257502;24859;24914.626280606168;25295.620565691897;25485.61771573465;25611 19:20:51 INFO - PROCESS | 15818 | |2;jquery.html;343.9535662685537;345.81558163290725;346.96877281044704;348.0532950374979;351.3991075261303;13661.453541858315;14091.718165636681;15594.14232217229;16381.262843172057;18416.907915460422;14751.557453276391;15621.68756624867;16014.679706405894;16226.675466490664;16271.83728162718;5039.0425819094435;5237.45006774289;5304.124819404794;5308.177232528964;5309.973450132744;3949.8025098744947;4097.79511024449;5169.121249387613;5262.394824595182;5568.220449137124;5700.8859822803515;5705.942940570582;5734.13987901816;5741.626794258381;5745.425457454242;5577.581681373893;5763.135529670583;5767.538596912237;5767.884642307173;5769.913451298213;4888.340074089988;5060.316857224265;5089.592832573385;5096.79612815487;5125.846224613268;11051.336919784839;11654.30074195551;11679.124065695107;20258;20407.183712651626;1992.9501762456055;2085.09298455171;2144.2066435418838;2176.260071575656;2267.6391279688714;8475.321974242046;8804.955975220148;9052.683156089572;9159.35884488086;12659.74680506394;1687.8649708023452;1732.1858726398573;1785.4911350265113;1785.8214178582168;1799.1543974332044;55382.16926746102;56380.718096409255;57442;57830.7108464455;58387.41612583862;10099.747506312255;10276;10281.845772313422;10284.537195826206;10345.94827025875;13474.52839150625;13525.932370338085;13532.93233533826;13544.661383465294;13545.796813047813;7338.70645174187;7343.32411465772;7364.93386803495;7383.372413344819;7394.815129621695;6987.371136597629;6989.196242432084;6997.230304666483;7021.89467157993;7058.71765129389;4451.065276292015;4547.272436410159;4552.362669226311;4590.081983603292;4599.701019433793;1735.548757323105;1788.678037953155;1789.2395731813926;1796.4520821149674;1819.2813838533705;843.304273973974;976.858355538443;993.7118235711707;994;1031.2265800649513;16220.7290979263;16685;16793.41223057187;17100.230489627997;17123.91438042827;872.6683860133109;878.6748902905965;882.849915514364;889.1730690457936;902.1294450854956;8851.46891186531;9036.412633178823;9299.209567186865;9411.952940235255;9602.183814375856;526714;576236;582960;610907;616598;65025;73407;75695;76280.61859690666;76557.6172119147;1068.3643232276784;1106.0266965070687;1110.1063643766684;1115.7043383503378;1126.79717650822;14326.296884095038;15188.088714677155;15483.30325135349;15488.690226195187;15507.094166138255;33002;33932.49101263532;34016.82991585026;34043.31913361669;34731;43604;44175.77912110419;44715;44738.55261447344;45514;6802.523823332319;6868.313168683092;6976.407005404598;7076.823079423056;7089.468289878177;9103.408278461879;9991.800163996824;10047.648332308334;10256.17950563968;10649.414282214553;7534.345842266606;8390.496570205807;8861;8925.910740892508;9219.262459003397;8801.867971980297;8835.69075082369;8891.73324800257;9143.039980802187;9306.255499559884;6911.965440172969;8752.64989400417;9000.774980625536;9064.773380665536;9224.354295199271;6541.574797638138;6548.672566371758;6588.176477940257;6628.138342015507;6729.966350168414;7537.397008239437;8888.466691998501;8951.41815781998;9043.90956090457;9054.637814487347 19:20:51 INFO - PROCESS | 15818 | |3;mootools.html;1329.9800502992464;1462.0861961274204;1472.5729538433854;1634.5178172439137;1806.0698740148825;6632.70152843122;7418.629068546571;7511.474196806225;7580.014598102246;7612.238776122399;7273.781786546412;7471.439642026842;7472.514286571369;7476.476646634737;7486.326230639242;1933.1494142577221;1966.3117908731901;1968.35044435336;2233.2853486884164;2272.318304508649;1995.1520603743425;2230.297456301268;2277.8519396239276;2277.9886100569474;2278.943026424344;2188.3544354415408;2223.399682085836;2225.5326381459913;2226.899789509476;2229.2532001779423;2190.507135894427;2195.9890200549053;2196.2971849008322;2199.14233448955;2199.186301068607;2221.0671517962332;2279.4757205842748;2280.908763649452;2281.1559722902466;2281.851679640818;7567.810804729926;7584.54492730438;7621.199774023758;7625.199354067799;7656.655450504741;4674.532546745332;4791.113643975876;4822.059698358821;4824.565789079;4826.0830442215865;3021.3504096619113;3059.571659967606;3075.3388021575247;3075.8923437679796;3082.7533797296164;940.1303793990531;940.2665920581957;972.7665360313545;982.4940155819759;985.1675334342469;10645.722513298377;10743.78512429747;10748.140148788156;10770.192235582284;10828.18788590851;4285.46431696038;4302.827886884552;4365.214261432972;4378.036831896978;4381.561843815657;9267.073292670679;9286.628534858664;9291.396059256127;9297.930737965085;9302.627894884265;4599.885002874955;4666.533346665306;4678.6491013174145;4693.624510039189;4714.858554243378;4146.37804329347;4146.460960075171;4173.39485774567;4181.289180839264;4185.058361868555;3283.868645254163;3571.0715214044535;3578.7673801202836;3590.622984586633;3643.2713457308646;1077.876044254905;1183.9408029598658;1208.5709573101421;1216.1547724331504;1228.9877101229051;1035.7980193862275;1045.7281106912105;1063.984040239397;1304.9934750326188;1305.2233920817098;7062.576245425291;7173.820654483576;7187.7843664690145;7223.638818059181;7235.565866048054;1092.3718861654581;1097.1442275025493;1120.081533142815;1122.6126986189752;1124.4377811094453;5477.123660214346;5548.4451554845;5568.805091821767;5599.552035837123;5610.887782244332;9066.637334506546;9177.311701622404;9605.903940960501;9606.183474404614;9606.471644059504;9227.307951903635;9483.288753343526;9484.762880928032;9495.620175193053;9503.57233924475;7256.195043964913;7283.126024877049;7307;7362.263773622595;7458.179600243969;6922.757703480354;6960.025596416607;6963.9303606963285;6995.230524642184;6999.720011199699;8257.545834978893;8349.58252087381;8499.320054395757;8630.956845215735;8641.395102342776;8701.260392866678;8727.214550690469;8730.43252188631;8826.42628229163;8844.911550884408;6461.870762584628;6608.240052394036;6619.470442364695;6619.933800661932;6621.470282377302;6329.651869147241;6483.4164925156965;7276.163241227327;7293.452991025801;7325.194228634739;6961.408280296029;6967.581945083311;7007.7196912122945;7101.573905565682;7108.573485590881;6859.142607174103;6924.965375173092;6928.480363972823;7052.224255332012;7062.1878483975;6931.896021559782;7013.964930175316;7044.682989265598;7045.1898031727005;7045.471589630695;6425.453836423956;6437.25971513282;6516.446102081376;6546.410823025951;6561.606303621798;6251.156093927261;6289.779857704958;6306.9684651576445;6404.935950640434;6411.551191416556 19:20:51 INFO - PROCESS | 15818 | |4;prototype.html;338.22883824879267;340.6933759616345;341.56109399421746;345.8460984861737;349.8250874562719;5951.1668366428685;6001.969990150049;6032.75868965242;6058.182145410368;6083.574149809515;5654.37801841797;5803.274590676166;5845.327787304462;5845.415458454152;5948.643081415118;4469.620082293;4513.074819661962;4649.093426781779;4650.581447669709;4657.604103651193;4619.630429565644;4623.722576645395;4632.258838585827;4632.4672662643725;4656.254999200129;4322.373255877896;4385.144896745136;4602.861914142564;4602.9769851150695;4618.49196588375;4428.136513379892;4467.843625473125;4478.373027776114;4482.125985432842;4511.593956543894;3941.7043721720984;3949.664278536328;3953.6639385652256;3961.5444223914333;3971.1660551284267;5648.209250704905;5655.519280861132;5665.291838520185;5665.971670141664;5669.744861481202;5188.178181060068;5260.92108618371;5269.736513174326;5274.868128296785;5331.386890507602;6292.905606415908;6294.929861923484;6297.685115744241;6308.211473565804;6314.71583778731;4455.643548516111;4457.598816106533;4462.263726485126;4462.286034234539;4464.8883777905485;6583.967080164616;6591.967040164816;6597.274299827015;6599.274079851212;6603.570767900071;4381.715188512737;4498.977505112453;4500.954990450119;4510.751908645056;4541;4590.586847183769;4595.241785105421;4595.586397224266;4596.126735920231;4599.172149013143;5299.284596579412;5303.655262408009;5308.0710875596615;5312.707801070901;5313;6211.9068213976825;6368.872622547523;6373.872522549523;6399.13611662429;6417.101605775195;1593.4184022831582;1606.6224437257235;1616.4988853455466;1617.1509957272526;1619.441292753998;1049.1397054415306;1076.903078722903;1078.6817888722846;1081.1296905990753;1099.197585762398;6000.669963151981;6029.095635654687;6048.274207095177;6066.181065556182;6071.787487437919;6547.148870646785;6549;6555.639439830759;6556;6562.639054851934;5811.3316968548315;5820.505257053198;6084.787032453932;6128.938710612926;6139.877202455926;3353.865845366158;3462.79223246606;3522.4011917974008;3524.7885126891956;3551.076720052753;6836.077129587442;6843.692033858489;6848.554843935129;6859.519833611699;6862.039314495974;6765.560238584575;6770.255271920085;6776.593404395653;6777.322267773282;6782.525223234326;6670.299618540081;6838.521303508706;6844.589324640538;6846.760363387258;6849.417799487;6548.508861835477;6586.308437613981;6591.901121483085;6595.175603049619;6595.637239951849;6448.419642232222;6471.158749362553;6517.816531461824;6521.413072823469;6534.281229064894;6664.866702665822;6844.691988860613;6858.211305699709;6863.862722745617;6866.519343645897;4560.270356742905;4567.2464043432465;4567.748773817339;4568.383268258743;4571.062932098978;6622.337766223339;6625.50308726857;6625.734970601315;6630.83422914431;6640.402363787282;6322.525810564134;6459.159139645179;6467.676616169078;6469;6469.4824414045825;6442.774502892376;6445.613263204223;6446.258680251831;6456.806295811133;6458.483321334188;6318.178636777189;6322.905156422749;6327.2407311121115;6328.050792381179;6337.683115844097;6233.376662333731;6283.392392157386;6319.936800631935;6358.650274234961;6500.5449618526245;6291.276503202191;6308.842278943063;6310.463610593151;6312.905306420499;6326.0510923360025 19:20:51 INFO - PROCESS | 15818 | |5;yui.html;819.3199644295236;825.5964710966722;830.6635812495938;839.2991851803744;851.6848765956597;12221.083418743585;12389.504419823208;12416.441260143292;12440.875591244085;12441.253524788508;11720.472578733956;11809.173357864931;11862.110341724383;11894.167408281424;11905.345206013666;808.8786681997703;831.8960129983752;832;832.1595188859235;832.6835802395082;670.6043434373719;673.9991113196899;677.9118714567124;813.048732982412;832.2592892325835;859.7850537365658;859.8753180788782;865.9220670139687;865.9610317535726;867.8698195270697;859.7549698335944;860.6170254236868;861.2033868671485;861.7716305179133;861.9482831030127;519.9688018718889;520.4769206946994;621.9315875253718;629.0469938043822;630.1524449615306;12433.564825231073;12473.75052498945;12477.50089996399;12523.060770442162;12536.686582835411;11527.538898444052;11758.941205294004;11823.822642660367;11945.761084778256;12138.08964327679;9567.330286879922;9614.278929080278;9683.757906052335;9744.95127524365;9753.951230243874;3484.7146840240853;3521.806300653463;3558.412861877813;3597.226596281786;3672.7429079964413;45151;45303.32045019327;45601;45720;45743.77128114338;9681.564329605184;9714.271429642806;9719.65981190655;9846.310758246997;10006.199504039805;16714.6657066858;16769.91615041917;16829.747553786703;16846.831531684773;16857.915710421614;7241.493095483371;7385.741499047507;7390.556566605914;7417.072865891763;7505.136909255505;4262.914741705211;4268.274393353137;4278;4304.139172165579;4319.784010799511;2907.8400687961944;2954.1580649514785;2956.024511911064;2966.1398194523777;2970.435617232719;532.3558494222035;570.2985328046526;571.0834111251464;578.1212556913468;592.3365830270125;507.73090262161116;511.81318818630933;537.7311344327836;547.2010864138323;570.9914351284734;7512.586807725627;7610.238976102345;7864.72473463426;8836.469811811183;9026.323025773094;412.57710846382696;469.5257789632428;487.5441462232824;517.2990597740084;637.8391327783389;3565.839537220779;3680.208755117609;3836.9424458633143;3855.190410013872;3870.322693528621;50892;53265.467345326826;53312.269720890254;53336.199957000674;53365;48904;49141.75429122832;49522.25716614254;49534.256986145236;50399.496005040215;41532.58467415348;41559.37660935088;41843.79078104651;42075;42433.78783106065;7619.771406857803;7647.646647346991;7745.302922736981;7776.183500732342;7784.455088143775;31843.36313273675;31858.6814131865;32134.03597892067;32457.35085298328;32506.34987300288;38743;40246;41784.58215417928;42240.15519689528;49334.25998610096;10507.211959102944;10535.683929482127;10707.304025238334;10893.56425742993;11160.776784464102;10921.126309895031;11296.322220666787;11751.412429378326;11822;12168.391580420766;10381.169506439617;10604.628837990942;10665.680029599125;10773.62292319765;11149.219554631098;10536.789264214825;10637.787244255227;10730.624428144978;10870.293430926964;11034.227604067639;9161.816763664823;9210.861837072584;9229.35394522377;9323.953380233055;9549.522523873917;8690.261327786957;8973.685920992733;8979.730608081769;9107.043760405062;9124.361294709306;8382.916170838458;8472.49165050099;8580.399372043898;8912.86630700527;9451.480168590793 19:20:51 INFO - PROCESS | 15818 | __end_tp_report 19:20:51 INFO - PROCESS | 15818 | __start_cc_report 19:20:51 INFO - PROCESS | 15818 | _x_x_mozilla_cycle_collect,714 19:20:51 INFO - PROCESS | 15818 | __end_cc_report 19:20:51 INFO - PROCESS | 15818 | __startTimestamp1452914451044__endTimestamp 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | ------- Summary: start ------- 19:20:51 INFO - PROCESS | 15818 | Number of tests: 6 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#0] dojo.html Cycles:165 Average:5094.33 Median:5284.82 stddev:548.52 (10.4%) stddev-sans-first:527.79 19:20:51 INFO - PROCESS | 15818 | Values: 3116.1 3129.9 3146.4 3161.4 3171.4 4908.7 4977.4 5040.5 5046.5 5061.4 5048.5 5079.9 5092.9 5168.8 5231.9 4596.9 4651.1 4652.3 4675.8 4754.7 4697.6 4706.9 4707.4 4766.7 4798.0 4521.6 4615.7 4683.5 4751.2 4761.2 4637.0 4642.1 4644.0 4653.6 4676.6 4638.5 4641.5 4645.6 4647.6 4674.2 4818.7 4905.2 4987.5 5056.0 5058.9 5457.8 5459.3 5463.6 5466.7 5475.2 5424.1 5496.7 5500.0 5507.8 5510.8 5094.1 5107.6 5135.6 5167.3 5171.5 5607.9 5623.4 5626.5 5630.5 5633.6 5202.2 5282.3 5395.9 5397.0 5399.7 5463.5 5531.8 5563.0 5569.3 5590.4 5422.7 5501.0 5515.8 5516.6 5527.4 5402.0 5442.6 5491.1 5506.9 5512.1 4270.3 4280.5 4284.0 4289.7 4315.3 3771.2 3845.7 3846.9 3868.8 3870.7 5019.3 5091.7 5108.7 5126.0 5128.3 5423.4 5429.4 5447.2 5450.9 5493.5 5082.9 5083.7 5088.6 5099.4 5128.7 4632.7 4664.3 4681.2 4684.7 4779.4 5677.0 5678.0 5713.3 5716.6 5720.0 5499.3 5526.5 5527.7 5531.0 5577.9 5537.4 5540.2 5584.3 5610.2 5643.2 5394.9 5419.9 5440.2 5448.5 5473.6 5337.4 5524.7 5556.6 5562.2 5609.2 5284.4 5324.6 5340.8 5341.7 5384.5 5367.9 5459.9 5463.2 5463.9 5467.5 5103.8 5181.0 5370.3 5370.8 5384.7 5316.7 5353.9 5376.4 5398.5 5426.5 5259.8 5284.7 5284.8 5286.7 5288.2 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#1] ext.html Cycles:180 Average:48622.78 Median:38239.02 stddev:84143.79 (220.0%) stddev-sans-first:84302.33 19:20:51 INFO - PROCESS | 15818 | Values: 524.5 526.9 581.4 582.5 592.2 27845.7 28232.4 28290.9 36598.6 36710.8 39157.4 39552.6 39628.8 39654.8 39678.4 8274.9 8447.2 8459.1 8464.5 8473.8 7511.5 7675.2 7678.3 9770.8 10011.7 9757.4 9840.1 9841.4 9843.7 9846.2 9804.2 9868.2 9899.5 9900.5 9903.9 9741.7 9850.0 9871.4 9874.8 9874.8 36319.5 36863.8 36925.6 40170.8 40213.0 3169.6 3257.7 3301.6 3346.4 3355.7 29651.0 29991.7 30023.0 30084.2 30826.2 3928.2 3928.5 3928.7 4005.5 4106.2 263495.0 265836.0 266899.0 266918.0 266971.0 53489.5 54633.2 60261.4 61378.7 61949.1 60329.0 60403.7 60770.4 60786.7 60880.4 14063.4 14262.6 14284.9 14372.4 14376.1 10776.0 10821.2 10827.2 10831.3 10855.5 20268.4 20498.5 20689.6 20726.0 20727.8 8012.4 8192.9 8243.2 8305.2 8310.0 889.4 985.9 997.9 1025.8 1070.6 27924.9 28167.9 28575.4 28654.9 28702.6 983.9 1025.0 1029.8 1059.5 1107.7 13779.4 16139.4 16198.8 16270.3 16566.7 383046.0 389218.0 389628.0 390131.0 391358.0 54951.5 55346.4 55634.0 55683.7 55703.4 1299.8 1318.4 1323.0 1324.9 1326.5 28881.0 30329.7 30627.7 30633.1 31044.8 42467.0 43411.1 43436.3 48334.5 49225.3 290960.0 292819.0 295585.0 296355.0 296378.0 37489.0 37771.6 38250.2 38329.0 38920.6 45010.0 45232.0 45932.8 45983.5 46240.5 37466.6 38076.8 38090.8 38227.8 39657.0 38087.0 38688.4 38856.3 39133.2 39372.6 36727.8 36996.6 37684.1 38202.2 38252.2 29271.4 31746.4 33575.0 33577.0 33664.5 24859.0 24914.6 25295.6 25485.6 25611.0 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#2] jquery.html Cycles:180 Average:28489.41 Median:265988.20 stddev:95371.63 (35.9%) stddev-sans-first:95615.76 19:20:51 INFO - PROCESS | 15818 | Values: 344.0 345.8 347.0 348.1 351.4 13661.5 14091.7 15594.1 16381.3 18416.9 14751.6 15621.7 16014.7 16226.7 16271.8 5039.0 5237.5 5304.1 5308.2 5310.0 3949.8 4097.8 5169.1 5262.4 5568.2 5700.9 5705.9 5734.1 5741.6 5745.4 5577.6 5763.1 5767.5 5767.9 5769.9 4888.3 5060.3 5089.6 5096.8 5125.8 11051.3 11654.3 11679.1 20258.0 20407.2 1993.0 2085.1 2144.2 2176.3 2267.6 8475.3 8805.0 9052.7 9159.4 12659.7 1687.9 1732.2 1785.5 1785.8 1799.2 55382.2 56380.7 57442.0 57830.7 58387.4 10099.7 10276.0 10281.8 10284.5 10345.9 13474.5 13525.9 13532.9 13544.7 13545.8 7338.7 7343.3 7364.9 7383.4 7394.8 6987.4 6989.2 6997.2 7021.9 7058.7 4451.1 4547.3 4552.4 4590.1 4599.7 1735.5 1788.7 1789.2 1796.5 1819.3 843.3 976.9 993.7 994.0 1031.2 16220.7 16685.0 16793.4 17100.2 17123.9 872.7 878.7 882.8 889.2 902.1 8851.5 9036.4 9299.2 9412.0 9602.2 526714.0 576236.0 582960.0 610907.0 616598.0 65025.0 73407.0 75695.0 76280.6 76557.6 1068.4 1106.0 1110.1 1115.7 1126.8 14326.3 15188.1 15483.3 15488.7 15507.1 33002.0 33932.5 34016.8 34043.3 34731.0 43604.0 44175.8 44715.0 44738.6 45514.0 6802.5 6868.3 6976.4 7076.8 7089.5 9103.4 9991.8 10047.6 10256.2 10649.4 7534.3 8390.5 8861.0 8925.9 9219.3 8801.9 8835.7 8891.7 9143.0 9306.3 6912.0 8752.6 9000.8 9064.8 9224.4 6541.6 6548.7 6588.2 6628.1 6730.0 7537.4 8888.5 8951.4 9043.9 9054.6 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#3] mootools.html Cycles:180 Average:5400.60 Median:6418.50 stddev:2826.39 (44.0%) stddev-sans-first:2817.76 19:20:51 INFO - PROCESS | 15818 | Values: 1330.0 1462.1 1472.6 1634.5 1806.1 6632.7 7418.6 7511.5 7580.0 7612.2 7273.8 7471.4 7472.5 7476.5 7486.3 1933.1 1966.3 1968.4 2233.3 2272.3 1995.2 2230.3 2277.9 2278.0 2278.9 2188.4 2223.4 2225.5 2226.9 2229.3 2190.5 2196.0 2196.3 2199.1 2199.2 2221.1 2279.5 2280.9 2281.2 2281.9 7567.8 7584.5 7621.2 7625.2 7656.7 4674.5 4791.1 4822.1 4824.6 4826.1 3021.4 3059.6 3075.3 3075.9 3082.8 940.1 940.3 972.8 982.5 985.2 10645.7 10743.8 10748.1 10770.2 10828.2 4285.5 4302.8 4365.2 4378.0 4381.6 9267.1 9286.6 9291.4 9297.9 9302.6 4599.9 4666.5 4678.6 4693.6 4714.9 4146.4 4146.5 4173.4 4181.3 4185.1 3283.9 3571.1 3578.8 3590.6 3643.3 1077.9 1183.9 1208.6 1216.2 1229.0 1035.8 1045.7 1064.0 1305.0 1305.2 7062.6 7173.8 7187.8 7223.6 7235.6 1092.4 1097.1 1120.1 1122.6 1124.4 5477.1 5548.4 5568.8 5599.6 5610.9 9066.6 9177.3 9605.9 9606.2 9606.5 9227.3 9483.3 9484.8 9495.6 9503.6 7256.2 7283.1 7307.0 7362.3 7458.2 6922.8 6960.0 6963.9 6995.2 6999.7 8257.5 8349.6 8499.3 8631.0 8641.4 8701.3 8727.2 8730.4 8826.4 8844.9 6461.9 6608.2 6619.5 6619.9 6621.5 6329.7 6483.4 7276.2 7293.5 7325.2 6961.4 6967.6 7007.7 7101.6 7108.6 6859.1 6925.0 6928.5 7052.2 7062.2 6931.9 7014.0 7044.7 7045.2 7045.5 6425.5 6437.3 6516.4 6546.4 6561.6 6251.2 6289.8 6307.0 6404.9 6411.6 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#4] prototype.html Cycles:180 Average:5320.33 Median:6030.93 stddev:1611.66 (26.7%) stddev-sans-first:1572.20 19:20:51 INFO - PROCESS | 15818 | Values: 338.2 340.7 341.6 345.8 349.8 5951.2 6002.0 6032.8 6058.2 6083.6 5654.4 5803.3 5845.3 5845.4 5948.6 4469.6 4513.1 4649.1 4650.6 4657.6 4619.6 4623.7 4632.3 4632.5 4656.3 4322.4 4385.1 4602.9 4603.0 4618.5 4428.1 4467.8 4478.4 4482.1 4511.6 3941.7 3949.7 3953.7 3961.5 3971.2 5648.2 5655.5 5665.3 5666.0 5669.7 5188.2 5260.9 5269.7 5274.9 5331.4 6292.9 6294.9 6297.7 6308.2 6314.7 4455.6 4457.6 4462.3 4462.3 4464.9 6584.0 6592.0 6597.3 6599.3 6603.6 4381.7 4499.0 4501.0 4510.8 4541.0 4590.6 4595.2 4595.6 4596.1 4599.2 5299.3 5303.7 5308.1 5312.7 5313.0 6211.9 6368.9 6373.9 6399.1 6417.1 1593.4 1606.6 1616.5 1617.2 1619.4 1049.1 1076.9 1078.7 1081.1 1099.2 6000.7 6029.1 6048.3 6066.2 6071.8 6547.1 6549.0 6555.6 6556.0 6562.6 5811.3 5820.5 6084.8 6128.9 6139.9 3353.9 3462.8 3522.4 3524.8 3551.1 6836.1 6843.7 6848.6 6859.5 6862.0 6765.6 6770.3 6776.6 6777.3 6782.5 6670.3 6838.5 6844.6 6846.8 6849.4 6548.5 6586.3 6591.9 6595.2 6595.6 6448.4 6471.2 6517.8 6521.4 6534.3 6664.9 6844.7 6858.2 6863.9 6866.5 4560.3 4567.2 4567.7 4568.4 4571.1 6622.3 6625.5 6625.7 6630.8 6640.4 6322.5 6459.2 6467.7 6469.0 6469.5 6442.8 6445.6 6446.3 6456.8 6458.5 6318.2 6322.9 6327.2 6328.1 6337.7 6233.4 6283.4 6319.9 6358.7 6500.5 6291.3 6308.8 6310.5 6312.9 6326.1 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - PROCESS | 15818 | [#5] yui.html Cycles:180 Average:12894.06 Median:49428.26 stddev:14912.07 (30.2%) stddev-sans-first:14926.34 19:20:51 INFO - PROCESS | 15818 | Values: 819.3 825.6 830.7 839.3 851.7 12221.1 12389.5 12416.4 12440.9 12441.3 11720.5 11809.2 11862.1 11894.2 11905.3 808.9 831.9 832.0 832.2 832.7 670.6 674.0 677.9 813.0 832.3 859.8 859.9 865.9 866.0 867.9 859.8 860.6 861.2 861.8 861.9 520.0 520.5 621.9 629.0 630.2 12433.6 12473.8 12477.5 12523.1 12536.7 11527.5 11758.9 11823.8 11945.8 12138.1 9567.3 9614.3 9683.8 9745.0 9754.0 3484.7 3521.8 3558.4 3597.2 3672.7 45151.0 45303.3 45601.0 45720.0 45743.8 9681.6 9714.3 9719.7 9846.3 10006.2 16714.7 16769.9 16829.7 16846.8 16857.9 7241.5 7385.7 7390.6 7417.1 7505.1 4262.9 4268.3 4278.0 4304.1 4319.8 2907.8 2954.2 2956.0 2966.1 2970.4 532.4 570.3 571.1 578.1 592.3 507.7 511.8 537.7 547.2 571.0 7512.6 7610.2 7864.7 8836.5 9026.3 412.6 469.5 487.5 517.3 637.8 3565.8 3680.2 3836.9 3855.2 3870.3 50892.0 53265.5 53312.3 53336.2 53365.0 48904.0 49141.8 49522.3 49534.3 50399.5 41532.6 41559.4 41843.8 42075.0 42433.8 7619.8 7647.6 7745.3 7776.2 7784.5 31843.4 31858.7 32134.0 32457.4 32506.3 38743.0 40246.0 41784.6 42240.2 49334.3 10507.2 10535.7 10707.3 10893.6 11160.8 10921.1 11296.3 11751.4 11822.0 12168.4 10381.2 10604.6 10665.7 10773.6 11149.2 10536.8 10637.8 10730.6 10870.3 11034.2 9161.8 9210.9 9229.4 9324.0 9549.5 8690.3 8973.7 8979.7 9107.0 9124.4 8382.9 8472.5 8580.4 8912.9 9451.5 19:20:51 INFO - PROCESS | 15818 | -------- Summary: end -------- 19:20:51 INFO - PROCESS | 15818 | 19:20:51 INFO - TEST-INFO | 15818: exit 0 19:20:51 INFO - TEST-OK | dromaeo_css | took 1112099ms 19:20:51 INFO - TEST-START | kraken 19:20:51 INFO - operating with platform_type : linux_ 19:20:51 INFO - Initialising browser for kraken test... 19:20:51 INFO - TEST-INFO | started process 16018 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoatlN7/profile http://localhost:35015/getInfo.html) 19:20:55 INFO - PROCESS | 16018 | __metrics Screen width/height:1600/1200 19:20:55 INFO - PROCESS | 16018 | colorDepth:24 19:20:55 INFO - PROCESS | 16018 | Browser inner width/height: 1024/697 19:20:55 INFO - PROCESS | 16018 | __metrics 19:20:55 INFO - PROCESS | 16018 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:20:55 INFO - PROCESS | 16018 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:20:56 INFO - TEST-INFO | 16018: exit 0 19:20:56 INFO - Browser initialized. 19:20:56 INFO - Running cycle 1/1 for kraken test... 19:20:56 INFO - TEST-INFO | started process 16102 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoatlN7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:08 INFO - PROCESS | 16102 | RSS: Main: 149807104 19:21:08 INFO - PROCESS | 16102 | 19:21:10 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35015/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:11 INFO - PROCESS | 16102 | RSS: Main: 186470400 19:21:11 INFO - PROCESS | 16102 | 19:21:14 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35015/tests/kraken/driver.html?testName=audio-dft) 19:21:14 INFO - PROCESS | 16102 | RSS: Main: 175841280 19:21:14 INFO - PROCESS | 16102 | 19:21:17 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35015/tests/kraken/driver.html?testName=audio-fft) 19:21:18 INFO - PROCESS | 16102 | RSS: Main: 160907264 19:21:18 INFO - PROCESS | 16102 | 19:21:20 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35015/tests/kraken/driver.html?testName=audio-oscillator) 19:21:20 INFO - PROCESS | 16102 | RSS: Main: 163475456 19:21:20 INFO - PROCESS | 16102 | 19:21:23 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:23 INFO - PROCESS | 16102 | RSS: Main: 164577280 19:21:23 INFO - PROCESS | 16102 | 19:21:26 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35015/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:27 INFO - PROCESS | 16102 | RSS: Main: 166277120 19:21:27 INFO - PROCESS | 16102 | 19:21:30 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35015/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:31 INFO - PROCESS | 16102 | RSS: Main: 165281792 19:21:31 INFO - PROCESS | 16102 | 19:21:33 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35015/tests/kraken/driver.html?testName=json-parse-financial) 19:21:34 INFO - PROCESS | 16102 | RSS: Main: 165081088 19:21:34 INFO - PROCESS | 16102 | 19:21:35 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:36 INFO - PROCESS | 16102 | RSS: Main: 175857664 19:21:36 INFO - PROCESS | 16102 | 19:21:38 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:38 INFO - PROCESS | 16102 | RSS: Main: 172793856 19:21:38 INFO - PROCESS | 16102 | 19:21:40 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:21:41 INFO - PROCESS | 16102 | RSS: Main: 184463360 19:21:41 INFO - PROCESS | 16102 | 19:21:43 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:21:44 INFO - PROCESS | 16102 | RSS: Main: 190296064 19:21:44 INFO - PROCESS | 16102 | 19:21:46 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:21:47 INFO - PROCESS | 16102 | RSS: Main: 188510208 19:21:47 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | Cycle 1(1): loaded http://localhost:35015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35015/tests/kraken/driver.html?testName=ai-astar) 19:21:49 INFO - PROCESS | 16102 | RSS: Main: 246939648 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | __start_tp_report 19:21:49 INFO - PROCESS | 16102 | _x_x_mozilla_page_load 19:21:49 INFO - PROCESS | 16102 | _x_x_mozilla_page_load_details 19:21:49 INFO - PROCESS | 16102 | |i|pagename|runs| 19:21:49 INFO - PROCESS | 16102 | |0;ai-astar;109;111;104;109;110;110;99;109;111;109 19:21:49 INFO - PROCESS | 16102 | |1;audio-beat-detection;152;126;148;161;128;151;152;125;171;124 19:21:49 INFO - PROCESS | 16102 | |2;audio-dft;160;159;161;160;161;168;160;164;169;162 19:21:49 INFO - PROCESS | 16102 | |3;audio-fft;74;72;95;92;73;73;72;109;97;85 19:21:49 INFO - PROCESS | 16102 | |4;audio-oscillator;96;96;139;95;96;96;140;95;95;136 19:21:49 INFO - PROCESS | 16102 | |5;imaging-gaussian-blur;109;109;110;110;110;110;111;110;110;110 19:21:49 INFO - PROCESS | 16102 | |6;imaging-darkroom;147;145;145;145;145;146;146;146;145;145 19:21:49 INFO - PROCESS | 16102 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;96;96 19:21:49 INFO - PROCESS | 16102 | |8;json-parse-financial;56;55;57;55;55;55;57;64;53;55 19:21:49 INFO - PROCESS | 16102 | |9;json-stringify-tinderbox;67;68;66;67;67;67;67;67;67;71 19:21:49 INFO - PROCESS | 16102 | |10;stanford-crypto-aes;80;82;82;82;89;90;83;82;83;81 19:21:49 INFO - PROCESS | 16102 | |11;stanford-crypto-ccm;119;122;119;117;126;114;119;113;114;118 19:21:49 INFO - PROCESS | 16102 | |12;stanford-crypto-pbkdf2;135;143;142;142;143;137;144;142;146;145 19:21:49 INFO - PROCESS | 16102 | |13;stanford-crypto-sha256-iterative;69;67;68;72;68;68;65;69;66;67 19:21:49 INFO - PROCESS | 16102 | __end_tp_report 19:21:49 INFO - PROCESS | 16102 | __start_cc_report 19:21:49 INFO - PROCESS | 16102 | _x_x_mozilla_cycle_collect,968 19:21:49 INFO - PROCESS | 16102 | __end_cc_report 19:21:49 INFO - PROCESS | 16102 | __startTimestamp1452914509436__endTimestamp 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | ------- Summary: start ------- 19:21:49 INFO - PROCESS | 16102 | Number of tests: 14 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.97 19:21:49 INFO - PROCESS | 16102 | Values: 109.0 111.0 104.0 109.0 110.0 110.0 99.0 109.0 111.0 109.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.50 stddev:16.84 (11.1%) stddev-sans-first:17.60 19:21:49 INFO - PROCESS | 16102 | Values: 152.0 126.0 148.0 161.0 128.0 151.0 152.0 125.0 171.0 124.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#2] audio-dft Cycles:10 Average:162.40 Median:161.50 stddev:3.50 (2.2%) stddev-sans-first:3.61 19:21:49 INFO - PROCESS | 16102 | Values: 160.0 159.0 161.0 160.0 161.0 168.0 160.0 164.0 169.0 162.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#3] audio-fft Cycles:10 Average:84.20 Median:79.50 stddev:13.37 (16.8%) stddev-sans-first:13.67 19:21:49 INFO - PROCESS | 16102 | Values: 74.0 72.0 95.0 92.0 73.0 73.0 72.0 109.0 97.0 85.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:95.50 stddev:20.68 (21.7%) stddev-sans-first:21.45 19:21:49 INFO - PROCESS | 16102 | Values: 96.0 96.0 139.0 95.0 96.0 96.0 140.0 95.0 95.0 136.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 19:21:49 INFO - PROCESS | 16102 | Values: 109.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 19:21:49 INFO - PROCESS | 16102 | Values: 147.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:21:49 INFO - PROCESS | 16102 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:2.97 (5.4%) stddev-sans-first:3.15 19:21:49 INFO - PROCESS | 16102 | Values: 56.0 55.0 57.0 55.0 55.0 55.0 57.0 64.0 53.0 55.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 19:21:49 INFO - PROCESS | 16102 | Values: 67.0 68.0 66.0 67.0 67.0 67.0 67.0 67.0 67.0 71.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.34 (4.0%) stddev-sans-first:3.31 19:21:49 INFO - PROCESS | 16102 | Values: 80.0 82.0 82.0 82.0 89.0 90.0 83.0 82.0 83.0 81.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:119.00 stddev:3.96 (3.3%) stddev-sans-first:4.18 19:21:49 INFO - PROCESS | 16102 | Values: 119.0 122.0 119.0 117.0 126.0 114.0 119.0 113.0 114.0 118.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:143.00 stddev:3.41 (2.4%) stddev-sans-first:2.55 19:21:49 INFO - PROCESS | 16102 | Values: 135.0 143.0 142.0 142.0 143.0 137.0 144.0 142.0 146.0 145.0 19:21:49 INFO - PROCESS | 16102 | 19:21:49 INFO - PROCESS | 16102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.91 (2.8%) stddev-sans-first:1.99 19:21:49 INFO - PROCESS | 16102 | Values: 69.0 67.0 68.0 72.0 68.0 68.0 65.0 69.0 66.0 67.0 19:21:49 INFO - PROCESS | 16102 | -------- Summary: end -------- 19:21:49 INFO - PROCESS | 16102 | 19:21:50 INFO - TEST-INFO | 16102: exit 0 19:21:50 INFO - TEST-OK | kraken | took 58590ms 19:21:50 INFO - TEST-START | v8_7 19:21:50 INFO - operating with platform_type : linux_ 19:21:50 INFO - Initialising browser for v8_7 test... 19:21:50 INFO - TEST-INFO | started process 16352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUeb5Rl/profile http://localhost:35015/getInfo.html) 19:21:54 INFO - PROCESS | 16352 | __metrics Screen width/height:1600/1200 19:21:54 INFO - PROCESS | 16352 | colorDepth:24 19:21:54 INFO - PROCESS | 16352 | Browser inner width/height: 1024/697 19:21:54 INFO - PROCESS | 16352 | __metrics 19:21:54 INFO - PROCESS | 16352 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:21:54 INFO - PROCESS | 16352 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:21:55 INFO - TEST-INFO | 16352: exit 0 19:21:55 INFO - Browser initialized. 19:21:55 INFO - Running cycle 1/1 for v8_7 test... 19:21:55 INFO - TEST-INFO | started process 16432 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUeb5Rl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:07 INFO - PROCESS | 16432 | RSS: Main: 150384640 19:22:07 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | Cycle 1(1): loaded http://localhost:35015/tests/v8_7/run.html (next: http://localhost:35015/tests/v8_7/run.html) 19:22:29 INFO - PROCESS | 16432 | RSS: Main: 593797120 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | __start_tp_report 19:22:29 INFO - PROCESS | 16432 | _x_x_mozilla_page_load 19:22:29 INFO - PROCESS | 16432 | _x_x_mozilla_page_load_details 19:22:29 INFO - PROCESS | 16432 | |i|pagename|runs| 19:22:29 INFO - PROCESS | 16432 | |0;Richards;169.26201760324983 19:22:29 INFO - PROCESS | 16432 | |1;DeltaBlue;189.465706707086 19:22:29 INFO - PROCESS | 16432 | |2;Encrypt;279.6420581655481 19:22:29 INFO - PROCESS | 16432 | |3;Decrypt;5159.79381443299 19:22:29 INFO - PROCESS | 16432 | |4;RayTrace;1970.4724409448818 19:22:29 INFO - PROCESS | 16432 | |5;Earley;788.6435331230284 19:22:29 INFO - PROCESS | 16432 | |6;Boyer;12219.512195121952 19:22:29 INFO - PROCESS | 16432 | |7;RegExp;42936.17021276596 19:22:29 INFO - PROCESS | 16432 | |8;Splay;643.7299035369775 19:22:29 INFO - PROCESS | 16432 | |9;NavierStokes;4822.115384615385 19:22:29 INFO - PROCESS | 16432 | __end_tp_report 19:22:29 INFO - PROCESS | 16432 | __startTimestamp1452914549843__endTimestamp 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | ------- Summary: start ------- 19:22:29 INFO - PROCESS | 16432 | Number of tests: 10 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#0] Richards Cycles:1 Average:169.26 Median:169.26 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 169.3 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#1] DeltaBlue Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 189.5 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 279.6 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 5159.8 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 1970.5 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 788.6 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 12219.5 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#7] RegExp Cycles:1 Average:42936.17 Median:42936.17 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 42936.2 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#8] Splay Cycles:1 Average:643.73 Median:643.73 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 643.7 19:22:29 INFO - PROCESS | 16432 | 19:22:29 INFO - PROCESS | 16432 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 19:22:29 INFO - PROCESS | 16432 | Values: 4822.1 19:22:29 INFO - PROCESS | 16432 | -------- Summary: end -------- 19:22:29 INFO - PROCESS | 16432 | 19:22:30 INFO - TEST-INFO | 16432: exit 0 19:22:30 INFO - TEST-OK | v8_7 | took 40429ms 19:22:30 INFO - SUITE-END | took 1211s 19:22:30 INFO - Completed test suite (00:20:11) 19:22:30 INFO - Working with test: dromaeo_css 19:22:30 INFO - Generating results file: dromaeo_css 19:22:30 INFO - Working with test: kraken 19:22:30 INFO - Generating results file: kraken 19:22:30 INFO - javascript benchmark 19:22:30 INFO - Working with test: v8_7 19:22:30 INFO - Generating results file: v8_7 19:22:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 19:22:30 INFO - process_Request line: dromaeo_css 6756.98 graph.html#tests=[[72,1,35]] 19:22:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:31 INFO - process_Request line: kraken 1493.00 graph.html#tests=[[232,1,35]] 19:22:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:22:31 INFO - process_Request line: v8_7 18759.11 graph.html#tests=[[230,1,35]] 19:22:31 INFO - RETURN: dromaeo_css: 6756.98 19:22:31 INFO - RETURN: kraken: 1493.00 19:22:31 INFO - RETURN: v8_7: 18759.11 19:22:31 INFO - javascript benchmark 19:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3116.065180445867, 3129.8591563379646, 3146.386454641346, 3161.399334126516, 3171.3657268546294, 4908.705477671342, 4977.427595826481, 5040.546350828425, 5046.54581087702, 5061.417936937253, 5048.545630893219, 5079.898402031957, 5092.898142037157, 5168.767405466753, 5231.895362092765, 4596.885077873047, 4651.093036857814, 4652.348671186037, 4675.836345727883, 4754.690945088575, 4697.624190064804, 4706.882327941795, 4707.411573553306, 4766.666333356667, 4798.040391921612, 4521.5930566249035, 4615.723056616614, 4683.508231635663, 4751.192297309466, 4761.166795810719, 4637.0, 4642.094791515656, 4644.0, 4653.604443622262, 4676.579107880273, 4638.489766125724, 4641.466231383401, 4645.581897629229, 4647.60495357895, 4674.228752255874, 4818.662693611449, 4905.23968784839, 4987.47631498691, 5056.0, 5058.949410505885, 5457.836264912059, 5459.344878614552, 5463.562914966793, 5466.699331536764, 5475.151351540518, 5424.105022671254, 5496.670199787985, 5499.972500137514, 5507.834764957058, 5510.8071217507195, 5094.083065048327, 5107.591392688613, 5135.563477104413, 5167.3282473278605, 5171.50870667286, 5607.943920560824, 5623.381428042912, 5626.521745651666, 5630.493255606933, 5633.633813802172, 5202.2456743771945, 5282.286891269629, 5395.892082158335, 5397.001554712391, 5399.70301633414, 5463.48096930791, 5531.778728850882, 5562.97218513913, 5569.331680198402, 5590.413006634326, 5422.674639521641, 5501.037318469252, 5515.834524964257, 5516.641418307878, 5527.419620939824, 5402.0, 5442.6462279951675, 5491.121420572769, 5506.944930550643, 5512.145617429305, 4270.274053410928, 4280.464941882203, 4284.014676624394, 4289.678274129453, 4315.331123675835, 3771.17034252464, 3845.692344612424, 3846.8845934622004, 3868.787216703052, 3870.729048966545, 5019.272205530177, 5091.719955402488, 5108.744562771846, 5126.0, 5128.3333166688835, 5423.376311724202, 5429.375621803543, 5447.237386765856, 5450.8909821803345, 5493.478119578634, 5082.872928176751, 5083.69497830124, 5088.618353623493, 5099.388073431212, 5128.666636668605, 4632.72203667781, 4664.323673067386, 4681.227597446451, 4684.672072954861, 4779.378680771478, 5676.971615141898, 5677.971610141923, 5713.342965558931, 5716.628419152658, 5720.0, 5499.312585926759, 5526.50261476469, 5527.723613819373, 5531.0, 5577.888442231214, 5537.36320323168, 5540.196671482532, 5584.301962254718, 5610.242617246783, 5643.238162847963, 5394.919076213781, 5419.918701219406, 5440.156775699773, 5448.45515448452, 5473.589480788877, 5337.386200586827, 5524.723763811713, 5556.638818476786, 5562.16567514876, 5609.186667933045, 5284.365876094893, 5324.627276090791, 5340.813071542478, 5341.7062061586985, 5384.515393614593, 5367.946320536901, 5459.863503412446, 5463.153211252262, 5463.890722185613, 5467.45325467466, 5103.795848166032, 5180.963807238492, 5370.3287089113865, 5370.758315875873, 5384.730763461889, 5316.734163291742, 5353.866153346197, 5376.408595054619, 5398.46015398457, 5426.511613954763, 5259.8422047338645, 5284.735763211901, 5284.81503147388, 5286.682799032071, 5288.206768984683], "unit": "score", "name": "dojo.html", "value": 5060.317448938037}, {"lowerIsBetter": false, "replicates": [524.5200641413107, 526.9288646032787, 581.4272941152965, 582.5252419278289, 592.2241863159262, 27845.72154278459, 28232.43535129299, 28290.858545707244, 36598.63401365985, 36710.8164459178, 39157.41263881044, 39552.60447395525, 39628.80185599075, 39654.80172599133, 39678.40482392767, 8274.875876861866, 8447.23974842264, 8459.11179326171, 8464.534450605213, 8473.788155296104, 7511.511751736147, 7675.194104619019, 7678.308952194301, 9770.755731106708, 10011.749706257366, 9757.365771224882, 9840.114389704926, 9841.360311579725, 9843.655472058479, 9846.212303015742, 9804.166645835077, 9868.161206297473, 9899.505024748734, 9900.45547494884, 9903.90096099037, 9741.659041933499, 9849.950750246275, 9871.40771553702, 9874.802503949953, 9874.802503949953, 36319.4552081719, 36863.81568092143, 36925.63074369276, 40170.79060651663, 40213.0, 3169.6196456425378, 3257.7068063874367, 3301.554290170844, 3346.380919529895, 3355.697987181141, 29651.0, 29991.70008299911, 30023.0, 30084.24789380261, 30826.229344266347, 3928.1750832325247, 3928.5482169550583, 3928.666063384616, 4005.499312585927, 4106.240345536055, 263495.0, 265836.0, 266899.0, 266918.0, 266971.0, 53489.46510534923, 54633.1805022925, 60261.39738602645, 61378.69310653507, 61949.07076393858, 60329.0, 60403.69798150981, 60770.392296076476, 60786.696066519384, 60880.391196087476, 14063.437462501386, 14262.57212283633, 14284.928575357264, 14372.35324410404, 14376.137431754129, 10776.0, 10821.188410869216, 10827.187960902964, 10831.2959657622, 10855.45722713877, 20268.391948241577, 20498.487537811376, 20689.58620827605, 20726.0, 20727.79272207289, 8012.399070069651, 8192.877106843402, 8243.216894395024, 8305.211004954519, 8310.0, 889.3996552327153, 985.8619793228954, 997.9122756195782, 1025.779457416659, 1070.577122036791, 27924.860375698398, 28167.859160704065, 28575.428491430055, 28654.85672571624, 28702.569461458093, 983.8819341678901, 1024.9846252306222, 1029.8146333660013, 1059.5338051257422, 1107.6566264458045, 13779.379927903268, 16139.354425822836, 16198.838011619968, 16270.26783794732, 16566.66866662684, 383046.0, 389218.0, 389628.0, 390131.0, 391358.0, 54951.450485495436, 55346.44653553413, 55634.0, 55683.72158139183, 55703.442965569826, 1299.7660421124099, 1318.413306078805, 1323.0341850449033, 1324.9337533123305, 1326.5025615394227, 28881.0, 30329.69670303269, 30627.693723062483, 30633.09870420722, 31044.844775775975, 42467.0, 43411.131777364906, 43436.34845477383, 48334.516654833, 49225.261621075, 290960.0, 292819.0, 295585.0, 296355.0, 296378.0, 37489.0, 37771.62228377681, 38250.23499529938, 38329.0, 38920.6107938917, 45010.0, 45232.0, 45932.7703361481, 45983.54016459793, 46240.53759462362, 37466.625333747405, 38076.809615951744, 38090.80954595209, 38227.80886095663, 39657.0, 38087.0, 38688.41967370548, 38856.337239531436, 39133.21733565256, 39372.60627393689, 36727.81636091803, 36996.630033699315, 37684.05789855275, 38202.23595528129, 38252.2349553013, 29271.414571708872, 31746.365072698878, 33575.0, 33577.0, 33664.49503257502, 24859.0, 24914.626280606168, 25295.620565691897, 25485.61771573465, 25611.0], "unit": "score", "name": "ext.html", "value": 18810.46168360083}, {"lowerIsBetter": false, "replicates": [343.9535662685537, 345.81558163290725, 346.96877281044704, 348.0532950374979, 351.3991075261303, 13661.453541858315, 14091.718165636681, 15594.14232217229, 16381.262843172057, 18416.907915460422, 14751.557453276391, 15621.68756624867, 16014.679706405894, 16226.675466490664, 16271.83728162718, 5039.0425819094435, 5237.45006774289, 5304.124819404794, 5308.177232528964, 5309.973450132744, 3949.8025098744947, 4097.79511024449, 5169.121249387613, 5262.394824595182, 5568.220449137124, 5700.8859822803515, 5705.942940570582, 5734.13987901816, 5741.626794258381, 5745.425457454242, 5577.581681373893, 5763.135529670583, 5767.538596912237, 5767.884642307173, 5769.913451298213, 4888.340074089988, 5060.316857224265, 5089.592832573385, 5096.79612815487, 5125.846224613268, 11051.336919784839, 11654.30074195551, 11679.124065695107, 20258.0, 20407.183712651626, 1992.9501762456055, 2085.09298455171, 2144.2066435418838, 2176.260071575656, 2267.6391279688714, 8475.321974242046, 8804.955975220148, 9052.683156089572, 9159.35884488086, 12659.74680506394, 1687.8649708023452, 1732.1858726398573, 1785.4911350265113, 1785.8214178582168, 1799.1543974332044, 55382.16926746102, 56380.718096409255, 57442.0, 57830.7108464455, 58387.41612583862, 10099.747506312255, 10276.0, 10281.845772313422, 10284.537195826206, 10345.94827025875, 13474.52839150625, 13525.932370338085, 13532.93233533826, 13544.661383465294, 13545.796813047813, 7338.70645174187, 7343.32411465772, 7364.93386803495, 7383.372413344819, 7394.815129621695, 6987.371136597629, 6989.196242432084, 6997.230304666483, 7021.89467157993, 7058.71765129389, 4451.065276292015, 4547.272436410159, 4552.362669226311, 4590.081983603292, 4599.701019433793, 1735.548757323105, 1788.678037953155, 1789.2395731813926, 1796.4520821149674, 1819.2813838533705, 843.304273973974, 976.858355538443, 993.7118235711707, 994.0, 1031.2265800649513, 16220.7290979263, 16685.0, 16793.41223057187, 17100.230489627997, 17123.91438042827, 872.6683860133109, 878.6748902905965, 882.849915514364, 889.1730690457936, 902.1294450854956, 8851.46891186531, 9036.412633178823, 9299.209567186865, 9411.952940235255, 9602.183814375856, 526714.0, 576236.0, 582960.0, 610907.0, 616598.0, 65025.0, 73407.0, 75695.0, 76280.61859690666, 76557.6172119147, 1068.3643232276784, 1106.0266965070687, 1110.1063643766684, 1115.7043383503378, 1126.79717650822, 14326.296884095038, 15188.088714677155, 15483.30325135349, 15488.690226195187, 15507.094166138255, 33002.0, 33932.49101263532, 34016.82991585026, 34043.31913361669, 34731.0, 43604.0, 44175.77912110419, 44715.0, 44738.55261447344, 45514.0, 6802.523823332319, 6868.313168683092, 6976.407005404598, 7076.823079423056, 7089.468289878177, 9103.408278461879, 9991.800163996824, 10047.648332308334, 10256.17950563968, 10649.414282214553, 7534.345842266606, 8390.496570205807, 8861.0, 8925.910740892508, 9219.262459003397, 8801.867971980297, 8835.69075082369, 8891.73324800257, 9143.039980802187, 9306.255499559884, 6911.965440172969, 8752.64989400417, 9000.774980625536, 9064.773380665536, 9224.354295199271, 6541.574797638138, 6548.672566371758, 6588.176477940257, 6628.138342015507, 6729.966350168414, 7537.397008239437, 8888.466691998501, 8951.41815781998, 9043.90956090457, 9054.637814487347], "unit": "score", "name": "jquery.html", "value": 7940.872489067042}, {"lowerIsBetter": false, "replicates": [1329.9800502992464, 1462.0861961274204, 1472.5729538433854, 1634.5178172439137, 1806.0698740148825, 6632.70152843122, 7418.629068546571, 7511.474196806225, 7580.014598102246, 7612.238776122399, 7273.781786546412, 7471.439642026842, 7472.514286571369, 7476.476646634737, 7486.326230639242, 1933.1494142577221, 1966.3117908731901, 1968.35044435336, 2233.2853486884164, 2272.318304508649, 1995.1520603743425, 2230.297456301268, 2277.8519396239276, 2277.9886100569474, 2278.943026424344, 2188.3544354415408, 2223.399682085836, 2225.5326381459913, 2226.899789509476, 2229.2532001779423, 2190.507135894427, 2195.9890200549053, 2196.2971849008322, 2199.14233448955, 2199.186301068607, 2221.0671517962332, 2279.4757205842748, 2280.908763649452, 2281.1559722902466, 2281.851679640818, 7567.810804729926, 7584.54492730438, 7621.199774023758, 7625.199354067799, 7656.655450504741, 4674.532546745332, 4791.113643975876, 4822.059698358821, 4824.565789079, 4826.0830442215865, 3021.3504096619113, 3059.571659967606, 3075.3388021575247, 3075.8923437679796, 3082.7533797296164, 940.1303793990531, 940.2665920581957, 972.7665360313545, 982.4940155819759, 985.1675334342469, 10645.722513298377, 10743.78512429747, 10748.140148788156, 10770.192235582284, 10828.18788590851, 4285.46431696038, 4302.827886884552, 4365.214261432972, 4378.036831896978, 4381.561843815657, 9267.073292670679, 9286.628534858664, 9291.396059256127, 9297.930737965085, 9302.627894884265, 4599.885002874955, 4666.533346665306, 4678.6491013174145, 4693.624510039189, 4714.858554243378, 4146.37804329347, 4146.460960075171, 4173.39485774567, 4181.289180839264, 4185.058361868555, 3283.868645254163, 3571.0715214044535, 3578.7673801202836, 3590.622984586633, 3643.2713457308646, 1077.876044254905, 1183.9408029598658, 1208.5709573101421, 1216.1547724331504, 1228.9877101229051, 1035.7980193862275, 1045.7281106912105, 1063.984040239397, 1304.9934750326188, 1305.2233920817098, 7062.576245425291, 7173.820654483576, 7187.7843664690145, 7223.638818059181, 7235.565866048054, 1092.3718861654581, 1097.1442275025493, 1120.081533142815, 1122.6126986189752, 1124.4377811094453, 5477.123660214346, 5548.4451554845, 5568.805091821767, 5599.552035837123, 5610.887782244332, 9066.637334506546, 9177.311701622404, 9605.903940960501, 9606.183474404614, 9606.471644059504, 9227.307951903635, 9483.288753343526, 9484.762880928032, 9495.620175193053, 9503.57233924475, 7256.195043964913, 7283.126024877049, 7307.0, 7362.263773622595, 7458.179600243969, 6922.757703480354, 6960.025596416607, 6963.9303606963285, 6995.230524642184, 6999.720011199699, 8257.545834978893, 8349.58252087381, 8499.320054395757, 8630.956845215735, 8641.395102342776, 8701.260392866678, 8727.214550690469, 8730.43252188631, 8826.42628229163, 8844.911550884408, 6461.870762584628, 6608.240052394036, 6619.470442364695, 6619.933800661932, 6621.470282377302, 6329.651869147241, 6483.4164925156965, 7276.163241227327, 7293.452991025801, 7325.194228634739, 6961.408280296029, 6967.581945083311, 7007.7196912122945, 7101.573905565682, 7108.573485590881, 6859.142607174103, 6924.965375173092, 6928.480363972823, 7052.224255332012, 7062.1878483975, 6931.896021559782, 7013.964930175316, 7044.682989265598, 7045.1898031727005, 7045.471589630695, 6425.453836423956, 6437.25971513282, 6516.446102081376, 6546.410823025951, 6561.606303621798, 6251.156093927261, 6289.779857704958, 6306.9684651576445, 6404.935950640434, 6411.551191416556], "unit": "score", "name": "mootools.html", "value": 4426.379154801405}, {"lowerIsBetter": false, "replicates": [338.22883824879267, 340.6933759616345, 341.56109399421746, 345.8460984861737, 349.8250874562719, 5951.1668366428685, 6001.969990150049, 6032.75868965242, 6058.182145410368, 6083.574149809515, 5654.37801841797, 5803.274590676166, 5845.327787304462, 5845.415458454152, 5948.643081415118, 4469.620082293, 4513.074819661962, 4649.093426781779, 4650.581447669709, 4657.604103651193, 4619.630429565644, 4623.722576645395, 4632.258838585827, 4632.4672662643725, 4656.254999200129, 4322.373255877896, 4385.144896745136, 4602.861914142564, 4602.9769851150695, 4618.49196588375, 4428.136513379892, 4467.843625473125, 4478.373027776114, 4482.125985432842, 4511.593956543894, 3941.7043721720984, 3949.664278536328, 3953.6639385652256, 3961.5444223914333, 3971.1660551284267, 5648.209250704905, 5655.519280861132, 5665.291838520185, 5665.971670141664, 5669.744861481202, 5188.178181060068, 5260.92108618371, 5269.736513174326, 5274.868128296785, 5331.386890507602, 6292.905606415908, 6294.929861923484, 6297.685115744241, 6308.211473565804, 6314.71583778731, 4455.643548516111, 4457.598816106533, 4462.263726485126, 4462.286034234539, 4464.8883777905485, 6583.967080164616, 6591.967040164816, 6597.274299827015, 6599.274079851212, 6603.570767900071, 4381.715188512737, 4498.977505112453, 4500.954990450119, 4510.751908645056, 4541.0, 4590.586847183769, 4595.241785105421, 4595.586397224266, 4596.126735920231, 4599.172149013143, 5299.284596579412, 5303.655262408009, 5308.0710875596615, 5312.707801070901, 5313.0, 6211.9068213976825, 6368.872622547523, 6373.872522549523, 6399.13611662429, 6417.101605775195, 1593.4184022831582, 1606.6224437257235, 1616.4988853455466, 1617.1509957272526, 1619.441292753998, 1049.1397054415306, 1076.903078722903, 1078.6817888722846, 1081.1296905990753, 1099.197585762398, 6000.669963151981, 6029.095635654687, 6048.274207095177, 6066.181065556182, 6071.787487437919, 6547.148870646785, 6549.0, 6555.639439830759, 6556.0, 6562.639054851934, 5811.3316968548315, 5820.505257053198, 6084.787032453932, 6128.938710612926, 6139.877202455926, 3353.865845366158, 3462.79223246606, 3522.4011917974008, 3524.7885126891956, 3551.076720052753, 6836.077129587442, 6843.692033858489, 6848.554843935129, 6859.519833611699, 6862.039314495974, 6765.560238584575, 6770.255271920085, 6776.593404395653, 6777.322267773282, 6782.525223234326, 6670.299618540081, 6838.521303508706, 6844.589324640538, 6846.760363387258, 6849.417799487, 6548.508861835477, 6586.308437613981, 6591.901121483085, 6595.175603049619, 6595.637239951849, 6448.419642232222, 6471.158749362553, 6517.816531461824, 6521.413072823469, 6534.281229064894, 6664.866702665822, 6844.691988860613, 6858.211305699709, 6863.862722745617, 6866.519343645897, 4560.270356742905, 4567.2464043432465, 4567.748773817339, 4568.383268258743, 4571.062932098978, 6622.337766223339, 6625.50308726857, 6625.734970601315, 6630.83422914431, 6640.402363787282, 6322.525810564134, 6459.159139645179, 6467.676616169078, 6469.0, 6469.4824414045825, 6442.774502892376, 6445.613263204223, 6446.258680251831, 6456.806295811133, 6458.483321334188, 6318.178636777189, 6322.905156422749, 6327.2407311121115, 6328.050792381179, 6337.683115844097, 6233.376662333731, 6283.392392157386, 6319.936800631935, 6358.650274234961, 6500.5449618526245, 6291.276503202191, 6308.842278943063, 6310.463610593151, 6312.905306420499, 6326.0510923360025], "unit": "score", "name": "prototype.html", "value": 4798.458578345604}, {"lowerIsBetter": false, "replicates": [819.3199644295236, 825.5964710966722, 830.6635812495938, 839.2991851803744, 851.6848765956597, 12221.083418743585, 12389.504419823208, 12416.441260143292, 12440.875591244085, 12441.253524788508, 11720.472578733956, 11809.173357864931, 11862.110341724383, 11894.167408281424, 11905.345206013666, 808.8786681997703, 831.8960129983752, 832.0, 832.1595188859235, 832.6835802395082, 670.6043434373719, 673.9991113196899, 677.9118714567124, 813.048732982412, 832.2592892325835, 859.7850537365658, 859.8753180788782, 865.9220670139687, 865.9610317535726, 867.8698195270697, 859.7549698335944, 860.6170254236868, 861.2033868671485, 861.7716305179133, 861.9482831030127, 519.9688018718889, 520.4769206946994, 621.9315875253718, 629.0469938043822, 630.1524449615306, 12433.564825231073, 12473.75052498945, 12477.50089996399, 12523.060770442162, 12536.686582835411, 11527.538898444052, 11758.941205294004, 11823.822642660367, 11945.761084778256, 12138.08964327679, 9567.330286879922, 9614.278929080278, 9683.757906052335, 9744.95127524365, 9753.951230243874, 3484.7146840240853, 3521.806300653463, 3558.412861877813, 3597.226596281786, 3672.7429079964413, 45151.0, 45303.32045019327, 45601.0, 45720.0, 45743.77128114338, 9681.564329605184, 9714.271429642806, 9719.65981190655, 9846.310758246997, 10006.199504039805, 16714.6657066858, 16769.91615041917, 16829.747553786703, 16846.831531684773, 16857.915710421614, 7241.493095483371, 7385.741499047507, 7390.556566605914, 7417.072865891763, 7505.136909255505, 4262.914741705211, 4268.274393353137, 4278.0, 4304.139172165579, 4319.784010799511, 2907.8400687961944, 2954.1580649514785, 2956.024511911064, 2966.1398194523777, 2970.435617232719, 532.3558494222035, 570.2985328046526, 571.0834111251464, 578.1212556913468, 592.3365830270125, 507.73090262161116, 511.81318818630933, 537.7311344327836, 547.2010864138323, 570.9914351284734, 7512.586807725627, 7610.238976102345, 7864.72473463426, 8836.469811811183, 9026.323025773094, 412.57710846382696, 469.5257789632428, 487.5441462232824, 517.2990597740084, 637.8391327783389, 3565.839537220779, 3680.208755117609, 3836.9424458633143, 3855.190410013872, 3870.322693528621, 50892.0, 53265.467345326826, 53312.269720890254, 53336.199957000674, 53365.0, 48904.0, 49141.75429122832, 49522.25716614254, 49534.256986145236, 50399.496005040215, 41532.58467415348, 41559.37660935088, 41843.79078104651, 42075.0, 42433.78783106065, 7619.771406857803, 7647.646647346991, 7745.302922736981, 7776.183500732342, 7784.455088143775, 31843.36313273675, 31858.6814131865, 32134.03597892067, 32457.35085298328, 32506.34987300288, 38743.0, 40246.0, 41784.58215417928, 42240.15519689528, 49334.25998610096, 10507.211959102944, 10535.683929482127, 10707.304025238334, 10893.56425742993, 11160.776784464102, 10921.126309895031, 11296.322220666787, 11751.412429378326, 11822.0, 12168.391580420766, 10381.169506439617, 10604.628837990942, 10665.680029599125, 10773.62292319765, 11149.219554631098, 10536.789264214825, 10637.787244255227, 10730.624428144978, 10870.293430926964, 11034.227604067639, 9161.816763664823, 9210.861837072584, 9229.35394522377, 9323.953380233055, 9549.522523873917, 8690.261327786957, 8973.685920992733, 8979.730608081769, 9107.043760405062, 9124.361294709306, 8382.916170838458, 8472.49165050099, 8580.399372043898, 8912.86630700527, 9451.480168590793], "unit": "score", "name": "yui.html", "value": 5927.611291579769}], "name": "dromaeo_css", "value": 6756.978851939644}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 110.0, 99.0, 109.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 148.0, 161.0, 128.0, 151.0, 152.0, 125.0, 171.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 160.0, 161.0, 168.0, 160.0, 164.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 95.0, 92.0, 73.0, 73.0, 72.0, 109.0, 97.0, 85.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 96.0, 140.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 57.0, 55.0, 55.0, 55.0, 57.0, 64.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 82.0, 89.0, 90.0, 83.0, 82.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 119.0, 117.0, 126.0, 114.0, 119.0, 113.0, 114.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 142.0, 142.0, 143.0, 137.0, 144.0, 142.0, 146.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 72.0, 68.0, 68.0, 65.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1493.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.26201760324983], "unit": "score", "name": "Richards", "value": 208.56421600000007}, {"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "DeltaBlue", "value": 348.97080399999993}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42936.17021276596], "unit": "score", "name": "RegExp", "value": 21.21719276511396}, {"lowerIsBetter": false, "replicates": [643.7299035369775], "unit": "score", "name": "Splay", "value": 126.5919130869131}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18759.107347229707}]} 19:22:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18759.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6756.98"}}} 19:22:31 INFO - Return code: 0 19:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:22:31 INFO - # TBPL SUCCESS # 19:22:31 INFO - Running post-action listener: _resource_record_post_action 19:22:31 INFO - Running post-run listener: _resource_record_post_run 19:22:32 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 540028928; Read time: 0; Write time: 476408 19:22:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237182976; Read time: 0; Write time: 233540 19:22:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302845952; Read time: 0; Write time: 242868 19:22:32 INFO - Running post-run listener: _upload_blobber_files 19:22:32 INFO - Blob upload gear active. 19:22:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:22:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:22:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:22:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:22:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:33 INFO - (blobuploader) - INFO - Done attempting. 19:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:34 INFO - (blobuploader) - INFO - Done attempting. 19:22:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:34 INFO - Return code: 0 19:22:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:22:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c3c55f6db4f78198b7ce94c0229a7b52c9bfa9d9a058d55fa173a1ea886248a0285fef14056c756e4fe3d1ec54256ad9787e7b4b66fbff6baa7d9424e98415c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea7cf4e4407856539706156d2491eca41adc06993ba276be44741aa7ff80a38aead0aa84d7547f26578713d4e51df096abc0b0c1e7eae5dfc1d5b6e4f92fe055"} 19:22:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:22:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:22:34 INFO - Contents: 19:22:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c3c55f6db4f78198b7ce94c0229a7b52c9bfa9d9a058d55fa173a1ea886248a0285fef14056c756e4fe3d1ec54256ad9787e7b4b66fbff6baa7d9424e98415c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea7cf4e4407856539706156d2491eca41adc06993ba276be44741aa7ff80a38aead0aa84d7547f26578713d4e51df096abc0b0c1e7eae5dfc1d5b6e4f92fe055"} 19:22:34 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:34 INFO - Copying logs to upload dir... 19:22:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:22:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.484418 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 19:22:34.441596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 19:22:34.444952) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 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/9c3c55f6db4f78198b7ce94c0229a7b52c9bfa9d9a058d55fa173a1ea886248a0285fef14056c756e4fe3d1ec54256ad9787e7b4b66fbff6baa7d9424e98415c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea7cf4e4407856539706156d2491eca41adc06993ba276be44741aa7ff80a38aead0aa84d7547f26578713d4e51df096abc0b0c1e7eae5dfc1d5b6e4f92fe055"} build_url:https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/HKJhX9qwRLyp4cf0QSxI-Q/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/9c3c55f6db4f78198b7ce94c0229a7b52c9bfa9d9a058d55fa173a1ea886248a0285fef14056c756e4fe3d1ec54256ad9787e7b4b66fbff6baa7d9424e98415c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea7cf4e4407856539706156d2491eca41adc06993ba276be44741aa7ff80a38aead0aa84d7547f26578713d4e51df096abc0b0c1e7eae5dfc1d5b6e4f92fe055"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 19:22:34.473306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:22:34.473645) ========= 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=14ef55db36f7623abb31b9cf000001d5-1452910529.268925-1814431323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:22:34.558061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 19:22:34.558841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 19:22:34.559486) ========= ========= Total master_lag: 0.30 =========