builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1450972376.67 results: success (0) buildid: 20151224053000 builduid: 37d636c966a94b3d9db11b4e0c588ef1 revision: d366e708162d156afe5d6933f042dd4cdf468ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.668027) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.668479) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.668771) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005031 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.717380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.717669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.759983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.760238) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021503 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.809024) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.809295) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.809654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.809942) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 07:52:56-- 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% 47.5M=0s 2015-12-24 07:52:57 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.993246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:56.993586) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107974 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.112980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.113332) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d366e708162d156afe5d6933f042dd4cdf468ec2 --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/b2g-inbound --rev d366e708162d156afe5d6933f042dd4cdf468ec2 --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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 07:52:57,255 truncating revision to first 12 chars 2015-12-24 07:52:57,255 Setting DEBUG logging. 2015-12-24 07:52:57,255 attempt 1/10 2015-12-24 07:52:57,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d366e708162d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 07:52:57,501 unpacking tar archive at: b2g-inbound-d366e708162d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.684653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.684963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.693079) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.693413) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:57.693899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-24 07:52:57.694243) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:58 INFO - MultiFileLogger online at 20151224 07:52:58 in /builds/slave/test-pgo 07:52:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:52:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:52:58 INFO - {'append_to_log': False, 07:52:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:52:58 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:52:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:52:58 INFO - 'branch': 'B2G-Inbound', 07:52:58 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:58 INFO - 'config_files': ('talos/linux_config.py',), 07:52:58 INFO - 'default_actions': ('clobber', 07:52:58 INFO - 'read-buildbot-config', 07:52:58 INFO - 'download-and-extract', 07:52:58 INFO - 'populate-webroot', 07:52:58 INFO - 'create-virtualenv', 07:52:58 INFO - 'install', 07:52:58 INFO - 'run-tests'), 07:52:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:58 INFO - 'download_minidump_stackwalk': True, 07:52:58 INFO - 'download_symbols': 'ondemand', 07:52:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:58 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:58 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:58 INFO - 'installer_path': 'installer.exe', 07:52:58 INFO - 'log_level': 'info', 07:52:58 INFO - 'log_name': 'talos', 07:52:58 INFO - 'log_to_console': True, 07:52:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:58 INFO - 'opt_config_files': (), 07:52:58 INFO - 'pip_index': False, 07:52:58 INFO - 'sps_profile': False, 07:52:58 INFO - 'sps_profile_interval': 0, 07:52:58 INFO - 'suite': 'dromaeojs', 07:52:58 INFO - 'system_bits': '64', 07:52:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:58 INFO - 'title': 'talos-linux64-ix-048', 07:52:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:58 INFO - 'use_talos_json': True, 07:52:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:52:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:58 INFO - 'work_dir': 'build'} 07:52:58 INFO - ##### 07:52:58 INFO - ##### Running clobber step. 07:52:58 INFO - ##### 07:52:58 INFO - Running pre-action listener: _resource_record_pre_action 07:52:58 INFO - Running main action method: clobber 07:52:58 INFO - rmtree: /builds/slave/test-pgo/build 07:52:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:53:02 INFO - Running post-action listener: _resource_record_post_action 07:53:02 INFO - ##### 07:53:02 INFO - ##### Running read-buildbot-config step. 07:53:02 INFO - ##### 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: read_buildbot_config 07:53:02 INFO - Using buildbot properties: 07:53:02 INFO - { 07:53:02 INFO - "project": "", 07:53:02 INFO - "product": "firefox", 07:53:02 INFO - "script_repo_revision": "production", 07:53:02 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:53:02 INFO - "repository": "", 07:53:02 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:53:02 INFO - "buildid": "20151224053000", 07:53:02 INFO - "pgo_build": "True", 07:53:02 INFO - "basedir": "/builds/slave/test-pgo", 07:53:02 INFO - "buildnumber": 1, 07:53:02 INFO - "slavename": "talos-linux64-ix-048", 07:53:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:53:02 INFO - "platform": "ubuntu64_hw", 07:53:02 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:53:02 INFO - "branch": "b2g-inbound", 07:53:02 INFO - "repo_path": "integration/b2g-inbound", 07:53:02 INFO - "revision": "d366e708162d156afe5d6933f042dd4cdf468ec2", 07:53:02 INFO - "stage_platform": "linux64-pgo", 07:53:02 INFO - "builduid": "37d636c966a94b3d9db11b4e0c588ef1", 07:53:02 INFO - "slavebuilddir": "test" 07:53:02 INFO - } 07:53:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:53:02 INFO - Running post-action listener: _resource_record_post_action 07:53:02 INFO - ##### 07:53:02 INFO - ##### Running download-and-extract step. 07:53:02 INFO - ##### 07:53:02 INFO - Running pre-action listener: _resource_record_pre_action 07:53:02 INFO - Running main action method: download_and_extract 07:53:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:53: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')]} 07:53:02 INFO - https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/test_packages.json 07:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/test_packages.json 07:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:53:03 INFO - Downloaded 1302 bytes. 07:53:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:53:03 INFO - Using the following test package requirements: 07:53:03 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:03 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:53:03 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'jsshell-linux-x86_64.zip'], 07:53:03 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:53:03 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:03 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:53:03 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:53:03 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:53:03 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:53:03 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:53:03 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:53:03 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:03 INFO - https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:08 INFO - Downloaded 23180376 bytes. 07:53:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:53:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:53:09 INFO - Return code: 0 07:53:09 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 07:53: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')]} 07:53:09 INFO - https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:10 INFO - Downloaded 23180376 bytes. 07:53:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:53:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:53:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:53:12 INFO - Return code: 0 07:53: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')]} 07:53:12 INFO - https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:13 INFO - Downloaded 11132277 bytes. 07:53:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:53:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:53:13 INFO - Return code: 0 07:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:13 INFO - https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8TgA0pAPRXKsPV2CBz7aQw/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 07:53:16 INFO - Downloaded 54831776 bytes. 07:53:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:16 INFO - mkdir: /builds/slave/test-pgo/properties 07:53:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:53:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:53:16 INFO - Contents: 07:53:16 INFO - build_url:https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:16 INFO - Running post-action listener: _resource_record_post_action 07:53:16 INFO - Running post-action listener: set_extra_try_arguments 07:53:16 INFO - ##### 07:53:16 INFO - ##### Running populate-webroot step. 07:53:16 INFO - ##### 07:53:16 INFO - Running pre-action listener: _resource_record_pre_action 07:53:16 INFO - Running main action method: populate_webroot 07:53:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:16 INFO - '--tppagecycles', 07:53:16 INFO - '7'], 07:53:16 INFO - 'tests': ['tsvgm']}}, 07:53:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'tests': ['damp', 'tps']}, 07:53:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['damp', 'tps']}, 07:53:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:16 INFO - 'other': {'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'other_l64': {'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:16 INFO - 'ts_paint', 07:53:16 INFO - 'tpaint', 07:53:16 INFO - 'sessionrestore', 07:53:16 INFO - 'sessionrestore_no_auto_restore']}, 07:53:16 INFO - 'svgr': {'tests': ['tsvgx', 07:53:16 INFO - 'tsvgr_opacity', 07:53:16 INFO - 'tart', 07:53:16 INFO - 'tscrollx', 07:53:16 INFO - 'cart']}, 07:53:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['tsvgx', 07:53:16 INFO - 'tsvgr_opacity', 07:53:16 INFO - 'tart', 07:53:16 INFO - 'tscrollx', 07:53:16 INFO - 'cart']}, 07:53:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'tests': ['tp5o']}, 07:53:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'talos_options': ['--e10s'], 07:53:16 INFO - 'tests': ['tp5o']}, 07:53:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'talos_options': ['--xperf_path', 07:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:16 INFO - 'tests': ['tp5n']}, 07:53:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:16 INFO - 'talos_options': ['--e10s', 07:53:16 INFO - '--xperf_path', 07:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:16 INFO - 'tests': ['tp5n']}}, 07:53:16 INFO - 'talos.zip': {'path': '', 07:53:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:16 INFO - Running post-action listener: _resource_record_post_action 07:53:16 INFO - ##### 07:53:16 INFO - ##### Running create-virtualenv step. 07:53:16 INFO - ##### 07:53:16 INFO - Running pre-action listener: _resource_record_pre_action 07:53:16 INFO - Running main action method: create_virtualenv 07:53:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:53:16 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 07:53:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:53:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:16 INFO - Using real prefix '/usr' 07:53:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:53:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:19 INFO - Installing pip.................done. 07:53:19 INFO - Return code: 0 07:53:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:53:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:53:19 INFO - Using env: {'DISPLAY': ':0', 07:53:19 INFO - 'HOME': '/home/cltbld', 07:53:19 INFO - 'LANG': 'en_US.UTF-8', 07:53:19 INFO - 'LANGUAGE': 'en_US:en', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MAIL': '/var/mail/cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SHLVL': '1', 07:53:19 INFO - 'TERM': 'linux', 07:53:19 INFO - 'TMOUT': '86400', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - '_': '/tools/buildbot/bin/python'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 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 07:53:20 INFO - Cleaning up... 07:53:20 INFO - Return code: 0 07:53:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:53:20 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')]} 07:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 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')]} 07:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:53:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:53:20 INFO - Using env: {'DISPLAY': ':0', 07:53:20 INFO - 'HOME': '/home/cltbld', 07:53:20 INFO - 'LANG': 'en_US.UTF-8', 07:53:20 INFO - 'LANGUAGE': 'en_US:en', 07:53:20 INFO - 'LOGNAME': 'cltbld', 07:53:20 INFO - 'MAIL': '/var/mail/cltbld', 07:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:20 INFO - 'MOZ_NO_REMOTE': '1', 07:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:20 INFO - 'NO_EM_RESTART': '1', 07:53:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:20 INFO - 'SHELL': '/bin/bash', 07:53:20 INFO - 'SHLVL': '1', 07:53:20 INFO - 'TERM': 'linux', 07:53:20 INFO - 'TMOUT': '86400', 07:53:20 INFO - 'USER': 'cltbld', 07:53:20 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:20 INFO - '_': '/tools/buildbot/bin/python'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 INFO - Downloading/unpacking psutil>=0.7.1 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:20 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 07:53:22 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:53:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:53:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:22 INFO - Installing collected packages: psutil 07:53:22 INFO - Running setup.py install for psutil 07:53:22 INFO - building 'psutil._psutil_linux' extension 07:53:22 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 07:53:23 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 07:53:23 INFO - building 'psutil._psutil_posix' extension 07:53:23 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 07:53:23 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 07:53:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:23 INFO - Successfully installed psutil 07:53:23 INFO - Cleaning up... 07:53:23 INFO - Return code: 0 07:53:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:53:23 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')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 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')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:53:23 INFO - Using env: {'DISPLAY': ':0', 07:53:23 INFO - 'HOME': '/home/cltbld', 07:53:23 INFO - 'LANG': 'en_US.UTF-8', 07:53:23 INFO - 'LANGUAGE': 'en_US:en', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MAIL': '/var/mail/cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SHLVL': '1', 07:53:23 INFO - 'TERM': 'linux', 07:53:23 INFO - 'TMOUT': '86400', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - '_': '/tools/buildbot/bin/python'} 07:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:53:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:25 INFO - Installing collected packages: mozsystemmonitor 07:53:25 INFO - Running setup.py install for mozsystemmonitor 07:53:25 INFO - Successfully installed mozsystemmonitor 07:53:25 INFO - Cleaning up... 07:53:25 INFO - Return code: 0 07:53:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:53:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:53:25 INFO - Using env: {'DISPLAY': ':0', 07:53:25 INFO - 'HOME': '/home/cltbld', 07:53:25 INFO - 'LANG': 'en_US.UTF-8', 07:53:25 INFO - 'LANGUAGE': 'en_US:en', 07:53:25 INFO - 'LOGNAME': 'cltbld', 07:53:25 INFO - 'MAIL': '/var/mail/cltbld', 07:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:25 INFO - 'MOZ_NO_REMOTE': '1', 07:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:25 INFO - 'NO_EM_RESTART': '1', 07:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:25 INFO - 'SHELL': '/bin/bash', 07:53:25 INFO - 'SHLVL': '1', 07:53:25 INFO - 'TERM': 'linux', 07:53:25 INFO - 'TMOUT': '86400', 07:53:25 INFO - 'USER': 'cltbld', 07:53:25 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:25 INFO - '_': '/tools/buildbot/bin/python'} 07:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:53:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:27 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 07:53:27 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 07:53:27 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 07:53:27 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 07:53:27 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 07:53:27 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 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:53:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:53:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Downloading docopt-0.6.1.tar.gz 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:53:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:28 INFO - Running setup.py install for blobuploader 07:53:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:53:28 INFO - Running setup.py install for requests 07:53:28 INFO - Running setup.py install for docopt 07:53:29 INFO - Successfully installed blobuploader requests docopt 07:53:29 INFO - Cleaning up... 07:53:29 INFO - Return code: 0 07:53:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:53:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:29 INFO - Using env: {'DISPLAY': ':0', 07:53:29 INFO - 'HOME': '/home/cltbld', 07:53:29 INFO - 'LANG': 'en_US.UTF-8', 07:53:29 INFO - 'LANGUAGE': 'en_US:en', 07:53:29 INFO - 'LOGNAME': 'cltbld', 07:53:29 INFO - 'MAIL': '/var/mail/cltbld', 07:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:29 INFO - 'MOZ_NO_REMOTE': '1', 07:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:29 INFO - 'NO_EM_RESTART': '1', 07:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:29 INFO - 'SHELL': '/bin/bash', 07:53:29 INFO - 'SHLVL': '1', 07:53:29 INFO - 'TERM': 'linux', 07:53:29 INFO - 'TMOUT': '86400', 07:53:29 INFO - 'USER': 'cltbld', 07:53:29 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:29 INFO - '_': '/tools/buildbot/bin/python'} 07:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:29 INFO - Running setup.py (path:/tmp/pip-Qy75uA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:29 INFO - Running setup.py (path:/tmp/pip-uJPm_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:29 INFO - Running setup.py (path:/tmp/pip-FMSV3Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:29 INFO - Running setup.py (path:/tmp/pip-OUjjPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:29 INFO - Running setup.py (path:/tmp/pip-tnSqzq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:29 INFO - Running setup.py (path:/tmp/pip-hnLUpg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:29 INFO - Running setup.py (path:/tmp/pip-M00oAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:29 INFO - Running setup.py (path:/tmp/pip-SQomEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:29 INFO - Running setup.py (path:/tmp/pip-TAGMat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:29 INFO - Running setup.py (path:/tmp/pip-ANi5Qb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:30 INFO - Running setup.py (path:/tmp/pip-AB1tad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:30 INFO - Running setup.py (path:/tmp/pip-nyQOxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:30 INFO - Running setup.py (path:/tmp/pip-tLiM2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:30 INFO - Running setup.py (path:/tmp/pip-J0BS31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:30 INFO - Running setup.py (path:/tmp/pip-cpzWb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:30 INFO - Running setup.py (path:/tmp/pip-rzY3Lu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:30 INFO - Running setup.py (path:/tmp/pip-0Wt0gU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:30 INFO - Running setup.py install for manifestparser 07:53:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:53:30 INFO - Running setup.py install for mozcrash 07:53:30 INFO - Running setup.py install for mozdebug 07:53:30 INFO - Running setup.py install for mozdevice 07:53:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:53:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:53:30 INFO - Running setup.py install for mozfile 07:53:31 INFO - Running setup.py install for mozhttpd 07:53:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for mozinfo 07:53:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for mozInstall 07:53:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for mozleak 07:53:31 INFO - Running setup.py install for mozlog 07:53:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for moznetwork 07:53:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for mozprocess 07:53:31 INFO - Running setup.py install for mozprofile 07:53:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:53:31 INFO - Running setup.py install for mozrunner 07:53:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:53:32 INFO - Running setup.py install for mozscreenshot 07:53:32 INFO - Running setup.py install for moztest 07:53:32 INFO - Running setup.py install for mozversion 07:53:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:53:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:32 INFO - Cleaning up... 07:53:32 INFO - Return code: 0 07:53:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:53:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:32 INFO - Using env: {'DISPLAY': ':0', 07:53:32 INFO - 'HOME': '/home/cltbld', 07:53:32 INFO - 'LANG': 'en_US.UTF-8', 07:53:32 INFO - 'LANGUAGE': 'en_US:en', 07:53:32 INFO - 'LOGNAME': 'cltbld', 07:53:32 INFO - 'MAIL': '/var/mail/cltbld', 07:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:32 INFO - 'MOZ_NO_REMOTE': '1', 07:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:32 INFO - 'NO_EM_RESTART': '1', 07:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:32 INFO - 'SHELL': '/bin/bash', 07:53:32 INFO - 'SHLVL': '1', 07:53:32 INFO - 'TERM': 'linux', 07:53:32 INFO - 'TMOUT': '86400', 07:53:32 INFO - 'USER': 'cltbld', 07:53:32 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:32 INFO - '_': '/tools/buildbot/bin/python'} 07:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:32 INFO - Running setup.py (path:/tmp/pip-Npwfg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:32 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)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:32 INFO - Running setup.py (path:/tmp/pip-pug5Zt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:32 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)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:32 INFO - Running setup.py (path:/tmp/pip-jkAJ_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:32 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)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:32 INFO - Running setup.py (path:/tmp/pip-1dNIk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:32 INFO - Running setup.py (path:/tmp/pip-EhO7QB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:32 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)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:32 INFO - Running setup.py (path:/tmp/pip-LNvVA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:32 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)) 07:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:32 INFO - Running setup.py (path:/tmp/pip-y4jkY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:33 INFO - Running setup.py (path:/tmp/pip-Ve90rg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:33 INFO - Running setup.py (path:/tmp/pip-jDHlbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:33 INFO - Running setup.py (path:/tmp/pip-YWQ19E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:33 INFO - Running setup.py (path:/tmp/pip-wiOWVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:33 INFO - Running setup.py (path:/tmp/pip-MBVRpM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:33 INFO - Running setup.py (path:/tmp/pip-5MGZfe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:33 INFO - Running setup.py (path:/tmp/pip-bt0P_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:33 INFO - Running setup.py (path:/tmp/pip-nx7ruY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:33 INFO - Running setup.py (path:/tmp/pip-blGDw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:33 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)) 07:53:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:33 INFO - Running setup.py (path:/tmp/pip-aotco6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:33 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)) 07:53:33 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)) 07:53:33 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)) 07:53:33 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)) 07:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:33 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 07:53:33 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 07:53:33 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 07:53:33 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 07:53:33 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 07:53:33 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 07:53:35 INFO - Downloading blessings-1.5.1.tar.gz 07:53:35 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:35 INFO - Installing collected packages: blessings 07:53:35 INFO - Running setup.py install for blessings 07:53:35 INFO - Successfully installed blessings 07:53:35 INFO - Cleaning up... 07:53:35 INFO - Return code: 0 07:53:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:53:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:35 INFO - Reading from file tmpfile_stdout 07:53:35 INFO - Current package versions: 07:53:35 INFO - argparse == 1.2.1 07:53:35 INFO - blessings == 1.5.1 07:53:35 INFO - blobuploader == 1.2.4 07:53:35 INFO - docopt == 0.6.1 07:53:35 INFO - manifestparser == 1.1 07:53:35 INFO - mozInstall == 1.12 07:53:35 INFO - mozcrash == 0.16 07:53:35 INFO - mozdebug == 0.1 07:53:35 INFO - mozdevice == 0.47 07:53:35 INFO - mozfile == 1.2 07:53:35 INFO - mozhttpd == 0.7 07:53:35 INFO - mozinfo == 0.9 07:53:35 INFO - mozleak == 0.1 07:53:35 INFO - mozlog == 3.1 07:53:35 INFO - moznetwork == 0.27 07:53:35 INFO - mozprocess == 0.22 07:53:35 INFO - mozprofile == 0.28 07:53:35 INFO - mozrunner == 6.11 07:53:35 INFO - mozscreenshot == 0.1 07:53:35 INFO - mozsystemmonitor == 0.0 07:53:35 INFO - moztest == 0.7 07:53:35 INFO - mozversion == 1.4 07:53:35 INFO - psutil == 3.1.1 07:53:35 INFO - requests == 1.2.3 07:53:35 INFO - wsgiref == 0.1.2 07:53:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:35 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')]} 07:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 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')]} 07:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:53:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:35 INFO - Using env: {'DISPLAY': ':0', 07:53:35 INFO - 'HOME': '/home/cltbld', 07:53:35 INFO - 'LANG': 'en_US.UTF-8', 07:53:35 INFO - 'LANGUAGE': 'en_US:en', 07:53:35 INFO - 'LOGNAME': 'cltbld', 07:53:35 INFO - 'MAIL': '/var/mail/cltbld', 07:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:35 INFO - 'MOZ_NO_REMOTE': '1', 07:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:35 INFO - 'NO_EM_RESTART': '1', 07:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:35 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:35 INFO - 'SHELL': '/bin/bash', 07:53:35 INFO - 'SHLVL': '1', 07:53:35 INFO - 'TERM': 'linux', 07:53:35 INFO - 'TMOUT': '86400', 07:53:35 INFO - 'USER': 'cltbld', 07:53:35 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:35 INFO - '_': '/tools/buildbot/bin/python'} 07:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:53:36 INFO - Cleaning up... 07:53:36 INFO - Return code: 0 07:53:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:53:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:53:36 INFO - Using env: {'DISPLAY': ':0', 07:53:36 INFO - 'HOME': '/home/cltbld', 07:53:36 INFO - 'LANG': 'en_US.UTF-8', 07:53:36 INFO - 'LANGUAGE': 'en_US:en', 07:53:36 INFO - 'LOGNAME': 'cltbld', 07:53:36 INFO - 'MAIL': '/var/mail/cltbld', 07:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:36 INFO - 'MOZ_NO_REMOTE': '1', 07:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:36 INFO - 'NO_EM_RESTART': '1', 07:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:36 INFO - 'SHELL': '/bin/bash', 07:53:36 INFO - 'SHLVL': '1', 07:53:36 INFO - 'TERM': 'linux', 07:53:36 INFO - 'TMOUT': '86400', 07:53:36 INFO - 'USER': 'cltbld', 07:53:36 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:36 INFO - '_': '/tools/buildbot/bin/python'} 07:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:36 INFO - Downloading/unpacking jsonschema 07:53:36 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 07:53:36 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 07:53:36 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 07:53:36 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 07:53:36 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 07:53:36 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 07:53:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:53:38 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:53:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:38 INFO - warning: no files found matching '*.txt' 07:53:38 INFO - no previously-included directories found matching 'build' 07:53:38 INFO - no previously-included directories found matching 'dist' 07:53:38 INFO - no previously-included directories found matching '.git*' 07:53:38 INFO - Installing collected packages: jsonschema, functools32 07:53:38 INFO - Running setup.py install for functools32 07:53:38 INFO - warning: no files found matching '*.txt' 07:53:38 INFO - no previously-included directories found matching 'build' 07:53:38 INFO - no previously-included directories found matching 'dist' 07:53:38 INFO - no previously-included directories found matching '.git*' 07:53:38 INFO - Successfully installed jsonschema functools32 07:53:38 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:53:38 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')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39989c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2762630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', '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 07:53:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:53:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:53:38 INFO - Using env: {'DISPLAY': ':0', 07:53:38 INFO - 'HOME': '/home/cltbld', 07:53:38 INFO - 'LANG': 'en_US.UTF-8', 07:53:38 INFO - 'LANGUAGE': 'en_US:en', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MAIL': '/var/mail/cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SHLVL': '1', 07:53:38 INFO - 'TERM': 'linux', 07:53:38 INFO - 'TMOUT': '86400', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - '_': '/tools/buildbot/bin/python'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 INFO - Downloading/unpacking flake8 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:53:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:53:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:53:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 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 07:53:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:53:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:41 INFO - no previously-included directories found matching 'docs/_build' 07:53:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:53:41 INFO - Running setup.py install for pep8 07:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:41 INFO - no previously-included directories found matching 'docs/_build' 07:53:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:53:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:53:41 INFO - Cleaning up... 07:53:41 INFO - Return code: 0 07:53:41 INFO - Running post-action listener: _resource_record_post_action 07:53:41 INFO - Running post-action listener: _start_resource_monitoring 07:53:41 INFO - Starting resource monitoring. 07:53:41 INFO - ##### 07:53:41 INFO - ##### Running install step. 07:53:41 INFO - ##### 07:53:41 INFO - Running pre-action listener: _resource_record_pre_action 07:53:41 INFO - Running main action method: install 07:53:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:41 INFO - Reading from file tmpfile_stdout 07:53:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:53:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:53:41 INFO - Reading from file tmpfile_stdout 07:53:41 INFO - Output received: 07:53:41 INFO - Usage: mozinstall [options] installer 07:53:41 INFO - Options: 07:53:41 INFO - -h, --help show this help message and exit 07:53:41 INFO - -d DEST, --destination=DEST 07:53:41 INFO - Directory to install application into. [default: 07:53:41 INFO - "/builds/slave/test-pgo"] 07:53:41 INFO - --app=APP Application being installed. [default: firefox] 07:53:41 INFO - mkdir: /builds/slave/test-pgo/build/application 07:53:41 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'] 07:53:41 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 07:53:57 INFO - Reading from file tmpfile_stdout 07:53:57 INFO - Output received: 07:53:57 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:53:57 INFO - Running post-action listener: _resource_record_post_action 07:53:57 INFO - ##### 07:53:57 INFO - ##### Running run-tests step. 07:53:57 INFO - ##### 07:53:57 INFO - Running pre-action listener: _resource_record_pre_action 07:53:57 INFO - Running main action method: run_tests 07:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:53:57 INFO - Python 2.7.3 07:53:57 INFO - Return code: 0 07:53:57 INFO - grabbing minidump binary from tooltool 07:53: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')]} 07:53:57 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 0x27f3840>, '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 0x27606b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2760b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:53:57 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 07:53:57 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 07:53:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:57 INFO - Return code: 0 07:53:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:53:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:53:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:53:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:53:59 INFO - Return code: 0 07:53:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:53:59 INFO - Using env: {'DISPLAY': ':0', 07:53:59 INFO - 'HOME': '/home/cltbld', 07:53:59 INFO - 'LANG': 'en_US.UTF-8', 07:53:59 INFO - 'LANGUAGE': 'en_US:en', 07:53:59 INFO - 'LOGNAME': 'cltbld', 07:53:59 INFO - 'MAIL': '/var/mail/cltbld', 07:53:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:59 INFO - 'MOZ_NO_REMOTE': '1', 07:53:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:59 INFO - 'NO_EM_RESTART': '1', 07:53:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:53:59 INFO - 'SHELL': '/bin/bash', 07:53:59 INFO - 'SHLVL': '1', 07:53:59 INFO - 'TERM': 'linux', 07:53:59 INFO - 'TMOUT': '86400', 07:53:59 INFO - 'USER': 'cltbld', 07:53:59 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185', 07:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:59 INFO - '_': '/tools/buildbot/bin/python'} 07:53:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:54:00 INFO - mozversion application_buildid: 20151224053000 07:54:00 INFO - mozversion application_changeset: d366e708162d156afe5d6933f042dd4cdf468ec2 07:54:00 INFO - mozversion application_display_name: Nightly 07:54:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:00 INFO - mozversion application_name: Firefox 07:54:00 INFO - mozversion application_remotingname: firefox 07:54:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:54:00 INFO - mozversion application_vendor: Mozilla 07:54:00 INFO - mozversion application_version: 46.0a1 07:54:00 INFO - mozversion platform_buildid: 20151224053000 07:54:00 INFO - mozversion platform_changeset: d366e708162d156afe5d6933f042dd4cdf468ec2 07:54:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:54:00 INFO - mozversion platform_version: 46.0a1 07:54:00 INFO - using testdate: 1450972440 07:54:00 INFO - actual date: 1450972440 07:54:00 INFO - starting webserver on 'localhost:56393' 07:54:00 INFO - SUITE-START | Running 3 tests 07:54:00 INFO - TEST-START | dromaeo_css 07:54:00 INFO - operating with platform_type : linux_ 07:54:00 INFO - Initialising browser for dromaeo_css test... 07:54:00 INFO - TEST-INFO | started process 3301 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppJxsYp/profile http://localhost:56393/getInfo.html) 07:54:05 INFO - PROCESS | 3301 | __metrics Screen width/height:1600/1200 07:54:05 INFO - PROCESS | 3301 | colorDepth:24 07:54:05 INFO - PROCESS | 3301 | Browser inner width/height: 1024/697 07:54:05 INFO - PROCESS | 3301 | __metrics 07:54:05 INFO - PROCESS | 3301 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:54:05 INFO - PROCESS | 3301 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:06 INFO - TEST-INFO | 3301: exit 0 07:54:06 INFO - Browser initialized. 07:54:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:06 INFO - TEST-INFO | started process 3394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppJxsYp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:18 INFO - PROCESS | 3394 | RSS: Main: 150368256 07:54:18 INFO - PROCESS | 3394 | 07:55:09 INFO - PROCESS | 3394 | 1450972509317 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] 07:57:19 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56393/tests/dromaeo/cssquery-ext.html) 07:57:20 INFO - PROCESS | 3394 | RSS: Main: 280129536 07:57:20 INFO - PROCESS | 3394 | 08:00:23 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-ext.html (next: http://localhost:56393/tests/dromaeo/cssquery-jquery.html) 08:00:23 INFO - PROCESS | 3394 | RSS: Main: 228478976 08:00:23 INFO - PROCESS | 3394 | 08:03:25 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56393/tests/dromaeo/cssquery-mootools.html) 08:03:26 INFO - PROCESS | 3394 | RSS: Main: 227504128 08:03:26 INFO - PROCESS | 3394 | 08:06:27 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56393/tests/dromaeo/cssquery-prototype.html) 08:06:28 INFO - PROCESS | 3394 | RSS: Main: 211337216 08:06:28 INFO - PROCESS | 3394 | 08:09:31 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56393/tests/dromaeo/cssquery-yui.html) 08:09:31 INFO - PROCESS | 3394 | RSS: Main: 215678976 08:09:31 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | Cycle 1(1): loaded http://localhost:56393/tests/dromaeo/cssquery-yui.html (next: http://localhost:56393/tests/dromaeo/cssquery-dojo.html) 08:12:34 INFO - PROCESS | 3394 | RSS: Main: 279162880 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | __start_tp_report 08:12:34 INFO - PROCESS | 3394 | _x_x_mozilla_page_load 08:12:34 INFO - PROCESS | 3394 | _x_x_mozilla_page_load_details 08:12:34 INFO - PROCESS | 3394 | |i|pagename|runs| 08:12:34 INFO - PROCESS | 3394 | |0;dojo.html;3197.520371944209;3226.499892516658;3273.541704161418;3274.3123943971777;3286.671332866714;5205.297284866542;5313.521783039526;5355.678659280441;5451.972740136299;5477.233187353773;5315.627906046579;5371.81198658047;5377.274068000819;5424.593155513333;5527.447255274481;4970.428400733907;4986.301917731521;4995.175795993657;5003.974980125113;5048.772805223755;4769.332293478916;5034.1945288753805;5063.41770696371;5077.873053173682;5127.871803204913;4876.731779752095;4921.966387058722;4936.308916751657;4945.653804233705;4950.900981980376;4881.707097574157;4965.4041515018425;4978.601711863079;4994.450610432849;5008;4801.663883528155;4898.583620392271;4936.876578085541;4954.578860796837;4979.203327467624;5230.21546767984;5316.627836051478;5319.468053194688;5328;5354.089804733205;5897.056470964668;5901.940980590182;5909.645421274738;5909.852253693692;5916.319623243339;5677.687727175004;5835.0372188588835;5855.443732845373;5944.167816505693;5944.851378715523;5463.945360546423;5468.589855760833;5477.1510415886;5492.890142197173;5547.306586676666;5963.880722385615;5965.582409231312;5966.31387390447;5990.191324171268;5997.760089596367;5631.943680563142;5735.541156707453;5735.942640573624;5742.799002034909;5747.798827041117;5890.67601281925;5907.172995780594;5917.7928772493615;5922.763089476459;5971.940280597139;5833.212516310244;5833.854153646193;5872.706364681834;5880.0297950838485;5887.941120588739;5594.916076258859;5696.174054762119;5697.914531282034;5704.771809127588;5880.235569375954;4458.197524445631;4459.487158976694;4490.416245888014;4503.842365517256;4510.751908645056;3977.5624681285035;4003.3394489908837;4008.2785098682516;4020.2562525932794;4038.414429907647;5270.446603106695;5372.247885296062;5422.457754224625;5428;5551.8889622207325;5823.883522329615;5845.386234445322;5854;5859.384764599741;5869.325027621793;5416.7562459688625;5420.918686219631;5427.701476418756;5428.457154284619;5433.402325744165;4830.855074347775;4918.458969513351;4923.138450771173;5013.974930125326;5104.18333066715;6097.390260973867;6111.938880611137;6117.113018612187;6119.143319935212;6126.908096378558;5919.6744179070565;5928.762849486145;5939.46544810969;5940.6435613863305;5944.375840536682;5884.911726324023;6019;6019.337872834072;6027.517798576191;6080.300765412034;5672.886542269214;5686.203931449518;5702.173184888251;5736.340320863154;5792.913106303325;5867.354590994902;5892.204552385373;5894.646321220741;5908.911366329423;5911.083782013795;5509.614326997232;5560.888782224252;5612.663240205601;5754.741036653444;5758.424157584208;5656.349519805275;5708.515785895614;5722.685252311163;5726.713664316851;5786.652800831964;5602.2717046783655;5608.298962629671;5618.719064046863;5626.831195064155;5634.2393776841245;5643.887122257614;5656.660600363992;5704.087346024616;5737.483626473638;5767.423257674199;5603.467670571289;5605.523530499953;5628.437156284339;5629.662220266797;5674.546036317167 08:12:34 INFO - PROCESS | 3394 | |1;ext.html;563.4675231905851;596.889575428546;602.587227748992;605.1830029460232;608.2579253310961;29786.659600317984;30389.240268993286;30399.392012159744;30401.391972160545;30414.695853041492;30486.23784405391;39725.205495890135;40243.59756402435;40257.396139057935;40454.39318410219;8702.477851328924;8834.646614135427;8887.422317549372;8896.644134234622;8910.86633700495;7754.806129846743;8660.090690477504;8695.608697608592;8779.165979231995;8785.38502304839;7794.688212471494;10438.112760415373;10604.628837990673;10644.840327395095;10654.893451065507;10172.389656620626;10291.845622315672;10308.072273495347;10309.278350515468;10311.123554497877;7845.764627061198;8037.799055023613;8039.95980020102;10235.334703244265;10394;42517;43017.784911075556;43163;43165.56834431647;43176.56823431757;3285.917852053694;3313.6355000949875;3327.93344133116;3641.7632853864416;4177.91644167118;28606;28716.282092947633;29041.273968150756;29459.410811783644;30125.096247112622;3856.903577410559;3914.3345631242755;3966.7619942803235;3986.866558051685;4059.7361171523758;281946.49294288806;286047;288815;289382;289633;54122.7293863536;56155.43844561584;56183;66259.33740662628;67495.66252168806;60351.39648603458;60524.697376513715;60545.69727151336;60623.69688151531;60645;15820.92089539568;16114.194290285439;16122.274497647633;16133.435329763402;16143.192840357935;12116.454759535842;12287.385630718429;12292.262464252173;12460.875391246153;12460.937695311466;19956.600867982557;20264.49338766513;20306.898465507576;20325.898370508054;20351.389458316273;7922;8030.980637101811;8090.595470226465;8155.67377304913;8187.38594605407;1014.1531820929606;1018.8217062014118;1023.0741179232806;1024.6157690865925;1039.29328056922;26715;27845.46568505342;27937.30156746057;28213.576796348072;28214.576781348296;992.270681049428;1012.9290949633455;1022.3456987527989;1043.5929987304958;1082.3019152646498;14317.856821431653;14400.567982960529;14459.710805784036;14485.78271325931;14698;408586;412795;413762;415538;415863;54552.181717274274;55098.72450637721;55101.44898550963;55135.172972405446;55174.724126379115;1367.7674795284825;1370.4586688258082;1383.5656720211698;1384.2386687321932;1385.9168449893039;26948.191554253404;27353.179404617895;27927.860360698065;27986.440271194057;27988.860055700407;44004.77997609991;44671;44674.55325446704;44691.32963005623;46785.766071169426;224509;305790;305854;306427;308235;30561.54157687592;30799.538006929466;31046.379072418877;31091.222719432197;31189;39162.21675566416;39850.40224396694;39951.83768104298;40437.393439099025;40965;33781.83109084439;34112.82943585266;35370.823145884104;36704.449433257985;41710;36113.27773444464;36145.81927090348;36735.63264367322;36843.81578092092;37104.81447592745;40704;41366.37950430686;41601;41751.164976699685;41982.160356793305;31046.53430198594;31134.377312453173;33761.324773504886;33873.66126338705;34033.31933361368;25043;25526.617100743875;25531.617025745;25640.102596409037;25813 08:12:34 INFO - PROCESS | 3394 | |2;jquery.html;361.93847046002196;365.7403243696975;366.5820964100925;366.69747458346836;367.8602131190148;13547.796783048238;13768.173909565434;17047.659046819073;17791.822081779195;18438.44684659461;14341;16820.495385138434;16952.4066657667;17093.658126837458;17233.052182129977;4611.354410382549;5414.83755487335;5540.473655002768;5545.972270138644;5551.472610102054;4029.9395509067385;4155.127423241123;6020.337762846083;6127.846803829895;6161.630302181883;6078.848028799293;6099.664518451484;6104.511639068864;6140.907886381686;6146.17026701394;5188.896222075575;5339.09235429974;5342.465753424626;5355;6082.452579267865;5139.229115632647;5145.536901678867;5146.150885103953;5152.974235128838;5396.83809485716;12578.81131783024;12589.874101259053;12821.294828784414;12826.166299190523;13368.86631133686;2099.2442720620566;2127.2448280860226;2138.786121387864;2175.184305885293;2233.129079658934;9739.853902191473;9790.657326993522;9822.852657210147;9975.850362244571;9982.750431239205;1786.7766529183853;1859.962800743991;1882.6799444094536;1886.962260754791;1946.902654867251;60661.6966915167;61681.383186168016;63912.680436597984;64074.67962660203;64410.677946610434;9737.074977877232;9961.501924903725;10086.445245511568;10280.742981425525;10386.636467723594;12274.631761047005;12276.877231227752;12291.877081229251;12306.07704422172;12308.569200077955;7510.924890751132;7719.189485103983;7743.7676869694;7757.069151701832;7802.531848089133;7528.360089392463;7561.584112873845;7573.734919277799;7605.391568674493;7605.6577454014705;3934.409838524244;3959.9010024749036;3977.721559490808;4102.261592913304;4396.978015109904;1693.4919524142708;1702.208473060033;1747.484492074841;1763.2594310389668;1766.7438221457817;930.1256818590504;943.6366998705548;971.2278738402987;1041.8280983637615;1068.2308737708838;15888.76166857498;16058.197090145446;16159.919200403923;16568;16758.899603573376;839.6683310092479;912.2291663544295;983.4738414948112;986.6581449229043;1020.9438480883474;8611.870821937677;9004.279657627374;9280.303977201602;9795.853062204073;9806.558704858298;525275;533941;539221;541382;543161;74392.62803685947;80578.5971070141;84202.5789871059;86706.99999999873;87107.56446217855;1134.325076579434;1149.6608500492375;1166.5333866453486;1169.9415029248673;1172.7126853920845;15014.699706006037;15258.160801155598;15343.309551070452;15443.84556154424;15548.455804046804;33296.50055249125;33543.83228083844;34012.149696257795;34371.828140859136;37080.62919370772;37267.44098838574;38529;38895.222095557365;39652.20695586014;41841.58158418498;9284.396514226553;9500.334976551576;9794.461304628314;9797.706068817946;9799.608015679578;11442.542298307975;11589.594364197214;15233.771493427386;17346;17996.55008624795;13710.588682339545;13841.100328478617;13974.30128493551;14016.719665606426;14713.33789979475;14139.293035348397;14189.01353810488;14363;14521;14598.708025839636;11310.208285419942;11404.407611602319;12531.436085375997;14545.709085818013;14576.927115364355;9434.811303774024;9449.480278584744;9500.47747373901;9614.375065620712;9626.614935402506;13414.195148291134;13677;13832.239226842217;13849.16904985704;14139.575812725634 08:12:34 INFO - PROCESS | 3394 | |3;mootools.html;1318.9406476708548;1682.9663406731863;1738.843504084632;1745.0576688588162;1776.999999999999;6525.608463492188;7450.18048014718;7531.322181003702;7540.283673051065;7557.433192510556;7431.2940270674335;7613.581253031081;7616.885746713804;7620.466567340274;7621.961890190555;1950.619629172305;1992.232990298731;2207.348832094536;2242.7532971373134;2245;2274.829387795922;2280.1677387753516;2284.9885750571225;2285.714285714286;2286.3826766772963;2215.3464727905225;2278.7949084582383;2280.464090938628;2281.9657705134437;2288.5766133265315;2261.6494443361307;2264.3320220534983;2283.748787633359;2297.7242730872235;2301.0795681727277;2304.3432621702736;2311.3412677386864;2331.6502524621274;2352.5882970480097;2353.0470159585393;7474.962625186894;7545.094588649343;7548.66031028605;7562.168161502231;7565.470417070807;4587.908241835178;4679.438467383901;4705.223638099744;4706.058788242365;4706.082313948781;3108.1141874565865;3158.210447388153;3160.5891234139413;3189.5375170600364;3210.598675165604;1029.6602121299952;1055.3087727538475;1099.5272033025797;1110.1618278199987;1132.8980391764699;10221.080102790711;10304.072633463024;10317.638882639072;10320.380777153396;10322.587096516205;4170.895727606834;4289.485261768607;4319.114581510783;4351.369051487517;4383.6410712678535;8904.688335908211;8911.197992180734;8914.064023277591;8963.820723585492;8967.237784788365;4743.549362810528;4760;4770.856874293777;4775.761211939459;4780.593649539828;4319.265724826787;4325.956740432555;4330.480342358937;4331.870043898688;4340.153670034313;3097.1018404662395;3308.7022168004996;3610.5847827500174;3610.909727256787;3707.3882809336696;1168.550108208329;1196.4615922834585;1202.687301301668;1222.93273869938;1227.5703503773607;996.496769131584;999.8550210219478;1058.9727963875182;1104.3042882983668;1261.104615722847;7031.40233080194;7088.751893683696;7097;7107.680154393065;7122.928770712227;1132.1452303510962;1221.419825582841;1227.2023184929867;1238.133306685324;1260.332024027267;5410.296661433988;5423.240746295522;5425.26758887553;5464.699441530754;5467.261919640877;8567.143285671507;8683.478991260417;8892.59983300753;8899.377043607015;8920;8821.470711757314;8843.955780221058;8847.73456796297;8944.329175311748;8959.283257339397;6938.306169383021;7270.927290727025;7283.126024876943;7293.124825021031;7298.087739032515;6846.144231971004;6863.073485079451;6865.656717164222;6875.449964002768;6899.413549848118;7659.348955338859;7717.614119294125;7840.529568225925;7965.681372745025;7990.560519171501;8124.593770311342;8192.262696357357;8212.712555060543;8214.096449390443;8238.876416853633;6678.599284042973;6822.931770682229;6863.313668633296;6881.071055407456;6884.345987131214;6300.527460440394;6454.2900280968115;6891.896621550781;6901.654917254217;6978.162620485574;6664.766733164316;6788.287229840993;6810.8421568332515;6849.4177994871;6901.895696688706;6626.801195964129;6718.193816741827;6734.528582999143;6816.48876334267;6900.585964842126;6653.168353955755;6688;6688.3646053624825;6689.130413046273;6694.430973367318;6006.33930267679;6010.849728756816;6077.149199112039;6228;6231.501479881508;6283.49732021428;6307.936920630735;6319.6840157991;6322.525810564318;6337.96831015842 08:12:34 INFO - PROCESS | 3394 | |4;prototype.html;347.27592968660343;349.0732106257883;351.3640311037023;351.74498488595754;351.9137811236246;5778.422157784219;5914.438128377803;5958.404159584039;6005.8198254052395;6018.39816018398;5686.31764188297;5799.768009279624;5818.098194779805;5829.795957141501;5863.618864773786;4579.885502862422;4582.198115329804;4588.334691469743;4590.081983603292;4596.310553416981;4391.0559229765595;4485.439320084989;4493.775311234442;4607.815687372501;4612.308153776927;4551.476580193271;4554.8861278467975;4561.6806823522365;4585.243434833248;4588.724676519403;4573.3368661544055;4575.473820510634;4579.564941330568;4585.541445855421;4593.127305811885;4067.471228740245;4068.389741538793;4070.8575199867864;4071.4503542021744;4074.286999775057;5492.313460817398;5618.185363122365;5636.633618814764;5640.294963129609;5685.687287199203;5251.632385733;5251.632385733;5251.842444726664;5256.710880901549;5258.684478931276;5932.080527518242;6290.24517057956;6293.527985401068;6294.8111556653375;6300.243970723543;4211.536730959622;4295.420118284054;4390.253656878338;4390.868273951786;4398.450193725785;6439.678016099177;6542.607443553355;6543.378379053982;6555.082288479617;6565.015247712833;4519.480259770103;4522.208613492626;4522.751248681288;4523.2988886722615;4524.5927866492175;4493;4577.908441831145;4579.564941330568;4584.106099310669;4601.562851529099;5246.580273578104;5255.080360936897;5258.079836028756;5258.605604579672;5264.15773476242;6314.242290925118;6317.557770955989;6324.620522768649;6327.557071005078;6328.462080723098;1578.226668932215;1607.7990251218598;1611.323244237423;1611.7743515907782;1612.129450096958;1084.0514549768952;1090.4438736244572;1090.6237348115046;1094.141099237095;1120.467777805536;5986.970065149646;6002.069679199731;6004.0693692477735;6006.189164462829;6007.669578173155;6474.125992990886;6476.740930362827;6482.092507048923;6487.156669633012;6489.7404103835315;5892.440218179266;5924.703764811742;5958.136070269873;5983.581149319506;5985.16207730918;3463.116905189211;3504.0714210734177;3507.3862074136923;3508.736844736655;3511.719062475047;6674.966625166843;6684.966575167093;6691.330866913269;6692.230393504712;6698.598084114871;6597.703103360361;6601.73593056282;6611.074449577063;6619.106420633249;6626.933730662631;6487.967560162169;6616.106825578581;6657.600543967377;6667.433268172163;6669.966650166718;6317.778877739257;6446.484281257394;6457.5479716419395;6464.450521705708;6474;6328.272248691459;6471.4822814175695;6474.902876456951;6494.642794646151;6498.772542960974;6746.898796518154;6747.156605424322;6749.966250168718;6752.93247067523;6754.223264324469;4409.889752756207;4552.226121559276;4554.339620755039;4554.749488778149;4556.202664533627;6490.415862572391;6518.445932095636;6519.1199188110895;6530.183727034121;6538.378854008862;6336.778212762531;6343.936560634519;6344.619322840645;6344.777932772331;6349.936500634934;6177.660228687465;6234.096056071935;6291.465225455888;6322.430981211713;6326.272478665012;6186.938130618816;6189.257289125334;6198.039303907902;6201.534884883742;6204.441600255818;6269.780557680459;6287.654179020198;6338.17603711533;6348.714307856065;6359.395857393541;6085.361037091042;6198.473129784019;6199.442050215503;6200.689965501797;6200.937990620036 08:12:34 INFO - PROCESS | 3394 | |5;yui.html;741.177293204543;759.3393747439725;769.7729169894882;783.4437549339972;813.0852790610563;13343.933280333596;13620.387082581283;13661.248631325285;13708.862911370883;13763.724725505484;14694.412223511046;14729.263536823142;14821.11073335598;14821.11073335598;14822.925885370585;690.3959035843637;690.5131882023187;824.9340052795762;828.3207769628907;839.0434904209176;836;837.1293854391425;837.5979529825657;845.2984023260678;846.187659846545;863.874738162966;868.8218915122385;870.6647940542905;870.6865528409768;871.3856731004659;715.1346870286959;726.0996364507998;857.7598272483715;871.6382701179003;873.1617647058831;643.7907680004017;643.8358218654213;644.0371644391618;644.1368566121373;644.1786721929531;13854.653633659138;14034;14041.22773247471;14049.297535123203;14063.789043164361;11058.889411105867;11441;11905.16663833532;12099.395030248541;12305.384730763426;9994.350367226107;10061.798764024752;10167.288289819642;10264.94867525665;10588.841167382496;3597.334493118781;3611.783293002402;3614.6023937366867;3681.4661874028384;3774.2451509697894;42977.35533966993;43127.56872431298;43458;43609.78195109036;43666.34500482495;9901.405915645084;9917.107460328605;9930.404175749478;9955.80088398228;10052.346597471142;18122;18461.1692473839;18489.260429582668;18494;18549.536261593566;7500.812479688051;7568.735094271784;7573.6213189341415;7585.734499292608;7654.540727556365;4385.51759306476;4393.165298593257;4427.535108813592;4475.060237350193;4475.1049790042125;3011.7590592752967;3017.3814368054495;3017.8038427502142;3043.8478076096108;3057.480228361184;551.052190232807;562.4038519169693;564.7599770097692;573.3778849947853;590.2268028882178;582.1035605167993;602.3284038297354;611.9204503414528;621.3910367839543;662.1722846441947;7673.462857600026;7860.410469214832;7907.367410607138;7934.166912474223;8096.392770542233;542.8425756530562;552.0614954577154;599.583289613723;622.9003359462464;681.2744427185032;3780.5652349980105;3867.16855875988;3900.01099439288;3906.1015966327905;4010.3737119804473;60343;61181;61448.38551614427;61666.69166654138;61741.691291543255;52530.21204681933;52763.472365276626;53156.20265696017;53278.80736100654;53487.73256133695;46967.29549056767;47405.76297118561;48734.512654873;49072.75463622659;50256.74871625618;8106.270435660819;8164.306033987177;8293;8363.163683631832;8431.15688431152;35883.461748074325;36115.638843611225;36121.819390903926;36515.81742091379;37201;40197.59802401938;44917.550824491336;46132;46675;46678;10932.0707739843;10975.670729878117;11019.779604408028;11035.944572656921;11039.448027598748;11639.47622357013;11861.347625880659;11917.165798394375;12351.320677362832;13111.082224244212;9635.5663995119;9723.756906077404;9918.107370336704;10069.395836249849;10069.647562335284;11122.388268645302;11130.276532025393;11236.213465057368;11475.221684955524;11588.015018723503;10253.74365640865;10299.948500257451;10516;10568.788624227625;10838.512266948164;9700.5149742514;9715.17421019193;9871.210303175585;10014.749631259278;10019.749506262402;9086.318526110701;9457.19613832832;9491.952540237531;9500.42997420157;9569.569369378534 08:12:34 INFO - PROCESS | 3394 | __end_tp_report 08:12:34 INFO - PROCESS | 3394 | __start_cc_report 08:12:34 INFO - PROCESS | 3394 | _x_x_mozilla_cycle_collect,1119 08:12:34 INFO - PROCESS | 3394 | __end_cc_report 08:12:34 INFO - PROCESS | 3394 | __startTimestamp1450973554475__endTimestamp 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | ------- Summary: start ------- 08:12:34 INFO - PROCESS | 3394 | Number of tests: 6 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#0] dojo.html Cycles:165 Average:5415.23 Median:5612.66 stddev:609.76 (10.9%) stddev-sans-first:586.29 08:12:34 INFO - PROCESS | 3394 | Values: 3197.5 3226.5 3273.5 3274.3 3286.7 5205.3 5313.5 5355.7 5452.0 5477.2 5315.6 5371.8 5377.3 5424.6 5527.4 4970.4 4986.3 4995.2 5004.0 5048.8 4769.3 5034.2 5063.4 5077.9 5127.9 4876.7 4922.0 4936.3 4945.7 4950.9 4881.7 4965.4 4978.6 4994.5 5008.0 4801.7 4898.6 4936.9 4954.6 4979.2 5230.2 5316.6 5319.5 5328.0 5354.1 5897.1 5901.9 5909.6 5909.9 5916.3 5677.7 5835.0 5855.4 5944.2 5944.9 5463.9 5468.6 5477.2 5492.9 5547.3 5963.9 5965.6 5966.3 5990.2 5997.8 5631.9 5735.5 5735.9 5742.8 5747.8 5890.7 5907.2 5917.8 5922.8 5971.9 5833.2 5833.9 5872.7 5880.0 5887.9 5594.9 5696.2 5697.9 5704.8 5880.2 4458.2 4459.5 4490.4 4503.8 4510.8 3977.6 4003.3 4008.3 4020.3 4038.4 5270.4 5372.2 5422.5 5428.0 5551.9 5823.9 5845.4 5854.0 5859.4 5869.3 5416.8 5420.9 5427.7 5428.5 5433.4 4830.9 4918.5 4923.1 5014.0 5104.2 6097.4 6111.9 6117.1 6119.1 6126.9 5919.7 5928.8 5939.5 5940.6 5944.4 5884.9 6019.0 6019.3 6027.5 6080.3 5672.9 5686.2 5702.2 5736.3 5792.9 5867.4 5892.2 5894.6 5908.9 5911.1 5509.6 5560.9 5612.7 5754.7 5758.4 5656.3 5708.5 5722.7 5726.7 5786.7 5602.3 5608.3 5618.7 5626.8 5634.2 5643.9 5656.7 5704.1 5737.5 5767.4 5603.5 5605.5 5628.4 5629.7 5674.5 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#1] ext.html Cycles:180 Average:49453.95 Median:18544.63 stddev:88399.72 (476.7%) stddev-sans-first:88571.49 08:12:34 INFO - PROCESS | 3394 | Values: 563.5 596.9 602.6 605.2 608.3 29786.7 30389.2 30399.4 30401.4 30414.7 30486.2 39725.2 40243.6 40257.4 40454.4 8702.5 8834.6 8887.4 8896.6 8910.9 7754.8 8660.1 8695.6 8779.2 8785.4 7794.7 10438.1 10604.6 10644.8 10654.9 10172.4 10291.8 10308.1 10309.3 10311.1 7845.8 8037.8 8040.0 10235.3 10394.0 42517.0 43017.8 43163.0 43165.6 43176.6 3285.9 3313.6 3327.9 3641.8 4177.9 28606.0 28716.3 29041.3 29459.4 30125.1 3856.9 3914.3 3966.8 3986.9 4059.7 281946.5 286047.0 288815.0 289382.0 289633.0 54122.7 56155.4 56183.0 66259.3 67495.7 60351.4 60524.7 60545.7 60623.7 60645.0 15820.9 16114.2 16122.3 16133.4 16143.2 12116.5 12287.4 12292.3 12460.9 12460.9 19956.6 20264.5 20306.9 20325.9 20351.4 7922.0 8031.0 8090.6 8155.7 8187.4 1014.2 1018.8 1023.1 1024.6 1039.3 26715.0 27845.5 27937.3 28213.6 28214.6 992.3 1012.9 1022.3 1043.6 1082.3 14317.9 14400.6 14459.7 14485.8 14698.0 408586.0 412795.0 413762.0 415538.0 415863.0 54552.2 55098.7 55101.4 55135.2 55174.7 1367.8 1370.5 1383.6 1384.2 1385.9 26948.2 27353.2 27927.9 27986.4 27988.9 44004.8 44671.0 44674.6 44691.3 46785.8 224509.0 305790.0 305854.0 306427.0 308235.0 30561.5 30799.5 31046.4 31091.2 31189.0 39162.2 39850.4 39951.8 40437.4 40965.0 33781.8 34112.8 35370.8 36704.4 41710.0 36113.3 36145.8 36735.6 36843.8 37104.8 40704.0 41366.4 41601.0 41751.2 41982.2 31046.5 31134.4 33761.3 33873.7 34033.3 25043.0 25526.6 25531.6 25640.1 25813.0 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#2] jquery.html Cycles:180 Average:28315.94 Median:37174.04 stddev:87765.81 (236.1%) stddev-sans-first:87986.92 08:12:34 INFO - PROCESS | 3394 | Values: 361.9 365.7 366.6 366.7 367.9 13547.8 13768.2 17047.7 17791.8 18438.4 14341.0 16820.5 16952.4 17093.7 17233.1 4611.4 5414.8 5540.5 5546.0 5551.5 4029.9 4155.1 6020.3 6127.8 6161.6 6078.8 6099.7 6104.5 6140.9 6146.2 5188.9 5339.1 5342.5 5355.0 6082.5 5139.2 5145.5 5146.2 5153.0 5396.8 12578.8 12589.9 12821.3 12826.2 13368.9 2099.2 2127.2 2138.8 2175.2 2233.1 9739.9 9790.7 9822.9 9975.9 9982.8 1786.8 1860.0 1882.7 1887.0 1946.9 60661.7 61681.4 63912.7 64074.7 64410.7 9737.1 9961.5 10086.4 10280.7 10386.6 12274.6 12276.9 12291.9 12306.1 12308.6 7510.9 7719.2 7743.8 7757.1 7802.5 7528.4 7561.6 7573.7 7605.4 7605.7 3934.4 3959.9 3977.7 4102.3 4397.0 1693.5 1702.2 1747.5 1763.3 1766.7 930.1 943.6 971.2 1041.8 1068.2 15888.8 16058.2 16159.9 16568.0 16758.9 839.7 912.2 983.5 986.7 1020.9 8611.9 9004.3 9280.3 9795.9 9806.6 525275.0 533941.0 539221.0 541382.0 543161.0 74392.6 80578.6 84202.6 86707.0 87107.6 1134.3 1149.7 1166.5 1169.9 1172.7 15014.7 15258.2 15343.3 15443.8 15548.5 33296.5 33543.8 34012.1 34371.8 37080.6 37267.4 38529.0 38895.2 39652.2 41841.6 9284.4 9500.3 9794.5 9797.7 9799.6 11442.5 11589.6 15233.8 17346.0 17996.6 13710.6 13841.1 13974.3 14016.7 14713.3 14139.3 14189.0 14363.0 14521.0 14598.7 11310.2 11404.4 12531.4 14545.7 14576.9 9434.8 9449.5 9500.5 9614.4 9626.6 13414.2 13677.0 13832.2 13849.2 14139.6 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#3] mootools.html Cycles:180 Average:5289.84 Median:6152.57 stddev:2661.19 (43.3%) stddev-sans-first:2651.91 08:12:34 INFO - PROCESS | 3394 | Values: 1318.9 1683.0 1738.8 1745.1 1777.0 6525.6 7450.2 7531.3 7540.3 7557.4 7431.3 7613.6 7616.9 7620.5 7622.0 1950.6 1992.2 2207.3 2242.8 2245.0 2274.8 2280.2 2285.0 2285.7 2286.4 2215.3 2278.8 2280.5 2282.0 2288.6 2261.6 2264.3 2283.7 2297.7 2301.1 2304.3 2311.3 2331.7 2352.6 2353.0 7475.0 7545.1 7548.7 7562.2 7565.5 4587.9 4679.4 4705.2 4706.1 4706.1 3108.1 3158.2 3160.6 3189.5 3210.6 1029.7 1055.3 1099.5 1110.2 1132.9 10221.1 10304.1 10317.6 10320.4 10322.6 4170.9 4289.5 4319.1 4351.4 4383.6 8904.7 8911.2 8914.1 8963.8 8967.2 4743.5 4760.0 4770.9 4775.8 4780.6 4319.3 4326.0 4330.5 4331.9 4340.2 3097.1 3308.7 3610.6 3610.9 3707.4 1168.6 1196.5 1202.7 1222.9 1227.6 996.5 999.9 1059.0 1104.3 1261.1 7031.4 7088.8 7097.0 7107.7 7122.9 1132.1 1221.4 1227.2 1238.1 1260.3 5410.3 5423.2 5425.3 5464.7 5467.3 8567.1 8683.5 8892.6 8899.4 8920.0 8821.5 8844.0 8847.7 8944.3 8959.3 6938.3 7270.9 7283.1 7293.1 7298.1 6846.1 6863.1 6865.7 6875.4 6899.4 7659.3 7717.6 7840.5 7965.7 7990.6 8124.6 8192.3 8212.7 8214.1 8238.9 6678.6 6822.9 6863.3 6881.1 6884.3 6300.5 6454.3 6891.9 6901.7 6978.2 6664.8 6788.3 6810.8 6849.4 6901.9 6626.8 6718.2 6734.5 6816.5 6900.6 6653.2 6688.0 6688.4 6689.1 6694.4 6006.3 6010.8 6077.1 6228.0 6231.5 6283.5 6307.9 6319.7 6322.5 6338.0 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#4] prototype.html Cycles:180 Average:5266.01 Median:5958.27 stddev:1569.36 (26.3%) stddev-sans-first:1529.72 08:12:34 INFO - PROCESS | 3394 | Values: 347.3 349.1 351.4 351.7 351.9 5778.4 5914.4 5958.4 6005.8 6018.4 5686.3 5799.8 5818.1 5829.8 5863.6 4579.9 4582.2 4588.3 4590.1 4596.3 4391.1 4485.4 4493.8 4607.8 4612.3 4551.5 4554.9 4561.7 4585.2 4588.7 4573.3 4575.5 4579.6 4585.5 4593.1 4067.5 4068.4 4070.9 4071.5 4074.3 5492.3 5618.2 5636.6 5640.3 5685.7 5251.6 5251.6 5251.8 5256.7 5258.7 5932.1 6290.2 6293.5 6294.8 6300.2 4211.5 4295.4 4390.3 4390.9 4398.5 6439.7 6542.6 6543.4 6555.1 6565.0 4519.5 4522.2 4522.8 4523.3 4524.6 4493.0 4577.9 4579.6 4584.1 4601.6 5246.6 5255.1 5258.1 5258.6 5264.2 6314.2 6317.6 6324.6 6327.6 6328.5 1578.2 1607.8 1611.3 1611.8 1612.1 1084.1 1090.4 1090.6 1094.1 1120.5 5987.0 6002.1 6004.1 6006.2 6007.7 6474.1 6476.7 6482.1 6487.2 6489.7 5892.4 5924.7 5958.1 5983.6 5985.2 3463.1 3504.1 3507.4 3508.7 3511.7 6675.0 6685.0 6691.3 6692.2 6698.6 6597.7 6601.7 6611.1 6619.1 6626.9 6488.0 6616.1 6657.6 6667.4 6670.0 6317.8 6446.5 6457.5 6464.5 6474.0 6328.3 6471.5 6474.9 6494.6 6498.8 6746.9 6747.2 6750.0 6752.9 6754.2 4409.9 4552.2 4554.3 4554.7 4556.2 6490.4 6518.4 6519.1 6530.2 6538.4 6336.8 6343.9 6344.6 6344.8 6349.9 6177.7 6234.1 6291.5 6322.4 6326.3 6186.9 6189.3 6198.0 6201.5 6204.4 6269.8 6287.7 6338.2 6348.7 6359.4 6085.4 6198.5 6199.4 6200.7 6200.9 08:12:34 INFO - PROCESS | 3394 | 08:12:34 INFO - PROCESS | 3394 | [#5] yui.html Cycles:180 Average:13878.28 Median:48070.14 stddev:16322.69 (34.0%) stddev-sans-first:16338.67 08:12:34 INFO - PROCESS | 3394 | Values: 741.2 759.3 769.8 783.4 813.1 13343.9 13620.4 13661.2 13708.9 13763.7 14694.4 14729.3 14821.1 14821.1 14822.9 690.4 690.5 824.9 828.3 839.0 836.0 837.1 837.6 845.3 846.2 863.9 868.8 870.7 870.7 871.4 715.1 726.1 857.8 871.6 873.2 643.8 643.8 644.0 644.1 644.2 13854.7 14034.0 14041.2 14049.3 14063.8 11058.9 11441.0 11905.2 12099.4 12305.4 9994.4 10061.8 10167.3 10264.9 10588.8 3597.3 3611.8 3614.6 3681.5 3774.2 42977.4 43127.6 43458.0 43609.8 43666.3 9901.4 9917.1 9930.4 9955.8 10052.3 18122.0 18461.2 18489.3 18494.0 18549.5 7500.8 7568.7 7573.6 7585.7 7654.5 4385.5 4393.2 4427.5 4475.1 4475.1 3011.8 3017.4 3017.8 3043.8 3057.5 551.1 562.4 564.8 573.4 590.2 582.1 602.3 611.9 621.4 662.2 7673.5 7860.4 7907.4 7934.2 8096.4 542.8 552.1 599.6 622.9 681.3 3780.6 3867.2 3900.0 3906.1 4010.4 60343.0 61181.0 61448.4 61666.7 61741.7 52530.2 52763.5 53156.2 53278.8 53487.7 46967.3 47405.8 48734.5 49072.8 50256.7 8106.3 8164.3 8293.0 8363.2 8431.2 35883.5 36115.6 36121.8 36515.8 37201.0 40197.6 44917.6 46132.0 46675.0 46678.0 10932.1 10975.7 11019.8 11035.9 11039.4 11639.5 11861.3 11917.2 12351.3 13111.1 9635.6 9723.8 9918.1 10069.4 10069.6 11122.4 11130.3 11236.2 11475.2 11588.0 10253.7 10299.9 10516.0 10568.8 10838.5 9700.5 9715.2 9871.2 10014.7 10019.7 9086.3 9457.2 9492.0 9500.4 9569.6 08:12:34 INFO - PROCESS | 3394 | -------- Summary: end -------- 08:12:34 INFO - PROCESS | 3394 | 08:12:35 INFO - TEST-INFO | 3394: exit 0 08:12:35 INFO - TEST-OK | dromaeo_css | took 1114796ms 08:12:35 INFO - TEST-START | kraken 08:12:35 INFO - operating with platform_type : linux_ 08:12:35 INFO - Initialising browser for kraken test... 08:12:35 INFO - TEST-INFO | started process 3585 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQEx2ck/profile http://localhost:56393/getInfo.html) 08:12:38 INFO - PROCESS | 3585 | __metrics Screen width/height:1600/1200 08:12:38 INFO - PROCESS | 3585 | colorDepth:24 08:12:38 INFO - PROCESS | 3585 | Browser inner width/height: 1024/697 08:12:38 INFO - PROCESS | 3585 | __metrics 08:12:38 INFO - PROCESS | 3585 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:38 INFO - PROCESS | 3585 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:40 INFO - TEST-INFO | 3585: exit 0 08:12:40 INFO - Browser initialized. 08:12:40 INFO - Running cycle 1/1 for kraken test... 08:12:40 INFO - TEST-INFO | started process 3666 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQEx2ck/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:51 INFO - PROCESS | 3666 | RSS: Main: 150179840 08:12:51 INFO - PROCESS | 3666 | 08:12:54 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56393/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:54 INFO - PROCESS | 3666 | RSS: Main: 187092992 08:12:54 INFO - PROCESS | 3666 | 08:12:57 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56393/tests/kraken/driver.html?testName=audio-dft) 08:12:58 INFO - PROCESS | 3666 | RSS: Main: 177242112 08:12:58 INFO - PROCESS | 3666 | 08:13:00 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56393/tests/kraken/driver.html?testName=audio-fft) 08:13:01 INFO - PROCESS | 3666 | RSS: Main: 159776768 08:13:01 INFO - PROCESS | 3666 | 08:13:03 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56393/tests/kraken/driver.html?testName=audio-oscillator) 08:13:04 INFO - PROCESS | 3666 | RSS: Main: 162689024 08:13:04 INFO - PROCESS | 3666 | 08:13:06 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:06 INFO - PROCESS | 3666 | RSS: Main: 165101568 08:13:06 INFO - PROCESS | 3666 | 08:13:09 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56393/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:10 INFO - PROCESS | 3666 | RSS: Main: 164626432 08:13:10 INFO - PROCESS | 3666 | 08:13:13 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56393/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:14 INFO - PROCESS | 3666 | RSS: Main: 166408192 08:13:14 INFO - PROCESS | 3666 | 08:13:16 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56393/tests/kraken/driver.html?testName=json-parse-financial) 08:13:17 INFO - PROCESS | 3666 | RSS: Main: 166694912 08:13:17 INFO - PROCESS | 3666 | 08:13:19 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:19 INFO - PROCESS | 3666 | RSS: Main: 177438720 08:13:19 INFO - PROCESS | 3666 | 08:13:21 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:21 INFO - PROCESS | 3666 | RSS: Main: 172470272 08:13:21 INFO - PROCESS | 3666 | 08:13:23 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:24 INFO - PROCESS | 3666 | RSS: Main: 186351616 08:13:24 INFO - PROCESS | 3666 | 08:13:27 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:28 INFO - PROCESS | 3666 | RSS: Main: 192331776 08:13:28 INFO - PROCESS | 3666 | 08:13:30 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:31 INFO - PROCESS | 3666 | RSS: Main: 189730816 08:13:31 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | Cycle 1(1): loaded http://localhost:56393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56393/tests/kraken/driver.html?testName=ai-astar) 08:13:33 INFO - PROCESS | 3666 | RSS: Main: 248627200 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | __start_tp_report 08:13:33 INFO - PROCESS | 3666 | _x_x_mozilla_page_load 08:13:33 INFO - PROCESS | 3666 | _x_x_mozilla_page_load_details 08:13:33 INFO - PROCESS | 3666 | |i|pagename|runs| 08:13:33 INFO - PROCESS | 3666 | |0;ai-astar;107;109;103;110;109;109;99;108;110;115 08:13:33 INFO - PROCESS | 3666 | |1;audio-beat-detection;160;123;153;158;125;149;145;130;161;122 08:13:33 INFO - PROCESS | 3666 | |2;audio-dft;160;160;161;160;160;160;161;162;161;162 08:13:33 INFO - PROCESS | 3666 | |3;audio-fft;71;71;85;96;72;71;71;95;89;71 08:13:33 INFO - PROCESS | 3666 | |4;audio-oscillator;93;92;138;92;92;93;132;92;93;132 08:13:33 INFO - PROCESS | 3666 | |5;imaging-gaussian-blur;108;110;109;110;110;110;109;109;110;109 08:13:33 INFO - PROCESS | 3666 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;146;147 08:13:33 INFO - PROCESS | 3666 | |7;imaging-desaturate;96;95;96;96;96;95;95;95;95;96 08:13:33 INFO - PROCESS | 3666 | |8;json-parse-financial;59;58;59;58;57;58;57;68;56;54 08:13:33 INFO - PROCESS | 3666 | |9;json-stringify-tinderbox;67;67;67;67;68;68;68;67;68;68 08:13:33 INFO - PROCESS | 3666 | |10;stanford-crypto-aes;82;83;93;84;83;84;83;84;85;83 08:13:33 INFO - PROCESS | 3666 | |11;stanford-crypto-ccm;114;122;122;124;111;115;125;119;123;115 08:13:33 INFO - PROCESS | 3666 | |12;stanford-crypto-pbkdf2;152;152;157;150;153;151;143;158;148;137 08:13:33 INFO - PROCESS | 3666 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;67;66;66;67;66 08:13:33 INFO - PROCESS | 3666 | __end_tp_report 08:13:33 INFO - PROCESS | 3666 | __start_cc_report 08:13:33 INFO - PROCESS | 3666 | _x_x_mozilla_cycle_collect,938 08:13:33 INFO - PROCESS | 3666 | __end_cc_report 08:13:33 INFO - PROCESS | 3666 | __startTimestamp1450973613363__endTimestamp 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | ------- Summary: start ------- 08:13:33 INFO - PROCESS | 3666 | Number of tests: 14 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:4.31 (3.9%) stddev-sans-first:4.56 08:13:33 INFO - PROCESS | 3666 | Values: 107.0 109.0 103.0 110.0 109.0 109.0 99.0 108.0 110.0 115.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:151.00 stddev:16.02 (10.6%) stddev-sans-first:15.71 08:13:33 INFO - PROCESS | 3666 | Values: 160.0 123.0 153.0 158.0 125.0 149.0 145.0 130.0 161.0 122.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 08:13:33 INFO - PROCESS | 3666 | Values: 160.0 160.0 161.0 160.0 160.0 160.0 161.0 162.0 161.0 162.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#3] audio-fft Cycles:10 Average:79.20 Median:78.50 stddev:10.80 (13.8%) stddev-sans-first:11.04 08:13:33 INFO - PROCESS | 3666 | Values: 71.0 71.0 85.0 96.0 72.0 71.0 71.0 95.0 89.0 71.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:20.15 (21.9%) stddev-sans-first:20.91 08:13:33 INFO - PROCESS | 3666 | Values: 93.0 92.0 138.0 92.0 92.0 93.0 132.0 92.0 93.0 132.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 08:13:33 INFO - PROCESS | 3666 | Values: 108.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:13:33 INFO - PROCESS | 3666 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 147.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:13:33 INFO - PROCESS | 3666 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:3.69 (6.4%) stddev-sans-first:3.91 08:13:33 INFO - PROCESS | 3666 | Values: 59.0 58.0 59.0 58.0 57.0 58.0 57.0 68.0 56.0 54.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:13:33 INFO - PROCESS | 3666 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.13 (3.7%) stddev-sans-first:3.20 08:13:33 INFO - PROCESS | 3666 | Values: 82.0 83.0 93.0 84.0 83.0 84.0 83.0 84.0 85.0 83.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:122.00 stddev:4.90 (4.0%) stddev-sans-first:4.85 08:13:33 INFO - PROCESS | 3666 | Values: 114.0 122.0 122.0 124.0 111.0 115.0 125.0 119.0 123.0 115.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.10 Median:152.00 stddev:6.26 (4.1%) stddev-sans-first:6.60 08:13:33 INFO - PROCESS | 3666 | Values: 152.0 152.0 157.0 150.0 153.0 151.0 143.0 158.0 148.0 137.0 08:13:33 INFO - PROCESS | 3666 | 08:13:33 INFO - PROCESS | 3666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:13:33 INFO - PROCESS | 3666 | Values: 67.0 68.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 08:13:33 INFO - PROCESS | 3666 | -------- Summary: end -------- 08:13:33 INFO - PROCESS | 3666 | 08:13:34 INFO - TEST-INFO | 3666: exit 0 08:13:34 INFO - TEST-OK | kraken | took 59011ms 08:13:34 INFO - TEST-START | v8_7 08:13:34 INFO - operating with platform_type : linux_ 08:13:34 INFO - Initialising browser for v8_7 test... 08:13:34 INFO - TEST-INFO | started process 3918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLlcPD1/profile http://localhost:56393/getInfo.html) 08:13:38 INFO - PROCESS | 3918 | __metrics Screen width/height:1600/1200 08:13:38 INFO - PROCESS | 3918 | colorDepth:24 08:13:38 INFO - PROCESS | 3918 | Browser inner width/height: 1024/697 08:13:38 INFO - PROCESS | 3918 | __metrics 08:13:38 INFO - PROCESS | 3918 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:13:38 INFO - PROCESS | 3918 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:38 ERROR - PROCESS | 3918 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:13:39 INFO - TEST-INFO | 3918: exit 0 08:13:39 INFO - Browser initialized. 08:13:39 INFO - Running cycle 1/1 for v8_7 test... 08:13:39 INFO - TEST-INFO | started process 3998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLlcPD1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:50 INFO - PROCESS | 3998 | RSS: Main: 150290432 08:13:50 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | Cycle 1(1): loaded http://localhost:56393/tests/v8_7/run.html (next: http://localhost:56393/tests/v8_7/run.html) 08:14:12 INFO - PROCESS | 3998 | RSS: Main: 627273728 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | __start_tp_report 08:14:12 INFO - PROCESS | 3998 | _x_x_mozilla_page_load 08:14:12 INFO - PROCESS | 3998 | _x_x_mozilla_page_load_details 08:14:12 INFO - PROCESS | 3998 | |i|pagename|runs| 08:14:12 INFO - PROCESS | 3998 | |0;Richards;165.6726308813784 08:14:12 INFO - PROCESS | 3998 | |1;DeltaBlue;188.67924528301887 08:14:12 INFO - PROCESS | 3998 | |2;Encrypt;279.4076557697681 08:14:12 INFO - PROCESS | 3998 | |3;Decrypt;5133.333333333333 08:14:12 INFO - PROCESS | 3998 | |4;RayTrace;1937.984496124031 08:14:12 INFO - PROCESS | 3998 | |5;Earley;780.64012490242 08:14:12 INFO - PROCESS | 3998 | |6;Boyer;12329.268292682927 08:14:12 INFO - PROCESS | 3998 | |7;RegExp;25820.51282051282 08:14:12 INFO - PROCESS | 3998 | |8;Splay;621.8905472636816 08:14:12 INFO - PROCESS | 3998 | |9;NavierStokes;4845.410628019324 08:14:12 INFO - PROCESS | 3998 | __end_tp_report 08:14:12 INFO - PROCESS | 3998 | __startTimestamp1450973652554__endTimestamp 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | ------- Summary: start ------- 08:14:12 INFO - PROCESS | 3998 | Number of tests: 10 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#0] Richards Cycles:1 Average:165.67 Median:165.67 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 165.7 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#1] DeltaBlue Cycles:1 Average:188.68 Median:188.68 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 188.7 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 279.4 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 5133.3 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#4] RayTrace Cycles:1 Average:1937.98 Median:1937.98 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 1938.0 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 780.6 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 12329.3 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 25820.5 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 621.9 08:14:12 INFO - PROCESS | 3998 | 08:14:12 INFO - PROCESS | 3998 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 08:14:12 INFO - PROCESS | 3998 | Values: 4845.4 08:14:12 INFO - PROCESS | 3998 | -------- Summary: end -------- 08:14:12 INFO - PROCESS | 3998 | 08:14:13 INFO - TEST-INFO | 3998: exit 0 08:14:13 INFO - TEST-OK | v8_7 | took 39179ms 08:14:13 INFO - SUITE-END | took 1212s 08:14:13 INFO - Completed test suite (00:20:13) 08:14:13 INFO - Working with test: dromaeo_css 08:14:13 INFO - Generating results file: dromaeo_css 08:14:13 INFO - Working with test: kraken 08:14:13 INFO - Generating results file: kraken 08:14:13 INFO - javascript benchmark 08:14:13 INFO - Working with test: v8_7 08:14:13 INFO - Generating results file: v8_7 08:14:13 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:14:13 INFO - process_Request line: dromaeo_css 6974.83 graph.html#tests=[[72,201,35]] 08:14:13 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:13 INFO - process_Request line: kraken 1491.90 graph.html#tests=[[232,201,35]] 08:14:13 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:14:13 INFO - process_Request line: v8_7 19863.78 graph.html#tests=[[230,201,35]] 08:14:13 INFO - RETURN: dromaeo_css: 6974.83 08:14:13 INFO - RETURN: kraken: 1491.90 08:14:13 INFO - RETURN: v8_7: 19863.78 08:14:13 INFO - javascript benchmark 08:14:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3197.520371944209, 3226.499892516658, 3273.541704161418, 3274.3123943971777, 3286.671332866714, 5205.297284866542, 5313.521783039526, 5355.678659280441, 5451.972740136299, 5477.233187353773, 5315.627906046579, 5371.81198658047, 5377.274068000819, 5424.593155513333, 5527.447255274481, 4970.428400733907, 4986.301917731521, 4995.175795993657, 5003.974980125113, 5048.772805223755, 4769.332293478916, 5034.1945288753805, 5063.41770696371, 5077.873053173682, 5127.871803204913, 4876.731779752095, 4921.966387058722, 4936.308916751657, 4945.653804233705, 4950.900981980376, 4881.707097574157, 4965.4041515018425, 4978.601711863079, 4994.450610432849, 5008.0, 4801.663883528155, 4898.583620392271, 4936.876578085541, 4954.578860796837, 4979.203327467624, 5230.21546767984, 5316.627836051478, 5319.468053194688, 5328.0, 5354.089804733205, 5897.056470964668, 5901.940980590182, 5909.645421274738, 5909.852253693692, 5916.319623243339, 5677.687727175004, 5835.0372188588835, 5855.443732845373, 5944.167816505693, 5944.851378715523, 5463.945360546423, 5468.589855760833, 5477.1510415886, 5492.890142197173, 5547.306586676666, 5963.880722385615, 5965.582409231312, 5966.31387390447, 5990.191324171268, 5997.760089596367, 5631.943680563142, 5735.541156707453, 5735.942640573624, 5742.799002034909, 5747.798827041117, 5890.67601281925, 5907.172995780594, 5917.7928772493615, 5922.763089476459, 5971.940280597139, 5833.212516310244, 5833.854153646193, 5872.706364681834, 5880.0297950838485, 5887.941120588739, 5594.916076258859, 5696.174054762119, 5697.914531282034, 5704.771809127588, 5880.235569375954, 4458.197524445631, 4459.487158976694, 4490.416245888014, 4503.842365517256, 4510.751908645056, 3977.5624681285035, 4003.3394489908837, 4008.2785098682516, 4020.2562525932794, 4038.414429907647, 5270.446603106695, 5372.247885296062, 5422.457754224625, 5428.0, 5551.8889622207325, 5823.883522329615, 5845.386234445322, 5854.0, 5859.384764599741, 5869.325027621793, 5416.7562459688625, 5420.918686219631, 5427.701476418756, 5428.457154284619, 5433.402325744165, 4830.855074347775, 4918.458969513351, 4923.138450771173, 5013.974930125326, 5104.18333066715, 6097.390260973867, 6111.938880611137, 6117.113018612187, 6119.143319935212, 6126.908096378558, 5919.6744179070565, 5928.762849486145, 5939.46544810969, 5940.6435613863305, 5944.375840536682, 5884.911726324023, 6019.0, 6019.337872834072, 6027.517798576191, 6080.300765412034, 5672.886542269214, 5686.203931449518, 5702.173184888251, 5736.340320863154, 5792.913106303325, 5867.354590994902, 5892.204552385373, 5894.646321220741, 5908.911366329423, 5911.083782013795, 5509.614326997232, 5560.888782224252, 5612.663240205601, 5754.741036653444, 5758.424157584208, 5656.349519805275, 5708.515785895614, 5722.685252311163, 5726.713664316851, 5786.652800831964, 5602.2717046783655, 5608.298962629671, 5618.719064046863, 5626.831195064155, 5634.2393776841245, 5643.887122257614, 5656.660600363992, 5704.087346024616, 5737.483626473638, 5767.423257674199, 5603.467670571289, 5605.523530499953, 5628.437156284339, 5629.662220266797, 5674.546036317167], "unit": "score", "name": "dojo.html", "value": 5375.3199541971135}, {"lowerIsBetter": false, "replicates": [563.4675231905851, 596.889575428546, 602.587227748992, 605.1830029460232, 608.2579253310961, 29786.659600317984, 30389.240268993286, 30399.392012159744, 30401.391972160545, 30414.695853041492, 30486.23784405391, 39725.205495890135, 40243.59756402435, 40257.396139057935, 40454.39318410219, 8702.477851328924, 8834.646614135427, 8887.422317549372, 8896.644134234622, 8910.86633700495, 7754.806129846743, 8660.090690477504, 8695.608697608592, 8779.165979231995, 8785.38502304839, 7794.688212471494, 10438.112760415373, 10604.628837990673, 10644.840327395095, 10654.893451065507, 10172.389656620626, 10291.845622315672, 10308.072273495347, 10309.278350515468, 10311.123554497877, 7845.764627061198, 8037.799055023613, 8039.95980020102, 10235.334703244265, 10394.0, 42517.0, 43017.784911075556, 43163.0, 43165.56834431647, 43176.56823431757, 3285.917852053694, 3313.6355000949875, 3327.93344133116, 3641.7632853864416, 4177.91644167118, 28606.0, 28716.282092947633, 29041.273968150756, 29459.410811783644, 30125.096247112622, 3856.903577410559, 3914.3345631242755, 3966.7619942803235, 3986.866558051685, 4059.7361171523758, 281946.49294288806, 286047.0, 288815.0, 289382.0, 289633.0, 54122.7293863536, 56155.43844561584, 56183.0, 66259.33740662628, 67495.66252168806, 60351.39648603458, 60524.697376513715, 60545.69727151336, 60623.69688151531, 60645.0, 15820.92089539568, 16114.194290285439, 16122.274497647633, 16133.435329763402, 16143.192840357935, 12116.454759535842, 12287.385630718429, 12292.262464252173, 12460.875391246153, 12460.937695311466, 19956.600867982557, 20264.49338766513, 20306.898465507576, 20325.898370508054, 20351.389458316273, 7922.0, 8030.980637101811, 8090.595470226465, 8155.67377304913, 8187.38594605407, 1014.1531820929606, 1018.8217062014118, 1023.0741179232806, 1024.6157690865925, 1039.29328056922, 26715.0, 27845.46568505342, 27937.30156746057, 28213.576796348072, 28214.576781348296, 992.270681049428, 1012.9290949633455, 1022.3456987527989, 1043.5929987304958, 1082.3019152646498, 14317.856821431653, 14400.567982960529, 14459.710805784036, 14485.78271325931, 14698.0, 408586.0, 412795.0, 413762.0, 415538.0, 415863.0, 54552.181717274274, 55098.72450637721, 55101.44898550963, 55135.172972405446, 55174.724126379115, 1367.7674795284825, 1370.4586688258082, 1383.5656720211698, 1384.2386687321932, 1385.9168449893039, 26948.191554253404, 27353.179404617895, 27927.860360698065, 27986.440271194057, 27988.860055700407, 44004.77997609991, 44671.0, 44674.55325446704, 44691.32963005623, 46785.766071169426, 224509.0, 305790.0, 305854.0, 306427.0, 308235.0, 30561.54157687592, 30799.538006929466, 31046.379072418877, 31091.222719432197, 31189.0, 39162.21675566416, 39850.40224396694, 39951.83768104298, 40437.393439099025, 40965.0, 33781.83109084439, 34112.82943585266, 35370.823145884104, 36704.449433257985, 41710.0, 36113.27773444464, 36145.81927090348, 36735.63264367322, 36843.81578092092, 37104.81447592745, 40704.0, 41366.37950430686, 41601.0, 41751.164976699685, 41982.160356793305, 31046.53430198594, 31134.377312453173, 33761.324773504886, 33873.66126338705, 34033.31933361368, 25043.0, 25526.617100743875, 25531.617025745, 25640.102596409037, 25813.0], "unit": "score", "name": "ext.html", "value": 18829.633805318823}, {"lowerIsBetter": false, "replicates": [361.93847046002196, 365.7403243696975, 366.5820964100925, 366.69747458346836, 367.8602131190148, 13547.796783048238, 13768.173909565434, 17047.659046819073, 17791.822081779195, 18438.44684659461, 14341.0, 16820.495385138434, 16952.4066657667, 17093.658126837458, 17233.052182129977, 4611.354410382549, 5414.83755487335, 5540.473655002768, 5545.972270138644, 5551.472610102054, 4029.9395509067385, 4155.127423241123, 6020.337762846083, 6127.846803829895, 6161.630302181883, 6078.848028799293, 6099.664518451484, 6104.511639068864, 6140.907886381686, 6146.17026701394, 5188.896222075575, 5339.09235429974, 5342.465753424626, 5355.0, 6082.452579267865, 5139.229115632647, 5145.536901678867, 5146.150885103953, 5152.974235128838, 5396.83809485716, 12578.81131783024, 12589.874101259053, 12821.294828784414, 12826.166299190523, 13368.86631133686, 2099.2442720620566, 2127.2448280860226, 2138.786121387864, 2175.184305885293, 2233.129079658934, 9739.853902191473, 9790.657326993522, 9822.852657210147, 9975.850362244571, 9982.750431239205, 1786.7766529183853, 1859.962800743991, 1882.6799444094536, 1886.962260754791, 1946.902654867251, 60661.6966915167, 61681.383186168016, 63912.680436597984, 64074.67962660203, 64410.677946610434, 9737.074977877232, 9961.501924903725, 10086.445245511568, 10280.742981425525, 10386.636467723594, 12274.631761047005, 12276.877231227752, 12291.877081229251, 12306.07704422172, 12308.569200077955, 7510.924890751132, 7719.189485103983, 7743.7676869694, 7757.069151701832, 7802.531848089133, 7528.360089392463, 7561.584112873845, 7573.734919277799, 7605.391568674493, 7605.6577454014705, 3934.409838524244, 3959.9010024749036, 3977.721559490808, 4102.261592913304, 4396.978015109904, 1693.4919524142708, 1702.208473060033, 1747.484492074841, 1763.2594310389668, 1766.7438221457817, 930.1256818590504, 943.6366998705548, 971.2278738402987, 1041.8280983637615, 1068.2308737708838, 15888.76166857498, 16058.197090145446, 16159.919200403923, 16568.0, 16758.899603573376, 839.6683310092479, 912.2291663544295, 983.4738414948112, 986.6581449229043, 1020.9438480883474, 8611.870821937677, 9004.279657627374, 9280.303977201602, 9795.853062204073, 9806.558704858298, 525275.0, 533941.0, 539221.0, 541382.0, 543161.0, 74392.62803685947, 80578.5971070141, 84202.5789871059, 86706.99999999873, 87107.56446217855, 1134.325076579434, 1149.6608500492375, 1166.5333866453486, 1169.9415029248673, 1172.7126853920845, 15014.699706006037, 15258.160801155598, 15343.309551070452, 15443.84556154424, 15548.455804046804, 33296.50055249125, 33543.83228083844, 34012.149696257795, 34371.828140859136, 37080.62919370772, 37267.44098838574, 38529.0, 38895.222095557365, 39652.20695586014, 41841.58158418498, 9284.396514226553, 9500.334976551576, 9794.461304628314, 9797.706068817946, 9799.608015679578, 11442.542298307975, 11589.594364197214, 15233.771493427386, 17346.0, 17996.55008624795, 13710.588682339545, 13841.100328478617, 13974.30128493551, 14016.719665606426, 14713.33789979475, 14139.293035348397, 14189.01353810488, 14363.0, 14521.0, 14598.708025839636, 11310.208285419942, 11404.407611602319, 12531.436085375997, 14545.709085818013, 14576.927115364355, 9434.811303774024, 9449.480278584744, 9500.47747373901, 9614.375065620712, 9626.614935402506, 13414.195148291134, 13677.0, 13832.239226842217, 13849.16904985704, 14139.575812725634], "unit": "score", "name": "jquery.html", "value": 8666.319880106952}, {"lowerIsBetter": false, "replicates": [1318.9406476708548, 1682.9663406731863, 1738.843504084632, 1745.0576688588162, 1776.999999999999, 6525.608463492188, 7450.18048014718, 7531.322181003702, 7540.283673051065, 7557.433192510556, 7431.2940270674335, 7613.581253031081, 7616.885746713804, 7620.466567340274, 7621.961890190555, 1950.619629172305, 1992.232990298731, 2207.348832094536, 2242.7532971373134, 2245.0, 2274.829387795922, 2280.1677387753516, 2284.9885750571225, 2285.714285714286, 2286.3826766772963, 2215.3464727905225, 2278.7949084582383, 2280.464090938628, 2281.9657705134437, 2288.5766133265315, 2261.6494443361307, 2264.3320220534983, 2283.748787633359, 2297.7242730872235, 2301.0795681727277, 2304.3432621702736, 2311.3412677386864, 2331.6502524621274, 2352.5882970480097, 2353.0470159585393, 7474.962625186894, 7545.094588649343, 7548.66031028605, 7562.168161502231, 7565.470417070807, 4587.908241835178, 4679.438467383901, 4705.223638099744, 4706.058788242365, 4706.082313948781, 3108.1141874565865, 3158.210447388153, 3160.5891234139413, 3189.5375170600364, 3210.598675165604, 1029.6602121299952, 1055.3087727538475, 1099.5272033025797, 1110.1618278199987, 1132.8980391764699, 10221.080102790711, 10304.072633463024, 10317.638882639072, 10320.380777153396, 10322.587096516205, 4170.895727606834, 4289.485261768607, 4319.114581510783, 4351.369051487517, 4383.6410712678535, 8904.688335908211, 8911.197992180734, 8914.064023277591, 8963.820723585492, 8967.237784788365, 4743.549362810528, 4760.0, 4770.856874293777, 4775.761211939459, 4780.593649539828, 4319.265724826787, 4325.956740432555, 4330.480342358937, 4331.870043898688, 4340.153670034313, 3097.1018404662395, 3308.7022168004996, 3610.5847827500174, 3610.909727256787, 3707.3882809336696, 1168.550108208329, 1196.4615922834585, 1202.687301301668, 1222.93273869938, 1227.5703503773607, 996.496769131584, 999.8550210219478, 1058.9727963875182, 1104.3042882983668, 1261.104615722847, 7031.40233080194, 7088.751893683696, 7097.0, 7107.680154393065, 7122.928770712227, 1132.1452303510962, 1221.419825582841, 1227.2023184929867, 1238.133306685324, 1260.332024027267, 5410.296661433988, 5423.240746295522, 5425.26758887553, 5464.699441530754, 5467.261919640877, 8567.143285671507, 8683.478991260417, 8892.59983300753, 8899.377043607015, 8920.0, 8821.470711757314, 8843.955780221058, 8847.73456796297, 8944.329175311748, 8959.283257339397, 6938.306169383021, 7270.927290727025, 7283.126024876943, 7293.124825021031, 7298.087739032515, 6846.144231971004, 6863.073485079451, 6865.656717164222, 6875.449964002768, 6899.413549848118, 7659.348955338859, 7717.614119294125, 7840.529568225925, 7965.681372745025, 7990.560519171501, 8124.593770311342, 8192.262696357357, 8212.712555060543, 8214.096449390443, 8238.876416853633, 6678.599284042973, 6822.931770682229, 6863.313668633296, 6881.071055407456, 6884.345987131214, 6300.527460440394, 6454.2900280968115, 6891.896621550781, 6901.654917254217, 6978.162620485574, 6664.766733164316, 6788.287229840993, 6810.8421568332515, 6849.4177994871, 6901.895696688706, 6626.801195964129, 6718.193816741827, 6734.528582999143, 6816.48876334267, 6900.585964842126, 6653.168353955755, 6688.0, 6688.3646053624825, 6689.130413046273, 6694.430973367318, 6006.33930267679, 6010.849728756816, 6077.149199112039, 6228.0, 6231.501479881508, 6283.49732021428, 6307.936920630735, 6319.6840157991, 6322.525810564318, 6337.96831015842], "unit": "score", "name": "mootools.html", "value": 4405.384049502854}, {"lowerIsBetter": false, "replicates": [347.27592968660343, 349.0732106257883, 351.3640311037023, 351.74498488595754, 351.9137811236246, 5778.422157784219, 5914.438128377803, 5958.404159584039, 6005.8198254052395, 6018.39816018398, 5686.31764188297, 5799.768009279624, 5818.098194779805, 5829.795957141501, 5863.618864773786, 4579.885502862422, 4582.198115329804, 4588.334691469743, 4590.081983603292, 4596.310553416981, 4391.0559229765595, 4485.439320084989, 4493.775311234442, 4607.815687372501, 4612.308153776927, 4551.476580193271, 4554.8861278467975, 4561.6806823522365, 4585.243434833248, 4588.724676519403, 4573.3368661544055, 4575.473820510634, 4579.564941330568, 4585.541445855421, 4593.127305811885, 4067.471228740245, 4068.389741538793, 4070.8575199867864, 4071.4503542021744, 4074.286999775057, 5492.313460817398, 5618.185363122365, 5636.633618814764, 5640.294963129609, 5685.687287199203, 5251.632385733, 5251.632385733, 5251.842444726664, 5256.710880901549, 5258.684478931276, 5932.080527518242, 6290.24517057956, 6293.527985401068, 6294.8111556653375, 6300.243970723543, 4211.536730959622, 4295.420118284054, 4390.253656878338, 4390.868273951786, 4398.450193725785, 6439.678016099177, 6542.607443553355, 6543.378379053982, 6555.082288479617, 6565.015247712833, 4519.480259770103, 4522.208613492626, 4522.751248681288, 4523.2988886722615, 4524.5927866492175, 4493.0, 4577.908441831145, 4579.564941330568, 4584.106099310669, 4601.562851529099, 5246.580273578104, 5255.080360936897, 5258.079836028756, 5258.605604579672, 5264.15773476242, 6314.242290925118, 6317.557770955989, 6324.620522768649, 6327.557071005078, 6328.462080723098, 1578.226668932215, 1607.7990251218598, 1611.323244237423, 1611.7743515907782, 1612.129450096958, 1084.0514549768952, 1090.4438736244572, 1090.6237348115046, 1094.141099237095, 1120.467777805536, 5986.970065149646, 6002.069679199731, 6004.0693692477735, 6006.189164462829, 6007.669578173155, 6474.125992990886, 6476.740930362827, 6482.092507048923, 6487.156669633012, 6489.7404103835315, 5892.440218179266, 5924.703764811742, 5958.136070269873, 5983.581149319506, 5985.16207730918, 3463.116905189211, 3504.0714210734177, 3507.3862074136923, 3508.736844736655, 3511.719062475047, 6674.966625166843, 6684.966575167093, 6691.330866913269, 6692.230393504712, 6698.598084114871, 6597.703103360361, 6601.73593056282, 6611.074449577063, 6619.106420633249, 6626.933730662631, 6487.967560162169, 6616.106825578581, 6657.600543967377, 6667.433268172163, 6669.966650166718, 6317.778877739257, 6446.484281257394, 6457.5479716419395, 6464.450521705708, 6474.0, 6328.272248691459, 6471.4822814175695, 6474.902876456951, 6494.642794646151, 6498.772542960974, 6746.898796518154, 6747.156605424322, 6749.966250168718, 6752.93247067523, 6754.223264324469, 4409.889752756207, 4552.226121559276, 4554.339620755039, 4554.749488778149, 4556.202664533627, 6490.415862572391, 6518.445932095636, 6519.1199188110895, 6530.183727034121, 6538.378854008862, 6336.778212762531, 6343.936560634519, 6344.619322840645, 6344.777932772331, 6349.936500634934, 6177.660228687465, 6234.096056071935, 6291.465225455888, 6322.430981211713, 6326.272478665012, 6186.938130618816, 6189.257289125334, 6198.039303907902, 6201.534884883742, 6204.441600255818, 6269.780557680459, 6287.654179020198, 6338.17603711533, 6348.714307856065, 6359.395857393541, 6085.361037091042, 6198.473129784019, 6199.442050215503, 6200.689965501797, 6200.937990620036], "unit": "score", "name": "prototype.html", "value": 4762.588674999032}, {"lowerIsBetter": false, "replicates": [741.177293204543, 759.3393747439725, 769.7729169894882, 783.4437549339972, 813.0852790610563, 13343.933280333596, 13620.387082581283, 13661.248631325285, 13708.862911370883, 13763.724725505484, 14694.412223511046, 14729.263536823142, 14821.11073335598, 14821.11073335598, 14822.925885370585, 690.3959035843637, 690.5131882023187, 824.9340052795762, 828.3207769628907, 839.0434904209176, 836.0, 837.1293854391425, 837.5979529825657, 845.2984023260678, 846.187659846545, 863.874738162966, 868.8218915122385, 870.6647940542905, 870.6865528409768, 871.3856731004659, 715.1346870286959, 726.0996364507998, 857.7598272483715, 871.6382701179003, 873.1617647058831, 643.7907680004017, 643.8358218654213, 644.0371644391618, 644.1368566121373, 644.1786721929531, 13854.653633659138, 14034.0, 14041.22773247471, 14049.297535123203, 14063.789043164361, 11058.889411105867, 11441.0, 11905.16663833532, 12099.395030248541, 12305.384730763426, 9994.350367226107, 10061.798764024752, 10167.288289819642, 10264.94867525665, 10588.841167382496, 3597.334493118781, 3611.783293002402, 3614.6023937366867, 3681.4661874028384, 3774.2451509697894, 42977.35533966993, 43127.56872431298, 43458.0, 43609.78195109036, 43666.34500482495, 9901.405915645084, 9917.107460328605, 9930.404175749478, 9955.80088398228, 10052.346597471142, 18122.0, 18461.1692473839, 18489.260429582668, 18494.0, 18549.536261593566, 7500.812479688051, 7568.735094271784, 7573.6213189341415, 7585.734499292608, 7654.540727556365, 4385.51759306476, 4393.165298593257, 4427.535108813592, 4475.060237350193, 4475.1049790042125, 3011.7590592752967, 3017.3814368054495, 3017.8038427502142, 3043.8478076096108, 3057.480228361184, 551.052190232807, 562.4038519169693, 564.7599770097692, 573.3778849947853, 590.2268028882178, 582.1035605167993, 602.3284038297354, 611.9204503414528, 621.3910367839543, 662.1722846441947, 7673.462857600026, 7860.410469214832, 7907.367410607138, 7934.166912474223, 8096.392770542233, 542.8425756530562, 552.0614954577154, 599.583289613723, 622.9003359462464, 681.2744427185032, 3780.5652349980105, 3867.16855875988, 3900.01099439288, 3906.1015966327905, 4010.3737119804473, 60343.0, 61181.0, 61448.38551614427, 61666.69166654138, 61741.691291543255, 52530.21204681933, 52763.472365276626, 53156.20265696017, 53278.80736100654, 53487.73256133695, 46967.29549056767, 47405.76297118561, 48734.512654873, 49072.75463622659, 50256.74871625618, 8106.270435660819, 8164.306033987177, 8293.0, 8363.163683631832, 8431.15688431152, 35883.461748074325, 36115.638843611225, 36121.819390903926, 36515.81742091379, 37201.0, 40197.59802401938, 44917.550824491336, 46132.0, 46675.0, 46678.0, 10932.0707739843, 10975.670729878117, 11019.779604408028, 11035.944572656921, 11039.448027598748, 11639.47622357013, 11861.347625880659, 11917.165798394375, 12351.320677362832, 13111.082224244212, 9635.5663995119, 9723.756906077404, 9918.107370336704, 10069.395836249849, 10069.647562335284, 11122.388268645302, 11130.276532025393, 11236.213465057368, 11475.221684955524, 11588.015018723503, 10253.74365640865, 10299.948500257451, 10516.0, 10568.788624227625, 10838.512266948164, 9700.5149742514, 9715.17421019193, 9871.210303175585, 10014.749631259278, 10019.749506262402, 9086.318526110701, 9457.19613832832, 9491.952540237531, 9500.42997420157, 9569.569369378534], "unit": "score", "name": "yui.html", "value": 6255.420827672094}], "name": "dromaeo_css", "value": 6974.835603042176}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 110.0, 109.0, 109.0, 99.0, 108.0, 110.0, 115.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [160.0, 123.0, 153.0, 158.0, 125.0, 149.0, 145.0, 130.0, 161.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 85.0, 96.0, 72.0, 71.0, 71.0, 95.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 138.0, 92.0, 92.0, 93.0, 132.0, 92.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 59.0, 58.0, 57.0, 58.0, 57.0, 68.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 93.0, 84.0, 83.0, 84.0, 83.0, 84.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [114.0, 122.0, 122.0, 124.0, 111.0, 115.0, 125.0, 119.0, 123.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [152.0, 152.0, 157.0, 150.0, 153.0, 151.0, 143.0, 158.0, 148.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1491.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6726308813784], "unit": "score", "name": "Richards", "value": 213.0828719999999}, {"lowerIsBetter": false, "replicates": [188.67924528301887], "unit": "score", "name": "DeltaBlue", "value": 350.4253999999999}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1937.984496124031], "unit": "score", "name": "RayTrace", "value": 381.83432400000015}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19863.779900151745}]} 08:14:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19863.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1491.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6974.83"}}} 08:14:13 INFO - Return code: 0 08:14:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:14:13 ERROR - # TBPL SUCCESS # 08:14:13 INFO - Running post-action listener: _resource_record_post_action 08:14:13 INFO - Running post-run listener: _resource_record_post_run 08:14:14 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10522624; Write bytes: 453484544; Read time: 2896; Write time: 410704 08:14:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7974912; Read time: 0; Write time: 2884 08:14:15 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8761344; Write bytes: 417935360; Read time: 2812; Write time: 401788 08:14:15 INFO - Running post-run listener: _upload_blobber_files 08:14:15 INFO - Blob upload gear active. 08:14:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:14:15 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 08:14:15 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:14:15 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:14:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:16 INFO - (blobuploader) - INFO - Done attempting. 08:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:17 INFO - (blobuploader) - INFO - Done attempting. 08:14:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:17 INFO - Return code: 0 08:14:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:14:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4fa4db3e1ed0a1e348e2a436d6a7c94e59241776ba4f034f94ea88a9c17a9651c43f3f601e5a4586ab88a1126d5ed5c61c9035543ae2c78bccfbe64f9d6e9a02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/26bec8101f5ca8fab1dc474981dc3125dcd5600311656ea87e6a2213a11a965e6d26c9c8e8bdb4570315714e1097d1c36105b274841eca04059b8454b21fb71e"} 08:14:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:14:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:14:17 INFO - Contents: 08:14:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4fa4db3e1ed0a1e348e2a436d6a7c94e59241776ba4f034f94ea88a9c17a9651c43f3f601e5a4586ab88a1126d5ed5c61c9035543ae2c78bccfbe64f9d6e9a02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/26bec8101f5ca8fab1dc474981dc3125dcd5600311656ea87e6a2213a11a965e6d26c9c8e8bdb4570315714e1097d1c36105b274841eca04059b8454b21fb71e"} 08:14:17 INFO - Copying logs to upload dir... 08:14:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.533166 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-24 08:14:17.367733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 08:14:17.370931) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4fa4db3e1ed0a1e348e2a436d6a7c94e59241776ba4f034f94ea88a9c17a9651c43f3f601e5a4586ab88a1126d5ed5c61c9035543ae2c78bccfbe64f9d6e9a02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/26bec8101f5ca8fab1dc474981dc3125dcd5600311656ea87e6a2213a11a965e6d26c9c8e8bdb4570315714e1097d1c36105b274841eca04059b8454b21fb71e"} build_url:https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/8TgA0pAPRXKsPV2CBz7aQw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4fa4db3e1ed0a1e348e2a436d6a7c94e59241776ba4f034f94ea88a9c17a9651c43f3f601e5a4586ab88a1126d5ed5c61c9035543ae2c78bccfbe64f9d6e9a02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/26bec8101f5ca8fab1dc474981dc3125dcd5600311656ea87e6a2213a11a965e6d26c9c8e8bdb4570315714e1097d1c36105b274841eca04059b8454b21fb71e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 08:14:17.395887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 08:14:17.396225) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450971629.812843-995254185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 08:14:17.480497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 08:14:17.480841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 08:14:17.481182) ========= ========= Total master_lag: 0.34 =========