builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1453294662.46 results: success (0) buildid: 20160120013040 builduid: 7fbda577b04d43719bc50d593d889743 revision: 39f56e62c694ea209ab0013a4c357084e7ed67ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.459293) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.459909) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.460396) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004950 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.483519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.483871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.497384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.497866) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.546990) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.547290) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.547697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.547970) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 04:57:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-01-20 04:57:43 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.660276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.660632) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.710823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:42.711200) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 39f56e62c694ea209ab0013a4c357084e7ed67ce --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 39f56e62c694ea209ab0013a4c357084e7ed67ce --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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 04:57:43,163 truncating revision to first 12 chars 2016-01-20 04:57:43,163 Setting DEBUG logging. 2016-01-20 04:57:43,163 attempt 1/10 2016-01-20 04:57:43,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/39f56e62c694?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 04:57:43,410 unpacking tar archive at: mozilla-inbound-39f56e62c694/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.263857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.264196) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004086 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.314533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.314858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.324599) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.324868) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 04:57:43.325242) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-20 04:57:43.325522) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:43 INFO - MultiFileLogger online at 20160120 04:57:43 in /builds/slave/test-pgo 04:57:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:57:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:57:43 INFO - {'append_to_log': False, 04:57:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:57:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:57:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:57:43 INFO - 'branch': 'Mozilla-Inbound', 04:57:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:43 INFO - 'config_files': ('talos/linux_config.py',), 04:57:43 INFO - 'default_actions': ('clobber', 04:57:43 INFO - 'read-buildbot-config', 04:57:43 INFO - 'download-and-extract', 04:57:43 INFO - 'populate-webroot', 04:57:43 INFO - 'create-virtualenv', 04:57:43 INFO - 'install', 04:57:43 INFO - 'run-tests'), 04:57:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:43 INFO - 'download_minidump_stackwalk': True, 04:57:43 INFO - 'download_symbols': 'ondemand', 04:57:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:43 INFO - 'installer_path': 'installer.exe', 04:57:43 INFO - 'log_level': 'info', 04:57:43 INFO - 'log_name': 'talos', 04:57:43 INFO - 'log_to_console': True, 04:57:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:43 INFO - 'opt_config_files': (), 04:57:43 INFO - 'pip_index': False, 04:57:43 INFO - 'sps_profile': False, 04:57:43 INFO - 'sps_profile_interval': 0, 04:57:43 INFO - 'suite': 'dromaeojs-e10s', 04:57:43 INFO - 'system_bits': '32', 04:57:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:43 INFO - 'title': 'talos-linux64-ix-047', 04:57:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:43 INFO - 'use_talos_json': True, 04:57:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:57:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:43 INFO - 'work_dir': 'build'} 04:57:43 INFO - ##### 04:57:43 INFO - ##### Running clobber step. 04:57:43 INFO - ##### 04:57:43 INFO - Running pre-action listener: _resource_record_pre_action 04:57:43 INFO - Running main action method: clobber 04:57:43 INFO - rmtree: /builds/slave/test-pgo/build 04:57:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:57:44 INFO - Running post-action listener: _resource_record_post_action 04:57:44 INFO - ##### 04:57:44 INFO - ##### Running read-buildbot-config step. 04:57:44 INFO - ##### 04:57:44 INFO - Running pre-action listener: _resource_record_pre_action 04:57:44 INFO - Running main action method: read_buildbot_config 04:57:44 INFO - Using buildbot properties: 04:57:44 INFO - { 04:57:44 INFO - "project": "", 04:57:44 INFO - "product": "firefox", 04:57:44 INFO - "script_repo_revision": "production", 04:57:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:57:44 INFO - "repository": "", 04:57:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:57:44 INFO - "buildid": "20160120013040", 04:57:44 INFO - "pgo_build": "True", 04:57:44 INFO - "basedir": "/builds/slave/test-pgo", 04:57:44 INFO - "buildnumber": 269, 04:57:44 INFO - "slavename": "talos-linux64-ix-047", 04:57:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:57:44 INFO - "platform": "ubuntu64_hw", 04:57:44 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:57:44 INFO - "branch": "mozilla-inbound", 04:57:44 INFO - "repo_path": "integration/mozilla-inbound", 04:57:44 INFO - "revision": "39f56e62c694ea209ab0013a4c357084e7ed67ce", 04:57:44 INFO - "stage_platform": "linux64-pgo", 04:57:44 INFO - "builduid": "7fbda577b04d43719bc50d593d889743", 04:57:44 INFO - "slavebuilddir": "test" 04:57:44 INFO - } 04:57:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:57:44 INFO - Running post-action listener: _resource_record_post_action 04:57:44 INFO - ##### 04:57:44 INFO - ##### Running download-and-extract step. 04:57:44 INFO - ##### 04:57:44 INFO - Running pre-action listener: _resource_record_pre_action 04:57:44 INFO - Running main action method: download_and_extract 04:57:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:44 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json 04:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json 04:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:57:44 INFO - Downloaded 1448 bytes. 04:57:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:57:44 INFO - Using the following test package requirements: 04:57:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:44 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:57:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'jsshell-linux-x86_64.zip'], 04:57:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:44 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:46 INFO - Downloaded 22484529 bytes. 04:57:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:57:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:57:47 INFO - Return code: 0 04:57:47 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 04:57:47 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')]} 04:57:47 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:48 INFO - Downloaded 22484529 bytes. 04:57:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:57:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:57:49 INFO - Return code: 0 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:50 INFO - Downloaded 10705515 bytes. 04:57:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:57:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:57:50 INFO - Return code: 0 04:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:50 INFO - https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aSnZ95h1Qcei6o3qrDDWCA/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 04:57:52 INFO - Downloaded 55948058 bytes. 04:57:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:52 INFO - mkdir: /builds/slave/test-pgo/properties 04:57:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:57:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:57:52 INFO - Contents: 04:57:52 INFO - build_url:https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:52 INFO - Running post-action listener: _resource_record_post_action 04:57:52 INFO - Running post-action listener: set_extra_try_arguments 04:57:52 INFO - ##### 04:57:52 INFO - ##### Running populate-webroot step. 04:57:52 INFO - ##### 04:57:52 INFO - Running pre-action listener: _resource_record_pre_action 04:57:52 INFO - Running main action method: populate_webroot 04:57:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:52 INFO - '--tppagecycles', 04:57:52 INFO - '7'], 04:57:52 INFO - 'tests': ['tsvgm']}}, 04:57:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'tests': ['damp', 'tps']}, 04:57:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['damp', 'tps']}, 04:57:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:52 INFO - 'other': {'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'other_l64': {'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:52 INFO - 'ts_paint', 04:57:52 INFO - 'tpaint', 04:57:52 INFO - 'sessionrestore', 04:57:52 INFO - 'sessionrestore_no_auto_restore']}, 04:57:52 INFO - 'svgr': {'tests': ['tsvgx', 04:57:52 INFO - 'tsvgr_opacity', 04:57:52 INFO - 'tart', 04:57:52 INFO - 'tscrollx', 04:57:52 INFO - 'cart']}, 04:57:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['tsvgx', 04:57:52 INFO - 'tsvgr_opacity', 04:57:52 INFO - 'tart', 04:57:52 INFO - 'tscrollx', 04:57:52 INFO - 'cart']}, 04:57:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'tests': ['tp5o']}, 04:57:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'talos_options': ['--e10s'], 04:57:52 INFO - 'tests': ['tp5o']}, 04:57:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'talos_options': ['--xperf_path', 04:57:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:52 INFO - 'tests': ['tp5n']}, 04:57:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:52 INFO - 'talos_options': ['--e10s', 04:57:52 INFO - '--xperf_path', 04:57:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:52 INFO - 'tests': ['tp5n']}}, 04:57:52 INFO - 'talos.zip': {'path': '', 04:57:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:52 INFO - Running post-action listener: _resource_record_post_action 04:57:52 INFO - ##### 04:57:52 INFO - ##### Running create-virtualenv step. 04:57:52 INFO - ##### 04:57:52 INFO - Running pre-action listener: _resource_record_pre_action 04:57:52 INFO - Running main action method: create_virtualenv 04:57:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:57:52 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 04:57:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:57:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:52 INFO - Using real prefix '/usr' 04:57:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:57:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:54 INFO - Installing pip.................done. 04:57:54 INFO - Return code: 0 04:57:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:57:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:57:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:57:54 INFO - Using env: {'DISPLAY': ':0', 04:57:54 INFO - 'HOME': '/home/cltbld', 04:57:54 INFO - 'LANG': 'en_US.UTF-8', 04:57:54 INFO - 'LANGUAGE': 'en_US:en', 04:57:54 INFO - 'LOGNAME': 'cltbld', 04:57:54 INFO - 'MAIL': '/var/mail/cltbld', 04:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:54 INFO - 'MOZ_NO_REMOTE': '1', 04:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:54 INFO - 'NO_EM_RESTART': '1', 04:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:54 INFO - 'SHELL': '/bin/bash', 04:57:54 INFO - 'SHLVL': '1', 04:57:54 INFO - 'TERM': 'linux', 04:57:54 INFO - 'TMOUT': '86400', 04:57:54 INFO - 'USER': 'cltbld', 04:57:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:54 INFO - '_': '/tools/buildbot/bin/python'} 04:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:54 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 04:57:54 INFO - Cleaning up... 04:57:55 INFO - Return code: 0 04:57:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:57:55 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')]} 04:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:55 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')]} 04:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:57:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:57:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:57:55 INFO - Using env: {'DISPLAY': ':0', 04:57:55 INFO - 'HOME': '/home/cltbld', 04:57:55 INFO - 'LANG': 'en_US.UTF-8', 04:57:55 INFO - 'LANGUAGE': 'en_US:en', 04:57:55 INFO - 'LOGNAME': 'cltbld', 04:57:55 INFO - 'MAIL': '/var/mail/cltbld', 04:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:55 INFO - 'MOZ_NO_REMOTE': '1', 04:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:55 INFO - 'NO_EM_RESTART': '1', 04:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:55 INFO - 'SHELL': '/bin/bash', 04:57:55 INFO - 'SHLVL': '1', 04:57:55 INFO - 'TERM': 'linux', 04:57:55 INFO - 'TMOUT': '86400', 04:57:55 INFO - 'USER': 'cltbld', 04:57:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:55 INFO - '_': '/tools/buildbot/bin/python'} 04:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:55 INFO - Downloading/unpacking psutil>=0.7.1 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:57 INFO - Installing collected packages: psutil 04:57:57 INFO - Running setup.py install for psutil 04:57:57 INFO - building 'psutil._psutil_linux' extension 04:57:57 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 04:57:57 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 04:57:57 INFO - building 'psutil._psutil_posix' extension 04:57:57 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 04:57:57 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 04:57:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:57 INFO - Successfully installed psutil 04:57:57 INFO - Cleaning up... 04:57:57 INFO - Return code: 0 04:57:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:57:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:57:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:57:57 INFO - Using env: {'DISPLAY': ':0', 04:57:57 INFO - 'HOME': '/home/cltbld', 04:57:57 INFO - 'LANG': 'en_US.UTF-8', 04:57:57 INFO - 'LANGUAGE': 'en_US:en', 04:57:57 INFO - 'LOGNAME': 'cltbld', 04:57:57 INFO - 'MAIL': '/var/mail/cltbld', 04:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:57 INFO - 'MOZ_NO_REMOTE': '1', 04:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:57 INFO - 'NO_EM_RESTART': '1', 04:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:57 INFO - 'SHELL': '/bin/bash', 04:57:57 INFO - 'SHLVL': '1', 04:57:57 INFO - 'TERM': 'linux', 04:57:57 INFO - 'TMOUT': '86400', 04:57:57 INFO - 'USER': 'cltbld', 04:57:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:57 INFO - '_': '/tools/buildbot/bin/python'} 04:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57:57 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 04:57:57 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 04:57:57 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 04:57:57 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 04:57:57 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 04:57:57 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 04:57:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:57:59 INFO - Installing collected packages: mozsystemmonitor 04:57:59 INFO - Running setup.py install for mozsystemmonitor 04:57:59 INFO - Successfully installed mozsystemmonitor 04:57:59 INFO - Cleaning up... 04:57:59 INFO - Return code: 0 04:57:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:57: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')]} 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:57:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:57:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:59 INFO - Using env: {'DISPLAY': ':0', 04:57:59 INFO - 'HOME': '/home/cltbld', 04:57:59 INFO - 'LANG': 'en_US.UTF-8', 04:57:59 INFO - 'LANGUAGE': 'en_US:en', 04:57:59 INFO - 'LOGNAME': 'cltbld', 04:57:59 INFO - 'MAIL': '/var/mail/cltbld', 04:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:59 INFO - 'MOZ_NO_REMOTE': '1', 04:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:59 INFO - 'NO_EM_RESTART': '1', 04:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:59 INFO - 'SHELL': '/bin/bash', 04:57:59 INFO - 'SHLVL': '1', 04:57:59 INFO - 'TERM': 'linux', 04:57:59 INFO - 'TMOUT': '86400', 04:57:59 INFO - 'USER': 'cltbld', 04:57:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:59 INFO - '_': '/tools/buildbot/bin/python'} 04:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:58:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:02 INFO - Downloading docopt-0.6.1.tar.gz 04:58:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:02 INFO - Running setup.py install for blobuploader 04:58:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:58:02 INFO - Running setup.py install for requests 04:58:02 INFO - Running setup.py install for docopt 04:58:02 INFO - Successfully installed blobuploader requests docopt 04:58:02 INFO - Cleaning up... 04:58:02 INFO - Return code: 0 04:58:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:58:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:58:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:02 INFO - Using env: {'DISPLAY': ':0', 04:58:02 INFO - 'HOME': '/home/cltbld', 04:58:02 INFO - 'LANG': 'en_US.UTF-8', 04:58:02 INFO - 'LANGUAGE': 'en_US:en', 04:58:02 INFO - 'LOGNAME': 'cltbld', 04:58:02 INFO - 'MAIL': '/var/mail/cltbld', 04:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:02 INFO - 'MOZ_NO_REMOTE': '1', 04:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:02 INFO - 'NO_EM_RESTART': '1', 04:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:02 INFO - 'SHELL': '/bin/bash', 04:58:02 INFO - 'SHLVL': '1', 04:58:02 INFO - 'TERM': 'linux', 04:58:02 INFO - 'TMOUT': '86400', 04:58:02 INFO - 'USER': 'cltbld', 04:58:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:02 INFO - '_': '/tools/buildbot/bin/python'} 04:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:03 INFO - Running setup.py (path:/tmp/pip-o7n2f9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:03 INFO - Running setup.py (path:/tmp/pip-DLpZ4F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:03 INFO - Running setup.py (path:/tmp/pip-O_0fMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:03 INFO - Running setup.py (path:/tmp/pip-twxzLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:03 INFO - Running setup.py (path:/tmp/pip-p2JJlG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:03 INFO - Running setup.py (path:/tmp/pip-RpmXtT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:03 INFO - Running setup.py (path:/tmp/pip-zMMAkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:03 INFO - Running setup.py (path:/tmp/pip-o9_tMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:03 INFO - Running setup.py (path:/tmp/pip-1aAUAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:03 INFO - Running setup.py (path:/tmp/pip-8nj1cG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:03 INFO - Running setup.py (path:/tmp/pip-aibiaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:03 INFO - Running setup.py (path:/tmp/pip-n6b6Nl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:04 INFO - Running setup.py (path:/tmp/pip-eTYJAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:04 INFO - Running setup.py (path:/tmp/pip-1UcgEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:04 INFO - Running setup.py (path:/tmp/pip-SX2CS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:04 INFO - Running setup.py (path:/tmp/pip-RyvKJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:04 INFO - Running setup.py (path:/tmp/pip-cKHlgM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:04 INFO - Running setup.py install for manifestparser 04:58:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:58:04 INFO - Running setup.py install for mozcrash 04:58:04 INFO - Running setup.py install for mozdebug 04:58:04 INFO - Running setup.py install for mozdevice 04:58:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:58:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:58:04 INFO - Running setup.py install for mozfile 04:58:04 INFO - Running setup.py install for mozhttpd 04:58:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozinfo 04:58:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozInstall 04:58:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozleak 04:58:05 INFO - Running setup.py install for mozlog 04:58:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for moznetwork 04:58:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozprocess 04:58:05 INFO - Running setup.py install for mozprofile 04:58:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozrunner 04:58:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:58:05 INFO - Running setup.py install for mozscreenshot 04:58:05 INFO - Running setup.py install for moztest 04:58:06 INFO - Running setup.py install for mozversion 04:58:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:06 INFO - Cleaning up... 04:58:06 INFO - Return code: 0 04:58:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:06 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')]} 04:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 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')]} 04:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:58:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:06 INFO - Using env: {'DISPLAY': ':0', 04:58:06 INFO - 'HOME': '/home/cltbld', 04:58:06 INFO - 'LANG': 'en_US.UTF-8', 04:58:06 INFO - 'LANGUAGE': 'en_US:en', 04:58:06 INFO - 'LOGNAME': 'cltbld', 04:58:06 INFO - 'MAIL': '/var/mail/cltbld', 04:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:06 INFO - 'MOZ_NO_REMOTE': '1', 04:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:06 INFO - 'NO_EM_RESTART': '1', 04:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:06 INFO - 'SHELL': '/bin/bash', 04:58:06 INFO - 'SHLVL': '1', 04:58:06 INFO - 'TERM': 'linux', 04:58:06 INFO - 'TMOUT': '86400', 04:58:06 INFO - 'USER': 'cltbld', 04:58:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:06 INFO - '_': '/tools/buildbot/bin/python'} 04:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:06 INFO - Running setup.py (path:/tmp/pip-wk5jeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:06 INFO - Running setup.py (path:/tmp/pip-k8HJh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:06 INFO - Running setup.py (path:/tmp/pip-oTqtpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:06 INFO - Running setup.py (path:/tmp/pip-9ORH7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:06 INFO - Running setup.py (path:/tmp/pip-GPJvkv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:06 INFO - Running setup.py (path:/tmp/pip-TeVolM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:06 INFO - Running setup.py (path:/tmp/pip-t9tE5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:06 INFO - Running setup.py (path:/tmp/pip-dNt24d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:06 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)) 04:58:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:06 INFO - Running setup.py (path:/tmp/pip-DXy906-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:07 INFO - Running setup.py (path:/tmp/pip-Xapmc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:07 INFO - Running setup.py (path:/tmp/pip-tsn0eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:07 INFO - Running setup.py (path:/tmp/pip-mI_Kr5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:07 INFO - Running setup.py (path:/tmp/pip-eIa_9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:07 INFO - Running setup.py (path:/tmp/pip-mOwrE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:07 INFO - Running setup.py (path:/tmp/pip-Hxbjty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:07 INFO - Running setup.py (path:/tmp/pip-5SKbl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:07 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)) 04:58:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:07 INFO - Running setup.py (path:/tmp/pip-c7pSAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:07 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)) 04:58:07 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)) 04:58:07 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)) 04:58:07 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)) 04:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58: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 04:58:09 INFO - Downloading blessings-1.5.1.tar.gz 04:58:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:09 INFO - Installing collected packages: blessings 04:58:09 INFO - Running setup.py install for blessings 04:58:09 INFO - Successfully installed blessings 04:58:09 INFO - Cleaning up... 04:58:09 INFO - Return code: 0 04:58:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:09 INFO - Reading from file tmpfile_stdout 04:58:09 INFO - Current package versions: 04:58:09 INFO - argparse == 1.2.1 04:58:09 INFO - blessings == 1.5.1 04:58:09 INFO - blobuploader == 1.2.4 04:58:09 INFO - docopt == 0.6.1 04:58:09 INFO - manifestparser == 1.1 04:58:09 INFO - mozInstall == 1.12 04:58:09 INFO - mozcrash == 0.16 04:58:09 INFO - mozdebug == 0.1 04:58:09 INFO - mozdevice == 0.48 04:58:09 INFO - mozfile == 1.2 04:58:09 INFO - mozhttpd == 0.7 04:58:09 INFO - mozinfo == 0.9 04:58:09 INFO - mozleak == 0.1 04:58:09 INFO - mozlog == 3.1 04:58:09 INFO - moznetwork == 0.27 04:58:09 INFO - mozprocess == 0.22 04:58:09 INFO - mozprofile == 0.28 04:58:09 INFO - mozrunner == 6.11 04:58:09 INFO - mozscreenshot == 0.1 04:58:09 INFO - mozsystemmonitor == 0.0 04:58:09 INFO - moztest == 0.7 04:58:09 INFO - mozversion == 1.4 04:58:09 INFO - psutil == 3.1.1 04:58:09 INFO - requests == 1.2.3 04:58:09 INFO - wsgiref == 0.1.2 04:58:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:09 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')]} 04:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:09 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')]} 04:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:58:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:09 INFO - Using env: {'DISPLAY': ':0', 04:58:09 INFO - 'HOME': '/home/cltbld', 04:58:09 INFO - 'LANG': 'en_US.UTF-8', 04:58:09 INFO - 'LANGUAGE': 'en_US:en', 04:58:09 INFO - 'LOGNAME': 'cltbld', 04:58:09 INFO - 'MAIL': '/var/mail/cltbld', 04:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:09 INFO - 'MOZ_NO_REMOTE': '1', 04:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:09 INFO - 'NO_EM_RESTART': '1', 04:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:09 INFO - 'SHELL': '/bin/bash', 04:58:09 INFO - 'SHLVL': '1', 04:58:09 INFO - 'TERM': 'linux', 04:58:09 INFO - 'TMOUT': '86400', 04:58:09 INFO - 'USER': 'cltbld', 04:58:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:09 INFO - '_': '/tools/buildbot/bin/python'} 04:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 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)) 04:58:10 INFO - Cleaning up... 04:58:10 INFO - Return code: 0 04:58:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:58:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:58:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:10 INFO - Using env: {'DISPLAY': ':0', 04:58:10 INFO - 'HOME': '/home/cltbld', 04:58:10 INFO - 'LANG': 'en_US.UTF-8', 04:58:10 INFO - 'LANGUAGE': 'en_US:en', 04:58:10 INFO - 'LOGNAME': 'cltbld', 04:58:10 INFO - 'MAIL': '/var/mail/cltbld', 04:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:10 INFO - 'MOZ_NO_REMOTE': '1', 04:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:10 INFO - 'NO_EM_RESTART': '1', 04:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:10 INFO - 'SHELL': '/bin/bash', 04:58:10 INFO - 'SHLVL': '1', 04:58:10 INFO - 'TERM': 'linux', 04:58:10 INFO - 'TMOUT': '86400', 04:58:10 INFO - 'USER': 'cltbld', 04:58:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:10 INFO - '_': '/tools/buildbot/bin/python'} 04:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:10 INFO - Downloading/unpacking jsonschema 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:12 INFO - warning: no files found matching '*.txt' 04:58:12 INFO - no previously-included directories found matching 'build' 04:58:12 INFO - no previously-included directories found matching 'dist' 04:58:12 INFO - no previously-included directories found matching '.git*' 04:58:12 INFO - Installing collected packages: jsonschema, functools32 04:58:12 INFO - Running setup.py install for functools32 04:58:12 INFO - warning: no files found matching '*.txt' 04:58:12 INFO - no previously-included directories found matching 'build' 04:58:12 INFO - no previously-included directories found matching 'dist' 04:58:12 INFO - no previously-included directories found matching '.git*' 04:58:12 INFO - Successfully installed jsonschema functools32 04:58:12 INFO - Cleaning up... 04:58:12 INFO - Return code: 0 04:58:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f28fac1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, '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': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', '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 04:58:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:58:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:58:12 INFO - Using env: {'DISPLAY': ':0', 04:58:12 INFO - 'HOME': '/home/cltbld', 04:58:12 INFO - 'LANG': 'en_US.UTF-8', 04:58:12 INFO - 'LANGUAGE': 'en_US:en', 04:58:12 INFO - 'LOGNAME': 'cltbld', 04:58:12 INFO - 'MAIL': '/var/mail/cltbld', 04:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:12 INFO - 'MOZ_NO_REMOTE': '1', 04:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:12 INFO - 'NO_EM_RESTART': '1', 04:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:12 INFO - 'SHELL': '/bin/bash', 04:58:12 INFO - 'SHLVL': '1', 04:58:12 INFO - 'TERM': 'linux', 04:58:12 INFO - 'TMOUT': '86400', 04:58:12 INFO - 'USER': 'cltbld', 04:58:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:12 INFO - '_': '/tools/buildbot/bin/python'} 04:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:12 INFO - Downloading/unpacking flake8 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:12 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 04:58:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 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 04:58:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:14 INFO - no previously-included directories found matching 'docs/_build' 04:58:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:15 INFO - Running setup.py install for pep8 04:58:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:15 INFO - no previously-included directories found matching 'docs/_build' 04:58:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:58:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:15 INFO - Cleaning up... 04:58:15 INFO - Return code: 0 04:58:15 INFO - Running post-action listener: _resource_record_post_action 04:58:15 INFO - Running post-action listener: _start_resource_monitoring 04:58:15 INFO - Starting resource monitoring. 04:58:15 INFO - ##### 04:58:15 INFO - ##### Running install step. 04:58:15 INFO - ##### 04:58:15 INFO - Running pre-action listener: _resource_record_pre_action 04:58:15 INFO - Running main action method: install 04:58:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:15 INFO - Reading from file tmpfile_stdout 04:58:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:58:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:58:15 INFO - Reading from file tmpfile_stdout 04:58:15 INFO - Output received: 04:58:15 INFO - Usage: mozinstall [options] installer 04:58:15 INFO - Options: 04:58:15 INFO - -h, --help show this help message and exit 04:58:15 INFO - -d DEST, --destination=DEST 04:58:15 INFO - Directory to install application into. [default: 04:58:15 INFO - "/builds/slave/test-pgo"] 04:58:15 INFO - --app=APP Application being installed. [default: firefox] 04:58:15 INFO - mkdir: /builds/slave/test-pgo/build/application 04:58:15 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'] 04:58:15 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 04:58:31 INFO - Reading from file tmpfile_stdout 04:58:31 INFO - Output received: 04:58:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:58:31 INFO - Running post-action listener: _resource_record_post_action 04:58:31 INFO - ##### 04:58:31 INFO - ##### Running run-tests step. 04:58:31 INFO - ##### 04:58:31 INFO - Running pre-action listener: _resource_record_pre_action 04:58:31 INFO - Running main action method: run_tests 04:58:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:58:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:58:31 INFO - Python 2.7.3 04:58:31 INFO - Return code: 0 04:58:31 INFO - grabbing minidump binary from tooltool 04:58:31 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')]} 04:58:31 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 0x1f337f0>, '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 0x1e9f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:58:31 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 04:58:31 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 04:58:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:32 INFO - Return code: 0 04:58:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:58:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:58:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:58:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:58:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:58:32 INFO - Return code: 0 04:58:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:58:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:58:32 INFO - Using env: {'DISPLAY': ':0', 04:58:32 INFO - 'HOME': '/home/cltbld', 04:58:32 INFO - 'LANG': 'en_US.UTF-8', 04:58:32 INFO - 'LANGUAGE': 'en_US:en', 04:58:32 INFO - 'LOGNAME': 'cltbld', 04:58:32 INFO - 'MAIL': '/var/mail/cltbld', 04:58:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:32 INFO - 'MOZ_NO_REMOTE': '1', 04:58:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:32 INFO - 'NO_EM_RESTART': '1', 04:58:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:58:32 INFO - 'SHELL': '/bin/bash', 04:58:32 INFO - 'SHLVL': '1', 04:58:32 INFO - 'TERM': 'linux', 04:58:32 INFO - 'TMOUT': '86400', 04:58:32 INFO - 'USER': 'cltbld', 04:58:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474', 04:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:32 INFO - '_': '/tools/buildbot/bin/python'} 04:58:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:58:33 INFO - mozversion application_buildid: 20160120013040 04:58:33 INFO - mozversion application_changeset: 39f56e62c694ea209ab0013a4c357084e7ed67ce 04:58:33 INFO - mozversion application_display_name: Nightly 04:58:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:33 INFO - mozversion application_name: Firefox 04:58:33 INFO - mozversion application_remotingname: firefox 04:58:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:58:33 INFO - mozversion application_vendor: Mozilla 04:58:33 INFO - mozversion application_version: 46.0a1 04:58:33 INFO - mozversion platform_buildid: 20160120013040 04:58:33 INFO - mozversion platform_changeset: 39f56e62c694ea209ab0013a4c357084e7ed67ce 04:58:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:58:33 INFO - mozversion platform_version: 46.0a1 04:58:33 INFO - using testdate: 1453294713 04:58:33 INFO - actual date: 1453294713 04:58:33 INFO - starting webserver on 'localhost:33314' 04:58:33 INFO - SUITE-START | Running 3 tests 04:58:33 INFO - TEST-START | dromaeo_css 04:58:33 INFO - operating with platform_type : linux_ 04:58:33 INFO - Initialising browser for dromaeo_css test... 04:58:33 INFO - TEST-INFO | started process 20826 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplHl__h/profile http://localhost:33314/getInfo.html) 04:58:36 INFO - PROCESS | 20826 | 04:58:36 INFO - PROCESS | 20826 | (process:20909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:58:37 INFO - PROCESS | 20826 | __metrics Screen width/height:1600/1200 04:58:37 INFO - PROCESS | 20826 | colorDepth:24 04:58:37 INFO - PROCESS | 20826 | Browser inner width/height: 1024/697 04:58:37 INFO - PROCESS | 20826 | __metrics 04:58:37 INFO - PROCESS | 20826 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:58:38 INFO - TEST-INFO | 20826: exit 0 04:58:38 INFO - Browser initialized. 04:58:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:38 INFO - TEST-INFO | started process 20958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplHl__h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:39 INFO - PROCESS | 20958 | -- checkerboarding starts below -- 04:58:39 INFO - PROCESS | 20958 | RENDERTRACE 0.059166 rect red 0 0 10 10 // viewport 04:58:39 INFO - PROCESS | 20958 | RENDERTRACE 23.036 rect brown 0 0 10 10 // page 04:58:39 INFO - PROCESS | 20958 | RENDERTRACE 23.0613 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 04:58:39 INFO - PROCESS | 20958 | Checkerboarded for 1 frames (32.1772 ms), 100 peak, 2 severity. 04:58:39 INFO - PROCESS | 20958 | 04:58:39 INFO - PROCESS | 20958 | (process:21018): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:58:50 INFO - PROCESS | 20958 | RSS: Main: 150609920 04:58:50 INFO - PROCESS | 20958 | 04:59:39 INFO - PROCESS | 20958 | 1453294779820 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:01:48 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33314/tests/dromaeo/cssquery-ext.html) 05:01:49 INFO - PROCESS | 20958 | RSS: Main: 155717632 05:01:49 INFO - PROCESS | 20958 | 05:04:51 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-ext.html (next: http://localhost:33314/tests/dromaeo/cssquery-jquery.html) 05:04:52 INFO - PROCESS | 20958 | RSS: Main: 151060480 05:04:52 INFO - PROCESS | 20958 | 05:07:54 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33314/tests/dromaeo/cssquery-mootools.html) 05:07:54 INFO - PROCESS | 20958 | RSS: Main: 151650304 05:07:54 INFO - PROCESS | 20958 | 05:10:56 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33314/tests/dromaeo/cssquery-prototype.html) 05:10:57 INFO - PROCESS | 20958 | RSS: Main: 150384640 05:10:57 INFO - PROCESS | 20958 | 05:13:59 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33314/tests/dromaeo/cssquery-yui.html) 05:14:00 INFO - PROCESS | 20958 | RSS: Main: 150843392 05:14:00 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | Cycle 1(1): loaded http://localhost:33314/tests/dromaeo/cssquery-yui.html (next: http://localhost:33314/tests/dromaeo/cssquery-dojo.html) 05:17:02 INFO - PROCESS | 20958 | RSS: Main: 153161728 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | __start_tp_report 05:17:02 INFO - PROCESS | 20958 | _x_x_mozilla_page_load 05:17:02 INFO - PROCESS | 20958 | _x_x_mozilla_page_load_details 05:17:02 INFO - PROCESS | 20958 | |i|pagename|runs| 05:17:02 INFO - PROCESS | 20958 | |0;dojo.html;3222.9194270143244;3234.385466761317;3268.166617512534;3277.4756039033746;3278.3934972030174;5222.973885130578;5238.345206849144;5277.868053298665;5290.761915713788;5300.416954135042;5265.262863199156;5268.998890210857;5278.234655974881;5297.947020529794;5305.867353316169;4536.591706746392;4815.518448155182;4977.1538838397555;4988.401391832985;4994.725290109042;4805.087033463631;4887.242477416006;4930.704157750529;4951.653384263085;4954.43024052235;4845.806167753286;4852.563269305761;4953.653244272867;4954.405471343426;4974.079795237856;4839.637027222972;4861.693210393969;4865.44047434546;4885.218365061573;4918.5573298403315;4764.428268607755;4792.281157826319;4804.447488538828;4882.682625629358;4891.5353041461;5067.2145817397995;5088.1350170471105;5110.310108135392;5162.328897243372;5204.635675502716;5756.251687280626;5768;5773.566982476289;5790.565707571949;5807.680577568232;5795.797147099831;5804.854878628026;5826.1552074948895;5830.82507524775;5831.825045248649;5275.182346736224;5322.414534401213;5359.9732001340135;5373.811916582901;5429.267048948421;5853.912191317134;5873.706314684334;5878.500327472213;5889.882202356014;5900.557458190653;5627.071533197059;5651.152327150878;5653.519450846642;5659.660420374791;5676.148577713294;5650.5479561634975;5713.942860571424;5745.798897038583;5760.193572899798;5828.76684932598;5632.7746890123935;5636.239107720406;5639.746211420496;5645.068563687028;5660.179274005329;5660.688662123623;5668.206451096849;5671.602987790815;5678.261825962681;5679.062954612443;4396.802143903532;4403.625691816167;4405.669574781904;4480.865574032784;4480.955190448054;3932.528096628423;3933.3116704576582;3945.270125026822;3952.604739526082;3972.841086356513;5301.575873930076;5338.065838478251;5344.251804747339;5345.946540534623;5361.195820626937;5729.684867332254;5762.279715035621;5801.767929282866;5841.123831425235;5868.823935281863;5343.251944727741;5364.678119312854;5372.758225879845;5374;5402.729863506809;4817.108834865561;4896.534829191221;4930.211166213388;4933.407991041098;4948.134076536664;5895.675737834375;5901.380355062743;5902.026165682701;5927.288725352899;5971.044632858721;5788.363280039108;5792.9710351447975;5816.534677225896;5837.5329973601165;5840.737166827418;5939.762409503572;6011.398860113954;6012.518998480198;6042.637441753509;6043;5628.409017053151;5664.518515926193;5671.461211184931;5672.546196304368;5718.456746609066;5631.915521267102;5670.979223739767;5717.42825717425;5728.341240757366;5732.398098199629;5570.2480165177185;5587.497125258584;5595.356533998643;5596;5619.157126430904;5617.775288988558;5623.156526521055;5629.605927585029;5644.350899646429;5672.4894759471845;5463.344398672185;5465.453454654662;5496.587755918402;5496.945030549803;5505.889882202414;5485.286912701324;5555.30558680165;5623.606347555632;5636.070048441961;5660.490555849993;5401;5404.83785486436;5423.511883930465;5444.237806706985;5445.646033007842 05:17:02 INFO - PROCESS | 20958 | |1;ext.html;522.2505704314311;529.1269405480956;536.393874921339;558.2184941082484;560.946710062544;34904.82547587262;35567.64432355676;35599.64400355996;35606;35628.82185589072;39703.03712035996;39729.40405893914;40109;40281.79859100708;40340.19319613606;8457.53483558404;8607.784805379853;8614.698485553006;8626.654933802673;8627.352948528855;8248.298894593936;8403.579821008956;8412.789680257982;8416.368772342068;8421.831563368729;8794.824103517925;8853.15894989975;8860.24687901529;8868.201861832435;8885.68900088497;8691.26124279437;8698;8745.212930836255;8751.474911505298;8788.912110878937;8419.07390187079;8565.914340856574;8574.699885503978;8602.827943441096;8609.440386374928;39679.40480892789;40212.798936005136;40513.18973620511;40533.79733101345;40565;3224.339010502841;3253.951190732117;3276.42662534058;3280.8851690190727;3792.1088544192094;29950.850245748632;30459.543106853416;30502.237444063852;30949.226269343446;31639.841800790848;3995.36074228125;4051;4069.572694867026;4074.3684728867074;4182.581741825824;228118;228793;228834.99999999834;228972;229468;53930;55191.448085519434;55782.16326755102;56057;61352;56147.157792633145;56160;56224.15663765047;56580.434195657515;56695;14166.362513686909;14272.429102835978;14311.427542898376;14383.712325753635;14436.566902992927;11409.828852567218;11413.543458261576;11494.655160345203;11577.76844463106;11593.478293476814;19761.40715778529;20235.898820505805;20657.793422065886;20936;20969.475763106046;7791.4935529190425;7967;7969.601519923981;8008.319292860056;8033;916.2166347772692;957.9712608621752;976.2970661123979;980.161961522902;1050.6270274052754;28988.565171522445;31099.533506997413;31382;31519.84240078785;32295.192620184684;1061.6443491430457;1070.7376692710336;1084.281413958884;1102.895224953628;1128.031584884382;14618.122912625277;14699.191544465157;14743.926280368743;15019.399224031135;15074.849251507563;371085;372526;373284;374273;375607;54455.72772136114;55022;55253;55532.44467555353;55553.444465555636;1338.7857942729117;1353.6480515066153;1356.9118007329491;1357.9185248885099;1378.6484446466288;28082.85958570194;28702.85648571744;28892.414219721533;28986.56520152157;29261.268468288465;47262;47361;47685;47828.28257576209;48135.037299254516;292564;294002;294158;294354;294701;28645.708343332066;29204.415911681222;31623.525647115774;32792.34415311728;33128.66871331352;40722.1855562893;41112.17775644411;41492;41512.37731434091;41983.160336793706;33928.66071339354;35086.82456587701;35432;35459.64540354667;36009.09977250485;34856.65143348635;35243.647563524035;35605.82197088998;35743.821280893426;35810.10474738153;34967.475487868214;35118.12204694903;35420.82289588536;38940.22119557537;39703.40444893271;29911.700882990892;31224;31394.843025784725;31593.8420307897;32700.50949235716;25501.744982549935;25666.358341041625;25673.871630641726;25905.487408652032;26407.60388594211 05:17:02 INFO - PROCESS | 20958 | |2;jquery.html;345.7476042488983;349.3118556443806;351.4254194392169;354.11647938393713;362.01170803705867;15615.84384156158;16522.83477165228;16911.40810071648;17541.561460963483;17982.280708771632;11276.267042642243;11385.089192864572;11586.362750048744;11588.246763960336;11636.476358563863;4792.9281060784115;4929.658412254186;5012.72430016349;5067.670601410915;5404.351477822647;5292.285541451913;5371.838844834661;5377.542908852753;5384.784608615671;5389.353277606673;5137.357830271216;5179.430262671103;5278.709670968095;5345.251664766916;5345.652532585389;5248.343957005374;5267.657602255879;5300.893982120375;5307.495787900143;5680.886382272372;5345.786168553253;5366.141417373202;5377.0321342158395;5384.757685904105;5396.703181325026;19044.61910761777;19125.521861953563;19793.703094453595;19982.900085499627;20056.298029568894;1995.750531183602;2027.341114137911;2142.464383904024;2208.0946811807244;2235.5417139486367;9408.153266206074;9478.431294122374;10740.570377184904;12266.32535210563;12852.871471285354;1707.6926153292402;1822.4350451360121;1878.098512713905;1908.761404824397;1929.7201905723591;55744.72127639336;55831.44168558303;55950.720246398916;56018.719906400205;56468.152977705366;10146.746331341628;10186.286959912883;10206.13247873939;10232.744181395525;10272.33229840058;13059.477620895057;13121.868781312256;13185;13231.603051908458;13252.602421927357;7341.926580734124;7379.520331178456;7481.8877716834295;7538.924610753932;7542.396608271325;7184.748533801292;7389.371903388273;7496.100467943882;7497.66260518278;7571.924280757232;4335.696501244883;4358.36803663467;4395.428594282723;4401.845935392246;4417.514073451917;1788.2131861980688;1810.1130446081324;1880.7084901839962;1897.4497395755352;1916.3963351544219;882.9117088291248;956.9952150239204;1032.210359075308;1078.6063086973354;1081.1134869407167;13683.794743078863;15445.227738613024;15891.523254302389;16350.918245408935;16429.58926026859;964.5996911281879;966.8694726212012;973.7808992976666;990.9702708918744;1011.2769369900557;9407.341486095907;9502.144806967406;9577.456356116092;9673.661421850202;9780.657676981271;553358;567757;579993;582854;595043;68276.31723682799;68741.3125868735;69206;69870.65064674745;69942.65028674925;1077.3159044007111;1084.3439718970067;1088.5319312695617;1096.0245381610373;1102.090775110537;14347.92826035863;14523.564293071226;14574.198419086628;14809.33357998871;14813.555593332218;31338.373232534766;31669.524957126123;31697.366052679277;31912;32229.838850805594;41648.3752743703;42491.366083075176;42943.7852810734;42993.570064300206;43076.78461607672;6866.485013624098;7006.859862802818;7053.118360204974;7181.497295189287;7230.385417239593;10426.530806113591;11035.503402346752;11179.273347232403;11471;11639.53441862316;8908.510031948304;9210.677626283048;9441.244700424088;9557.235421166151;9970.900290996997;9764;9804.803903922024;9853.852192216978;9921.801563968536;10032.548535315782;9295.349325547148;9858.802823943624;9927.851082233918;10047.698569042941;10231;7256.129264488084;7284.781456556312;7373.5575865448245;7389.519681220703;7439.888401673871;8825.779355516164;9450.52747362643;9807.950960245153;9936.503174841084;10029.097381235724 05:17:02 INFO - PROCESS | 20958 | |3;mootools.html;1451.1148199598244;1470.69115485748;1616.3696158498187;1721.715916873716;1738.9217485213164;7658.54048757075;7687.3850091992645;7830.530168189898;7885.250901164394;7903.249191326815;7880.172581878906;7961.084475285344;7981.640826162822;8052.91947080529;8056.154103819103;2279.9886000570013;2303.49323148907;2305.9538809223804;2306.4349234437586;2309.7459279479244;2248.269312473453;2275.112706044644;2314.2941402872116;2314.7338056123594;2319.6868422762964;2236.798688118069;2307.5500277445904;2312.0173926081434;2315.2591170825344;2338.286822519131;2223.288547664748;2263.230501629454;2266.8186545076355;2268.3421807675836;2275.4993901341677;2249.336445748508;2255.3572231913827;2257.9322620321254;2260.2315212827552;2262.061244583496;7735.497192682514;7745.651445684957;7757.185495523002;7766.611669416507;7779.533228006281;4814.975925120387;4912.484189160158;4914.975425122851;4968.850934471971;4975.278584605248;3145.952810707818;3151.448496513101;3181.0456862941023;3189.9681003189903;3193.0740085375214;1115.4144074360945;1122.6351435783322;1125.6293336234803;1126.645106791358;1190.69042049067;10908.781824363548;10997.395143267197;11002.724931876686;11005.834912476319;11014.50434730431;4171.311733563989;4226.408302837605;4273.102648443862;4312.374705667723;4323.935140972888;8851.60167792451;8866.42368246062;8872.645094196288;8880.644774209088;8883.333749968779;4770.451398089264;4793.13723529768;4801.567858892717;4812.494688057774;4820.421549414093;4323.265044942367;4347.6304514116655;4380.2772542530765;4381.38660587518;4388.363687265392;3508.8771593089964;3603.1352475405715;3604.0809593553477;3618.3667858124722;3649.6350364963823;1096.4188979840696;1122.1135303110452;1122.119136477861;1137.6928229378186;1138.2658185470325;962.3167551038841;1013.5236438873718;1130.8812574679705;1225.957091501811;1376.3256004557695;7107.609081500567;7122.501424900311;7133.322334378226;7167.820804479929;7171.89242161368;642.9774957876546;651.8012006338017;654.6726636681659;662.3773652766384;788.8364662123322;5446.101393270145;5554.888902221933;5574.358948720868;5606.747696353592;5645.435456454404;9172.541372931326;9390.577424015935;9580.56887440067;9583.041695830501;9644.517774111266;9442.197413219954;9493;9518.619255229853;9524.809503809885;9542.52287385628;7398.852022959511;7472.551646901204;7478.5138965967035;7504.849903001909;7558.281963213486;7304.598247096461;7324.194338622854;7364.594947277951;7374.557526548424;7393.260673932564;8399.160083991552;8618.310535157047;8629.050804411385;8730.079382535832;8773.473591584525;8590.098039705741;8784.648614055366;8800.735977920673;8896.866547001671;8926.553672316488;6704.329567043452;6722.630255336004;6728.495362847708;6862.622555759481;6864.176298844171;7568.697252109854;7575.621218939141;7593.278638529331;7604.80987975305;7611.923880761122;6828.214755303204;7157.427405807419;7379.667914943733;7468.850622987618;7499.62501874915;6750.696218670269;6788.214066186799;6806.76176333826;6829.93170068293;6935.410490108397;6929.1684997800585;7052.400545953651;7077.5753454792875;7097.893531596927;7143.464240182111;6572.638504882086;6639.136912201383;6644.4020038196795;6645.700943457653;6658.101156344025;6602.1747281589805;6663.46692264608;6668.466522678077;6671.366220209073;6730.394264516217 05:17:02 INFO - PROCESS | 20958 | |4;prototype.html;331.6915268800016;338.13268965104504;339.8776440481426;345.82362994872636;354.792446418845;6180.536459765513;6215.968920155398;6235.095911092889;6261.874762504747;6410.102585638003;6183.165272688186;6230.345813689565;6236;6245.344238854912;6251.4686251668545;4769.117713223048;4770.0459908018365;4772.928406073912;4775.546323099309;4776.402949631296;4777.474477807438;4784.66507344486;4786.018866132452;4787.066522028206;4788.880277993043;4661.997670500841;4683.859484215462;4700.670953033289;4700.976495117537;4701.130290896195;4676.485586585472;4682.321063445798;4683.157031734287;4685;4687.343771871941;4040.151568170688;4041.838326466938;4042.535108462535;4042.757434553936;4050.5139383274195;5942.227510423617;5945.286565612154;5947.613405128653;5958.344582095966;5958.642481451084;5356.062689029404;5451.318585176853;5470.972645136789;5474.39781624021;5487.807926722546;6623.07276981223;6627;6631.568948018412;6631.668416579152;6632.834179145511;4503.144402563503;4507.166174257773;4511.368408422823;4512.52618475062;4517.796699148546;6708.530402871801;6807.727690892359;6910.2053263874795;6924.480663950224;6928.307169283082;4539.251023581138;4559.452865656076;4562.041971186021;4568.6116680081905;4569.405977223007;4617.238155704338;4617.607503362185;4625.930611040837;4634.374359461497;4638.976805115953;5397.4062853086125;5400.972995134999;5421.674699517963;5423.891522169534;5435.456454354533;6409;6635.4359879410795;6639.203295604559;6644.103046088716;6644.634545099969;1600;1649.736042233237;1650.7193777057928;1652.6694661067595;1654.3713388912377;1085.3813326404031;1090.6346373964811;1091;1103.6578660615235;1109.8501702270253;6158.076288556752;6217.129601855744;6224.035274532454;6229.626222426669;6239.313675495692;6705.664716764142;6707.463402927754;6719.966400167968;6732.2931092235585;6746.392824645805;6074.149619053336;6153.538484613582;6160.353162917919;6161.599496032743;6187.783427580013;3631.0559254593995;3646.6717995380013;3653.013686304683;3654.214343916071;3656.9817150914073;7062.223155452896;7064.364207221375;7083.574985500886;7094.787156385317;7105.71577136919;6643.60138391698;6890.621015844176;6907.481938854606;6912.377885990285;6922.7923162305215;7059.682314295869;7062.364387205176;7069.257727938595;7072.434205263567;7072.5402848814665;6663.866722665616;6717.596944183365;6733.158355205599;6736.966315168393;6754.662266886734;6509.153810004858;6621.966890165711;6632.801015969336;6636.13730215069;6656.134702488839;7022.964885175541;7067.469939754436;7075.752348667772;7089.7873063808165;7098.538594991309;4539.6822222445435;4568.862934111849;4569.337446070368;4576.88557786058;4584.289435137559;6738.898916516354;6741.494387920828;6753.15585551806;6756.189257289157;6913.41235994926;6637.103990961352;6647.268800432045;6678;6713.765018224339;6721;6633.1045308882685;6670.9332906670315;6677.29888361715;6679.56582822115;6689.5986240825705;6457.806265812033;6555.2133743951035;6566.4418524424045;6570.967145164243;6571.638559879252;6683.598984060972;6713.227978782307;6723.294054124247;6731.966340168267;6741.393274605309;6535.607863528204;6537.607743535403;6538.346165383614;6543.378379053982;6550.803475895731 05:17:02 INFO - PROCESS | 20958 | |5;yui.html;854.7820305822016;856.131027007587;857.9142085791418;861.3582880753839;888.1074520107292;13025.544105956293;13194.07641465098;13209.933950330247;13253.536126235584;13263.933680331585;11687.29876207426;12679.112462127654;12690.873091269084;12711.173773704702;12721.618351449471;655.223560081304;780.7540624703229;801.2148094867034;802.8033131882697;804.6781287484994;794.7973266816954;795.5982228974389;796.2555011064644;796.2753893956501;802.9116797152309;818.0633175014605;824.6412810427483;826.3348004856089;827.3091968206555;828.6850996621275;813.0649752784316;817.0726225733805;818.6275244763618;820.7496713502379;821.1706176761454;604.1270364323555;604.5526310530176;605.3764622438895;608.5101493297893;608.9238845144357;12773.042021848305;12780.233186008869;12801.61595152147;13189;13298.135621184592;12728.490860365575;13059.412326445332;13299.53451629198;13354.933225333909;13423.194608323533;10407.479626018669;11470.942645286803;11595.304281743123;11925.821112683318;12005;3645.398509245971;3697.4638677391627;3708.2398108387715;3801.7528860624247;3815.8855234342736;49060;49623;49692.254616180784;49866.50133498655;49893.999999999636;9559.091886270793;10243.84634230487;10425.165986721044;10494.003069708366;10524.538384370042;18972.905135474233;19084.427467176007;19105.617887642446;19126.426207213804;19141.80858191428;7533.886991695129;7669.118051424158;7772.067351917806;7892.052953645484;7912.960435197902;4009.538903026131;4138.296489596776;4143.254214241466;4150.979245103756;4282.48610166782;3074.200707815984;3084.9691503085132;3085.6605773364913;3092.5515800209296;3103.239706271933;531.5667730799386;539.981100661475;541.3206425935426;556.8273835111129;567.6962824888665;562.6820846221872;625.4152367536368;637.6142433827467;638.8339031851659;678.8167194857459;8273.33813294935;8292.58537073156;8339.874901876477;8391.202835730595;8400.453970491899;588.3381196154327;589.4997232044457;698.6576577477;700.7162099349772;737.6238118559573;3940.704447166474;4009.9599004009588;4071.307877660805;4177.394277829698;4259.084296876186;48713.85932195732;48754.75622621864;49116.50883491191;49408.75295623571;49555.75222123866;45936.3109553357;47139.29291060637;47292;47529.5247047532;47793.76103119462;43560.3465948011;43893.99999999936;43996;44499.55500444954;44772.77613611976;8083.19168083187;8281.834363312579;8490.915090849012;8510.361722870686;8536.274416674403;31679.683203167675;32029.519557207128;32071.839640801645;32198;32260.677393225767;41093.58906410898;42206;42377;43848;44108.558914411726;9991.25065620067;10136.341137826017;10379.169666426818;10448.42533660656;10613.681589552325;11292.661220163409;11509.13681473876;11527.365994870028;11665.416729163677;11904.702382440162;11598.304101753922;11611.303321800719;11953.820692689791;11957.461914214055;12383.133180677267;11366.204365694322;11991.880081199077;12333.62999110028;12487.562935297221;12520.87479125197;10918.672439826818;11010.614628487965;11116.777664446505;11277.605283815026;11620.928366989074;9280;9377.296702747184;9550.166798809343;9681.177099946302;9705.17506011997;9004.63981440735;9630.66292679781;10146.49267536635;10231.59073637076;10243 05:17:02 INFO - PROCESS | 20958 | __end_tp_report 05:17:02 INFO - PROCESS | 20958 | __start_cc_report 05:17:02 INFO - PROCESS | 20958 | _x_x_mozilla_cycle_collect,321 05:17:02 INFO - PROCESS | 20958 | __end_cc_report 05:17:02 INFO - PROCESS | 20958 | __startTimestamp1453295822861__endTimestamp 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | ------- Summary: start ------- 05:17:02 INFO - PROCESS | 20958 | Number of tests: 6 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#0] dojo.html Cycles:165 Average:5318.03 Median:5485.29 stddev:588.34 (10.7%) stddev-sans-first:566.72 05:17:02 INFO - PROCESS | 20958 | Values: 3222.9 3234.4 3268.2 3277.5 3278.4 5223.0 5238.3 5277.9 5290.8 5300.4 5265.3 5269.0 5278.2 5297.9 5305.9 4536.6 4815.5 4977.2 4988.4 4994.7 4805.1 4887.2 4930.7 4951.7 4954.4 4845.8 4852.6 4953.7 4954.4 4974.1 4839.6 4861.7 4865.4 4885.2 4918.6 4764.4 4792.3 4804.4 4882.7 4891.5 5067.2 5088.1 5110.3 5162.3 5204.6 5756.3 5768.0 5773.6 5790.6 5807.7 5795.8 5804.9 5826.2 5830.8 5831.8 5275.2 5322.4 5360.0 5373.8 5429.3 5853.9 5873.7 5878.5 5889.9 5900.6 5627.1 5651.2 5653.5 5659.7 5676.1 5650.5 5713.9 5745.8 5760.2 5828.8 5632.8 5636.2 5639.7 5645.1 5660.2 5660.7 5668.2 5671.6 5678.3 5679.1 4396.8 4403.6 4405.7 4480.9 4481.0 3932.5 3933.3 3945.3 3952.6 3972.8 5301.6 5338.1 5344.3 5345.9 5361.2 5729.7 5762.3 5801.8 5841.1 5868.8 5343.3 5364.7 5372.8 5374.0 5402.7 4817.1 4896.5 4930.2 4933.4 4948.1 5895.7 5901.4 5902.0 5927.3 5971.0 5788.4 5793.0 5816.5 5837.5 5840.7 5939.8 6011.4 6012.5 6042.6 6043.0 5628.4 5664.5 5671.5 5672.5 5718.5 5631.9 5671.0 5717.4 5728.3 5732.4 5570.2 5587.5 5595.4 5596.0 5619.2 5617.8 5623.2 5629.6 5644.4 5672.5 5463.3 5465.5 5496.6 5496.9 5505.9 5485.3 5555.3 5623.6 5636.1 5660.5 5401.0 5404.8 5423.5 5444.2 5445.6 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#1] ext.html Cycles:180 Average:46634.84 Median:35776.96 stddev:79877.95 (223.3%) stddev-sans-first:80026.99 05:17:02 INFO - PROCESS | 20958 | Values: 522.3 529.1 536.4 558.2 560.9 34904.8 35567.6 35599.6 35606.0 35628.8 39703.0 39729.4 40109.0 40281.8 40340.2 8457.5 8607.8 8614.7 8626.7 8627.4 8248.3 8403.6 8412.8 8416.4 8421.8 8794.8 8853.2 8860.2 8868.2 8885.7 8691.3 8698.0 8745.2 8751.5 8788.9 8419.1 8565.9 8574.7 8602.8 8609.4 39679.4 40212.8 40513.2 40533.8 40565.0 3224.3 3254.0 3276.4 3280.9 3792.1 29950.9 30459.5 30502.2 30949.2 31639.8 3995.4 4051.0 4069.6 4074.4 4182.6 228118.0 228793.0 228835.0 228972.0 229468.0 53930.0 55191.4 55782.2 56057.0 61352.0 56147.2 56160.0 56224.2 56580.4 56695.0 14166.4 14272.4 14311.4 14383.7 14436.6 11409.8 11413.5 11494.7 11577.8 11593.5 19761.4 20235.9 20657.8 20936.0 20969.5 7791.5 7967.0 7969.6 8008.3 8033.0 916.2 958.0 976.3 980.2 1050.6 28988.6 31099.5 31382.0 31519.8 32295.2 1061.6 1070.7 1084.3 1102.9 1128.0 14618.1 14699.2 14743.9 15019.4 15074.8 371085.0 372526.0 373284.0 374273.0 375607.0 54455.7 55022.0 55253.0 55532.4 55553.4 1338.8 1353.6 1356.9 1357.9 1378.6 28082.9 28702.9 28892.4 28986.6 29261.3 47262.0 47361.0 47685.0 47828.3 48135.0 292564.0 294002.0 294158.0 294354.0 294701.0 28645.7 29204.4 31623.5 32792.3 33128.7 40722.2 41112.2 41492.0 41512.4 41983.2 33928.7 35086.8 35432.0 35459.6 36009.1 34856.7 35243.6 35605.8 35743.8 35810.1 34967.5 35118.1 35420.8 38940.2 39703.4 29911.7 31224.0 31394.8 31593.8 32700.5 25501.7 25666.4 25673.9 25905.5 26407.6 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#2] jquery.html Cycles:180 Average:28243.81 Median:4605.22 stddev:94014.22 (2041.5%) stddev-sans-first:94254.61 05:17:02 INFO - PROCESS | 20958 | Values: 345.7 349.3 351.4 354.1 362.0 15615.8 16522.8 16911.4 17541.6 17982.3 11276.3 11385.1 11586.4 11588.2 11636.5 4792.9 4929.7 5012.7 5067.7 5404.4 5292.3 5371.8 5377.5 5384.8 5389.4 5137.4 5179.4 5278.7 5345.3 5345.7 5248.3 5267.7 5300.9 5307.5 5680.9 5345.8 5366.1 5377.0 5384.8 5396.7 19044.6 19125.5 19793.7 19982.9 20056.3 1995.8 2027.3 2142.5 2208.1 2235.5 9408.2 9478.4 10740.6 12266.3 12852.9 1707.7 1822.4 1878.1 1908.8 1929.7 55744.7 55831.4 55950.7 56018.7 56468.2 10146.7 10186.3 10206.1 10232.7 10272.3 13059.5 13121.9 13185.0 13231.6 13252.6 7341.9 7379.5 7481.9 7538.9 7542.4 7184.7 7389.4 7496.1 7497.7 7571.9 4335.7 4358.4 4395.4 4401.8 4417.5 1788.2 1810.1 1880.7 1897.4 1916.4 882.9 957.0 1032.2 1078.6 1081.1 13683.8 15445.2 15891.5 16350.9 16429.6 964.6 966.9 973.8 991.0 1011.3 9407.3 9502.1 9577.5 9673.7 9780.7 553358.0 567757.0 579993.0 582854.0 595043.0 68276.3 68741.3 69206.0 69870.7 69942.7 1077.3 1084.3 1088.5 1096.0 1102.1 14347.9 14523.6 14574.2 14809.3 14813.6 31338.4 31669.5 31697.4 31912.0 32229.8 41648.4 42491.4 42943.8 42993.6 43076.8 6866.5 7006.9 7053.1 7181.5 7230.4 10426.5 11035.5 11179.3 11471.0 11639.5 8908.5 9210.7 9441.2 9557.2 9970.9 9764.0 9804.8 9853.9 9921.8 10032.5 9295.3 9858.8 9927.9 10047.7 10231.0 7256.1 7284.8 7373.6 7389.5 7439.9 8825.8 9450.5 9808.0 9936.5 10029.1 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#3] mootools.html Cycles:180 Average:5510.13 Median:6641.77 stddev:2879.38 (43.4%) stddev-sans-first:2871.29 05:17:02 INFO - PROCESS | 20958 | Values: 1451.1 1470.7 1616.4 1721.7 1738.9 7658.5 7687.4 7830.5 7885.3 7903.2 7880.2 7961.1 7981.6 8052.9 8056.2 2280.0 2303.5 2306.0 2306.4 2309.7 2248.3 2275.1 2314.3 2314.7 2319.7 2236.8 2307.6 2312.0 2315.3 2338.3 2223.3 2263.2 2266.8 2268.3 2275.5 2249.3 2255.4 2257.9 2260.2 2262.1 7735.5 7745.7 7757.2 7766.6 7779.5 4815.0 4912.5 4915.0 4968.9 4975.3 3146.0 3151.4 3181.0 3190.0 3193.1 1115.4 1122.6 1125.6 1126.6 1190.7 10908.8 10997.4 11002.7 11005.8 11014.5 4171.3 4226.4 4273.1 4312.4 4323.9 8851.6 8866.4 8872.6 8880.6 8883.3 4770.5 4793.1 4801.6 4812.5 4820.4 4323.3 4347.6 4380.3 4381.4 4388.4 3508.9 3603.1 3604.1 3618.4 3649.6 1096.4 1122.1 1122.1 1137.7 1138.3 962.3 1013.5 1130.9 1226.0 1376.3 7107.6 7122.5 7133.3 7167.8 7171.9 643.0 651.8 654.7 662.4 788.8 5446.1 5554.9 5574.4 5606.7 5645.4 9172.5 9390.6 9580.6 9583.0 9644.5 9442.2 9493.0 9518.6 9524.8 9542.5 7398.9 7472.6 7478.5 7504.8 7558.3 7304.6 7324.2 7364.6 7374.6 7393.3 8399.2 8618.3 8629.1 8730.1 8773.5 8590.1 8784.6 8800.7 8896.9 8926.6 6704.3 6722.6 6728.5 6862.6 6864.2 7568.7 7575.6 7593.3 7604.8 7611.9 6828.2 7157.4 7379.7 7468.9 7499.6 6750.7 6788.2 6806.8 6829.9 6935.4 6929.2 7052.4 7077.6 7097.9 7143.5 6572.6 6639.1 6644.4 6645.7 6658.1 6602.2 6663.5 6668.5 6671.4 6730.4 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#4] prototype.html Cycles:180 Average:5493.80 Median:6226.83 stddev:1675.12 (26.9%) stddev-sans-first:1634.40 05:17:02 INFO - PROCESS | 20958 | Values: 331.7 338.1 339.9 345.8 354.8 6180.5 6216.0 6235.1 6261.9 6410.1 6183.2 6230.3 6236.0 6245.3 6251.5 4769.1 4770.0 4772.9 4775.5 4776.4 4777.5 4784.7 4786.0 4787.1 4788.9 4662.0 4683.9 4700.7 4701.0 4701.1 4676.5 4682.3 4683.2 4685.0 4687.3 4040.2 4041.8 4042.5 4042.8 4050.5 5942.2 5945.3 5947.6 5958.3 5958.6 5356.1 5451.3 5471.0 5474.4 5487.8 6623.1 6627.0 6631.6 6631.7 6632.8 4503.1 4507.2 4511.4 4512.5 4517.8 6708.5 6807.7 6910.2 6924.5 6928.3 4539.3 4559.5 4562.0 4568.6 4569.4 4617.2 4617.6 4625.9 4634.4 4639.0 5397.4 5401.0 5421.7 5423.9 5435.5 6409.0 6635.4 6639.2 6644.1 6644.6 1600.0 1649.7 1650.7 1652.7 1654.4 1085.4 1090.6 1091.0 1103.7 1109.9 6158.1 6217.1 6224.0 6229.6 6239.3 6705.7 6707.5 6720.0 6732.3 6746.4 6074.1 6153.5 6160.4 6161.6 6187.8 3631.1 3646.7 3653.0 3654.2 3657.0 7062.2 7064.4 7083.6 7094.8 7105.7 6643.6 6890.6 6907.5 6912.4 6922.8 7059.7 7062.4 7069.3 7072.4 7072.5 6663.9 6717.6 6733.2 6737.0 6754.7 6509.2 6622.0 6632.8 6636.1 6656.1 7023.0 7067.5 7075.8 7089.8 7098.5 4539.7 4568.9 4569.3 4576.9 4584.3 6738.9 6741.5 6753.2 6756.2 6913.4 6637.1 6647.3 6678.0 6713.8 6721.0 6633.1 6670.9 6677.3 6679.6 6689.6 6457.8 6555.2 6566.4 6571.0 6571.6 6683.6 6713.2 6723.3 6732.0 6741.4 6535.6 6537.6 6538.3 6543.4 6550.8 05:17:02 INFO - PROCESS | 20958 | 05:17:02 INFO - PROCESS | 20958 | [#5] yui.html Cycles:180 Average:13332.95 Median:43871.00 stddev:14835.69 (33.8%) stddev-sans-first:14847.71 05:17:02 INFO - PROCESS | 20958 | Values: 854.8 856.1 857.9 861.4 888.1 13025.5 13194.1 13209.9 13253.5 13263.9 11687.3 12679.1 12690.9 12711.2 12721.6 655.2 780.8 801.2 802.8 804.7 794.8 795.6 796.3 796.3 802.9 818.1 824.6 826.3 827.3 828.7 813.1 817.1 818.6 820.7 821.2 604.1 604.6 605.4 608.5 608.9 12773.0 12780.2 12801.6 13189.0 13298.1 12728.5 13059.4 13299.5 13354.9 13423.2 10407.5 11470.9 11595.3 11925.8 12005.0 3645.4 3697.5 3708.2 3801.8 3815.9 49060.0 49623.0 49692.3 49866.5 49894.0 9559.1 10243.8 10425.2 10494.0 10524.5 18972.9 19084.4 19105.6 19126.4 19141.8 7533.9 7669.1 7772.1 7892.1 7913.0 4009.5 4138.3 4143.3 4151.0 4282.5 3074.2 3085.0 3085.7 3092.6 3103.2 531.6 540.0 541.3 556.8 567.7 562.7 625.4 637.6 638.8 678.8 8273.3 8292.6 8339.9 8391.2 8400.5 588.3 589.5 698.7 700.7 737.6 3940.7 4010.0 4071.3 4177.4 4259.1 48713.9 48754.8 49116.5 49408.8 49555.8 45936.3 47139.3 47292.0 47529.5 47793.8 43560.3 43894.0 43996.0 44499.6 44772.8 8083.2 8281.8 8490.9 8510.4 8536.3 31679.7 32029.5 32071.8 32198.0 32260.7 41093.6 42206.0 42377.0 43848.0 44108.6 9991.3 10136.3 10379.2 10448.4 10613.7 11292.7 11509.1 11527.4 11665.4 11904.7 11598.3 11611.3 11953.8 11957.5 12383.1 11366.2 11991.9 12333.6 12487.6 12520.9 10918.7 11010.6 11116.8 11277.6 11620.9 9280.0 9377.3 9550.2 9681.2 9705.2 9004.6 9630.7 10146.5 10231.6 10243.0 05:17:02 INFO - PROCESS | 20958 | -------- Summary: end -------- 05:17:02 INFO - PROCESS | 20958 | 05:17:03 INFO - TEST-INFO | 20958: exit 0 05:17:03 INFO - TEST-OK | dromaeo_css | took 1110349ms 05:17:03 INFO - TEST-START | kraken 05:17:03 INFO - operating with platform_type : linux_ 05:17:03 INFO - Initialising browser for kraken test... 05:17:03 INFO - TEST-INFO | started process 21204 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZX8pI3/profile http://localhost:33314/getInfo.html) 05:17:06 INFO - PROCESS | 21204 | -- checkerboarding starts below -- 05:17:06 INFO - PROCESS | 21204 | RENDERTRACE 0.034701 rect red 0 0 1024 768 // viewport 05:17:06 INFO - PROCESS | 21204 | RENDERTRACE 253.961 rect brown 0 0 1024 768 // page 05:17:06 INFO - PROCESS | 21204 | RENDERTRACE 253.995 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 05:17:06 INFO - PROCESS | 21204 | Checkerboarded for 1 frames (266.915 ms), 786432 peak, 10594 severity. 05:17:06 INFO - PROCESS | 21204 | 05:17:06 INFO - PROCESS | 21204 | (process:21276): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:07 INFO - PROCESS | 21204 | __metrics Screen width/height:1600/1200 05:17:07 INFO - PROCESS | 21204 | colorDepth:24 05:17:07 INFO - PROCESS | 21204 | Browser inner width/height: 1024/697 05:17:07 INFO - PROCESS | 21204 | __metrics 05:17:07 INFO - PROCESS | 21204 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:17:08 INFO - TEST-INFO | 21204: exit 0 05:17:08 INFO - Browser initialized. 05:17:08 INFO - Running cycle 1/1 for kraken test... 05:17:08 INFO - TEST-INFO | started process 21325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZX8pI3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:09 INFO - PROCESS | 21325 | -- checkerboarding starts below -- 05:17:09 INFO - PROCESS | 21325 | RENDERTRACE 0.043459 rect red 0 0 10 10 // viewport 05:17:09 INFO - PROCESS | 21325 | RENDERTRACE 39.0242 rect brown 0 0 10 10 // page 05:17:09 INFO - PROCESS | 21325 | RENDERTRACE 39.0625 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:17:09 INFO - PROCESS | 21325 | Checkerboarded for 1 frames (44.1763 ms), 100 peak, 1 severity. 05:17:09 INFO - PROCESS | 21325 | 05:17:09 INFO - PROCESS | 21325 | (process:21388): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:20 INFO - PROCESS | 21325 | RSS: Main: 150290432 05:17:20 INFO - PROCESS | 21325 | 05:17:22 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:23 INFO - PROCESS | 21325 | RSS: Main: 152076288 05:17:23 INFO - PROCESS | 21325 | 05:17:26 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-dft) 05:17:26 INFO - PROCESS | 21325 | RSS: Main: 155086848 05:17:26 INFO - PROCESS | 21325 | 05:17:29 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-fft) 05:17:30 INFO - PROCESS | 21325 | RSS: Main: 146751488 05:17:30 INFO - PROCESS | 21325 | 05:17:32 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33314/tests/kraken/driver.html?testName=audio-oscillator) 05:17:33 INFO - PROCESS | 21325 | RSS: Main: 146862080 05:17:33 INFO - PROCESS | 21325 | 05:17:35 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:35 INFO - PROCESS | 21325 | RSS: Main: 148254720 05:17:35 INFO - PROCESS | 21325 | 05:17:38 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:39 INFO - PROCESS | 21325 | RSS: Main: 147423232 05:17:39 INFO - PROCESS | 21325 | 05:17:42 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33314/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:43 INFO - PROCESS | 21325 | RSS: Main: 147783680 05:17:43 INFO - PROCESS | 21325 | 05:17:46 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33314/tests/kraken/driver.html?testName=json-parse-financial) 05:17:46 INFO - PROCESS | 21325 | RSS: Main: 150294528 05:17:46 INFO - PROCESS | 21325 | 05:17:48 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:48 INFO - PROCESS | 21325 | RSS: Main: 150921216 05:17:48 INFO - PROCESS | 21325 | 05:17:50 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:51 INFO - PROCESS | 21325 | RSS: Main: 149864448 05:17:51 INFO - PROCESS | 21325 | 05:17:53 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:54 INFO - PROCESS | 21325 | RSS: Main: 150437888 05:17:54 INFO - PROCESS | 21325 | 05:17:56 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:57 INFO - PROCESS | 21325 | RSS: Main: 150151168 05:17:57 INFO - PROCESS | 21325 | 05:17:59 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:00 INFO - PROCESS | 21325 | RSS: Main: 150593536 05:18:00 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | Cycle 1(1): loaded http://localhost:33314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33314/tests/kraken/driver.html?testName=ai-astar) 05:18:02 INFO - PROCESS | 21325 | RSS: Main: 150241280 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | __start_tp_report 05:18:02 INFO - PROCESS | 21325 | _x_x_mozilla_page_load 05:18:02 INFO - PROCESS | 21325 | _x_x_mozilla_page_load_details 05:18:02 INFO - PROCESS | 21325 | |i|pagename|runs| 05:18:02 INFO - PROCESS | 21325 | |0;ai-astar;113;106;110;115;112;122;111;110;111;112 05:18:02 INFO - PROCESS | 21325 | |1;audio-beat-detection;155;127;151;167;129;155;158;136;166;133 05:18:02 INFO - PROCESS | 21325 | |2;audio-dft;162;162;164;162;163;162;162;165;169;166 05:18:02 INFO - PROCESS | 21325 | |3;audio-fft;74;76;75;73;77;75;141;74;73;74 05:18:02 INFO - PROCESS | 21325 | |4;audio-oscillator;97;97;142;96;96;96;139;96;96;148 05:18:02 INFO - PROCESS | 21325 | |5;imaging-gaussian-blur;110;110;109;110;110;109;110;110;109;109 05:18:02 INFO - PROCESS | 21325 | |6;imaging-darkroom;146;146;147;146;147;146;147;147;147;147 05:18:02 INFO - PROCESS | 21325 | |7;imaging-desaturate;97;96;96;97;97;96;98;97;97;96 05:18:02 INFO - PROCESS | 21325 | |8;json-parse-financial;64;61;59;59;63;60;59;59;67;70 05:18:02 INFO - PROCESS | 21325 | |9;json-stringify-tinderbox;70;70;70;70;72;70;69;70;72;69 05:18:02 INFO - PROCESS | 21325 | |10;stanford-crypto-aes;84;92;83;90;83;82;82;91;83;83 05:18:02 INFO - PROCESS | 21325 | |11;stanford-crypto-ccm;116;120;124;119;129;119;127;130;119;131 05:18:02 INFO - PROCESS | 21325 | |12;stanford-crypto-pbkdf2;136;149;160;146;152;148;149;147;152;138 05:18:02 INFO - PROCESS | 21325 | |13;stanford-crypto-sha256-iterative;67;68;72;68;68;66;68;68;67;67 05:18:02 INFO - PROCESS | 21325 | __end_tp_report 05:18:02 INFO - PROCESS | 21325 | __start_cc_report 05:18:02 INFO - PROCESS | 21325 | _x_x_mozilla_cycle_collect,749 05:18:02 INFO - PROCESS | 21325 | __end_cc_report 05:18:02 INFO - PROCESS | 21325 | __startTimestamp1453295882264__endTimestamp 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | ------- Summary: start ------- 05:18:02 INFO - PROCESS | 21325 | Number of tests: 14 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.40 05:18:02 INFO - PROCESS | 21325 | Values: 113.0 106.0 110.0 115.0 112.0 122.0 111.0 110.0 111.0 112.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:155.00 stddev:15.14 (9.8%) stddev-sans-first:15.82 05:18:02 INFO - PROCESS | 21325 | Values: 155.0 127.0 151.0 167.0 129.0 155.0 158.0 136.0 166.0 133.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.36 (1.4%) stddev-sans-first:2.42 05:18:02 INFO - PROCESS | 21325 | Values: 162.0 162.0 164.0 162.0 163.0 162.0 162.0 165.0 169.0 166.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.50 stddev:21.05 (28.3%) stddev-sans-first:22.16 05:18:02 INFO - PROCESS | 21325 | Values: 74.0 76.0 75.0 73.0 77.0 75.0 141.0 74.0 73.0 74.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.00 stddev:22.67 (23.6%) stddev-sans-first:23.53 05:18:02 INFO - PROCESS | 21325 | Values: 97.0 97.0 142.0 96.0 96.0 96.0 139.0 96.0 96.0 148.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:18:02 INFO - PROCESS | 21325 | Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:18:02 INFO - PROCESS | 21325 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:18:02 INFO - PROCESS | 21325 | Values: 97.0 96.0 96.0 97.0 97.0 96.0 98.0 97.0 97.0 96.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:3.87 (6.2%) stddev-sans-first:4.04 05:18:02 INFO - PROCESS | 21325 | Values: 64.0 61.0 59.0 59.0 63.0 60.0 59.0 59.0 67.0 70.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 05:18:02 INFO - PROCESS | 21325 | Values: 70.0 70.0 70.0 70.0 72.0 70.0 69.0 70.0 72.0 69.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:83.50 stddev:4.00 (4.8%) stddev-sans-first:4.22 05:18:02 INFO - PROCESS | 21325 | Values: 84.0 92.0 83.0 90.0 83.0 82.0 82.0 91.0 83.0 83.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.50 stddev:5.48 (4.4%) stddev-sans-first:5.12 05:18:02 INFO - PROCESS | 21325 | Values: 116.0 120.0 124.0 119.0 129.0 119.0 127.0 130.0 119.0 131.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.00 stddev:6.88 (4.6%) stddev-sans-first:5.85 05:18:02 INFO - PROCESS | 21325 | Values: 136.0 149.0 160.0 146.0 152.0 148.0 149.0 147.0 152.0 138.0 05:18:02 INFO - PROCESS | 21325 | 05:18:02 INFO - PROCESS | 21325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.66 05:18:02 INFO - PROCESS | 21325 | Values: 67.0 68.0 72.0 68.0 68.0 66.0 68.0 68.0 67.0 67.0 05:18:02 INFO - PROCESS | 21325 | -------- Summary: end -------- 05:18:02 INFO - PROCESS | 21325 | 05:18:03 INFO - TEST-INFO | 21325: exit 0 05:18:03 INFO - TEST-OK | kraken | took 59650ms 05:18:03 INFO - TEST-START | v8_7 05:18:03 INFO - operating with platform_type : linux_ 05:18:03 INFO - Initialising browser for v8_7 test... 05:18:03 INFO - TEST-INFO | started process 21616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppAzjIG/profile http://localhost:33314/getInfo.html) 05:18:06 INFO - PROCESS | 21616 | 05:18:06 INFO - PROCESS | 21616 | (process:21688): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:07 INFO - PROCESS | 21616 | __metrics Screen width/height:1600/1200 05:18:07 INFO - PROCESS | 21616 | colorDepth:24 05:18:07 INFO - PROCESS | 21616 | Browser inner width/height: 1024/697 05:18:07 INFO - PROCESS | 21616 | __metrics 05:18:07 INFO - PROCESS | 21616 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:18:08 INFO - TEST-INFO | 21616: exit 0 05:18:08 INFO - Browser initialized. 05:18:08 INFO - Running cycle 1/1 for v8_7 test... 05:18:08 INFO - TEST-INFO | started process 21738 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppAzjIG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:08 INFO - PROCESS | 21738 | -- checkerboarding starts below -- 05:18:08 INFO - PROCESS | 21738 | RENDERTRACE 0.060222 rect red 0 0 10 10 // viewport 05:18:08 INFO - PROCESS | 21738 | RENDERTRACE 39.5377 rect brown 0 0 10 10 // page 05:18:08 INFO - PROCESS | 21738 | RENDERTRACE 39.5568 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 05:18:08 INFO - PROCESS | 21738 | Checkerboarded for 1 frames (50.4294 ms), 100 peak, 2 severity. 05:18:09 INFO - PROCESS | 21738 | 05:18:09 INFO - PROCESS | 21738 | (process:21800): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:20 INFO - PROCESS | 21738 | RSS: Main: 150106112 05:18:20 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | Cycle 1(1): loaded http://localhost:33314/tests/v8_7/run.html (next: http://localhost:33314/tests/v8_7/run.html) 05:18:42 INFO - PROCESS | 21738 | RSS: Main: 146198528 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | __start_tp_report 05:18:42 INFO - PROCESS | 21738 | _x_x_mozilla_page_load 05:18:42 INFO - PROCESS | 21738 | _x_x_mozilla_page_load_details 05:18:42 INFO - PROCESS | 21738 | |i|pagename|runs| 05:18:42 INFO - PROCESS | 21738 | |0;Richards;165.97510373443984 05:18:42 INFO - PROCESS | 21738 | |1;DeltaBlue;187.9699248120301 05:18:42 INFO - PROCESS | 21738 | |2;Encrypt;283.12570781426956 05:18:42 INFO - PROCESS | 21738 | |3;Decrypt;5229.166666666667 05:18:42 INFO - PROCESS | 21738 | |4;RayTrace;1075.268817204301 05:18:42 INFO - PROCESS | 21738 | |5;Earley;714.2857142857143 05:18:42 INFO - PROCESS | 21738 | |6;Boyer;12268.292682926829 05:18:42 INFO - PROCESS | 21738 | |7;RegExp;42458.333333333336 05:18:42 INFO - PROCESS | 21738 | |8;Splay;581.7335660267597 05:18:42 INFO - PROCESS | 21738 | |9;NavierStokes;4835.748792270531 05:18:42 INFO - PROCESS | 21738 | __end_tp_report 05:18:42 INFO - PROCESS | 21738 | __startTimestamp1453295922704__endTimestamp 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | ------- Summary: start ------- 05:18:42 INFO - PROCESS | 21738 | Number of tests: 10 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 166.0 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#1] DeltaBlue Cycles:1 Average:187.97 Median:187.97 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 188.0 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 283.1 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 5229.2 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 1075.3 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 714.3 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 12268.3 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#7] RegExp Cycles:1 Average:42458.33 Median:42458.33 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 42458.3 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#8] Splay Cycles:1 Average:581.73 Median:581.73 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 581.7 05:18:42 INFO - PROCESS | 21738 | 05:18:42 INFO - PROCESS | 21738 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:18:42 INFO - PROCESS | 21738 | Values: 4835.7 05:18:42 INFO - PROCESS | 21738 | -------- Summary: end -------- 05:18:42 INFO - PROCESS | 21738 | 05:18:43 INFO - TEST-INFO | 21738: exit 0 05:18:43 INFO - TEST-OK | v8_7 | took 40462ms 05:18:43 INFO - SUITE-END | took 1210s 05:18:43 INFO - Completed test suite (00:20:10) 05:18:43 INFO - Working with test: dromaeo_css 05:18:43 INFO - Generating results file: dromaeo_css 05:18:43 INFO - Working with test: kraken 05:18:43 INFO - Generating results file: kraken 05:18:43 INFO - javascript benchmark 05:18:43 INFO - Working with test: v8_7 05:18:43 INFO - Generating results file: v8_7 05:18:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 05:18:43 INFO - process_Request line: dromaeo_css 6908.04 graph.html#tests=[[72,63,43]] 05:18:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:43 INFO - process_Request line: kraken 1524.60 graph.html#tests=[[232,63,43]] 05:18:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:43 INFO - process_Request line: v8_7 20349.95 graph.html#tests=[[230,63,43]] 05:18:43 INFO - RETURN: dromaeo_css: 6908.04 05:18:43 INFO - RETURN: kraken: 1524.60 05:18:43 INFO - RETURN: v8_7: 20349.95 05:18:43 INFO - javascript benchmark 05:18:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3222.9194270143244, 3234.385466761317, 3268.166617512534, 3277.4756039033746, 3278.3934972030174, 5222.973885130578, 5238.345206849144, 5277.868053298665, 5290.761915713788, 5300.416954135042, 5265.262863199156, 5268.998890210857, 5278.234655974881, 5297.947020529794, 5305.867353316169, 4536.591706746392, 4815.518448155182, 4977.1538838397555, 4988.401391832985, 4994.725290109042, 4805.087033463631, 4887.242477416006, 4930.704157750529, 4951.653384263085, 4954.43024052235, 4845.806167753286, 4852.563269305761, 4953.653244272867, 4954.405471343426, 4974.079795237856, 4839.637027222972, 4861.693210393969, 4865.44047434546, 4885.218365061573, 4918.5573298403315, 4764.428268607755, 4792.281157826319, 4804.447488538828, 4882.682625629358, 4891.5353041461, 5067.2145817397995, 5088.1350170471105, 5110.310108135392, 5162.328897243372, 5204.635675502716, 5756.251687280626, 5768.0, 5773.566982476289, 5790.565707571949, 5807.680577568232, 5795.797147099831, 5804.854878628026, 5826.1552074948895, 5830.82507524775, 5831.825045248649, 5275.182346736224, 5322.414534401213, 5359.9732001340135, 5373.811916582901, 5429.267048948421, 5853.912191317134, 5873.706314684334, 5878.500327472213, 5889.882202356014, 5900.557458190653, 5627.071533197059, 5651.152327150878, 5653.519450846642, 5659.660420374791, 5676.148577713294, 5650.5479561634975, 5713.942860571424, 5745.798897038583, 5760.193572899798, 5828.76684932598, 5632.7746890123935, 5636.239107720406, 5639.746211420496, 5645.068563687028, 5660.179274005329, 5660.688662123623, 5668.206451096849, 5671.602987790815, 5678.261825962681, 5679.062954612443, 4396.802143903532, 4403.625691816167, 4405.669574781904, 4480.865574032784, 4480.955190448054, 3932.528096628423, 3933.3116704576582, 3945.270125026822, 3952.604739526082, 3972.841086356513, 5301.575873930076, 5338.065838478251, 5344.251804747339, 5345.946540534623, 5361.195820626937, 5729.684867332254, 5762.279715035621, 5801.767929282866, 5841.123831425235, 5868.823935281863, 5343.251944727741, 5364.678119312854, 5372.758225879845, 5374.0, 5402.729863506809, 4817.108834865561, 4896.534829191221, 4930.211166213388, 4933.407991041098, 4948.134076536664, 5895.675737834375, 5901.380355062743, 5902.026165682701, 5927.288725352899, 5971.044632858721, 5788.363280039108, 5792.9710351447975, 5816.534677225896, 5837.5329973601165, 5840.737166827418, 5939.762409503572, 6011.398860113954, 6012.518998480198, 6042.637441753509, 6043.0, 5628.409017053151, 5664.518515926193, 5671.461211184931, 5672.546196304368, 5718.456746609066, 5631.915521267102, 5670.979223739767, 5717.42825717425, 5728.341240757366, 5732.398098199629, 5570.2480165177185, 5587.497125258584, 5595.356533998643, 5596.0, 5619.157126430904, 5617.775288988558, 5623.156526521055, 5629.605927585029, 5644.350899646429, 5672.4894759471845, 5463.344398672185, 5465.453454654662, 5496.587755918402, 5496.945030549803, 5505.889882202414, 5485.286912701324, 5555.30558680165, 5623.606347555632, 5636.070048441961, 5660.490555849993, 5401.0, 5404.83785486436, 5423.511883930465, 5444.237806706985, 5445.646033007842], "unit": "score", "name": "dojo.html", "value": 5280.458915609623}, {"lowerIsBetter": false, "replicates": [522.2505704314311, 529.1269405480956, 536.393874921339, 558.2184941082484, 560.946710062544, 34904.82547587262, 35567.64432355676, 35599.64400355996, 35606.0, 35628.82185589072, 39703.03712035996, 39729.40405893914, 40109.0, 40281.79859100708, 40340.19319613606, 8457.53483558404, 8607.784805379853, 8614.698485553006, 8626.654933802673, 8627.352948528855, 8248.298894593936, 8403.579821008956, 8412.789680257982, 8416.368772342068, 8421.831563368729, 8794.824103517925, 8853.15894989975, 8860.24687901529, 8868.201861832435, 8885.68900088497, 8691.26124279437, 8698.0, 8745.212930836255, 8751.474911505298, 8788.912110878937, 8419.07390187079, 8565.914340856574, 8574.699885503978, 8602.827943441096, 8609.440386374928, 39679.40480892789, 40212.798936005136, 40513.18973620511, 40533.79733101345, 40565.0, 3224.339010502841, 3253.951190732117, 3276.42662534058, 3280.8851690190727, 3792.1088544192094, 29950.850245748632, 30459.543106853416, 30502.237444063852, 30949.226269343446, 31639.841800790848, 3995.36074228125, 4051.0, 4069.572694867026, 4074.3684728867074, 4182.581741825824, 228118.0, 228793.0, 228834.99999999834, 228972.0, 229468.0, 53930.0, 55191.448085519434, 55782.16326755102, 56057.0, 61352.0, 56147.157792633145, 56160.0, 56224.15663765047, 56580.434195657515, 56695.0, 14166.362513686909, 14272.429102835978, 14311.427542898376, 14383.712325753635, 14436.566902992927, 11409.828852567218, 11413.543458261576, 11494.655160345203, 11577.76844463106, 11593.478293476814, 19761.40715778529, 20235.898820505805, 20657.793422065886, 20936.0, 20969.475763106046, 7791.4935529190425, 7967.0, 7969.601519923981, 8008.319292860056, 8033.0, 916.2166347772692, 957.9712608621752, 976.2970661123979, 980.161961522902, 1050.6270274052754, 28988.565171522445, 31099.533506997413, 31382.0, 31519.84240078785, 32295.192620184684, 1061.6443491430457, 1070.7376692710336, 1084.281413958884, 1102.895224953628, 1128.031584884382, 14618.122912625277, 14699.191544465157, 14743.926280368743, 15019.399224031135, 15074.849251507563, 371085.0, 372526.0, 373284.0, 374273.0, 375607.0, 54455.72772136114, 55022.0, 55253.0, 55532.44467555353, 55553.444465555636, 1338.7857942729117, 1353.6480515066153, 1356.9118007329491, 1357.9185248885099, 1378.6484446466288, 28082.85958570194, 28702.85648571744, 28892.414219721533, 28986.56520152157, 29261.268468288465, 47262.0, 47361.0, 47685.0, 47828.28257576209, 48135.037299254516, 292564.0, 294002.0, 294158.0, 294354.0, 294701.0, 28645.708343332066, 29204.415911681222, 31623.525647115774, 32792.34415311728, 33128.66871331352, 40722.1855562893, 41112.17775644411, 41492.0, 41512.37731434091, 41983.160336793706, 33928.66071339354, 35086.82456587701, 35432.0, 35459.64540354667, 36009.09977250485, 34856.65143348635, 35243.647563524035, 35605.82197088998, 35743.821280893426, 35810.10474738153, 34967.475487868214, 35118.12204694903, 35420.82289588536, 38940.22119557537, 39703.40444893271, 29911.700882990892, 31224.0, 31394.843025784725, 31593.8420307897, 32700.50949235716, 25501.744982549935, 25666.358341041625, 25673.871630641726, 25905.487408652032, 26407.60388594211], "unit": "score", "name": "ext.html", "value": 18370.15540797478}, {"lowerIsBetter": false, "replicates": [345.7476042488983, 349.3118556443806, 351.4254194392169, 354.11647938393713, 362.01170803705867, 15615.84384156158, 16522.83477165228, 16911.40810071648, 17541.561460963483, 17982.280708771632, 11276.267042642243, 11385.089192864572, 11586.362750048744, 11588.246763960336, 11636.476358563863, 4792.9281060784115, 4929.658412254186, 5012.72430016349, 5067.670601410915, 5404.351477822647, 5292.285541451913, 5371.838844834661, 5377.542908852753, 5384.784608615671, 5389.353277606673, 5137.357830271216, 5179.430262671103, 5278.709670968095, 5345.251664766916, 5345.652532585389, 5248.343957005374, 5267.657602255879, 5300.893982120375, 5307.495787900143, 5680.886382272372, 5345.786168553253, 5366.141417373202, 5377.0321342158395, 5384.757685904105, 5396.703181325026, 19044.61910761777, 19125.521861953563, 19793.703094453595, 19982.900085499627, 20056.298029568894, 1995.750531183602, 2027.341114137911, 2142.464383904024, 2208.0946811807244, 2235.5417139486367, 9408.153266206074, 9478.431294122374, 10740.570377184904, 12266.32535210563, 12852.871471285354, 1707.6926153292402, 1822.4350451360121, 1878.098512713905, 1908.761404824397, 1929.7201905723591, 55744.72127639336, 55831.44168558303, 55950.720246398916, 56018.719906400205, 56468.152977705366, 10146.746331341628, 10186.286959912883, 10206.13247873939, 10232.744181395525, 10272.33229840058, 13059.477620895057, 13121.868781312256, 13185.0, 13231.603051908458, 13252.602421927357, 7341.926580734124, 7379.520331178456, 7481.8877716834295, 7538.924610753932, 7542.396608271325, 7184.748533801292, 7389.371903388273, 7496.100467943882, 7497.66260518278, 7571.924280757232, 4335.696501244883, 4358.36803663467, 4395.428594282723, 4401.845935392246, 4417.514073451917, 1788.2131861980688, 1810.1130446081324, 1880.7084901839962, 1897.4497395755352, 1916.3963351544219, 882.9117088291248, 956.9952150239204, 1032.210359075308, 1078.6063086973354, 1081.1134869407167, 13683.794743078863, 15445.227738613024, 15891.523254302389, 16350.918245408935, 16429.58926026859, 964.5996911281879, 966.8694726212012, 973.7808992976666, 990.9702708918744, 1011.2769369900557, 9407.341486095907, 9502.144806967406, 9577.456356116092, 9673.661421850202, 9780.657676981271, 553358.0, 567757.0, 579993.0, 582854.0, 595043.0, 68276.31723682799, 68741.3125868735, 69206.0, 69870.65064674745, 69942.65028674925, 1077.3159044007111, 1084.3439718970067, 1088.5319312695617, 1096.0245381610373, 1102.090775110537, 14347.92826035863, 14523.564293071226, 14574.198419086628, 14809.33357998871, 14813.555593332218, 31338.373232534766, 31669.524957126123, 31697.366052679277, 31912.0, 32229.838850805594, 41648.3752743703, 42491.366083075176, 42943.7852810734, 42993.570064300206, 43076.78461607672, 6866.485013624098, 7006.859862802818, 7053.118360204974, 7181.497295189287, 7230.385417239593, 10426.530806113591, 11035.503402346752, 11179.273347232403, 11471.0, 11639.53441862316, 8908.510031948304, 9210.677626283048, 9441.244700424088, 9557.235421166151, 9970.900290996997, 9764.0, 9804.803903922024, 9853.852192216978, 9921.801563968536, 10032.548535315782, 9295.349325547148, 9858.802823943624, 9927.851082233918, 10047.698569042941, 10231.0, 7256.129264488084, 7284.781456556312, 7373.5575865448245, 7389.519681220703, 7439.888401673871, 8825.779355516164, 9450.52747362643, 9807.950960245153, 9936.503174841084, 10029.097381235724], "unit": "score", "name": "jquery.html", "value": 8106.621687923074}, {"lowerIsBetter": false, "replicates": [1451.1148199598244, 1470.69115485748, 1616.3696158498187, 1721.715916873716, 1738.9217485213164, 7658.54048757075, 7687.3850091992645, 7830.530168189898, 7885.250901164394, 7903.249191326815, 7880.172581878906, 7961.084475285344, 7981.640826162822, 8052.91947080529, 8056.154103819103, 2279.9886000570013, 2303.49323148907, 2305.9538809223804, 2306.4349234437586, 2309.7459279479244, 2248.269312473453, 2275.112706044644, 2314.2941402872116, 2314.7338056123594, 2319.6868422762964, 2236.798688118069, 2307.5500277445904, 2312.0173926081434, 2315.2591170825344, 2338.286822519131, 2223.288547664748, 2263.230501629454, 2266.8186545076355, 2268.3421807675836, 2275.4993901341677, 2249.336445748508, 2255.3572231913827, 2257.9322620321254, 2260.2315212827552, 2262.061244583496, 7735.497192682514, 7745.651445684957, 7757.185495523002, 7766.611669416507, 7779.533228006281, 4814.975925120387, 4912.484189160158, 4914.975425122851, 4968.850934471971, 4975.278584605248, 3145.952810707818, 3151.448496513101, 3181.0456862941023, 3189.9681003189903, 3193.0740085375214, 1115.4144074360945, 1122.6351435783322, 1125.6293336234803, 1126.645106791358, 1190.69042049067, 10908.781824363548, 10997.395143267197, 11002.724931876686, 11005.834912476319, 11014.50434730431, 4171.311733563989, 4226.408302837605, 4273.102648443862, 4312.374705667723, 4323.935140972888, 8851.60167792451, 8866.42368246062, 8872.645094196288, 8880.644774209088, 8883.333749968779, 4770.451398089264, 4793.13723529768, 4801.567858892717, 4812.494688057774, 4820.421549414093, 4323.265044942367, 4347.6304514116655, 4380.2772542530765, 4381.38660587518, 4388.363687265392, 3508.8771593089964, 3603.1352475405715, 3604.0809593553477, 3618.3667858124722, 3649.6350364963823, 1096.4188979840696, 1122.1135303110452, 1122.119136477861, 1137.6928229378186, 1138.2658185470325, 962.3167551038841, 1013.5236438873718, 1130.8812574679705, 1225.957091501811, 1376.3256004557695, 7107.609081500567, 7122.501424900311, 7133.322334378226, 7167.820804479929, 7171.89242161368, 642.9774957876546, 651.8012006338017, 654.6726636681659, 662.3773652766384, 788.8364662123322, 5446.101393270145, 5554.888902221933, 5574.358948720868, 5606.747696353592, 5645.435456454404, 9172.541372931326, 9390.577424015935, 9580.56887440067, 9583.041695830501, 9644.517774111266, 9442.197413219954, 9493.0, 9518.619255229853, 9524.809503809885, 9542.52287385628, 7398.852022959511, 7472.551646901204, 7478.5138965967035, 7504.849903001909, 7558.281963213486, 7304.598247096461, 7324.194338622854, 7364.594947277951, 7374.557526548424, 7393.260673932564, 8399.160083991552, 8618.310535157047, 8629.050804411385, 8730.079382535832, 8773.473591584525, 8590.098039705741, 8784.648614055366, 8800.735977920673, 8896.866547001671, 8926.553672316488, 6704.329567043452, 6722.630255336004, 6728.495362847708, 6862.622555759481, 6864.176298844171, 7568.697252109854, 7575.621218939141, 7593.278638529331, 7604.80987975305, 7611.923880761122, 6828.214755303204, 7157.427405807419, 7379.667914943733, 7468.850622987618, 7499.62501874915, 6750.696218670269, 6788.214066186799, 6806.76176333826, 6829.93170068293, 6935.410490108397, 6929.1684997800585, 7052.400545953651, 7077.5753454792875, 7097.893531596927, 7143.464240182111, 6572.638504882086, 6639.136912201383, 6644.4020038196795, 6645.700943457653, 6658.101156344025, 6602.1747281589805, 6663.46692264608, 6668.466522678077, 6671.366220209073, 6730.394264516217], "unit": "score", "name": "mootools.html", "value": 4478.732278397923}, {"lowerIsBetter": false, "replicates": [331.6915268800016, 338.13268965104504, 339.8776440481426, 345.82362994872636, 354.792446418845, 6180.536459765513, 6215.968920155398, 6235.095911092889, 6261.874762504747, 6410.102585638003, 6183.165272688186, 6230.345813689565, 6236.0, 6245.344238854912, 6251.4686251668545, 4769.117713223048, 4770.0459908018365, 4772.928406073912, 4775.546323099309, 4776.402949631296, 4777.474477807438, 4784.66507344486, 4786.018866132452, 4787.066522028206, 4788.880277993043, 4661.997670500841, 4683.859484215462, 4700.670953033289, 4700.976495117537, 4701.130290896195, 4676.485586585472, 4682.321063445798, 4683.157031734287, 4685.0, 4687.343771871941, 4040.151568170688, 4041.838326466938, 4042.535108462535, 4042.757434553936, 4050.5139383274195, 5942.227510423617, 5945.286565612154, 5947.613405128653, 5958.344582095966, 5958.642481451084, 5356.062689029404, 5451.318585176853, 5470.972645136789, 5474.39781624021, 5487.807926722546, 6623.07276981223, 6627.0, 6631.568948018412, 6631.668416579152, 6632.834179145511, 4503.144402563503, 4507.166174257773, 4511.368408422823, 4512.52618475062, 4517.796699148546, 6708.530402871801, 6807.727690892359, 6910.2053263874795, 6924.480663950224, 6928.307169283082, 4539.251023581138, 4559.452865656076, 4562.041971186021, 4568.6116680081905, 4569.405977223007, 4617.238155704338, 4617.607503362185, 4625.930611040837, 4634.374359461497, 4638.976805115953, 5397.4062853086125, 5400.972995134999, 5421.674699517963, 5423.891522169534, 5435.456454354533, 6409.0, 6635.4359879410795, 6639.203295604559, 6644.103046088716, 6644.634545099969, 1600.0, 1649.736042233237, 1650.7193777057928, 1652.6694661067595, 1654.3713388912377, 1085.3813326404031, 1090.6346373964811, 1091.0, 1103.6578660615235, 1109.8501702270253, 6158.076288556752, 6217.129601855744, 6224.035274532454, 6229.626222426669, 6239.313675495692, 6705.664716764142, 6707.463402927754, 6719.966400167968, 6732.2931092235585, 6746.392824645805, 6074.149619053336, 6153.538484613582, 6160.353162917919, 6161.599496032743, 6187.783427580013, 3631.0559254593995, 3646.6717995380013, 3653.013686304683, 3654.214343916071, 3656.9817150914073, 7062.223155452896, 7064.364207221375, 7083.574985500886, 7094.787156385317, 7105.71577136919, 6643.60138391698, 6890.621015844176, 6907.481938854606, 6912.377885990285, 6922.7923162305215, 7059.682314295869, 7062.364387205176, 7069.257727938595, 7072.434205263567, 7072.5402848814665, 6663.866722665616, 6717.596944183365, 6733.158355205599, 6736.966315168393, 6754.662266886734, 6509.153810004858, 6621.966890165711, 6632.801015969336, 6636.13730215069, 6656.134702488839, 7022.964885175541, 7067.469939754436, 7075.752348667772, 7089.7873063808165, 7098.538594991309, 4539.6822222445435, 4568.862934111849, 4569.337446070368, 4576.88557786058, 4584.289435137559, 6738.898916516354, 6741.494387920828, 6753.15585551806, 6756.189257289157, 6913.41235994926, 6637.103990961352, 6647.268800432045, 6678.0, 6713.765018224339, 6721.0, 6633.1045308882685, 6670.9332906670315, 6677.29888361715, 6679.56582822115, 6689.5986240825705, 6457.806265812033, 6555.2133743951035, 6566.4418524424045, 6570.967145164243, 6571.638559879252, 6683.598984060972, 6713.227978782307, 6723.294054124247, 6731.966340168267, 6741.393274605309, 6535.607863528204, 6537.607743535403, 6538.346165383614, 6543.378379053982, 6550.803475895731], "unit": "score", "name": "prototype.html", "value": 4945.380995872806}, {"lowerIsBetter": false, "replicates": [854.7820305822016, 856.131027007587, 857.9142085791418, 861.3582880753839, 888.1074520107292, 13025.544105956293, 13194.07641465098, 13209.933950330247, 13253.536126235584, 13263.933680331585, 11687.29876207426, 12679.112462127654, 12690.873091269084, 12711.173773704702, 12721.618351449471, 655.223560081304, 780.7540624703229, 801.2148094867034, 802.8033131882697, 804.6781287484994, 794.7973266816954, 795.5982228974389, 796.2555011064644, 796.2753893956501, 802.9116797152309, 818.0633175014605, 824.6412810427483, 826.3348004856089, 827.3091968206555, 828.6850996621275, 813.0649752784316, 817.0726225733805, 818.6275244763618, 820.7496713502379, 821.1706176761454, 604.1270364323555, 604.5526310530176, 605.3764622438895, 608.5101493297893, 608.9238845144357, 12773.042021848305, 12780.233186008869, 12801.61595152147, 13189.0, 13298.135621184592, 12728.490860365575, 13059.412326445332, 13299.53451629198, 13354.933225333909, 13423.194608323533, 10407.479626018669, 11470.942645286803, 11595.304281743123, 11925.821112683318, 12005.0, 3645.398509245971, 3697.4638677391627, 3708.2398108387715, 3801.7528860624247, 3815.8855234342736, 49060.0, 49623.0, 49692.254616180784, 49866.50133498655, 49893.999999999636, 9559.091886270793, 10243.84634230487, 10425.165986721044, 10494.003069708366, 10524.538384370042, 18972.905135474233, 19084.427467176007, 19105.617887642446, 19126.426207213804, 19141.80858191428, 7533.886991695129, 7669.118051424158, 7772.067351917806, 7892.052953645484, 7912.960435197902, 4009.538903026131, 4138.296489596776, 4143.254214241466, 4150.979245103756, 4282.48610166782, 3074.200707815984, 3084.9691503085132, 3085.6605773364913, 3092.5515800209296, 3103.239706271933, 531.5667730799386, 539.981100661475, 541.3206425935426, 556.8273835111129, 567.6962824888665, 562.6820846221872, 625.4152367536368, 637.6142433827467, 638.8339031851659, 678.8167194857459, 8273.33813294935, 8292.58537073156, 8339.874901876477, 8391.202835730595, 8400.453970491899, 588.3381196154327, 589.4997232044457, 698.6576577477, 700.7162099349772, 737.6238118559573, 3940.704447166474, 4009.9599004009588, 4071.307877660805, 4177.394277829698, 4259.084296876186, 48713.85932195732, 48754.75622621864, 49116.50883491191, 49408.75295623571, 49555.75222123866, 45936.3109553357, 47139.29291060637, 47292.0, 47529.5247047532, 47793.76103119462, 43560.3465948011, 43893.99999999936, 43996.0, 44499.55500444954, 44772.77613611976, 8083.19168083187, 8281.834363312579, 8490.915090849012, 8510.361722870686, 8536.274416674403, 31679.683203167675, 32029.519557207128, 32071.839640801645, 32198.0, 32260.677393225767, 41093.58906410898, 42206.0, 42377.0, 43848.0, 44108.558914411726, 9991.25065620067, 10136.341137826017, 10379.169666426818, 10448.42533660656, 10613.681589552325, 11292.661220163409, 11509.13681473876, 11527.365994870028, 11665.416729163677, 11904.702382440162, 11598.304101753922, 11611.303321800719, 11953.820692689791, 11957.461914214055, 12383.133180677267, 11366.204365694322, 11991.880081199077, 12333.62999110028, 12487.562935297221, 12520.87479125197, 10918.672439826818, 11010.614628487965, 11116.777664446505, 11277.605283815026, 11620.928366989074, 9280.0, 9377.296702747184, 9550.166798809343, 9681.177099946302, 9705.17506011997, 9004.63981440735, 9630.66292679781, 10146.49267536635, 10231.59073637076, 10243.0], "unit": "score", "name": "yui.html", "value": 6238.948597782841}], "name": "dromaeo_css", "value": 6908.0353532084455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 110.0, 115.0, 112.0, 122.0, 111.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 151.0, 167.0, 129.0, 155.0, 158.0, 136.0, 166.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 162.0, 163.0, 162.0, 162.0, 165.0, 169.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 75.0, 73.0, 77.0, 75.0, 141.0, 74.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 96.0, 96.0, 96.0, 139.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 98.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 59.0, 59.0, 63.0, 60.0, 59.0, 59.0, 67.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 72.0, 70.0, 69.0, 70.0, 72.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 83.0, 90.0, 83.0, 82.0, 82.0, 91.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [116.0, 120.0, 124.0, 119.0, 129.0, 119.0, 127.0, 130.0, 119.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [136.0, 149.0, 160.0, 146.0, 152.0, 148.0, 149.0, 147.0, 152.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 72.0, 68.0, 68.0, 66.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1524.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [187.9699248120301], "unit": "score", "name": "DeltaBlue", "value": 351.74775999999986}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42458.333333333336], "unit": "score", "name": "RegExp", "value": 21.455976447497545}, {"lowerIsBetter": false, "replicates": [581.7335660267597], "unit": "score", "name": "Splay", "value": 140.08302900000007}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20349.94955871106}]} 05:18:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20349.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1524.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6908.04"}}} 05:18:43 INFO - Return code: 0 05:18:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:43 INFO - # TBPL SUCCESS # 05:18:43 INFO - Running post-action listener: _resource_record_post_action 05:18:43 INFO - Running post-run listener: _resource_record_post_run 05:18:45 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 147456; Write bytes: 556974080; Read time: 104; Write time: 575988 05:18:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246931456; Read time: 0; Write time: 273944 05:18:45 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 147456; Write bytes: 309854208; Read time: 104; Write time: 302028 05:18:45 INFO - Running post-run listener: _upload_blobber_files 05:18:45 INFO - Blob upload gear active. 05:18:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:18:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:18:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:18:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:18:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:46 INFO - (blobuploader) - INFO - Done attempting. 05:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:47 INFO - (blobuploader) - INFO - Done attempting. 05:18:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:47 INFO - Return code: 0 05:18:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:18:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab2d34b1650fabfaab24526db807f28c0d6f24b7281ca49710ec5da9f3e8320b28b0fdde489c9bb512ddac5e8fe191c4dd0ad9e434ce5000b49f276a5ed077d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/141672827bdbc85370b90e66b375f67bd540549c608038d14e4147b4a46cc815a35e072b4af594155cc615ce869db4b54fc1e8aa0bbd89a900d86808d724dacb"} 05:18:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:18:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:18:47 INFO - Contents: 05:18:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab2d34b1650fabfaab24526db807f28c0d6f24b7281ca49710ec5da9f3e8320b28b0fdde489c9bb512ddac5e8fe191c4dd0ad9e434ce5000b49f276a5ed077d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/141672827bdbc85370b90e66b375f67bd540549c608038d14e4147b4a46cc815a35e072b4af594155cc615ce869db4b54fc1e8aa0bbd89a900d86808d724dacb"} 05:18:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:47 INFO - Copying logs to upload dir... 05:18:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:18:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.405627 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-20 05:18:46.755281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:18:46.759104) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab2d34b1650fabfaab24526db807f28c0d6f24b7281ca49710ec5da9f3e8320b28b0fdde489c9bb512ddac5e8fe191c4dd0ad9e434ce5000b49f276a5ed077d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/141672827bdbc85370b90e66b375f67bd540549c608038d14e4147b4a46cc815a35e072b4af594155cc615ce869db4b54fc1e8aa0bbd89a900d86808d724dacb"} build_url:https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/aSnZ95h1Qcei6o3qrDDWCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab2d34b1650fabfaab24526db807f28c0d6f24b7281ca49710ec5da9f3e8320b28b0fdde489c9bb512ddac5e8fe191c4dd0ad9e434ce5000b49f276a5ed077d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/141672827bdbc85370b90e66b375f67bd540549c608038d14e4147b4a46cc815a35e072b4af594155cc615ce869db4b54fc1e8aa0bbd89a900d86808d724dacb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 05:18:46.783784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:18:46.784111) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453294660.920302-1499970474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 05:18:46.866578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:18:46.866907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 05:18:46.867188) ========= ========= Total master_lag: 0.28 =========