builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1452261684.51 results: success (0) buildid: 20160108030334 builduid: f0decaed0803452686554b01eda178b2 revision: 1424cdfc075d1b7e277be914488ac73e20d1c982 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.510004) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.510499) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.510990) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006382 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.544765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.545052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.582166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.582419) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.636082) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.636500) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.636887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.637219) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 06:01:24-- 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% 43.8M=0s 2016-01-08 06:01:24 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.818742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.819049) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019470 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:24.873966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 06:01:24.874276) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1424cdfc075d1b7e277be914488ac73e20d1c982 --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 1424cdfc075d1b7e277be914488ac73e20d1c982 --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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 06:01:24,922 truncating revision to first 12 chars 2016-01-08 06:01:24,922 Setting DEBUG logging. 2016-01-08 06:01:24,922 attempt 1/10 2016-01-08 06:01:24,922 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1424cdfc075d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 06:01:25,860 unpacking tar archive at: mozilla-central-1424cdfc075d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 06:01:26.159122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:26.159418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:26.169635) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:26.170134) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:01:26.170806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-08 06:01:26.171273) ========= /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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:26 INFO - MultiFileLogger online at 20160108 06:01:26 in /builds/slave/test-pgo 06:01:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:01:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:01:26 INFO - {'append_to_log': False, 06:01:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:01:26 INFO - 'blob_upload_branch': 'Firefox', 06:01:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:01:26 INFO - 'branch': 'Firefox', 06:01:26 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:26 INFO - 'config_files': ('talos/linux_config.py',), 06:01:26 INFO - 'default_actions': ('clobber', 06:01:26 INFO - 'read-buildbot-config', 06:01:26 INFO - 'download-and-extract', 06:01:26 INFO - 'populate-webroot', 06:01:26 INFO - 'create-virtualenv', 06:01:26 INFO - 'install', 06:01:26 INFO - 'run-tests'), 06:01:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:26 INFO - 'download_minidump_stackwalk': True, 06:01:26 INFO - 'download_symbols': 'ondemand', 06:01:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:26 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:26 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:26 INFO - 'installer_path': 'installer.exe', 06:01:26 INFO - 'log_level': 'info', 06:01:26 INFO - 'log_name': 'talos', 06:01:26 INFO - 'log_to_console': True, 06:01:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:26 INFO - 'opt_config_files': (), 06:01:26 INFO - 'pip_index': False, 06:01:26 INFO - 'sps_profile': False, 06:01:26 INFO - 'sps_profile_interval': 0, 06:01:26 INFO - 'suite': 'dromaeojs', 06:01:26 INFO - 'system_bits': '32', 06:01:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:26 INFO - 'title': 'talos-linux64-ix-030', 06:01:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:26 INFO - 'use_talos_json': True, 06:01:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:01:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:26 INFO - 'work_dir': 'build'} 06:01:26 INFO - ##### 06:01:26 INFO - ##### Running clobber step. 06:01:26 INFO - ##### 06:01:26 INFO - Running pre-action listener: _resource_record_pre_action 06:01:26 INFO - Running main action method: clobber 06:01:26 INFO - rmtree: /builds/slave/test-pgo/build 06:01:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:01:27 INFO - Running post-action listener: _resource_record_post_action 06:01:27 INFO - ##### 06:01:27 INFO - ##### Running read-buildbot-config step. 06:01:27 INFO - ##### 06:01:27 INFO - Running pre-action listener: _resource_record_pre_action 06:01:27 INFO - Running main action method: read_buildbot_config 06:01:27 INFO - Using buildbot properties: 06:01:27 INFO - { 06:01:27 INFO - "project": "", 06:01:27 INFO - "product": "firefox", 06:01:27 INFO - "script_repo_revision": "production", 06:01:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:01:27 INFO - "repository": "", 06:01:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:01:27 INFO - "buildid": "20160108030334", 06:01:27 INFO - "stage_platform": "linux64-pgo", 06:01:27 INFO - "basedir": "/builds/slave/test-pgo", 06:01:27 INFO - "nightly_build": "True", 06:01:27 INFO - "buildnumber": 633, 06:01:27 INFO - "slavename": "talos-linux64-ix-030", 06:01:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:01:27 INFO - "platform": "ubuntu64_hw", 06:01:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:01:27 INFO - "branch": "mozilla-central", 06:01:27 INFO - "repo_path": "mozilla-central", 06:01:27 INFO - "revision": "1424cdfc075d1b7e277be914488ac73e20d1c982", 06:01:27 INFO - "pgo_build": "True", 06:01:27 INFO - "builduid": "f0decaed0803452686554b01eda178b2", 06:01:27 INFO - "slavebuilddir": "test" 06:01:27 INFO - } 06:01:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:01:27 INFO - Running post-action listener: _resource_record_post_action 06:01:27 INFO - ##### 06:01:27 INFO - ##### Running download-and-extract step. 06:01:27 INFO - ##### 06:01:27 INFO - Running pre-action listener: _resource_record_pre_action 06:01:27 INFO - Running main action method: download_and_extract 06:01:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:27 INFO - https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/test_packages.json 06:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/test_packages.json 06:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:01:30 INFO - Downloaded 1302 bytes. 06:01:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:01:30 INFO - Using the following test package requirements: 06:01:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'jsshell-linux-x86_64.zip'], 06:01:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:30 INFO - https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:31 INFO - Downloaded 24028381 bytes. 06:01:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:01:32 INFO - Return code: 0 06:01:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:32 INFO - https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:01:41 INFO - Downloaded 24028381 bytes. 06:01:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:01:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:01:42 INFO - Return code: 0 06:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:42 INFO - https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:01:43 INFO - Downloaded 11132285 bytes. 06:01:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:01:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:01:43 INFO - Return code: 0 06:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:43 INFO - https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:01:45 INFO - Downloaded 55922754 bytes. 06:01:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:01:45 INFO - mkdir: /builds/slave/test-pgo/properties 06:01:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:01:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:01:45 INFO - Contents: 06:01:45 INFO - build_url:https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:01:45 INFO - Running post-action listener: _resource_record_post_action 06:01:45 INFO - Running post-action listener: set_extra_try_arguments 06:01:45 INFO - ##### 06:01:45 INFO - ##### Running populate-webroot step. 06:01:45 INFO - ##### 06:01:45 INFO - Running pre-action listener: _resource_record_pre_action 06:01:45 INFO - Running main action method: populate_webroot 06:01:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:45 INFO - '--tppagecycles', 06:01:45 INFO - '7'], 06:01:45 INFO - 'tests': ['tsvgm']}}, 06:01:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:01:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:01:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:01:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'tests': ['damp', 'tps']}, 06:01:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['damp', 'tps']}, 06:01:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:01:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:45 INFO - 'other': {'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'other_l64': {'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'other_nol64': {'tests': ['a11yr', 06:01:45 INFO - 'ts_paint', 06:01:45 INFO - 'tpaint', 06:01:45 INFO - 'sessionrestore', 06:01:45 INFO - 'sessionrestore_no_auto_restore']}, 06:01:45 INFO - 'svgr': {'tests': ['tsvgx', 06:01:45 INFO - 'tsvgr_opacity', 06:01:45 INFO - 'tart', 06:01:45 INFO - 'tscrollx', 06:01:45 INFO - 'cart']}, 06:01:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['tsvgx', 06:01:45 INFO - 'tsvgr_opacity', 06:01:45 INFO - 'tart', 06:01:45 INFO - 'tscrollx', 06:01:45 INFO - 'cart']}, 06:01:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'tests': ['tp5o']}, 06:01:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'talos_options': ['--e10s'], 06:01:45 INFO - 'tests': ['tp5o']}, 06:01:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'talos_options': ['--xperf_path', 06:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:45 INFO - 'tests': ['tp5n']}, 06:01:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:45 INFO - 'talos_options': ['--e10s', 06:01:45 INFO - '--xperf_path', 06:01:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:45 INFO - 'tests': ['tp5n']}}, 06:01:45 INFO - 'talos.zip': {'path': '', 06:01:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:45 INFO - Running post-action listener: _resource_record_post_action 06:01:45 INFO - ##### 06:01:45 INFO - ##### Running create-virtualenv step. 06:01:45 INFO - ##### 06:01:45 INFO - Running pre-action listener: _resource_record_pre_action 06:01:45 INFO - Running main action method: create_virtualenv 06:01:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:01:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:01:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:01:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:45 INFO - Using real prefix '/usr' 06:01:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:01:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:48 INFO - Installing pip.................done. 06:01:48 INFO - Return code: 0 06:01:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:48 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:01:48 INFO - Using env: {'DISPLAY': ':0', 06:01:48 INFO - 'HOME': '/home/cltbld', 06:01:48 INFO - 'LANG': 'en_US.UTF-8', 06:01:48 INFO - 'LANGUAGE': 'en_US:en', 06:01:48 INFO - 'LOGNAME': 'cltbld', 06:01:48 INFO - 'MAIL': '/var/mail/cltbld', 06:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:48 INFO - 'MOZ_NO_REMOTE': '1', 06:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:48 INFO - 'NO_EM_RESTART': '1', 06:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:48 INFO - 'SHELL': '/bin/bash', 06:01:48 INFO - 'SHLVL': '1', 06:01:48 INFO - 'TERM': 'linux', 06:01:48 INFO - 'TMOUT': '86400', 06:01:48 INFO - 'USER': 'cltbld', 06:01:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:48 INFO - '_': '/tools/buildbot/bin/python'} 06:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:01:48 INFO - Cleaning up... 06:01:48 INFO - Return code: 0 06:01:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:48 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:01:48 INFO - Using env: {'DISPLAY': ':0', 06:01:48 INFO - 'HOME': '/home/cltbld', 06:01:48 INFO - 'LANG': 'en_US.UTF-8', 06:01:48 INFO - 'LANGUAGE': 'en_US:en', 06:01:48 INFO - 'LOGNAME': 'cltbld', 06:01:48 INFO - 'MAIL': '/var/mail/cltbld', 06:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:48 INFO - 'MOZ_NO_REMOTE': '1', 06:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:48 INFO - 'NO_EM_RESTART': '1', 06:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:48 INFO - 'SHELL': '/bin/bash', 06:01:48 INFO - 'SHLVL': '1', 06:01:48 INFO - 'TERM': 'linux', 06:01:48 INFO - 'TMOUT': '86400', 06:01:48 INFO - 'USER': 'cltbld', 06:01:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:48 INFO - '_': '/tools/buildbot/bin/python'} 06:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:48 INFO - Downloading/unpacking psutil>=0.7.1 06: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 06: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 06: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 06: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 06: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 06: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 06:01:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:01:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:50 INFO - Installing collected packages: psutil 06:01:50 INFO - Running setup.py install for psutil 06:01:50 INFO - building 'psutil._psutil_linux' extension 06:01:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:01:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:01:50 INFO - building 'psutil._psutil_posix' extension 06:01:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:01:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:01:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:51 INFO - Successfully installed psutil 06:01:51 INFO - Cleaning up... 06:01:51 INFO - Return code: 0 06:01:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:51 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:01:51 INFO - Using env: {'DISPLAY': ':0', 06:01:51 INFO - 'HOME': '/home/cltbld', 06:01:51 INFO - 'LANG': 'en_US.UTF-8', 06:01:51 INFO - 'LANGUAGE': 'en_US:en', 06:01:51 INFO - 'LOGNAME': 'cltbld', 06:01:51 INFO - 'MAIL': '/var/mail/cltbld', 06:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:51 INFO - 'MOZ_NO_REMOTE': '1', 06:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:51 INFO - 'NO_EM_RESTART': '1', 06:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:51 INFO - 'SHELL': '/bin/bash', 06:01:51 INFO - 'SHLVL': '1', 06:01:51 INFO - 'TERM': 'linux', 06:01:51 INFO - 'TMOUT': '86400', 06:01:51 INFO - 'USER': 'cltbld', 06:01:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:51 INFO - '_': '/tools/buildbot/bin/python'} 06:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:01:53 INFO - Installing collected packages: mozsystemmonitor 06:01:53 INFO - Running setup.py install for mozsystemmonitor 06:01:53 INFO - Successfully installed mozsystemmonitor 06:01:53 INFO - Cleaning up... 06:01:53 INFO - Return code: 0 06:01:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:53 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:01:53 INFO - Using env: {'DISPLAY': ':0', 06:01:53 INFO - 'HOME': '/home/cltbld', 06:01:53 INFO - 'LANG': 'en_US.UTF-8', 06:01:53 INFO - 'LANGUAGE': 'en_US:en', 06:01:53 INFO - 'LOGNAME': 'cltbld', 06:01:53 INFO - 'MAIL': '/var/mail/cltbld', 06:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:53 INFO - 'MOZ_NO_REMOTE': '1', 06:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:53 INFO - 'NO_EM_RESTART': '1', 06:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:53 INFO - 'SHELL': '/bin/bash', 06:01:53 INFO - 'SHLVL': '1', 06:01:53 INFO - 'TERM': 'linux', 06:01:53 INFO - 'TMOUT': '86400', 06:01:53 INFO - 'USER': 'cltbld', 06:01:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:53 INFO - '_': '/tools/buildbot/bin/python'} 06:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:01:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:55 INFO - Downloading docopt-0.6.1.tar.gz 06:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:55 INFO - Running setup.py install for blobuploader 06:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:01:56 INFO - Running setup.py install for requests 06:01:56 INFO - Running setup.py install for docopt 06:01:56 INFO - Successfully installed blobuploader requests docopt 06:01:56 INFO - Cleaning up... 06:01:56 INFO - Return code: 0 06:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:56 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:56 INFO - Using env: {'DISPLAY': ':0', 06:01:56 INFO - 'HOME': '/home/cltbld', 06:01:56 INFO - 'LANG': 'en_US.UTF-8', 06:01:56 INFO - 'LANGUAGE': 'en_US:en', 06:01:56 INFO - 'LOGNAME': 'cltbld', 06:01:56 INFO - 'MAIL': '/var/mail/cltbld', 06:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:56 INFO - 'MOZ_NO_REMOTE': '1', 06:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:56 INFO - 'NO_EM_RESTART': '1', 06:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:56 INFO - 'SHELL': '/bin/bash', 06:01:56 INFO - 'SHLVL': '1', 06:01:56 INFO - 'TERM': 'linux', 06:01:56 INFO - 'TMOUT': '86400', 06:01:56 INFO - 'USER': 'cltbld', 06:01:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:56 INFO - '_': '/tools/buildbot/bin/python'} 06:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:01:56 INFO - Running setup.py (path:/tmp/pip-OISq5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:01:56 INFO - Running setup.py (path:/tmp/pip-2yE7vN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:01:56 INFO - Running setup.py (path:/tmp/pip-tk2TbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:01:56 INFO - Running setup.py (path:/tmp/pip-Kt0Lrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:01:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:01:56 INFO - Running setup.py (path:/tmp/pip-IZlJsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:01:57 INFO - Running setup.py (path:/tmp/pip-VIsfSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:01:57 INFO - Running setup.py (path:/tmp/pip-_rn6l0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:01:57 INFO - Running setup.py (path:/tmp/pip-qacsTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:01:57 INFO - Running setup.py (path:/tmp/pip-mw2nVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:01:57 INFO - Running setup.py (path:/tmp/pip-Ad3ZmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:01:57 INFO - Running setup.py (path:/tmp/pip-e4GrRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:01:57 INFO - Running setup.py (path:/tmp/pip-dYaxh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:01:57 INFO - Running setup.py (path:/tmp/pip-p_pV0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:01:57 INFO - Running setup.py (path:/tmp/pip-Zu6iC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:01:57 INFO - Running setup.py (path:/tmp/pip-I3Kkqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:01:57 INFO - Running setup.py (path:/tmp/pip-AIrg1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:01:57 INFO - Running setup.py (path:/tmp/pip-5voEhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:57 INFO - Running setup.py install for manifestparser 06:01:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for mozcrash 06:01:58 INFO - Running setup.py install for mozdebug 06:01:58 INFO - Running setup.py install for mozdevice 06:01:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for mozfile 06:01:58 INFO - Running setup.py install for mozhttpd 06:01:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for mozinfo 06:01:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for mozInstall 06:01:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for mozleak 06:01:58 INFO - Running setup.py install for mozlog 06:01:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:01:58 INFO - Running setup.py install for moznetwork 06:01:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Running setup.py install for mozprocess 06:01:59 INFO - Running setup.py install for mozprofile 06:01:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Running setup.py install for mozrunner 06:01:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Running setup.py install for mozscreenshot 06:01:59 INFO - Running setup.py install for moztest 06:01:59 INFO - Running setup.py install for mozversion 06:01:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:01:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:59 INFO - Cleaning up... 06:01:59 INFO - Return code: 0 06:01:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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', '-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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06: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', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06: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 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:01:59 INFO - Using env: {'DISPLAY': ':0', 06:01:59 INFO - 'HOME': '/home/cltbld', 06:01:59 INFO - 'LANG': 'en_US.UTF-8', 06:01:59 INFO - 'LANGUAGE': 'en_US:en', 06:01:59 INFO - 'LOGNAME': 'cltbld', 06:01:59 INFO - 'MAIL': '/var/mail/cltbld', 06:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:59 INFO - 'MOZ_NO_REMOTE': '1', 06:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:59 INFO - 'NO_EM_RESTART': '1', 06:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:59 INFO - 'SHELL': '/bin/bash', 06:01:59 INFO - 'SHLVL': '1', 06:01:59 INFO - 'TERM': 'linux', 06:01:59 INFO - 'TMOUT': '86400', 06:01:59 INFO - 'USER': 'cltbld', 06:01:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:59 INFO - '_': '/tools/buildbot/bin/python'} 06:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:01:59 INFO - Running setup.py (path:/tmp/pip-lM20Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:01:59 INFO - Running setup.py (path:/tmp/pip-boHOs3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:02:00 INFO - Running setup.py (path:/tmp/pip-3v8I_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:02:00 INFO - Running setup.py (path:/tmp/pip-mUTVi4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:02:00 INFO - Running setup.py (path:/tmp/pip-h5yDin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:02:00 INFO - Running setup.py (path:/tmp/pip-jJK7Gz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:02:00 INFO - Running setup.py (path:/tmp/pip-zAImze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:02:00 INFO - Running setup.py (path:/tmp/pip-oLMBYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:02:00 INFO - Running setup.py (path:/tmp/pip-L52k5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:02:00 INFO - Running setup.py (path:/tmp/pip-tz_oQV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:02:00 INFO - Running setup.py (path:/tmp/pip-gbyjGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:02:00 INFO - Running setup.py (path:/tmp/pip-yb5GN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:02:00 INFO - Running setup.py (path:/tmp/pip-zs5IVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:02:00 INFO - Running setup.py (path:/tmp/pip-TpYJ9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:02:00 INFO - Running setup.py (path:/tmp/pip-Ugvoiq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:02:01 INFO - Running setup.py (path:/tmp/pip-c7Tvh2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:02:01 INFO - Running setup.py (path:/tmp/pip-_z4wgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:02:01 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:01 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:02:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06: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 06: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 06: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 06: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 06: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 06: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 06:02:02 INFO - Downloading blessings-1.5.1.tar.gz 06:02:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:02 INFO - Installing collected packages: blessings 06:02:02 INFO - Running setup.py install for blessings 06:02:03 INFO - Successfully installed blessings 06:02:03 INFO - Cleaning up... 06:02:03 INFO - Return code: 0 06:02:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:02:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:02:03 INFO - Reading from file tmpfile_stdout 06:02:03 INFO - Current package versions: 06:02:03 INFO - argparse == 1.2.1 06:02:03 INFO - blessings == 1.5.1 06:02:03 INFO - blobuploader == 1.2.4 06:02:03 INFO - docopt == 0.6.1 06:02:03 INFO - manifestparser == 1.1 06:02:03 INFO - mozInstall == 1.12 06:02:03 INFO - mozcrash == 0.16 06:02:03 INFO - mozdebug == 0.1 06:02:03 INFO - mozdevice == 0.47 06:02:03 INFO - mozfile == 1.2 06:02:03 INFO - mozhttpd == 0.7 06:02:03 INFO - mozinfo == 0.9 06:02:03 INFO - mozleak == 0.1 06:02:03 INFO - mozlog == 3.1 06:02:03 INFO - moznetwork == 0.27 06:02:03 INFO - mozprocess == 0.22 06:02:03 INFO - mozprofile == 0.28 06:02:03 INFO - mozrunner == 6.11 06:02:03 INFO - mozscreenshot == 0.1 06:02:03 INFO - mozsystemmonitor == 0.0 06:02:03 INFO - moztest == 0.7 06:02:03 INFO - mozversion == 1.4 06:02:03 INFO - psutil == 3.1.1 06:02:03 INFO - requests == 1.2.3 06:02:03 INFO - wsgiref == 0.1.2 06:02:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:02:03 INFO - Using env: {'DISPLAY': ':0', 06:02:03 INFO - 'HOME': '/home/cltbld', 06:02:03 INFO - 'LANG': 'en_US.UTF-8', 06:02:03 INFO - 'LANGUAGE': 'en_US:en', 06:02:03 INFO - 'LOGNAME': 'cltbld', 06:02:03 INFO - 'MAIL': '/var/mail/cltbld', 06:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:03 INFO - 'MOZ_NO_REMOTE': '1', 06:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:03 INFO - 'NO_EM_RESTART': '1', 06:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:02:03 INFO - 'SHELL': '/bin/bash', 06:02:03 INFO - 'SHLVL': '1', 06:02:03 INFO - 'TERM': 'linux', 06:02:03 INFO - 'TMOUT': '86400', 06:02:03 INFO - 'USER': 'cltbld', 06:02:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:03 INFO - '_': '/tools/buildbot/bin/python'} 06:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:02:03 INFO - Cleaning up... 06:02:03 INFO - Return code: 0 06:02:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:03 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:02:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:02:03 INFO - Using env: {'DISPLAY': ':0', 06:02:03 INFO - 'HOME': '/home/cltbld', 06:02:03 INFO - 'LANG': 'en_US.UTF-8', 06:02:03 INFO - 'LANGUAGE': 'en_US:en', 06:02:03 INFO - 'LOGNAME': 'cltbld', 06:02:03 INFO - 'MAIL': '/var/mail/cltbld', 06:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:03 INFO - 'MOZ_NO_REMOTE': '1', 06:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:03 INFO - 'NO_EM_RESTART': '1', 06:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:02:03 INFO - 'SHELL': '/bin/bash', 06:02:03 INFO - 'SHLVL': '1', 06:02:03 INFO - 'TERM': 'linux', 06:02:03 INFO - 'TMOUT': '86400', 06:02:03 INFO - 'USER': 'cltbld', 06:02:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:03 INFO - '_': '/tools/buildbot/bin/python'} 06:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:03 INFO - Downloading/unpacking jsonschema 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:02:05 INFO - Downloading/unpacking functools32 (from jsonschema) 06:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:02:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:05 INFO - warning: no files found matching '*.txt' 06:02:05 INFO - no previously-included directories found matching 'build' 06:02:05 INFO - no previously-included directories found matching 'dist' 06:02:05 INFO - no previously-included directories found matching '.git*' 06:02:05 INFO - Installing collected packages: jsonschema, functools32 06:02:05 INFO - Running setup.py install for functools32 06:02:05 INFO - warning: no files found matching '*.txt' 06:02:05 INFO - no previously-included directories found matching 'build' 06:02:05 INFO - no previously-included directories found matching 'dist' 06:02:05 INFO - no previously-included directories found matching '.git*' 06:02:05 INFO - Successfully installed jsonschema functools32 06:02:05 INFO - Cleaning up... 06:02:05 INFO - Return code: 0 06:02:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:02:05 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 0x7fb9b5c76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:02:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:02:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:02:05 INFO - Using env: {'DISPLAY': ':0', 06:02:05 INFO - 'HOME': '/home/cltbld', 06:02:05 INFO - 'LANG': 'en_US.UTF-8', 06:02:05 INFO - 'LANGUAGE': 'en_US:en', 06:02:05 INFO - 'LOGNAME': 'cltbld', 06:02:05 INFO - 'MAIL': '/var/mail/cltbld', 06:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:05 INFO - 'MOZ_NO_REMOTE': '1', 06:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:05 INFO - 'NO_EM_RESTART': '1', 06:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 06:02:05 INFO - 'SHELL': '/bin/bash', 06:02:05 INFO - 'SHLVL': '1', 06:02:05 INFO - 'TERM': 'linux', 06:02:05 INFO - 'TMOUT': '86400', 06:02:05 INFO - 'USER': 'cltbld', 06:02:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:05 INFO - '_': '/tools/buildbot/bin/python'} 06:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:06 INFO - Downloading/unpacking flake8 06:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:02:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:02:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:02:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:02:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:02:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:08 INFO - no previously-included directories found matching 'docs/_build' 06:02:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:02:08 INFO - Running setup.py install for pep8 06:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:02:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:02:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:02:08 INFO - no previously-included directories found matching 'docs/_build' 06:02:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:02:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:02:08 INFO - Cleaning up... 06:02:08 INFO - Return code: 0 06:02:08 INFO - Running post-action listener: _resource_record_post_action 06:02:08 INFO - Running post-action listener: _start_resource_monitoring 06:02:08 INFO - Starting resource monitoring. 06:02:08 INFO - ##### 06:02:08 INFO - ##### Running install step. 06:02:08 INFO - ##### 06:02:08 INFO - Running pre-action listener: _resource_record_pre_action 06:02:08 INFO - Running main action method: install 06:02:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:02:08 INFO - Reading from file tmpfile_stdout 06:02:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:02:09 INFO - Reading from file tmpfile_stdout 06:02:09 INFO - Output received: 06:02:09 INFO - Usage: mozinstall [options] installer 06:02:09 INFO - Options: 06:02:09 INFO - -h, --help show this help message and exit 06:02:09 INFO - -d DEST, --destination=DEST 06:02:09 INFO - Directory to install application into. [default: 06:02:09 INFO - "/builds/slave/test-pgo"] 06:02:09 INFO - --app=APP Application being installed. [default: firefox] 06:02:09 INFO - mkdir: /builds/slave/test-pgo/build/application 06:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:02:25 INFO - Reading from file tmpfile_stdout 06:02:25 INFO - Output received: 06:02:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:02:25 INFO - Running post-action listener: _resource_record_post_action 06:02:25 INFO - ##### 06:02:25 INFO - ##### Running run-tests step. 06:02:25 INFO - ##### 06:02:25 INFO - Running pre-action listener: _resource_record_pre_action 06:02:25 INFO - Running main action method: run_tests 06:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:02:25 INFO - Python 2.7.3 06:02:25 INFO - Return code: 0 06:02:25 INFO - grabbing minidump binary from tooltool 06:02: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')]} 06:02:25 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 0x2350840>, '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 0x22bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:02:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:02:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:25 INFO - Return code: 0 06:02:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:02:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:02:26 INFO - Return code: 0 06:02:26 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/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:02:26 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/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:02:26 INFO - Using env: {'DISPLAY': ':0', 06:02:26 INFO - 'HOME': '/home/cltbld', 06:02:26 INFO - 'LANG': 'en_US.UTF-8', 06:02:26 INFO - 'LANGUAGE': 'en_US:en', 06:02:26 INFO - 'LOGNAME': 'cltbld', 06:02:26 INFO - 'MAIL': '/var/mail/cltbld', 06:02:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:02:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:26 INFO - 'MOZ_NO_REMOTE': '1', 06:02:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:26 INFO - 'NO_EM_RESTART': '1', 06:02:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:02:26 INFO - 'PWD': '/builds/slave/test-pgo', 06:02:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:02:26 INFO - 'SHELL': '/bin/bash', 06:02:26 INFO - 'SHLVL': '1', 06:02:26 INFO - 'TERM': 'linux', 06:02:26 INFO - 'TMOUT': '86400', 06:02:26 INFO - 'USER': 'cltbld', 06:02:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036', 06:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:26 INFO - '_': '/tools/buildbot/bin/python'} 06:02:26 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/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:02:26 INFO - mozversion application_buildid: 20160108030334 06:02:26 INFO - mozversion application_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:02:26 INFO - mozversion application_display_name: Nightly 06:02:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:26 INFO - mozversion application_name: Firefox 06:02:26 INFO - mozversion application_remotingname: firefox 06:02:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:26 INFO - mozversion application_vendor: Mozilla 06:02:26 INFO - mozversion application_version: 46.0a1 06:02:26 INFO - mozversion platform_buildid: 20160108030334 06:02:26 INFO - mozversion platform_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:02:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:26 INFO - mozversion platform_version: 46.0a1 06:02:26 INFO - using testdate: 1452261746 06:02:26 INFO - actual date: 1452261746 06:02:26 INFO - starting webserver on 'localhost:55479' 06:02:26 INFO - SUITE-START | Running 3 tests 06:02:26 INFO - TEST-START | dromaeo_css 06:02:26 INFO - operating with platform_type : linux_ 06:02:26 INFO - Initialising browser for dromaeo_css test... 06:02:26 INFO - TEST-INFO | started process 4656 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqoO6u/profile http://localhost:55479/getInfo.html) 06:02:30 INFO - PROCESS | 4656 | __metrics Screen width/height:1600/1200 06:02:30 INFO - PROCESS | 4656 | colorDepth:24 06:02:30 INFO - PROCESS | 4656 | Browser inner width/height: 1024/697 06:02:30 INFO - PROCESS | 4656 | __metrics 06:02:30 INFO - PROCESS | 4656 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:02:30 INFO - PROCESS | 4656 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:31 INFO - TEST-INFO | 4656: exit 0 06:02:31 INFO - Browser initialized. 06:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:31 INFO - TEST-INFO | started process 4750 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqoO6u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:43 INFO - PROCESS | 4750 | RSS: Main: 148762624 06:02:43 INFO - PROCESS | 4750 | 06:03:34 INFO - PROCESS | 4750 | 1452261814765 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:05:43 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55479/tests/dromaeo/cssquery-ext.html) 06:05:44 INFO - PROCESS | 4750 | RSS: Main: 256065536 06:05:44 INFO - PROCESS | 4750 | 06:08:46 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-ext.html (next: http://localhost:55479/tests/dromaeo/cssquery-jquery.html) 06:08:47 INFO - PROCESS | 4750 | RSS: Main: 240615424 06:08:47 INFO - PROCESS | 4750 | 06:11:49 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55479/tests/dromaeo/cssquery-mootools.html) 06:11:49 INFO - PROCESS | 4750 | RSS: Main: 232955904 06:11:49 INFO - PROCESS | 4750 | 06:14:51 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55479/tests/dromaeo/cssquery-prototype.html) 06:14:52 INFO - PROCESS | 4750 | RSS: Main: 213196800 06:14:52 INFO - PROCESS | 4750 | 06:17:55 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55479/tests/dromaeo/cssquery-yui.html) 06:17:55 INFO - PROCESS | 4750 | RSS: Main: 219029504 06:17:55 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | Cycle 1(1): loaded http://localhost:55479/tests/dromaeo/cssquery-yui.html (next: http://localhost:55479/tests/dromaeo/cssquery-dojo.html) 06:20:58 INFO - PROCESS | 4750 | RSS: Main: 317526016 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | __start_tp_report 06:20:58 INFO - PROCESS | 4750 | _x_x_mozilla_page_load 06:20:58 INFO - PROCESS | 4750 | _x_x_mozilla_page_load_details 06:20:58 INFO - PROCESS | 4750 | |i|pagename|runs| 06:20:58 INFO - PROCESS | 4750 | |0;dojo.html;3058;3125.23431759219;3157.557941888136;3157.984210078949;3185.9840700796485;4977.377827771528;5059.620528460367;5080.771365288561;5081.364829396325;5089.796408143675;5067.569256613183;5105.770240339184;5134.2812006319145;5138.6146039047035;5146.819861304855;4416.470023597173;4525.705829121113;4588.128255631436;4633.6061434778085;4729.929051064237;4567.566081222279;4668.6731928765;4701.529847015306;4704.01215744694;4816.373871396713;4527.32090186473;4613.653975951817;4635.814567417299;4646.047560250157;4658.184817656914;4646.976765116153;4672.719636821767;4684.648651351163;4699.553542413465;4713.670043096985;4528.07174529224;4652.883677908046;4667.719936803803;4671.719696818168;4685.344051832746;4792.712437253741;4891.902161956741;4910.459849416561;4930.778114984834;4935.0376676548085;5390.299261096072;5391.973040134774;5396.83809485716;5403.675779453245;5403.7027963462;5308.362996440414;5442;5453.454654534555;5496.395396506381;5502.284702988626;5072.873178170538;5097.847064588068;5114.820981265638;5133.974330128325;5175.922361164623;5554.305711786027;5577.888442231133;5594.328680558359;5594.552435805126;5597.496225339739;5223.503767142115;5364.758585863646;5371.194320851825;5384.434634363413;5389.191621256843;5385.461453854583;5412.485813847678;5423;5498.697571633598;5539.639923405047;5393.110136827458;5420.322459692538;5451.863703407446;5454.645448045864;5455.509004189642;5352.705601191972;5402.837914862561;5483.321936781584;5486;5533.723313834373;4234.25900467417;4236.2374772540625;4237.089025859455;4245.766482843412;4319.136172765397;3817.904552386157;3823.5602905665646;3835.9041023974064;3841.4429907663234;3864.478295430137;5032.245163225545;5033.295338652591;5038.445770965191;5050.267711181931;5076.390833100052;5232.764525596357;5328.254044433782;5337.039332920034;5426.620136590401;5436.945630543644;5000.299958005882;5037.697738135724;5040.31955685985;5059.696418214919;5074.594032477393;4671.299305104261;4682.81268749253;4684.205793307432;4684.859454216379;4728.432588089451;5402.054640437987;5535.6955367455175;5571.916421253684;5584.413636568183;5613.045782217033;5319.734013299397;5373.516383525502;5402.324709411324;5467.207254947931;5510.834674959758;5530.253415788817;5552.7778888845605;5557.416471270459;5583;5598.1602759586385;5309.177077552986;5379.784808607768;5382.30030096085;5388.245645609696;5445;5408.323959505062;5429.131338985743;5438;5468.26178465902;5495.395506494362;5314.5216930476445;5339.065663508948;5341.332333458317;5345.759440825094;5349.893002140013;5192.818251361185;5269.947300527099;5326.627136100591;5341.118715411913;5374.274472946102;5225.764840582106;5226.085435048775;5236.581073514034;5279.8680032997945;5318.441563635763;5291.3385826771655;5292.629515933848;5315.3090098286975;5323.30796996388;5366.382865970463;5183.948160518346;5187.351581052369;5195.246689230116;5201.765920533509;5225.216217567396 06:20:58 INFO - PROCESS | 4750 | |1;ext.html;520.4067363205946;561.9438056194383;568.4287291272269;572.9829552544234;581.3663107213137;28395;29201.56197657034;37717.62282377175;38066.4290035649;38217.617823821754;40283.798581007126;40399.59600403995;40829;40879.38680919789;40930.181396372056;7362.926370736278;8315.625796839142;8478.66085356585;8488.575571221414;8511.872321915176;7416.295451932057;7536.057992750906;7543.735969241077;7545.056867891513;9943.701688949342;9935.05616966387;10028.94985525075;10031.197504199647;10039.447830369327;10045.19638428924;9912.157466615346;9974.551145198484;9977.850332244985;9988.800223995479;9994.250431217615;7480.102387713509;7696.730614428524;10006.69979900604;10262.897371026269;10271.332363396356;37059.25881482382;37407.25185496302;37425.25149496995;37445.81277093597;37506;3250.203700093469;3307.6526964668847;3394.372041172391;3609.855605775766;3731.9813400933094;28862.855685721646;29000.27499312513;29232;29377.70622293771;29948;3653.5250417445827;3688.114852435423;3728.328900797855;3733.290674771785;3770.4909837171904;282424;283728;284024;284349;284551;52935.73532132392;54578.45421545813;61464.692676537226;62160.067598986054;62222.377776222565;56990.14514782282;57328.42671573314;57351.42648573544;57360.71319643375;57695;14718.779218311734;14838.851611483962;14916.477923272634;14923.552293431214;14933;11141.944290278496;11177.944110279397;11241.60654377093;11242.325460472397;11252.831207531894;20430.897845510677;20459.181632734522;20500.794992050185;20562.177512899318;20592.58814823695;7986.680532778624;8210.507369557845;8270.917290827136;8315.251627353568;8388.454750441202;941.3363578677016;952.3143336797494;956.086936975187;987.456898705709;1086.7554800170058;27615;27773.86113069422;28441.85779071133;28458.28854278618;28509.429811404072;1034.3173505486343;1048.3028785857318;1062.617457715222;1098.0885864732254;1127.9154063445274;14023.77011585934;14765.33555989983;14767.556973290819;15339.616509587126;15627.60930976712;332871;337188;337687.6081152708;337922;338392;45655.543444565126;46689;53683.731581341846;53854.19218711722;53908;1244.458660482693;1369.397465115366;1373.8969577281744;1376.8347798264272;1383.5295999360064;27372.58941115845;29142.56286155752;29542.113736587937;29584.260393490335;30240.243993899447;38663.226735465694;39596.20807583775;46368;47337;47361.763191183825;202131;204237;204619;205351;205368;31198.688013120485;31423;31596.368072637957;31748.841255794498;31837.20406989751;39734.40398394084;40747;40871.699087965564;41154.1769164621;41357;36386.45420318644;36623.81688091649;36896.81551592225;36900.26199476049;37461.250774984896;36727.81636091803;36785.24110691762;37661.623383766906;37761.81119094387;38002.239955201294;36023.27953440864;36366.63633363633;36560.45159322665;36611.81694091512;39146.4128038074;31133.221669458446;31529.527057093703;31628.525572116898;31840.5223921646;31958.201044974063;26050;26770.866145669148;26824.189662181623;26907.730922691306;26999.460010800067 06:20:58 INFO - PROCESS | 4750 | |2;jquery.html;353.8425400696689;359.4697820714446;370.2908929400199;370.76456450154143;374.43086508507054;13678.794818077737;13832.446702131927;16451.588710282234;17160.141992900353;18083.4574962751;15182.84817151828;15683.372665093382;16331;16772.66454670909;16857.578560535992;4844.539768721975;4998.650094493387;5015.69905805651;5021.6986980781085;5022.0709168803705;3771.924561508768;3897.902552436183;4900.950990490085;4961.454240033593;5282.630215884889;5426.158945363455;5438.048341540234;5450.482204190615;5488.1493368527745;5488.259085023531;5467.753951072212;5953.2856057272975;5964.2246507953905;5971.731272092723;5972.372900845392;5108.386993560759;5223.399309079428;5224.03355379256;5325.840224793263;5334.03987282289;12600.180988235736;12685.365731713377;12685.556005539762;17740.29038838445;20220.79779202204;1996.9900150499154;2057.197692899755;2107.388857231401;2172.1094351315883;2180.2042254576963;9554.808903821955;9795.608175673036;12280.754384912341;13280.601581952556;13368.131071480322;1840.0891558678406;1869.4765465669634;1878.098512713905;1889.1782074797507;1908.6373589018042;52938.47061529412;59615.70192149055;62654.68672656653;64093.35906640967;64463.67768161176;14545;15024.699506009818;15077.170755608548;15077.623059423602;15094.24528773557;23362.76637233606;23480.412989675395;23637.645435318485;23766.881165594063;23804.285871423886;8709.085546017704;8840.381173317806;8848.070952550019;8901.643934242687;8917.509536975529;7455.515391499535;7481.326680598663;7493.587852668155;7565.243475652501;7568.508046976929;7662.770116896502;7669.923300766921;7680.193579674165;7682.884756728654;7691.692332306757;2413.553492603874;2997.6552696439753;3007.3083190866223;3065.8773649054233;3072.8476821192053;858.6350800909588;985.6845809341086;1036.5905467340358;1041.4792603698152;1086.7174534621056;15430.537083887277;15676.843231567766;15768.211589420484;15912.92043539798;16035.599110022109;915.3775432705824;922.087133737595;940.5861420974886;964.4984608003799;985.4678473624306;8866.423682460749;9173.862392064124;9321.300902432346;9411.90588094124;9534.189593884597;233727;236486;378469;499360;507010;70758.64620676864;71056.64471677608;71355.64322178355;71397.64301178565;72631.27368726351;1136.2841409911703;1159.263867444179;1179.168686076314;1186.3771519951922;1189.1141099880472;14173.149611023371;14269.143851368952;14591.197484138474;14804.925975370053;14837.777433338724;29621.25946851346;31556.684433155373;31978.84010579932;32568.185795355304;33132;39921.40117898292;41702.1659566813;42892.78553607212;42981.57018429776;42998;6816.693248803716;6970.128733908262;7037.612931288828;7081.539699919489;7251.093613298338;9283.48940808262;9944.105030547285;9982.500874956078;10672.733181670521;10699.411532365795;8972.237359824489;9100.908990910006;9111.817763644558;9250.629974800933;9478;9140.908590914005;9205.953970230106;9335.859962100438;9361.157495825408;9460.716178514656;9239.168474837297;9464.1009104135;9472.810543789223;9536.666216682383;9676.806463870824;7140.571565706075;7141.892871607034;7248.528845625017;7261.818454538678;7339.082614673166;8895.911040889509;9175.77060573491;9513.381630194015;9523.857142143012;9558.522073896416 06:20:58 INFO - PROCESS | 4750 | |3;mootools.html;1300.265350077207;1434.7632640614295;1452.941882324707;1609.7263465210913;1814.0657561355904;6836.658167091644;7447.813804654887;7624.0851097868335;7632.3894088472925;7638.312551870331;7560;7704.229577042293;7733.265339792725;7740.187280335568;7750.612469376537;2035.704822800693;2081.6253074446668;2228.075348730283;2284.7829456201634;2312.1098377124845;2301.3211102724654;2305.6310990241564;2309.6535519672016;2310.2722642367685;2311.6070268054386;2208.6907832903407;2292.85096468729;2296.9655455168186;2298.2990187992655;2298.5977453945575;2229.6989906362596;2245.831562632801;2294.919677811277;2312.976870231293;2319.5592837361014;2281.3840263129027;2283.942901427461;2302.988485057581;2303.97696023041;2329;7732.497387669783;7803.531788092732;7807;7807.063152421746;7821.648025838851;4834.589059929875;4898.2162853943555;4902.289168070645;4906.411230652309;4948.455669876311;2972.4946759050795;3041.5437684347303;3074.446599612069;3084.1364417963005;3109.7667674924246;953.2564599612314;967.6855022117769;977.6724797192949;979.0601023017912;1018.8522664213722;10119.797604047952;10151.796964060752;10154.543045562894;10173.491325433699;10188.643397481126;4204.327307630764;4351.586599273064;4352;4354.433923589913;4409.492908315585;8465.32277417805;8749.868751968726;8773.561321933877;8797.12028797115;8797.164269394398;4858.514148585114;4878.707277563358;4879.536444037811;4882.95117048825;4883.121038213085;4485.977570112129;4489.371487991683;4495.415595972503;4502.842400515966;4505.909881802346;3374.983125084359;3422.5892892853017;3463.8960831175104;3601.8739344123355;3679.1170119171206;1097.2154909239932;1133.3709791066037;1137.1641843245209;1143.422571601336;1152.7060599547062;1315.1057281048788;1318.4462525739214;1341.3092257487401;1351.4391527516168;1357.9660508487366;7211.71153153868;7246.891296630555;7367.152777430664;7371.705131794775;7377.963110184414;1086.6196831109207;1091.7980173667897;1100.1034157161887;1108.1245815805585;1122.0406552397583;5832.912506312408;5838.474537291664;5871.442212989845;5890.057590785454;5920.171176035358;9152.405093668891;9204.723858284262;9369.718908432758;9376.343655944154;9469;9244.815103698023;9282.582283797245;9314.34799564024;9365.391249568756;9404.576794044284;7253.8549229015125;7313.232110628307;7356.117265928123;7392.039034925425;7475.140358858801;7118;7130.2869713028285;7183.102112235971;7189.1013623297085;7191;8172.877406839021;8393.496390216607;8443.66225350979;8580.957095214484;8589.570521474026;8674.78313042179;8738.126187381211;8761.386702930733;8785.956070219863;8786.560671966248;6792.830179245559;7037.26108758573;7037.859242815218;7038.964805175941;7040.401565866959;6694.732210711712;6817.93182068173;7205.71177152908;7392.22381649919;7397.112346518452;6896.4827637926355;7023.894641580278;7042;7118.644067796486;7129.500934934505;7040.964795176196;7043.859122817413;7044.36600705939;7063.823404414725;7223.2776722329445;7175.03137076488;7214.675339609626;7258.782236532912;7260.382867456114;7270.091238595176;6657.933420665731;6679.632620205935;6695;6700.83247918806;6704.463642908653;6730.057791909038;6780.796576102724;6785.864282714417;6789.762358317435;6792.320767923168 06:20:58 INFO - PROCESS | 4750 | |4;prototype.html;328.93092450585374;334.9447341188704;341.34121146187846;345.53180440503115;347.1425578820314;5807.274090738658;5850.327212370578;5902.350741418446;5961.195238642782;5972.552058595601;5738.139279108136;5870.471657550819;5872.647641141524;5888.617239879405;5888.970555147218;4595.793189306489;4597.747123908201;4600.907981840378;4601.171789077965;4612.769361531927;4417.11657668466;4470.619997300233;4496.145732310851;4557.680962332638;4594.035252596958;4482.61897738691;4488.34918936754;4489.147062058215;4515.819367225307;4520.638348932094;4476.328550717386;4484.663650226246;4494.213512635309;4501.797419116115;4516.570925762047;4027.8791636250958;4040.4141399497203;4040.7979601020124;4042.514898212204;4046.190761847642;5429.321334833146;5594.636348637367;5622.437756224385;5626.465485778845;5670.829875103754;5307.442718514539;5308.309919710413;5309.097453432887;5313.415524292324;5316.308879845596;6035.486983606399;6318.494520438354;6329.430351268362;6330;6336.6831658416895;4212.220739163265;4232.8518501852595;4253.829846806124;4258.893527661833;4335.674824388152;6408.359164083601;6511.869762604769;6518.152640156797;6520.18497687789;6550.082988381583;4522.683412161183;4529.818807247739;4536.364908912755;4538.205813982539;4538.931916021263;4516.07420478801;4566.931496027562;4585.931211031837;4595.747233902168;4600.079984003212;5251.317328747238;5262;5262.1317482615705;5262.289590905255;5269.182132164397;6317.905231421532;6323.810285691437;6325.462335701517;6328.493720502349;6337.493000559944;1558.7194305024977;1571.5049759325775;1573.0090043272664;1573.1269145624287;1573.9763903541457;1082.1396989393452;1083.041508265191;1085.7448499602588;1102.0412241349916;1114.2757207814984;5938.554608404387;5938.6436813791315;5939.851503712442;5939.940600594025;5941.970290148522;6460.676966151674;6461.935380646228;6464.709088091047;6465.967670161714;6471.805845824632;5924.822255332347;5929.555283353766;5931;5933.169356290036;5940.257467816523;3424.49322298188;3535.487354333607;3542.167590616203;3547.8048707320827;3548.4677298405445;6767.35710107539;6772.322767723287;6773.288804675537;6775.695093720795;6780.050792888999;6761.966190169018;6774.390304872585;6774.695138718769;6780.660966951633;6786.083878676414;6554.934450655528;6731.528792984542;6755.1556055493065;6768.83077923046;6785.287544807823;6319.368063193644;6467.482601391972;6559.704813283318;6562.868742625025;6568.7372505099265;6356.650384228727;6452.677366131768;6491.967540162269;6508.772192973223;6548.050532672831;6743.865122697421;6748.7300507979135;6749.156355455568;6754.527183097136;6754.59472431636;4506.324051392317;4539.046800172001;4579.93130103042;4583.74789386587;4586.701864378805;6546.18172728409;6551.672416379257;6555.672216389257;6558.1802274715665;6558.934410655832;6387.8722425550295;6393.465568263677;6398.200224971879;6402.90395644075;6474.5791523550815;6251.156093927261;6372.776952806815;6379.808605741835;6389.329120442472;6393.456556192776;6235.75056997715;6254.6247225166635;6264.123022776724;6270.717817698123;6275.466585340298;6396.9040464394;6398.872022559616;6402.391772781578;6403.871922561616;6404.935950640434;6107.8778424430375;6243.719032643451;6245.937540624535;6258.3428739983465;6266.874662506633 06:20:58 INFO - PROCESS | 4750 | |5;yui.html;712.1418690477974;742.8402893377922;757.8408534207816;793.2583034862404;850.3962186847338;13425.530106446276;13522.729545409085;13556.322183890816;13560.050796444253;13612.183269003866;12585.811212831815;12703.047271454654;12706.301153436558;12732.936335318334;12735.172213806096;670.3966430212798;677.6273049822603;807.8990126234236;808.9797755056112;810.7527204202715;804.9315808156314;826.921442462965;834.724540901504;834.8038211020436;835.0438747633985;868.9348298877578;869.84342818293;870.1863757386832;871.8866547348836;873.8514452543083;702.5854745700036;715.2061212054615;717.1000394504889;845.0662018469565;868.5917618719192;633.2021652717563;633.4647223096476;634.2927635686177;638.042935596605;638.3520726462644;12466.81299780504;12508.687282817911;12553.93723031379;12557.183783054072;12570.30863302518;11767.470463829148;12144.149909506337;12150.939245303716;12410.317432541207;12594.992400608022;8873.51195684237;8961.462312261285;9027.864582031274;9074.274058075403;9437;3576.213233088716;3584.8207589620415;3610.422332426799;3612.7832330060282;3616.077900135475;44632.77683611594;45002.549974500165;45152.54847451516;45176.096478070256;45215.99999999967;9338.20625246848;9419.717408477756;9424.481653509123;9496.762580935394;9764.609415623296;17267.481975540755;17424.47726568205;17460;17468.47594572165;17492.38776642837;7428.1457632371885;7542.47202695817;7646.235376462309;7653.425993050543;7933.880991785128;4270.081932384553;4359.694821362475;4368.978155109204;4387.3857659927635;4423.60187583119;3071.800332978349;3091.5517249998625;3102.953455698166;3104.8602812873473;3112.377524495065;557.1670352822475;567.690608618304;579.2151634535144;585.783260193731;591.7899145803264;614.612793939824;631.8330609629486;635.8569321902628;646.4957333280049;667.2597864768741;8196.54918979462;8322.791930201793;8371.121032291643;8419.158084191531;8732.476051436934;491.574787808543;501.9498050194951;578.7569220927221;597.2146627185238;646.6023395611664;3645.929527337007;3735.906602334909;3830.7701537907815;3908.159745654698;3922.588128246493;53794;53801.73099134479;54231.72884135554;54626.180607290924;54996;44507.55492445099;44583;45869.54130458653;51128.74435627798;51136.74431627818;44968.55031449709;44972.55027449749;44993.100137997055;45176.77411612987;46307.30539041917;7924.247196516321;7975.521468711664;8036.87944680842;8176.877346839683;8183.3453323732765;32516.18709532186;32545;32752.508712368857;33678.83160584181;34599;39565.60434395734;39925.401118982656;42900.57099428966;44291.33562996493;44480;10864.945675271572;10889.618863339745;10912.181586381212;10917.39954302521;11364.94317528407;11190.888091118984;11279.266847654877;11295.265807722471;11869;11965.282083074695;10497.422641754776;10690.358578485315;10877.238593298393;10915.617953371593;11369.2609980351;9980.500974951368;10837.566497340018;10858.45707714627;10864.293820901932;11142.052925501423;10654.786904262026;10784.730381740206;11084.16868734832;11115.610953616584;11138.777224455303;9226.538673066454;9281.628734850801;9416.387934784218;9441.669541566012;9552.283578731483;8919.643214271357;8967.551622418723;9197.632094716137;9526.142647161789;9689.70930872075 06:20:58 INFO - PROCESS | 4750 | __end_tp_report 06:20:58 INFO - PROCESS | 4750 | __start_cc_report 06:20:58 INFO - PROCESS | 4750 | _x_x_mozilla_cycle_collect,860 06:20:58 INFO - PROCESS | 4750 | __end_cc_report 06:20:58 INFO - PROCESS | 4750 | __startTimestamp1452262858451__endTimestamp 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | ------- Summary: start ------- 06:20:58 INFO - PROCESS | 4750 | Number of tests: 6 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#0] dojo.html Cycles:165 Average:5049.31 Median:5225.76 stddev:530.88 (10.2%) stddev-sans-first:509.00 06:20:58 INFO - PROCESS | 4750 | Values: 3058.0 3125.2 3157.6 3158.0 3186.0 4977.4 5059.6 5080.8 5081.4 5089.8 5067.6 5105.8 5134.3 5138.6 5146.8 4416.5 4525.7 4588.1 4633.6 4729.9 4567.6 4668.7 4701.5 4704.0 4816.4 4527.3 4613.7 4635.8 4646.0 4658.2 4647.0 4672.7 4684.6 4699.6 4713.7 4528.1 4652.9 4667.7 4671.7 4685.3 4792.7 4891.9 4910.5 4930.8 4935.0 5390.3 5392.0 5396.8 5403.7 5403.7 5308.4 5442.0 5453.5 5496.4 5502.3 5072.9 5097.8 5114.8 5134.0 5175.9 5554.3 5577.9 5594.3 5594.6 5597.5 5223.5 5364.8 5371.2 5384.4 5389.2 5385.5 5412.5 5423.0 5498.7 5539.6 5393.1 5420.3 5451.9 5454.6 5455.5 5352.7 5402.8 5483.3 5486.0 5533.7 4234.3 4236.2 4237.1 4245.8 4319.1 3817.9 3823.6 3835.9 3841.4 3864.5 5032.2 5033.3 5038.4 5050.3 5076.4 5232.8 5328.3 5337.0 5426.6 5436.9 5000.3 5037.7 5040.3 5059.7 5074.6 4671.3 4682.8 4684.2 4684.9 4728.4 5402.1 5535.7 5571.9 5584.4 5613.0 5319.7 5373.5 5402.3 5467.2 5510.8 5530.3 5552.8 5557.4 5583.0 5598.2 5309.2 5379.8 5382.3 5388.2 5445.0 5408.3 5429.1 5438.0 5468.3 5495.4 5314.5 5339.1 5341.3 5345.8 5349.9 5192.8 5269.9 5326.6 5341.1 5374.3 5225.8 5226.1 5236.6 5279.9 5318.4 5291.3 5292.6 5315.3 5323.3 5366.4 5183.9 5187.4 5195.2 5201.8 5225.2 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#1] ext.html Cycles:180 Average:44518.17 Median:36376.55 stddev:73316.54 (201.5%) stddev-sans-first:73447.79 06:20:58 INFO - PROCESS | 4750 | Values: 520.4 561.9 568.4 573.0 581.4 28395.0 29201.6 37717.6 38066.4 38217.6 40283.8 40399.6 40829.0 40879.4 40930.2 7362.9 8315.6 8478.7 8488.6 8511.9 7416.3 7536.1 7543.7 7545.1 9943.7 9935.1 10028.9 10031.2 10039.4 10045.2 9912.2 9974.6 9977.9 9988.8 9994.3 7480.1 7696.7 10006.7 10262.9 10271.3 37059.3 37407.3 37425.3 37445.8 37506.0 3250.2 3307.7 3394.4 3609.9 3732.0 28862.9 29000.3 29232.0 29377.7 29948.0 3653.5 3688.1 3728.3 3733.3 3770.5 282424.0 283728.0 284024.0 284349.0 284551.0 52935.7 54578.5 61464.7 62160.1 62222.4 56990.1 57328.4 57351.4 57360.7 57695.0 14718.8 14838.9 14916.5 14923.6 14933.0 11141.9 11177.9 11241.6 11242.3 11252.8 20430.9 20459.2 20500.8 20562.2 20592.6 7986.7 8210.5 8270.9 8315.3 8388.5 941.3 952.3 956.1 987.5 1086.8 27615.0 27773.9 28441.9 28458.3 28509.4 1034.3 1048.3 1062.6 1098.1 1127.9 14023.8 14765.3 14767.6 15339.6 15627.6 332871.0 337188.0 337687.6 337922.0 338392.0 45655.5 46689.0 53683.7 53854.2 53908.0 1244.5 1369.4 1373.9 1376.8 1383.5 27372.6 29142.6 29542.1 29584.3 30240.2 38663.2 39596.2 46368.0 47337.0 47361.8 202131.0 204237.0 204619.0 205351.0 205368.0 31198.7 31423.0 31596.4 31748.8 31837.2 39734.4 40747.0 40871.7 41154.2 41357.0 36386.5 36623.8 36896.8 36900.3 37461.3 36727.8 36785.2 37661.6 37761.8 38002.2 36023.3 36366.6 36560.5 36611.8 39146.4 31133.2 31529.5 31628.5 31840.5 31958.2 26050.0 26770.9 26824.2 26907.7 26999.5 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#2] jquery.html Cycles:180 Average:23229.09 Median:256016.04 stddev:64153.49 (25.1%) stddev-sans-first:64310.46 06:20:58 INFO - PROCESS | 4750 | Values: 353.8 359.5 370.3 370.8 374.4 13678.8 13832.4 16451.6 17160.1 18083.5 15182.8 15683.4 16331.0 16772.7 16857.6 4844.5 4998.7 5015.7 5021.7 5022.1 3771.9 3897.9 4901.0 4961.5 5282.6 5426.2 5438.0 5450.5 5488.1 5488.3 5467.8 5953.3 5964.2 5971.7 5972.4 5108.4 5223.4 5224.0 5325.8 5334.0 12600.2 12685.4 12685.6 17740.3 20220.8 1997.0 2057.2 2107.4 2172.1 2180.2 9554.8 9795.6 12280.8 13280.6 13368.1 1840.1 1869.5 1878.1 1889.2 1908.6 52938.5 59615.7 62654.7 64093.4 64463.7 14545.0 15024.7 15077.2 15077.6 15094.2 23362.8 23480.4 23637.6 23766.9 23804.3 8709.1 8840.4 8848.1 8901.6 8917.5 7455.5 7481.3 7493.6 7565.2 7568.5 7662.8 7669.9 7680.2 7682.9 7691.7 2413.6 2997.7 3007.3 3065.9 3072.8 858.6 985.7 1036.6 1041.5 1086.7 15430.5 15676.8 15768.2 15912.9 16035.6 915.4 922.1 940.6 964.5 985.5 8866.4 9173.9 9321.3 9411.9 9534.2 233727.0 236486.0 378469.0 499360.0 507010.0 70758.6 71056.6 71355.6 71397.6 72631.3 1136.3 1159.3 1179.2 1186.4 1189.1 14173.1 14269.1 14591.2 14804.9 14837.8 29621.3 31556.7 31978.8 32568.2 33132.0 39921.4 41702.2 42892.8 42981.6 42998.0 6816.7 6970.1 7037.6 7081.5 7251.1 9283.5 9944.1 9982.5 10672.7 10699.4 8972.2 9100.9 9111.8 9250.6 9478.0 9140.9 9206.0 9335.9 9361.2 9460.7 9239.2 9464.1 9472.8 9536.7 9676.8 7140.6 7141.9 7248.5 7261.8 7339.1 8895.9 9175.8 9513.4 9523.9 9558.5 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#3] mootools.html Cycles:180 Average:5467.91 Median:6702.65 stddev:2782.11 (41.5%) stddev-sans-first:2772.28 06:20:58 INFO - PROCESS | 4750 | Values: 1300.3 1434.8 1452.9 1609.7 1814.1 6836.7 7447.8 7624.1 7632.4 7638.3 7560.0 7704.2 7733.3 7740.2 7750.6 2035.7 2081.6 2228.1 2284.8 2312.1 2301.3 2305.6 2309.7 2310.3 2311.6 2208.7 2292.9 2297.0 2298.3 2298.6 2229.7 2245.8 2294.9 2313.0 2319.6 2281.4 2283.9 2303.0 2304.0 2329.0 7732.5 7803.5 7807.0 7807.1 7821.6 4834.6 4898.2 4902.3 4906.4 4948.5 2972.5 3041.5 3074.4 3084.1 3109.8 953.3 967.7 977.7 979.1 1018.9 10119.8 10151.8 10154.5 10173.5 10188.6 4204.3 4351.6 4352.0 4354.4 4409.5 8465.3 8749.9 8773.6 8797.1 8797.2 4858.5 4878.7 4879.5 4883.0 4883.1 4486.0 4489.4 4495.4 4502.8 4505.9 3375.0 3422.6 3463.9 3601.9 3679.1 1097.2 1133.4 1137.2 1143.4 1152.7 1315.1 1318.4 1341.3 1351.4 1358.0 7211.7 7246.9 7367.2 7371.7 7378.0 1086.6 1091.8 1100.1 1108.1 1122.0 5832.9 5838.5 5871.4 5890.1 5920.2 9152.4 9204.7 9369.7 9376.3 9469.0 9244.8 9282.6 9314.3 9365.4 9404.6 7253.9 7313.2 7356.1 7392.0 7475.1 7118.0 7130.3 7183.1 7189.1 7191.0 8172.9 8393.5 8443.7 8581.0 8589.6 8674.8 8738.1 8761.4 8786.0 8786.6 6792.8 7037.3 7037.9 7039.0 7040.4 6694.7 6817.9 7205.7 7392.2 7397.1 6896.5 7023.9 7042.0 7118.6 7129.5 7041.0 7043.9 7044.4 7063.8 7223.3 7175.0 7214.7 7258.8 7260.4 7270.1 6657.9 6679.6 6695.0 6700.8 6704.5 6730.1 6780.8 6785.9 6789.8 6792.3 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#4] prototype.html Cycles:180 Average:5281.40 Median:5932.08 stddev:1591.89 (26.8%) stddev-sans-first:1552.35 06:20:58 INFO - PROCESS | 4750 | Values: 328.9 334.9 341.3 345.5 347.1 5807.3 5850.3 5902.4 5961.2 5972.6 5738.1 5870.5 5872.6 5888.6 5889.0 4595.8 4597.7 4600.9 4601.2 4612.8 4417.1 4470.6 4496.1 4557.7 4594.0 4482.6 4488.3 4489.1 4515.8 4520.6 4476.3 4484.7 4494.2 4501.8 4516.6 4027.9 4040.4 4040.8 4042.5 4046.2 5429.3 5594.6 5622.4 5626.5 5670.8 5307.4 5308.3 5309.1 5313.4 5316.3 6035.5 6318.5 6329.4 6330.0 6336.7 4212.2 4232.9 4253.8 4258.9 4335.7 6408.4 6511.9 6518.2 6520.2 6550.1 4522.7 4529.8 4536.4 4538.2 4538.9 4516.1 4566.9 4585.9 4595.7 4600.1 5251.3 5262.0 5262.1 5262.3 5269.2 6317.9 6323.8 6325.5 6328.5 6337.5 1558.7 1571.5 1573.0 1573.1 1574.0 1082.1 1083.0 1085.7 1102.0 1114.3 5938.6 5938.6 5939.9 5939.9 5942.0 6460.7 6461.9 6464.7 6466.0 6471.8 5924.8 5929.6 5931.0 5933.2 5940.3 3424.5 3535.5 3542.2 3547.8 3548.5 6767.4 6772.3 6773.3 6775.7 6780.1 6762.0 6774.4 6774.7 6780.7 6786.1 6554.9 6731.5 6755.2 6768.8 6785.3 6319.4 6467.5 6559.7 6562.9 6568.7 6356.7 6452.7 6492.0 6508.8 6548.1 6743.9 6748.7 6749.2 6754.5 6754.6 4506.3 4539.0 4579.9 4583.7 4586.7 6546.2 6551.7 6555.7 6558.2 6558.9 6387.9 6393.5 6398.2 6402.9 6474.6 6251.2 6372.8 6379.8 6389.3 6393.5 6235.8 6254.6 6264.1 6270.7 6275.5 6396.9 6398.9 6402.4 6403.9 6404.9 6107.9 6243.7 6245.9 6258.3 6266.9 06:20:58 INFO - PROCESS | 4750 | 06:20:58 INFO - PROCESS | 4750 | [#5] yui.html Cycles:180 Average:13154.59 Median:46088.42 stddev:15053.41 (32.7%) stddev-sans-first:15066.64 06:20:58 INFO - PROCESS | 4750 | Values: 712.1 742.8 757.8 793.3 850.4 13425.5 13522.7 13556.3 13560.1 13612.2 12585.8 12703.0 12706.3 12732.9 12735.2 670.4 677.6 807.9 809.0 810.8 804.9 826.9 834.7 834.8 835.0 868.9 869.8 870.2 871.9 873.9 702.6 715.2 717.1 845.1 868.6 633.2 633.5 634.3 638.0 638.4 12466.8 12508.7 12553.9 12557.2 12570.3 11767.5 12144.1 12150.9 12410.3 12595.0 8873.5 8961.5 9027.9 9074.3 9437.0 3576.2 3584.8 3610.4 3612.8 3616.1 44632.8 45002.5 45152.5 45176.1 45216.0 9338.2 9419.7 9424.5 9496.8 9764.6 17267.5 17424.5 17460.0 17468.5 17492.4 7428.1 7542.5 7646.2 7653.4 7933.9 4270.1 4359.7 4369.0 4387.4 4423.6 3071.8 3091.6 3103.0 3104.9 3112.4 557.2 567.7 579.2 585.8 591.8 614.6 631.8 635.9 646.5 667.3 8196.5 8322.8 8371.1 8419.2 8732.5 491.6 501.9 578.8 597.2 646.6 3645.9 3735.9 3830.8 3908.2 3922.6 53794.0 53801.7 54231.7 54626.2 54996.0 44507.6 44583.0 45869.5 51128.7 51136.7 44968.6 44972.6 44993.1 45176.8 46307.3 7924.2 7975.5 8036.9 8176.9 8183.3 32516.2 32545.0 32752.5 33678.8 34599.0 39565.6 39925.4 42900.6 44291.3 44480.0 10864.9 10889.6 10912.2 10917.4 11364.9 11190.9 11279.3 11295.3 11869.0 11965.3 10497.4 10690.4 10877.2 10915.6 11369.3 9980.5 10837.6 10858.5 10864.3 11142.1 10654.8 10784.7 11084.2 11115.6 11138.8 9226.5 9281.6 9416.4 9441.7 9552.3 8919.6 8967.6 9197.6 9526.1 9689.7 06:20:58 INFO - PROCESS | 4750 | -------- Summary: end -------- 06:20:58 INFO - PROCESS | 4750 | 06:20:59 INFO - TEST-INFO | 4750: exit 0 06:20:59 INFO - TEST-OK | dromaeo_css | took 1112853ms 06:20:59 INFO - TEST-START | kraken 06:20:59 INFO - operating with platform_type : linux_ 06:20:59 INFO - Initialising browser for kraken test... 06:20:59 INFO - TEST-INFO | started process 4935 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcYSeYk/profile http://localhost:55479/getInfo.html) 06:21:03 INFO - PROCESS | 4935 | __metrics Screen width/height:1600/1200 06:21:03 INFO - PROCESS | 4935 | colorDepth:24 06:21:03 INFO - PROCESS | 4935 | Browser inner width/height: 1024/697 06:21:03 INFO - PROCESS | 4935 | __metrics 06:21:03 INFO - PROCESS | 4935 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:21:03 INFO - PROCESS | 4935 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:04 INFO - TEST-INFO | 4935: exit 0 06:21:04 INFO - Browser initialized. 06:21:04 INFO - Running cycle 1/1 for kraken test... 06:21:04 INFO - TEST-INFO | started process 5016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcYSeYk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:16 INFO - PROCESS | 5016 | RSS: Main: 149037056 06:21:16 INFO - PROCESS | 5016 | 06:21:18 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55479/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:19 INFO - PROCESS | 5016 | RSS: Main: 185495552 06:21:19 INFO - PROCESS | 5016 | 06:21:21 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55479/tests/kraken/driver.html?testName=audio-dft) 06:21:22 INFO - PROCESS | 5016 | RSS: Main: 176181248 06:21:22 INFO - PROCESS | 5016 | 06:21:25 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55479/tests/kraken/driver.html?testName=audio-fft) 06:21:25 INFO - PROCESS | 5016 | RSS: Main: 160260096 06:21:25 INFO - PROCESS | 5016 | 06:21:27 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55479/tests/kraken/driver.html?testName=audio-oscillator) 06:21:28 INFO - PROCESS | 5016 | RSS: Main: 162344960 06:21:28 INFO - PROCESS | 5016 | 06:21:30 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:31 INFO - PROCESS | 5016 | RSS: Main: 164597760 06:21:31 INFO - PROCESS | 5016 | 06:21:33 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55479/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:34 INFO - PROCESS | 5016 | RSS: Main: 165257216 06:21:34 INFO - PROCESS | 5016 | 06:21:37 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55479/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:38 INFO - PROCESS | 5016 | RSS: Main: 165789696 06:21:38 INFO - PROCESS | 5016 | 06:21:41 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55479/tests/kraken/driver.html?testName=json-parse-financial) 06:21:41 INFO - PROCESS | 5016 | RSS: Main: 164757504 06:21:41 INFO - PROCESS | 5016 | 06:21:43 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:43 INFO - PROCESS | 5016 | RSS: Main: 178032640 06:21:43 INFO - PROCESS | 5016 | 06:21:45 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:46 INFO - PROCESS | 5016 | RSS: Main: 175620096 06:21:46 INFO - PROCESS | 5016 | 06:21:48 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:48 INFO - PROCESS | 5016 | RSS: Main: 189407232 06:21:48 INFO - PROCESS | 5016 | 06:21:51 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:51 INFO - PROCESS | 5016 | RSS: Main: 194310144 06:21:51 INFO - PROCESS | 5016 | 06:21:54 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:55 INFO - PROCESS | 5016 | RSS: Main: 194514944 06:21:55 INFO - PROCESS | 5016 | 06:21:56 INFO - PROCESS | 5016 | Cycle 1(1): loaded http://localhost:55479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55479/tests/kraken/driver.html?testName=ai-astar) 06:21:57 INFO - PROCESS | 5016 | RSS: Main: 251985920 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | __start_tp_report 06:21:57 INFO - PROCESS | 5016 | _x_x_mozilla_page_load 06:21:57 INFO - PROCESS | 5016 | _x_x_mozilla_page_load_details 06:21:57 INFO - PROCESS | 5016 | |i|pagename|runs| 06:21:57 INFO - PROCESS | 5016 | |0;ai-astar;111;112;105;111;111;112;101;111;111;110 06:21:57 INFO - PROCESS | 5016 | |1;audio-beat-detection;157;129;146;168;126;144;154;126;171;124 06:21:57 INFO - PROCESS | 5016 | |2;audio-dft;161;161;160;161;160;162;160;163;161;163 06:21:57 INFO - PROCESS | 5016 | |3;audio-fft;72;74;83;94;70;74;74;96;90;71 06:21:57 INFO - PROCESS | 5016 | |4;audio-oscillator;95;95;141;95;96;96;138;95;97;135 06:21:57 INFO - PROCESS | 5016 | |5;imaging-gaussian-blur;109;110;109;109;109;109;109;110;109;109 06:21:57 INFO - PROCESS | 5016 | |6;imaging-darkroom;149;149;147;148;147;148;148;148;147;145 06:21:57 INFO - PROCESS | 5016 | |7;imaging-desaturate;96;95;96;96;95;95;96;96;96;95 06:21:57 INFO - PROCESS | 5016 | |8;json-parse-financial;57;58;56;57;56;56;56;66;55;56 06:21:57 INFO - PROCESS | 5016 | |9;json-stringify-tinderbox;67;68;67;68;68;67;68;67;67;67 06:21:57 INFO - PROCESS | 5016 | |10;stanford-crypto-aes;84;83;86;93;84;85;84;85;87;86 06:21:57 INFO - PROCESS | 5016 | |11;stanford-crypto-ccm;123;125;123;121;114;116;122;118;116;116 06:21:57 INFO - PROCESS | 5016 | |12;stanford-crypto-pbkdf2;160;158;153;150;156;143;164;165;147;151 06:21:57 INFO - PROCESS | 5016 | |13;stanford-crypto-sha256-iterative;69;68;67;67;67;67;66;71;67;69 06:21:57 INFO - PROCESS | 5016 | __end_tp_report 06:21:57 INFO - PROCESS | 5016 | __start_cc_report 06:21:57 INFO - PROCESS | 5016 | _x_x_mozilla_cycle_collect,957 06:21:57 INFO - PROCESS | 5016 | __end_cc_report 06:21:57 INFO - PROCESS | 5016 | __startTimestamp1452262917115__endTimestamp 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | ------- Summary: start ------- 06:21:57 INFO - PROCESS | 5016 | Number of tests: 14 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.60 (3.2%) stddev-sans-first:3.77 06:21:57 INFO - PROCESS | 5016 | Values: 111.0 112.0 105.0 111.0 111.0 112.0 101.0 111.0 111.0 110.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.00 stddev:17.79 (11.9%) stddev-sans-first:18.29 06:21:57 INFO - PROCESS | 5016 | Values: 157.0 129.0 146.0 168.0 126.0 144.0 154.0 126.0 171.0 124.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 06:21:57 INFO - PROCESS | 5016 | Values: 161.0 161.0 160.0 161.0 160.0 162.0 160.0 163.0 161.0 163.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#3] audio-fft Cycles:10 Average:79.80 Median:78.50 stddev:10.08 (12.8%) stddev-sans-first:10.28 06:21:57 INFO - PROCESS | 5016 | Values: 72.0 74.0 83.0 94.0 70.0 74.0 74.0 96.0 90.0 71.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:20.55 (21.6%) stddev-sans-first:21.23 06:21:57 INFO - PROCESS | 5016 | Values: 95.0 95.0 141.0 95.0 96.0 96.0 138.0 95.0 97.0 135.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:21:57 INFO - PROCESS | 5016 | Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.17 (0.8%) stddev-sans-first:1.13 06:21:57 INFO - PROCESS | 5016 | Values: 149.0 149.0 147.0 148.0 147.0 148.0 148.0 148.0 147.0 145.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:21:57 INFO - PROCESS | 5016 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.50 stddev:3.16 (5.6%) stddev-sans-first:3.35 06:21:57 INFO - PROCESS | 5016 | Values: 57.0 58.0 56.0 57.0 56.0 56.0 56.0 66.0 55.0 56.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:21:57 INFO - PROCESS | 5016 | Values: 67.0 68.0 67.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.83 (3.3%) stddev-sans-first:2.93 06:21:57 INFO - PROCESS | 5016 | Values: 84.0 83.0 86.0 93.0 84.0 85.0 84.0 85.0 87.0 86.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.50 stddev:3.84 (3.2%) stddev-sans-first:3.84 06:21:57 INFO - PROCESS | 5016 | Values: 123.0 125.0 123.0 121.0 114.0 116.0 122.0 118.0 116.0 116.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:157.00 stddev:7.21 (4.6%) stddev-sans-first:7.39 06:21:57 INFO - PROCESS | 5016 | Values: 160.0 158.0 153.0 150.0 156.0 143.0 164.0 165.0 147.0 151.0 06:21:57 INFO - PROCESS | 5016 | 06:21:57 INFO - PROCESS | 5016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.48 (2.2%) stddev-sans-first:1.50 06:21:57 INFO - PROCESS | 5016 | Values: 69.0 68.0 67.0 67.0 67.0 67.0 66.0 71.0 67.0 69.0 06:21:57 INFO - PROCESS | 5016 | -------- Summary: end -------- 06:21:57 INFO - PROCESS | 5016 | 06:21:58 INFO - TEST-INFO | 5016: exit 0 06:21:58 INFO - TEST-OK | kraken | took 58825ms 06:21:58 INFO - TEST-START | v8_7 06:21:58 INFO - operating with platform_type : linux_ 06:21:58 INFO - Initialising browser for v8_7 test... 06:21:58 INFO - TEST-INFO | started process 5265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmf_NuB/profile http://localhost:55479/getInfo.html) 06:22:01 INFO - PROCESS | 5265 | __metrics Screen width/height:1600/1200 06:22:01 INFO - PROCESS | 5265 | colorDepth:24 06:22:01 INFO - PROCESS | 5265 | Browser inner width/height: 1024/697 06:22:01 INFO - PROCESS | 5265 | __metrics 06:22:02 INFO - PROCESS | 5265 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:22:02 INFO - PROCESS | 5265 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:22:03 INFO - TEST-INFO | 5265: exit 0 06:22:03 INFO - Browser initialized. 06:22:03 INFO - Running cycle 1/1 for v8_7 test... 06:22:03 INFO - TEST-INFO | started process 5348 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmf_NuB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:14 INFO - PROCESS | 5348 | RSS: Main: 148692992 06:22:14 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | Cycle 1(1): loaded http://localhost:55479/tests/v8_7/run.html (next: http://localhost:55479/tests/v8_7/run.html) 06:22:37 INFO - PROCESS | 5348 | RSS: Main: 551292928 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | __start_tp_report 06:22:37 INFO - PROCESS | 5348 | _x_x_mozilla_page_load 06:22:37 INFO - PROCESS | 5348 | _x_x_mozilla_page_load_details 06:22:37 INFO - PROCESS | 5348 | |i|pagename|runs| 06:22:37 INFO - PROCESS | 5348 | |0;Richards;167.64459346186086 06:22:37 INFO - PROCESS | 5348 | |1;DeltaBlue;190.94901661256444 06:22:37 INFO - PROCESS | 5348 | |2;Encrypt;280.1120448179272 06:22:37 INFO - PROCESS | 5348 | |3;Decrypt;5159.79381443299 06:22:37 INFO - PROCESS | 5348 | |4;RayTrace;1113.5857461024498 06:22:37 INFO - PROCESS | 5348 | |5;Earley;799.3605115907275 06:22:37 INFO - PROCESS | 5348 | |6;Boyer;12108.43373493976 06:22:37 INFO - PROCESS | 5348 | |7;RegExp;42104.166666666664 06:22:37 INFO - PROCESS | 5348 | |8;Splay;595.959595959596 06:22:37 INFO - PROCESS | 5348 | |9;NavierStokes;4845.410628019324 06:22:37 INFO - PROCESS | 5348 | __end_tp_report 06:22:37 INFO - PROCESS | 5348 | __startTimestamp1452262957436__endTimestamp 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | ------- Summary: start ------- 06:22:37 INFO - PROCESS | 5348 | Number of tests: 10 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 167.6 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 190.9 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 280.1 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 5159.8 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 1113.6 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 799.4 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 12108.4 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#7] RegExp Cycles:1 Average:42104.17 Median:42104.17 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 42104.2 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#8] Splay Cycles:1 Average:595.96 Median:595.96 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 596.0 06:22:37 INFO - PROCESS | 5348 | 06:22:37 INFO - PROCESS | 5348 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:22:37 INFO - PROCESS | 5348 | Values: 4845.4 06:22:37 INFO - PROCESS | 5348 | -------- Summary: end -------- 06:22:37 INFO - PROCESS | 5348 | 06:22:38 INFO - TEST-INFO | 5348: exit 0 06:22:38 INFO - TEST-OK | v8_7 | took 40224ms 06:22:38 INFO - SUITE-END | took 1211s 06:22:38 INFO - Completed test suite (00:20:12) 06:22:38 INFO - Working with test: dromaeo_css 06:22:38 INFO - Generating results file: dromaeo_css 06:22:38 INFO - Working with test: kraken 06:22:38 INFO - Generating results file: kraken 06:22:38 INFO - javascript benchmark 06:22:38 INFO - Working with test: v8_7 06:22:38 INFO - Generating results file: v8_7 06:22:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:22:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:22:38 INFO - process_Request line: dromaeo_css 6830.25 graph.html#tests=[[72,1,35]] 06:22:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:22:38 INFO - process_Request line: kraken 1508.00 graph.html#tests=[[232,1,35]] 06:22:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:22:38 INFO - process_Request line: v8_7 20036.82 graph.html#tests=[[230,1,35]] 06:22:38 INFO - RETURN: dromaeo_css: 6830.25 06:22:38 INFO - RETURN: kraken: 1508.00 06:22:38 INFO - RETURN: v8_7: 20036.82 06:22:38 INFO - javascript benchmark 06:22:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3058.0, 3125.23431759219, 3157.557941888136, 3157.984210078949, 3185.9840700796485, 4977.377827771528, 5059.620528460367, 5080.771365288561, 5081.364829396325, 5089.796408143675, 5067.569256613183, 5105.770240339184, 5134.2812006319145, 5138.6146039047035, 5146.819861304855, 4416.470023597173, 4525.705829121113, 4588.128255631436, 4633.6061434778085, 4729.929051064237, 4567.566081222279, 4668.6731928765, 4701.529847015306, 4704.01215744694, 4816.373871396713, 4527.32090186473, 4613.653975951817, 4635.814567417299, 4646.047560250157, 4658.184817656914, 4646.976765116153, 4672.719636821767, 4684.648651351163, 4699.553542413465, 4713.670043096985, 4528.07174529224, 4652.883677908046, 4667.719936803803, 4671.719696818168, 4685.344051832746, 4792.712437253741, 4891.902161956741, 4910.459849416561, 4930.778114984834, 4935.0376676548085, 5390.299261096072, 5391.973040134774, 5396.83809485716, 5403.675779453245, 5403.7027963462, 5308.362996440414, 5442.0, 5453.454654534555, 5496.395396506381, 5502.284702988626, 5072.873178170538, 5097.847064588068, 5114.820981265638, 5133.974330128325, 5175.922361164623, 5554.305711786027, 5577.888442231133, 5594.328680558359, 5594.552435805126, 5597.496225339739, 5223.503767142115, 5364.758585863646, 5371.194320851825, 5384.434634363413, 5389.191621256843, 5385.461453854583, 5412.485813847678, 5423.0, 5498.697571633598, 5539.639923405047, 5393.110136827458, 5420.322459692538, 5451.863703407446, 5454.645448045864, 5455.509004189642, 5352.705601191972, 5402.837914862561, 5483.321936781584, 5486.0, 5533.723313834373, 4234.25900467417, 4236.2374772540625, 4237.089025859455, 4245.766482843412, 4319.136172765397, 3817.904552386157, 3823.5602905665646, 3835.9041023974064, 3841.4429907663234, 3864.478295430137, 5032.245163225545, 5033.295338652591, 5038.445770965191, 5050.267711181931, 5076.390833100052, 5232.764525596357, 5328.254044433782, 5337.039332920034, 5426.620136590401, 5436.945630543644, 5000.299958005882, 5037.697738135724, 5040.31955685985, 5059.696418214919, 5074.594032477393, 4671.299305104261, 4682.81268749253, 4684.205793307432, 4684.859454216379, 4728.432588089451, 5402.054640437987, 5535.6955367455175, 5571.916421253684, 5584.413636568183, 5613.045782217033, 5319.734013299397, 5373.516383525502, 5402.324709411324, 5467.207254947931, 5510.834674959758, 5530.253415788817, 5552.7778888845605, 5557.416471270459, 5583.0, 5598.1602759586385, 5309.177077552986, 5379.784808607768, 5382.30030096085, 5388.245645609696, 5445.0, 5408.323959505062, 5429.131338985743, 5438.0, 5468.26178465902, 5495.395506494362, 5314.5216930476445, 5339.065663508948, 5341.332333458317, 5345.759440825094, 5349.893002140013, 5192.818251361185, 5269.947300527099, 5326.627136100591, 5341.118715411913, 5374.274472946102, 5225.764840582106, 5226.085435048775, 5236.581073514034, 5279.8680032997945, 5318.441563635763, 5291.3385826771655, 5292.629515933848, 5315.3090098286975, 5323.30796996388, 5366.382865970463, 5183.948160518346, 5187.351581052369, 5195.246689230116, 5201.765920533509, 5225.216217567396], "unit": "score", "name": "dojo.html", "value": 5017.110164254141}, {"lowerIsBetter": false, "replicates": [520.4067363205946, 561.9438056194383, 568.4287291272269, 572.9829552544234, 581.3663107213137, 28395.0, 29201.56197657034, 37717.62282377175, 38066.4290035649, 38217.617823821754, 40283.798581007126, 40399.59600403995, 40829.0, 40879.38680919789, 40930.181396372056, 7362.926370736278, 8315.625796839142, 8478.66085356585, 8488.575571221414, 8511.872321915176, 7416.295451932057, 7536.057992750906, 7543.735969241077, 7545.056867891513, 9943.701688949342, 9935.05616966387, 10028.94985525075, 10031.197504199647, 10039.447830369327, 10045.19638428924, 9912.157466615346, 9974.551145198484, 9977.850332244985, 9988.800223995479, 9994.250431217615, 7480.102387713509, 7696.730614428524, 10006.69979900604, 10262.897371026269, 10271.332363396356, 37059.25881482382, 37407.25185496302, 37425.25149496995, 37445.81277093597, 37506.0, 3250.203700093469, 3307.6526964668847, 3394.372041172391, 3609.855605775766, 3731.9813400933094, 28862.855685721646, 29000.27499312513, 29232.0, 29377.70622293771, 29948.0, 3653.5250417445827, 3688.114852435423, 3728.328900797855, 3733.290674771785, 3770.4909837171904, 282424.0, 283728.0, 284024.0, 284349.0, 284551.0, 52935.73532132392, 54578.45421545813, 61464.692676537226, 62160.067598986054, 62222.377776222565, 56990.14514782282, 57328.42671573314, 57351.42648573544, 57360.71319643375, 57695.0, 14718.779218311734, 14838.851611483962, 14916.477923272634, 14923.552293431214, 14933.0, 11141.944290278496, 11177.944110279397, 11241.60654377093, 11242.325460472397, 11252.831207531894, 20430.897845510677, 20459.181632734522, 20500.794992050185, 20562.177512899318, 20592.58814823695, 7986.680532778624, 8210.507369557845, 8270.917290827136, 8315.251627353568, 8388.454750441202, 941.3363578677016, 952.3143336797494, 956.086936975187, 987.456898705709, 1086.7554800170058, 27615.0, 27773.86113069422, 28441.85779071133, 28458.28854278618, 28509.429811404072, 1034.3173505486343, 1048.3028785857318, 1062.617457715222, 1098.0885864732254, 1127.9154063445274, 14023.77011585934, 14765.33555989983, 14767.556973290819, 15339.616509587126, 15627.60930976712, 332871.0, 337188.0, 337687.6081152708, 337922.0, 338392.0, 45655.543444565126, 46689.0, 53683.731581341846, 53854.19218711722, 53908.0, 1244.458660482693, 1369.397465115366, 1373.8969577281744, 1376.8347798264272, 1383.5295999360064, 27372.58941115845, 29142.56286155752, 29542.113736587937, 29584.260393490335, 30240.243993899447, 38663.226735465694, 39596.20807583775, 46368.0, 47337.0, 47361.763191183825, 202131.0, 204237.0, 204619.0, 205351.0, 205368.0, 31198.688013120485, 31423.0, 31596.368072637957, 31748.841255794498, 31837.20406989751, 39734.40398394084, 40747.0, 40871.699087965564, 41154.1769164621, 41357.0, 36386.45420318644, 36623.81688091649, 36896.81551592225, 36900.26199476049, 37461.250774984896, 36727.81636091803, 36785.24110691762, 37661.623383766906, 37761.81119094387, 38002.239955201294, 36023.27953440864, 36366.63633363633, 36560.45159322665, 36611.81694091512, 39146.4128038074, 31133.221669458446, 31529.527057093703, 31628.525572116898, 31840.5223921646, 31958.201044974063, 26050.0, 26770.866145669148, 26824.189662181623, 26907.730922691306, 26999.460010800067], "unit": "score", "name": "ext.html", "value": 18270.30432789451}, {"lowerIsBetter": false, "replicates": [353.8425400696689, 359.4697820714446, 370.2908929400199, 370.76456450154143, 374.43086508507054, 13678.794818077737, 13832.446702131927, 16451.588710282234, 17160.141992900353, 18083.4574962751, 15182.84817151828, 15683.372665093382, 16331.0, 16772.66454670909, 16857.578560535992, 4844.539768721975, 4998.650094493387, 5015.69905805651, 5021.6986980781085, 5022.0709168803705, 3771.924561508768, 3897.902552436183, 4900.950990490085, 4961.454240033593, 5282.630215884889, 5426.158945363455, 5438.048341540234, 5450.482204190615, 5488.1493368527745, 5488.259085023531, 5467.753951072212, 5953.2856057272975, 5964.2246507953905, 5971.731272092723, 5972.372900845392, 5108.386993560759, 5223.399309079428, 5224.03355379256, 5325.840224793263, 5334.03987282289, 12600.180988235736, 12685.365731713377, 12685.556005539762, 17740.29038838445, 20220.79779202204, 1996.9900150499154, 2057.197692899755, 2107.388857231401, 2172.1094351315883, 2180.2042254576963, 9554.808903821955, 9795.608175673036, 12280.754384912341, 13280.601581952556, 13368.131071480322, 1840.0891558678406, 1869.4765465669634, 1878.098512713905, 1889.1782074797507, 1908.6373589018042, 52938.47061529412, 59615.70192149055, 62654.68672656653, 64093.35906640967, 64463.67768161176, 14545.0, 15024.699506009818, 15077.170755608548, 15077.623059423602, 15094.24528773557, 23362.76637233606, 23480.412989675395, 23637.645435318485, 23766.881165594063, 23804.285871423886, 8709.085546017704, 8840.381173317806, 8848.070952550019, 8901.643934242687, 8917.509536975529, 7455.515391499535, 7481.326680598663, 7493.587852668155, 7565.243475652501, 7568.508046976929, 7662.770116896502, 7669.923300766921, 7680.193579674165, 7682.884756728654, 7691.692332306757, 2413.553492603874, 2997.6552696439753, 3007.3083190866223, 3065.8773649054233, 3072.8476821192053, 858.6350800909588, 985.6845809341086, 1036.5905467340358, 1041.4792603698152, 1086.7174534621056, 15430.537083887277, 15676.843231567766, 15768.211589420484, 15912.92043539798, 16035.599110022109, 915.3775432705824, 922.087133737595, 940.5861420974886, 964.4984608003799, 985.4678473624306, 8866.423682460749, 9173.862392064124, 9321.300902432346, 9411.90588094124, 9534.189593884597, 233727.0, 236486.0, 378469.0, 499360.0, 507010.0, 70758.64620676864, 71056.64471677608, 71355.64322178355, 71397.64301178565, 72631.27368726351, 1136.2841409911703, 1159.263867444179, 1179.168686076314, 1186.3771519951922, 1189.1141099880472, 14173.149611023371, 14269.143851368952, 14591.197484138474, 14804.925975370053, 14837.777433338724, 29621.25946851346, 31556.684433155373, 31978.84010579932, 32568.185795355304, 33132.0, 39921.40117898292, 41702.1659566813, 42892.78553607212, 42981.57018429776, 42998.0, 6816.693248803716, 6970.128733908262, 7037.612931288828, 7081.539699919489, 7251.093613298338, 9283.48940808262, 9944.105030547285, 9982.500874956078, 10672.733181670521, 10699.411532365795, 8972.237359824489, 9100.908990910006, 9111.817763644558, 9250.629974800933, 9478.0, 9140.908590914005, 9205.953970230106, 9335.859962100438, 9361.157495825408, 9460.716178514656, 9239.168474837297, 9464.1009104135, 9472.810543789223, 9536.666216682383, 9676.806463870824, 7140.571565706075, 7141.892871607034, 7248.528845625017, 7261.818454538678, 7339.082614673166, 8895.911040889509, 9175.77060573491, 9513.381630194015, 9523.857142143012, 9558.522073896416], "unit": "score", "name": "jquery.html", "value": 8475.32689046772}, {"lowerIsBetter": false, "replicates": [1300.265350077207, 1434.7632640614295, 1452.941882324707, 1609.7263465210913, 1814.0657561355904, 6836.658167091644, 7447.813804654887, 7624.0851097868335, 7632.3894088472925, 7638.312551870331, 7560.0, 7704.229577042293, 7733.265339792725, 7740.187280335568, 7750.612469376537, 2035.704822800693, 2081.6253074446668, 2228.075348730283, 2284.7829456201634, 2312.1098377124845, 2301.3211102724654, 2305.6310990241564, 2309.6535519672016, 2310.2722642367685, 2311.6070268054386, 2208.6907832903407, 2292.85096468729, 2296.9655455168186, 2298.2990187992655, 2298.5977453945575, 2229.6989906362596, 2245.831562632801, 2294.919677811277, 2312.976870231293, 2319.5592837361014, 2281.3840263129027, 2283.942901427461, 2302.988485057581, 2303.97696023041, 2329.0, 7732.497387669783, 7803.531788092732, 7807.0, 7807.063152421746, 7821.648025838851, 4834.589059929875, 4898.2162853943555, 4902.289168070645, 4906.411230652309, 4948.455669876311, 2972.4946759050795, 3041.5437684347303, 3074.446599612069, 3084.1364417963005, 3109.7667674924246, 953.2564599612314, 967.6855022117769, 977.6724797192949, 979.0601023017912, 1018.8522664213722, 10119.797604047952, 10151.796964060752, 10154.543045562894, 10173.491325433699, 10188.643397481126, 4204.327307630764, 4351.586599273064, 4352.0, 4354.433923589913, 4409.492908315585, 8465.32277417805, 8749.868751968726, 8773.561321933877, 8797.12028797115, 8797.164269394398, 4858.514148585114, 4878.707277563358, 4879.536444037811, 4882.95117048825, 4883.121038213085, 4485.977570112129, 4489.371487991683, 4495.415595972503, 4502.842400515966, 4505.909881802346, 3374.983125084359, 3422.5892892853017, 3463.8960831175104, 3601.8739344123355, 3679.1170119171206, 1097.2154909239932, 1133.3709791066037, 1137.1641843245209, 1143.422571601336, 1152.7060599547062, 1315.1057281048788, 1318.4462525739214, 1341.3092257487401, 1351.4391527516168, 1357.9660508487366, 7211.71153153868, 7246.891296630555, 7367.152777430664, 7371.705131794775, 7377.963110184414, 1086.6196831109207, 1091.7980173667897, 1100.1034157161887, 1108.1245815805585, 1122.0406552397583, 5832.912506312408, 5838.474537291664, 5871.442212989845, 5890.057590785454, 5920.171176035358, 9152.405093668891, 9204.723858284262, 9369.718908432758, 9376.343655944154, 9469.0, 9244.815103698023, 9282.582283797245, 9314.34799564024, 9365.391249568756, 9404.576794044284, 7253.8549229015125, 7313.232110628307, 7356.117265928123, 7392.039034925425, 7475.140358858801, 7118.0, 7130.2869713028285, 7183.102112235971, 7189.1013623297085, 7191.0, 8172.877406839021, 8393.496390216607, 8443.66225350979, 8580.957095214484, 8589.570521474026, 8674.78313042179, 8738.126187381211, 8761.386702930733, 8785.956070219863, 8786.560671966248, 6792.830179245559, 7037.26108758573, 7037.859242815218, 7038.964805175941, 7040.401565866959, 6694.732210711712, 6817.93182068173, 7205.71177152908, 7392.22381649919, 7397.112346518452, 6896.4827637926355, 7023.894641580278, 7042.0, 7118.644067796486, 7129.500934934505, 7040.964795176196, 7043.859122817413, 7044.36600705939, 7063.823404414725, 7223.2776722329445, 7175.03137076488, 7214.675339609626, 7258.782236532912, 7260.382867456114, 7270.091238595176, 6657.933420665731, 6679.632620205935, 6695.0, 6700.83247918806, 6704.463642908653, 6730.057791909038, 6780.796576102724, 6785.864282714417, 6789.762358317435, 6792.320767923168], "unit": "score", "name": "mootools.html", "value": 4508.033753328838}, {"lowerIsBetter": false, "replicates": [328.93092450585374, 334.9447341188704, 341.34121146187846, 345.53180440503115, 347.1425578820314, 5807.274090738658, 5850.327212370578, 5902.350741418446, 5961.195238642782, 5972.552058595601, 5738.139279108136, 5870.471657550819, 5872.647641141524, 5888.617239879405, 5888.970555147218, 4595.793189306489, 4597.747123908201, 4600.907981840378, 4601.171789077965, 4612.769361531927, 4417.11657668466, 4470.619997300233, 4496.145732310851, 4557.680962332638, 4594.035252596958, 4482.61897738691, 4488.34918936754, 4489.147062058215, 4515.819367225307, 4520.638348932094, 4476.328550717386, 4484.663650226246, 4494.213512635309, 4501.797419116115, 4516.570925762047, 4027.8791636250958, 4040.4141399497203, 4040.7979601020124, 4042.514898212204, 4046.190761847642, 5429.321334833146, 5594.636348637367, 5622.437756224385, 5626.465485778845, 5670.829875103754, 5307.442718514539, 5308.309919710413, 5309.097453432887, 5313.415524292324, 5316.308879845596, 6035.486983606399, 6318.494520438354, 6329.430351268362, 6330.0, 6336.6831658416895, 4212.220739163265, 4232.8518501852595, 4253.829846806124, 4258.893527661833, 4335.674824388152, 6408.359164083601, 6511.869762604769, 6518.152640156797, 6520.18497687789, 6550.082988381583, 4522.683412161183, 4529.818807247739, 4536.364908912755, 4538.205813982539, 4538.931916021263, 4516.07420478801, 4566.931496027562, 4585.931211031837, 4595.747233902168, 4600.079984003212, 5251.317328747238, 5262.0, 5262.1317482615705, 5262.289590905255, 5269.182132164397, 6317.905231421532, 6323.810285691437, 6325.462335701517, 6328.493720502349, 6337.493000559944, 1558.7194305024977, 1571.5049759325775, 1573.0090043272664, 1573.1269145624287, 1573.9763903541457, 1082.1396989393452, 1083.041508265191, 1085.7448499602588, 1102.0412241349916, 1114.2757207814984, 5938.554608404387, 5938.6436813791315, 5939.851503712442, 5939.940600594025, 5941.970290148522, 6460.676966151674, 6461.935380646228, 6464.709088091047, 6465.967670161714, 6471.805845824632, 5924.822255332347, 5929.555283353766, 5931.0, 5933.169356290036, 5940.257467816523, 3424.49322298188, 3535.487354333607, 3542.167590616203, 3547.8048707320827, 3548.4677298405445, 6767.35710107539, 6772.322767723287, 6773.288804675537, 6775.695093720795, 6780.050792888999, 6761.966190169018, 6774.390304872585, 6774.695138718769, 6780.660966951633, 6786.083878676414, 6554.934450655528, 6731.528792984542, 6755.1556055493065, 6768.83077923046, 6785.287544807823, 6319.368063193644, 6467.482601391972, 6559.704813283318, 6562.868742625025, 6568.7372505099265, 6356.650384228727, 6452.677366131768, 6491.967540162269, 6508.772192973223, 6548.050532672831, 6743.865122697421, 6748.7300507979135, 6749.156355455568, 6754.527183097136, 6754.59472431636, 4506.324051392317, 4539.046800172001, 4579.93130103042, 4583.74789386587, 4586.701864378805, 6546.18172728409, 6551.672416379257, 6555.672216389257, 6558.1802274715665, 6558.934410655832, 6387.8722425550295, 6393.465568263677, 6398.200224971879, 6402.90395644075, 6474.5791523550815, 6251.156093927261, 6372.776952806815, 6379.808605741835, 6389.329120442472, 6393.456556192776, 6235.75056997715, 6254.6247225166635, 6264.123022776724, 6270.717817698123, 6275.466585340298, 6396.9040464394, 6398.872022559616, 6402.391772781578, 6403.871922561616, 6404.935950640434, 6107.8778424430375, 6243.719032643451, 6245.937540624535, 6258.3428739983465, 6266.874662506633], "unit": "score", "name": "prototype.html", "value": 4766.008001052447}, {"lowerIsBetter": false, "replicates": [712.1418690477974, 742.8402893377922, 757.8408534207816, 793.2583034862404, 850.3962186847338, 13425.530106446276, 13522.729545409085, 13556.322183890816, 13560.050796444253, 13612.183269003866, 12585.811212831815, 12703.047271454654, 12706.301153436558, 12732.936335318334, 12735.172213806096, 670.3966430212798, 677.6273049822603, 807.8990126234236, 808.9797755056112, 810.7527204202715, 804.9315808156314, 826.921442462965, 834.724540901504, 834.8038211020436, 835.0438747633985, 868.9348298877578, 869.84342818293, 870.1863757386832, 871.8866547348836, 873.8514452543083, 702.5854745700036, 715.2061212054615, 717.1000394504889, 845.0662018469565, 868.5917618719192, 633.2021652717563, 633.4647223096476, 634.2927635686177, 638.042935596605, 638.3520726462644, 12466.81299780504, 12508.687282817911, 12553.93723031379, 12557.183783054072, 12570.30863302518, 11767.470463829148, 12144.149909506337, 12150.939245303716, 12410.317432541207, 12594.992400608022, 8873.51195684237, 8961.462312261285, 9027.864582031274, 9074.274058075403, 9437.0, 3576.213233088716, 3584.8207589620415, 3610.422332426799, 3612.7832330060282, 3616.077900135475, 44632.77683611594, 45002.549974500165, 45152.54847451516, 45176.096478070256, 45215.99999999967, 9338.20625246848, 9419.717408477756, 9424.481653509123, 9496.762580935394, 9764.609415623296, 17267.481975540755, 17424.47726568205, 17460.0, 17468.47594572165, 17492.38776642837, 7428.1457632371885, 7542.47202695817, 7646.235376462309, 7653.425993050543, 7933.880991785128, 4270.081932384553, 4359.694821362475, 4368.978155109204, 4387.3857659927635, 4423.60187583119, 3071.800332978349, 3091.5517249998625, 3102.953455698166, 3104.8602812873473, 3112.377524495065, 557.1670352822475, 567.690608618304, 579.2151634535144, 585.783260193731, 591.7899145803264, 614.612793939824, 631.8330609629486, 635.8569321902628, 646.4957333280049, 667.2597864768741, 8196.54918979462, 8322.791930201793, 8371.121032291643, 8419.158084191531, 8732.476051436934, 491.574787808543, 501.9498050194951, 578.7569220927221, 597.2146627185238, 646.6023395611664, 3645.929527337007, 3735.906602334909, 3830.7701537907815, 3908.159745654698, 3922.588128246493, 53794.0, 53801.73099134479, 54231.72884135554, 54626.180607290924, 54996.0, 44507.55492445099, 44583.0, 45869.54130458653, 51128.74435627798, 51136.74431627818, 44968.55031449709, 44972.55027449749, 44993.100137997055, 45176.77411612987, 46307.30539041917, 7924.247196516321, 7975.521468711664, 8036.87944680842, 8176.877346839683, 8183.3453323732765, 32516.18709532186, 32545.0, 32752.508712368857, 33678.83160584181, 34599.0, 39565.60434395734, 39925.401118982656, 42900.57099428966, 44291.33562996493, 44480.0, 10864.945675271572, 10889.618863339745, 10912.181586381212, 10917.39954302521, 11364.94317528407, 11190.888091118984, 11279.266847654877, 11295.265807722471, 11869.0, 11965.282083074695, 10497.422641754776, 10690.358578485315, 10877.238593298393, 10915.617953371593, 11369.2609980351, 9980.500974951368, 10837.566497340018, 10858.45707714627, 10864.293820901932, 11142.052925501423, 10654.786904262026, 10784.730381740206, 11084.16868734832, 11115.610953616584, 11138.777224455303, 9226.538673066454, 9281.628734850801, 9416.387934784218, 9441.669541566012, 9552.283578731483, 8919.643214271357, 8967.551622418723, 9197.632094716137, 9526.142647161789, 9689.70930872075], "unit": "score", "name": "yui.html", "value": 6082.528357592256}], "name": "dromaeo_css", "value": 6830.253323634438}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 111.0, 111.0, 112.0, 101.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 146.0, 168.0, 126.0, 144.0, 154.0, 126.0, 171.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 160.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 83.0, 94.0, 70.0, 74.0, 74.0, 96.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 95.0, 96.0, 96.0, 138.0, 95.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 57.0, 56.0, 56.0, 56.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 93.0, 84.0, 85.0, 84.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 123.0, 121.0, 114.0, 116.0, 122.0, 118.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [160.0, 158.0, 153.0, 150.0, 156.0, 143.0, 164.0, 165.0, 147.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 71.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1508.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [42104.166666666664], "unit": "score", "name": "RegExp", "value": 21.63645719940624}, {"lowerIsBetter": false, "replicates": [595.959595959596], "unit": "score", "name": "Splay", "value": 136.73913559322037}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20036.815151211613}]} 06:22:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20036.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1508.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6830.25"}}} 06:22:38 INFO - Return code: 0 06:22:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:22:38 INFO - # TBPL SUCCESS # 06:22:38 INFO - Running post-action listener: _resource_record_post_action 06:22:38 INFO - Running post-run listener: _resource_record_post_run 06:22:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 551919616; Read time: 300; Write time: 429492 06:22:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 238784512; Read time: 168; Write time: 217796 06:22:39 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313135104; Read time: 132; Write time: 211696 06:22:39 INFO - Running post-run listener: _upload_blobber_files 06:22:39 INFO - Blob upload gear active. 06:22:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:22:39 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 06:22:39 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'] 06:22:39 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 06:22:40 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:41 INFO - (blobuploader) - INFO - Done attempting. 06:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:41 INFO - (blobuploader) - INFO - Done attempting. 06:22:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:41 INFO - Return code: 0 06:22:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:22:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78f78ad2378e33b0bd87c052915521f6ca5d384f54ec9b5f0ab143b3bcd00350ac7262b48ad34ab22199fa9da619e0fce98c314d4921209d4768fd1c34e8df81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86345220a977fb6c22c9e085b7b3bc0ac380925702235d63e7f277cbb4bf7b61e8f081111c28b80e550ca66b93471b5a361913e75c28e40e2e8e87857609b3a8"} 06:22:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:22:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:22:41 INFO - Contents: 06:22:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78f78ad2378e33b0bd87c052915521f6ca5d384f54ec9b5f0ab143b3bcd00350ac7262b48ad34ab22199fa9da619e0fce98c314d4921209d4768fd1c34e8df81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86345220a977fb6c22c9e085b7b3bc0ac380925702235d63e7f277cbb4bf7b61e8f081111c28b80e550ca66b93471b5a361913e75c28e40e2e8e87857609b3a8"} 06:22:41 INFO - Copying logs to upload dir... 06:22:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.795666 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-08 06:22:42.025940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 06:22:42.031070) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 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/78f78ad2378e33b0bd87c052915521f6ca5d384f54ec9b5f0ab143b3bcd00350ac7262b48ad34ab22199fa9da619e0fce98c314d4921209d4768fd1c34e8df81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86345220a977fb6c22c9e085b7b3bc0ac380925702235d63e7f277cbb4bf7b61e8f081111c28b80e550ca66b93471b5a361913e75c28e40e2e8e87857609b3a8"} build_url:https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/H5DYvyN2RC6Et9U9FmiVnw/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/78f78ad2378e33b0bd87c052915521f6ca5d384f54ec9b5f0ab143b3bcd00350ac7262b48ad34ab22199fa9da619e0fce98c314d4921209d4768fd1c34e8df81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86345220a977fb6c22c9e085b7b3bc0ac380925702235d63e7f277cbb4bf7b61e8f081111c28b80e550ca66b93471b5a361913e75c28e40e2e8e87857609b3a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 06:22:42.059168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:22:42.059934) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452261604.115588-1014103036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:22:42.142910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 06:22:42.143504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 06:22:42.144214) ========= ========= Total master_lag: 0.31 =========