builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1450983333.39 results: success (0) buildid: 20151224083107 builduid: 8ebe2dd669204f40a2735f0cac6ac1c0 revision: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.389224) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.389818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.390157) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.408189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.408584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.421273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.421596) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.470656) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.471019) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.471435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.471750) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 10:55:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2015-12-24 10:55:34 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.581655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.582011) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020396 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:33.632609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 10:55:33.633005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f9649cb1feee315d7cc11eee4f4756ec79cd18a --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/fx-team --rev 0f9649cb1feee315d7cc11eee4f4756ec79cd18a --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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 10:55:34,271 truncating revision to first 12 chars 2015-12-24 10:55:34,271 Setting DEBUG logging. 2015-12-24 10:55:34,272 attempt 1/10 2015-12-24 10:55:34,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f9649cb1fee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 10:55:35,442 unpacking tar archive at: fx-team-0f9649cb1fee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 10:55:35.078691) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:35.079067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:35.089266) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:35.089580) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 10:55:35.090028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-24 10:55:35.090363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:55:35 INFO - MultiFileLogger online at 20151224 10:55:35 in /builds/slave/test-pgo 10:55:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:55:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:55:35 INFO - {'append_to_log': False, 10:55:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:55:35 INFO - 'blob_upload_branch': 'Fx-Team', 10:55:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:55:35 INFO - 'branch': 'Fx-Team', 10:55:35 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:35 INFO - 'config_files': ('talos/linux_config.py',), 10:55:35 INFO - 'default_actions': ('clobber', 10:55:35 INFO - 'read-buildbot-config', 10:55:35 INFO - 'download-and-extract', 10:55:35 INFO - 'populate-webroot', 10:55:35 INFO - 'create-virtualenv', 10:55:35 INFO - 'install', 10:55:35 INFO - 'run-tests'), 10:55:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:35 INFO - 'download_minidump_stackwalk': True, 10:55:35 INFO - 'download_symbols': 'ondemand', 10:55:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:35 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:35 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:35 INFO - 'installer_path': 'installer.exe', 10:55:35 INFO - 'log_level': 'info', 10:55:35 INFO - 'log_name': 'talos', 10:55:35 INFO - 'log_to_console': True, 10:55:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:55:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:55:35 INFO - 'opt_config_files': (), 10:55:35 INFO - 'pip_index': False, 10:55:35 INFO - 'sps_profile': False, 10:55:35 INFO - 'sps_profile_interval': 0, 10:55:35 INFO - 'suite': 'dromaeojs-e10s', 10:55:35 INFO - 'system_bits': '64', 10:55:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:35 INFO - 'title': 'talos-linux64-ix-014', 10:55:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:35 INFO - 'use_talos_json': True, 10:55:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:55:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:35 INFO - 'work_dir': 'build'} 10:55:35 INFO - ##### 10:55:35 INFO - ##### Running clobber step. 10:55:35 INFO - ##### 10:55:35 INFO - Running pre-action listener: _resource_record_pre_action 10:55:35 INFO - Running main action method: clobber 10:55:35 INFO - rmtree: /builds/slave/test-pgo/build 10:55:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:55:36 INFO - Running post-action listener: _resource_record_post_action 10:55:36 INFO - ##### 10:55:36 INFO - ##### Running read-buildbot-config step. 10:55:36 INFO - ##### 10:55:36 INFO - Running pre-action listener: _resource_record_pre_action 10:55:36 INFO - Running main action method: read_buildbot_config 10:55:36 INFO - Using buildbot properties: 10:55:36 INFO - { 10:55:36 INFO - "project": "", 10:55:36 INFO - "product": "firefox", 10:55:36 INFO - "script_repo_revision": "production", 10:55:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:55:36 INFO - "repository": "", 10:55:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:55:36 INFO - "buildid": "20151224083107", 10:55:36 INFO - "pgo_build": "True", 10:55:36 INFO - "basedir": "/builds/slave/test-pgo", 10:55:36 INFO - "buildnumber": 156, 10:55:36 INFO - "slavename": "talos-linux64-ix-014", 10:55:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:55:36 INFO - "platform": "ubuntu64_hw", 10:55:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:55:36 INFO - "branch": "fx-team", 10:55:36 INFO - "repo_path": "integration/fx-team", 10:55:36 INFO - "revision": "0f9649cb1feee315d7cc11eee4f4756ec79cd18a", 10:55:36 INFO - "stage_platform": "linux64-pgo", 10:55:36 INFO - "builduid": "8ebe2dd669204f40a2735f0cac6ac1c0", 10:55:36 INFO - "slavebuilddir": "test" 10:55:36 INFO - } 10:55:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:55:36 INFO - Running post-action listener: _resource_record_post_action 10:55:36 INFO - ##### 10:55:36 INFO - ##### Running download-and-extract step. 10:55:36 INFO - ##### 10:55:36 INFO - Running pre-action listener: _resource_record_pre_action 10:55:36 INFO - Running main action method: download_and_extract 10:55:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:55: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')]} 10:55:36 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json 10:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json 10:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:55:37 INFO - Downloaded 1302 bytes. 10:55:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:55:37 INFO - Using the following test package requirements: 10:55:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:55:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:55:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'jsshell-linux-x86_64.zip'], 10:55:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:55:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:55:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:55:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:55:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:55:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:55:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:55:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:55:37 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')]} 10:55:37 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:38 INFO - Downloaded 23183082 bytes. 10:55:38 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 10:55:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:38 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 10:55:39 INFO - Return code: 0 10:55:39 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 10:55:39 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')]} 10:55:39 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:40 INFO - Downloaded 23183082 bytes. 10:55:40 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 10:55:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:55:40 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 10:55:41 INFO - Return code: 0 10:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:41 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:42 INFO - Downloaded 11132277 bytes. 10:55:42 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 10:55:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:55:42 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 10:55:43 INFO - Return code: 0 10:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:43 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:55:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:55:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:55:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:55:44 INFO - Downloaded 54882716 bytes. 10:55:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:55:44 INFO - mkdir: /builds/slave/test-pgo/properties 10:55:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:55:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:55:44 INFO - Contents: 10:55:44 INFO - build_url:https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:55:44 INFO - Running post-action listener: _resource_record_post_action 10:55:44 INFO - Running post-action listener: set_extra_try_arguments 10:55:44 INFO - ##### 10:55:44 INFO - ##### Running populate-webroot step. 10:55:44 INFO - ##### 10:55:44 INFO - Running pre-action listener: _resource_record_pre_action 10:55:44 INFO - Running main action method: populate_webroot 10:55:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:55:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:55:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:55:44 INFO - '--tppagecycles', 10:55:44 INFO - '7'], 10:55:44 INFO - 'tests': ['tsvgm']}}, 10:55:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:55:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:55:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:55:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:55:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'tests': ['damp', 'tps']}, 10:55:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['damp', 'tps']}, 10:55:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:55:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:55:44 INFO - 'other': {'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'other_l64': {'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'other_nol64': {'tests': ['a11yr', 10:55:44 INFO - 'ts_paint', 10:55:44 INFO - 'tpaint', 10:55:44 INFO - 'sessionrestore', 10:55:44 INFO - 'sessionrestore_no_auto_restore']}, 10:55:44 INFO - 'svgr': {'tests': ['tsvgx', 10:55:44 INFO - 'tsvgr_opacity', 10:55:44 INFO - 'tart', 10:55:44 INFO - 'tscrollx', 10:55:44 INFO - 'cart']}, 10:55:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['tsvgx', 10:55:44 INFO - 'tsvgr_opacity', 10:55:44 INFO - 'tart', 10:55:44 INFO - 'tscrollx', 10:55:44 INFO - 'cart']}, 10:55:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'tests': ['tp5o']}, 10:55:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'talos_options': ['--e10s'], 10:55:44 INFO - 'tests': ['tp5o']}, 10:55:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'talos_options': ['--xperf_path', 10:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:44 INFO - 'tests': ['tp5n']}, 10:55:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:44 INFO - 'talos_options': ['--e10s', 10:55:44 INFO - '--xperf_path', 10:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:44 INFO - 'tests': ['tp5n']}}, 10:55:44 INFO - 'talos.zip': {'path': '', 10:55:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:55:44 INFO - Running post-action listener: _resource_record_post_action 10:55:44 INFO - ##### 10:55:44 INFO - ##### Running create-virtualenv step. 10:55:44 INFO - ##### 10:55:44 INFO - Running pre-action listener: _resource_record_pre_action 10:55:44 INFO - Running main action method: create_virtualenv 10:55:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:55:44 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 10:55:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:55:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:55:44 INFO - Using real prefix '/usr' 10:55:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:55:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:55:46 INFO - Installing pip.................done. 10:55:46 INFO - Return code: 0 10:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:55:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:55:46 INFO - Using env: {'DISPLAY': ':0', 10:55:46 INFO - 'HOME': '/home/cltbld', 10:55:46 INFO - 'LANG': 'en_US.UTF-8', 10:55:46 INFO - 'LANGUAGE': 'en_US:en', 10:55:46 INFO - 'LOGNAME': 'cltbld', 10:55:46 INFO - 'MAIL': '/var/mail/cltbld', 10:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:46 INFO - 'MOZ_NO_REMOTE': '1', 10:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:46 INFO - 'NO_EM_RESTART': '1', 10:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:46 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:46 INFO - 'SHELL': '/bin/bash', 10:55:46 INFO - 'SHLVL': '1', 10:55:46 INFO - 'TERM': 'linux', 10:55:46 INFO - 'TMOUT': '86400', 10:55:46 INFO - 'USER': 'cltbld', 10:55:46 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:46 INFO - '_': '/tools/buildbot/bin/python'} 10:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:47 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 10:55:47 INFO - Cleaning up... 10:55:47 INFO - Return code: 0 10:55:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:47 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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:47 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 10:55:47 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 10:55:47 INFO - Using env: {'DISPLAY': ':0', 10:55:47 INFO - 'HOME': '/home/cltbld', 10:55:47 INFO - 'LANG': 'en_US.UTF-8', 10:55:47 INFO - 'LANGUAGE': 'en_US:en', 10:55:47 INFO - 'LOGNAME': 'cltbld', 10:55:47 INFO - 'MAIL': '/var/mail/cltbld', 10:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:47 INFO - 'MOZ_NO_REMOTE': '1', 10:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:47 INFO - 'NO_EM_RESTART': '1', 10:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:47 INFO - 'SHELL': '/bin/bash', 10:55:47 INFO - 'SHLVL': '1', 10:55:47 INFO - 'TERM': 'linux', 10:55:47 INFO - 'TMOUT': '86400', 10:55:47 INFO - 'USER': 'cltbld', 10:55:47 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:47 INFO - '_': '/tools/buildbot/bin/python'} 10:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:47 INFO - Downloading/unpacking psutil>=0.7.1 10:55:47 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 10:55:47 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 10:55:47 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 10:55:47 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 10:55:47 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 10:55:47 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 10:55:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:55:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:49 INFO - Installing collected packages: psutil 10:55:49 INFO - Running setup.py install for psutil 10:55:49 INFO - building 'psutil._psutil_linux' extension 10:55:49 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 10:55:49 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 10:55:49 INFO - building 'psutil._psutil_posix' extension 10:55:49 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 10:55:49 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 10:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:49 INFO - Successfully installed psutil 10:55:49 INFO - Cleaning up... 10:55:49 INFO - Return code: 0 10:55:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:55:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:55:49 INFO - Using env: {'DISPLAY': ':0', 10:55:49 INFO - 'HOME': '/home/cltbld', 10:55:49 INFO - 'LANG': 'en_US.UTF-8', 10:55:49 INFO - 'LANGUAGE': 'en_US:en', 10:55:49 INFO - 'LOGNAME': 'cltbld', 10:55:49 INFO - 'MAIL': '/var/mail/cltbld', 10:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:49 INFO - 'MOZ_NO_REMOTE': '1', 10:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:49 INFO - 'NO_EM_RESTART': '1', 10:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:49 INFO - 'SHELL': '/bin/bash', 10:55:49 INFO - 'SHLVL': '1', 10:55:49 INFO - 'TERM': 'linux', 10:55:49 INFO - 'TMOUT': '86400', 10:55:49 INFO - 'USER': 'cltbld', 10:55:49 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:49 INFO - '_': '/tools/buildbot/bin/python'} 10:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:55:49 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 10:55:49 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 10:55:49 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 10:55:49 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 10:55:49 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 10:55:49 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 10:55:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:55:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:55:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:55:51 INFO - Installing collected packages: mozsystemmonitor 10:55:51 INFO - Running setup.py install for mozsystemmonitor 10:55:51 INFO - Successfully installed mozsystemmonitor 10:55:51 INFO - Cleaning up... 10:55:51 INFO - Return code: 0 10:55:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:55:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:55:51 INFO - Using env: {'DISPLAY': ':0', 10:55:51 INFO - 'HOME': '/home/cltbld', 10:55:51 INFO - 'LANG': 'en_US.UTF-8', 10:55:51 INFO - 'LANGUAGE': 'en_US:en', 10:55:51 INFO - 'LOGNAME': 'cltbld', 10:55:51 INFO - 'MAIL': '/var/mail/cltbld', 10:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:51 INFO - 'MOZ_NO_REMOTE': '1', 10:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:51 INFO - 'NO_EM_RESTART': '1', 10:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:51 INFO - 'SHELL': '/bin/bash', 10:55:51 INFO - 'SHLVL': '1', 10:55:51 INFO - 'TERM': 'linux', 10:55:51 INFO - 'TMOUT': '86400', 10:55:51 INFO - 'USER': 'cltbld', 10:55:51 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:51 INFO - '_': '/tools/buildbot/bin/python'} 10:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:55:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:55:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:54 INFO - Downloading docopt-0.6.1.tar.gz 10:55:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:55:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:55:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:55:54 INFO - Running setup.py install for blobuploader 10:55:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:55:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:55:54 INFO - Running setup.py install for requests 10:55:54 INFO - Running setup.py install for docopt 10:55:54 INFO - Successfully installed blobuploader requests docopt 10:55:54 INFO - Cleaning up... 10:55:54 INFO - Return code: 0 10:55:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:54 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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:54 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 10:55:54 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 10:55:54 INFO - Using env: {'DISPLAY': ':0', 10:55:54 INFO - 'HOME': '/home/cltbld', 10:55:54 INFO - 'LANG': 'en_US.UTF-8', 10:55:54 INFO - 'LANGUAGE': 'en_US:en', 10:55:54 INFO - 'LOGNAME': 'cltbld', 10:55:54 INFO - 'MAIL': '/var/mail/cltbld', 10:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:54 INFO - 'MOZ_NO_REMOTE': '1', 10:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:54 INFO - 'NO_EM_RESTART': '1', 10:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:54 INFO - 'SHELL': '/bin/bash', 10:55:54 INFO - 'SHLVL': '1', 10:55:54 INFO - 'TERM': 'linux', 10:55:54 INFO - 'TMOUT': '86400', 10:55:54 INFO - 'USER': 'cltbld', 10:55:54 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:54 INFO - '_': '/tools/buildbot/bin/python'} 10:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:55 INFO - Running setup.py (path:/tmp/pip-d64dm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:55 INFO - Running setup.py (path:/tmp/pip-eEES0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:55 INFO - Running setup.py (path:/tmp/pip-A6PGxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:55 INFO - Running setup.py (path:/tmp/pip-kSHeSc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:55 INFO - Running setup.py (path:/tmp/pip-OUecyw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:55 INFO - Running setup.py (path:/tmp/pip-97f22r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:55 INFO - Running setup.py (path:/tmp/pip-Ml9dc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:55 INFO - Running setup.py (path:/tmp/pip-rY544p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:55 INFO - Running setup.py (path:/tmp/pip-O8hMqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:55 INFO - Running setup.py (path:/tmp/pip-B3gBOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:55 INFO - Running setup.py (path:/tmp/pip-_EqU0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:55 INFO - Running setup.py (path:/tmp/pip-ewMSgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:56 INFO - Running setup.py (path:/tmp/pip-COLHUv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:56 INFO - Running setup.py (path:/tmp/pip-TXFM_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:56 INFO - Running setup.py (path:/tmp/pip-M9MY4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:56 INFO - Running setup.py (path:/tmp/pip-29g3Ol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:56 INFO - Running setup.py (path:/tmp/pip-gQhXTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:55:56 INFO - Running setup.py install for manifestparser 10:55:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:55:56 INFO - Running setup.py install for mozcrash 10:55:56 INFO - Running setup.py install for mozdebug 10:55:56 INFO - Running setup.py install for mozdevice 10:55:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:55:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:55:56 INFO - Running setup.py install for mozfile 10:55:56 INFO - Running setup.py install for mozhttpd 10:55:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozinfo 10:55:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozInstall 10:55:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozleak 10:55:57 INFO - Running setup.py install for mozlog 10:55:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for moznetwork 10:55:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozprocess 10:55:57 INFO - Running setup.py install for mozprofile 10:55:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozrunner 10:55:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:55:57 INFO - Running setup.py install for mozscreenshot 10:55:57 INFO - Running setup.py install for moztest 10:55:58 INFO - Running setup.py install for mozversion 10:55:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:55:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:55:58 INFO - Cleaning up... 10:55:58 INFO - Return code: 0 10:55:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:55:58 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')]} 10:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:58 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')]} 10:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:58 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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:55:58 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 10:55:58 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 10:55:58 INFO - Using env: {'DISPLAY': ':0', 10:55:58 INFO - 'HOME': '/home/cltbld', 10:55:58 INFO - 'LANG': 'en_US.UTF-8', 10:55:58 INFO - 'LANGUAGE': 'en_US:en', 10:55:58 INFO - 'LOGNAME': 'cltbld', 10:55:58 INFO - 'MAIL': '/var/mail/cltbld', 10:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:58 INFO - 'MOZ_NO_REMOTE': '1', 10:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:55:58 INFO - 'NO_EM_RESTART': '1', 10:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:55:58 INFO - 'SHELL': '/bin/bash', 10:55:58 INFO - 'SHLVL': '1', 10:55:58 INFO - 'TERM': 'linux', 10:55:58 INFO - 'TMOUT': '86400', 10:55:58 INFO - 'USER': 'cltbld', 10:55:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:58 INFO - '_': '/tools/buildbot/bin/python'} 10:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:58 INFO - Running setup.py (path:/tmp/pip-nu5V8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:58 INFO - Running setup.py (path:/tmp/pip-8x9w4h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:58 INFO - Running setup.py (path:/tmp/pip-PUqFYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:58 INFO - Running setup.py (path:/tmp/pip-qXWwFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:58 INFO - Running setup.py (path:/tmp/pip-IB5Y5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:58 INFO - Running setup.py (path:/tmp/pip-Kd_hz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:58 INFO - Running setup.py (path:/tmp/pip-h8WeoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:58 INFO - Running setup.py (path:/tmp/pip-02l9g7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:55:58 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)) 10:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:58 INFO - Running setup.py (path:/tmp/pip-cbPCgu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:59 INFO - Running setup.py (path:/tmp/pip-V2_2I8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:59 INFO - Running setup.py (path:/tmp/pip-P_bJUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:59 INFO - Running setup.py (path:/tmp/pip-VeCcHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:59 INFO - Running setup.py (path:/tmp/pip-buW4XD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:59 INFO - Running setup.py (path:/tmp/pip-0_NUDH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:59 INFO - Running setup.py (path:/tmp/pip-6roC1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:59 INFO - Running setup.py (path:/tmp/pip-IWZwJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:55:59 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)) 10:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:59 INFO - Running setup.py (path:/tmp/pip-17b8qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:55:59 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)) 10:55:59 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)) 10:55:59 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)) 10:55:59 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)) 10:55:59 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)) 10:55:59 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)) 10:55:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:01 INFO - Downloading blessings-1.5.1.tar.gz 10:56:01 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 10:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:01 INFO - Installing collected packages: blessings 10:56:01 INFO - Running setup.py install for blessings 10:56:01 INFO - Successfully installed blessings 10:56:01 INFO - Cleaning up... 10:56:01 INFO - Return code: 0 10:56:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:56:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:56:01 INFO - Reading from file tmpfile_stdout 10:56:01 INFO - Current package versions: 10:56:01 INFO - argparse == 1.2.1 10:56:01 INFO - blessings == 1.5.1 10:56:01 INFO - blobuploader == 1.2.4 10:56:01 INFO - docopt == 0.6.1 10:56:01 INFO - manifestparser == 1.1 10:56:01 INFO - mozInstall == 1.12 10:56:01 INFO - mozcrash == 0.16 10:56:01 INFO - mozdebug == 0.1 10:56:01 INFO - mozdevice == 0.47 10:56:01 INFO - mozfile == 1.2 10:56:01 INFO - mozhttpd == 0.7 10:56:01 INFO - mozinfo == 0.9 10:56:01 INFO - mozleak == 0.1 10:56:01 INFO - mozlog == 3.1 10:56:01 INFO - moznetwork == 0.27 10:56:01 INFO - mozprocess == 0.22 10:56:01 INFO - mozprofile == 0.28 10:56:01 INFO - mozrunner == 6.11 10:56:01 INFO - mozscreenshot == 0.1 10:56:01 INFO - mozsystemmonitor == 0.0 10:56:01 INFO - moztest == 0.7 10:56:01 INFO - mozversion == 1.4 10:56:01 INFO - psutil == 3.1.1 10:56:01 INFO - requests == 1.2.3 10:56:01 INFO - wsgiref == 0.1.2 10:56:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:56:01 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')]} 10:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:01 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')]} 10:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:01 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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:56:01 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 10:56:01 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 10:56:01 INFO - Using env: {'DISPLAY': ':0', 10:56:01 INFO - 'HOME': '/home/cltbld', 10:56:01 INFO - 'LANG': 'en_US.UTF-8', 10:56:01 INFO - 'LANGUAGE': 'en_US:en', 10:56:01 INFO - 'LOGNAME': 'cltbld', 10:56:01 INFO - 'MAIL': '/var/mail/cltbld', 10:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:01 INFO - 'MOZ_NO_REMOTE': '1', 10:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:01 INFO - 'NO_EM_RESTART': '1', 10:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:01 INFO - 'SHELL': '/bin/bash', 10:56:01 INFO - 'SHLVL': '1', 10:56:01 INFO - 'TERM': 'linux', 10:56:01 INFO - 'TMOUT': '86400', 10:56:01 INFO - 'USER': 'cltbld', 10:56:01 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:01 INFO - '_': '/tools/buildbot/bin/python'} 10:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 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)) 10:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:56:01 INFO - Cleaning up... 10:56:02 INFO - Return code: 0 10:56:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:02 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 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:56:02 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 10:56:02 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 10:56:02 INFO - Using env: {'DISPLAY': ':0', 10:56:02 INFO - 'HOME': '/home/cltbld', 10:56:02 INFO - 'LANG': 'en_US.UTF-8', 10:56:02 INFO - 'LANGUAGE': 'en_US:en', 10:56:02 INFO - 'LOGNAME': 'cltbld', 10:56:02 INFO - 'MAIL': '/var/mail/cltbld', 10:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:02 INFO - 'MOZ_NO_REMOTE': '1', 10:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:02 INFO - 'NO_EM_RESTART': '1', 10:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:02 INFO - 'SHELL': '/bin/bash', 10:56:02 INFO - 'SHLVL': '1', 10:56:02 INFO - 'TERM': 'linux', 10:56:02 INFO - 'TMOUT': '86400', 10:56:02 INFO - 'USER': 'cltbld', 10:56:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:02 INFO - '_': '/tools/buildbot/bin/python'} 10:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:02 INFO - Downloading/unpacking jsonschema 10:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:56:03 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 10:56:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:56:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:56:04 INFO - warning: no files found matching '*.txt' 10:56:04 INFO - no previously-included directories found matching 'build' 10:56:04 INFO - no previously-included directories found matching 'dist' 10:56:04 INFO - no previously-included directories found matching '.git*' 10:56:04 INFO - Installing collected packages: jsonschema, functools32 10:56:04 INFO - Running setup.py install for functools32 10:56:04 INFO - warning: no files found matching '*.txt' 10:56:04 INFO - no previously-included directories found matching 'build' 10:56:04 INFO - no previously-included directories found matching 'dist' 10:56:04 INFO - no previously-included directories found matching '.git*' 10:56:04 INFO - Successfully installed jsonschema functools32 10:56:04 INFO - Cleaning up... 10:56:04 INFO - Return code: 0 10:56:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4cce4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1116630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, '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': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', '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 10:56:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:56:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:56:04 INFO - Using env: {'DISPLAY': ':0', 10:56:04 INFO - 'HOME': '/home/cltbld', 10:56:04 INFO - 'LANG': 'en_US.UTF-8', 10:56:04 INFO - 'LANGUAGE': 'en_US:en', 10:56:04 INFO - 'LOGNAME': 'cltbld', 10:56:04 INFO - 'MAIL': '/var/mail/cltbld', 10:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:04 INFO - 'MOZ_NO_REMOTE': '1', 10:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:04 INFO - 'NO_EM_RESTART': '1', 10:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:04 INFO - 'SHELL': '/bin/bash', 10:56:04 INFO - 'SHLVL': '1', 10:56:04 INFO - 'TERM': 'linux', 10:56:04 INFO - 'TMOUT': '86400', 10:56:04 INFO - 'USER': 'cltbld', 10:56:04 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:04 INFO - '_': '/tools/buildbot/bin/python'} 10:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:04 INFO - Downloading/unpacking flake8 10:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:56:06 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 10:56:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:56:06 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 10:56:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 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 10:56:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:56:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:56:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:06 INFO - no previously-included directories found matching 'docs/_build' 10:56:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:56:07 INFO - Running setup.py install for pep8 10:56:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:56:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:56:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:56:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:56:07 INFO - no previously-included directories found matching 'docs/_build' 10:56:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:56:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:56:07 INFO - Cleaning up... 10:56:07 INFO - Return code: 0 10:56:07 INFO - Running post-action listener: _resource_record_post_action 10:56:07 INFO - Running post-action listener: _start_resource_monitoring 10:56:07 INFO - Starting resource monitoring. 10:56:07 INFO - ##### 10:56:07 INFO - ##### Running install step. 10:56:07 INFO - ##### 10:56:07 INFO - Running pre-action listener: _resource_record_pre_action 10:56:07 INFO - Running main action method: install 10:56:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:56:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:56:07 INFO - Reading from file tmpfile_stdout 10:56:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:56:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:56:07 INFO - Reading from file tmpfile_stdout 10:56:07 INFO - Output received: 10:56:07 INFO - Usage: mozinstall [options] installer 10:56:07 INFO - Options: 10:56:07 INFO - -h, --help show this help message and exit 10:56:07 INFO - -d DEST, --destination=DEST 10:56:07 INFO - Directory to install application into. [default: 10:56:07 INFO - "/builds/slave/test-pgo"] 10:56:07 INFO - --app=APP Application being installed. [default: firefox] 10:56:07 INFO - mkdir: /builds/slave/test-pgo/build/application 10:56:07 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'] 10:56:07 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 10:56:23 INFO - Reading from file tmpfile_stdout 10:56:23 INFO - Output received: 10:56:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:56:23 INFO - Running post-action listener: _resource_record_post_action 10:56:23 INFO - ##### 10:56:23 INFO - ##### Running run-tests step. 10:56:23 INFO - ##### 10:56:23 INFO - Running pre-action listener: _resource_record_pre_action 10:56:23 INFO - Running main action method: run_tests 10:56:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:56:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:56:23 INFO - Python 2.7.3 10:56:23 INFO - Return code: 0 10:56:23 INFO - grabbing minidump binary from tooltool 10:56: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')]} 10:56:23 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 0x11a7840>, '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 0x11146b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1114b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:56:23 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 10:56:23 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 10:56:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:56:23 INFO - Return code: 0 10:56:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:56:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:56:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:56:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:56:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:56:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:56:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:56:24 INFO - Return code: 0 10:56:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:56:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:56:24 INFO - Using env: {'DISPLAY': ':0', 10:56:24 INFO - 'HOME': '/home/cltbld', 10:56:24 INFO - 'LANG': 'en_US.UTF-8', 10:56:24 INFO - 'LANGUAGE': 'en_US:en', 10:56:24 INFO - 'LOGNAME': 'cltbld', 10:56:24 INFO - 'MAIL': '/var/mail/cltbld', 10:56:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:56:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:24 INFO - 'MOZ_NO_REMOTE': '1', 10:56:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:24 INFO - 'NO_EM_RESTART': '1', 10:56:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:56:24 INFO - 'SHELL': '/bin/bash', 10:56:24 INFO - 'SHLVL': '1', 10:56:24 INFO - 'TERM': 'linux', 10:56:24 INFO - 'TMOUT': '86400', 10:56:24 INFO - 'USER': 'cltbld', 10:56:24 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274', 10:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:24 INFO - '_': '/tools/buildbot/bin/python'} 10:56:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:56:24 INFO - mozversion application_buildid: 20151224083107 10:56:24 INFO - mozversion application_changeset: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a 10:56:24 INFO - mozversion application_display_name: Nightly 10:56:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:56:24 INFO - mozversion application_name: Firefox 10:56:24 INFO - mozversion application_remotingname: firefox 10:56:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:56:24 INFO - mozversion application_vendor: Mozilla 10:56:24 INFO - mozversion application_version: 46.0a1 10:56:24 INFO - mozversion platform_buildid: 20151224083107 10:56:24 INFO - mozversion platform_changeset: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a 10:56:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:56:24 INFO - mozversion platform_version: 46.0a1 10:56:24 INFO - using testdate: 1450983384 10:56:24 INFO - actual date: 1450983384 10:56:24 INFO - starting webserver on 'localhost:35590' 10:56:24 INFO - SUITE-START | Running 3 tests 10:56:24 INFO - TEST-START | dromaeo_css 10:56:24 INFO - operating with platform_type : linux_ 10:56:24 INFO - Initialising browser for dromaeo_css test... 10:56:24 INFO - TEST-INFO | started process 21293 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo_FRMR/profile http://localhost:35590/getInfo.html) 10:56:29 INFO - PROCESS | 21293 | __metrics Screen width/height:1600/1200 10:56:29 INFO - PROCESS | 21293 | colorDepth:24 10:56:29 INFO - PROCESS | 21293 | Browser inner width/height: 1024/697 10:56:29 INFO - PROCESS | 21293 | __metrics 10:56:29 INFO - PROCESS | 21293 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:56:30 INFO - TEST-INFO | 21293: exit 0 10:56:30 INFO - Browser initialized. 10:56:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:56:30 INFO - TEST-INFO | started process 21427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo_FRMR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:42 INFO - PROCESS | 21427 | RSS: Main: 149082112 10:56:42 INFO - PROCESS | 21427 | 10:57:31 INFO - PROCESS | 21427 | 1450983451820 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] 10:59:40 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35590/tests/dromaeo/cssquery-ext.html) 10:59:42 INFO - PROCESS | 21427 | RSS: Main: 156254208 10:59:42 INFO - PROCESS | 21427 | 11:02:44 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-ext.html (next: http://localhost:35590/tests/dromaeo/cssquery-jquery.html) 11:02:44 INFO - PROCESS | 21427 | RSS: Main: 151609344 11:02:44 INFO - PROCESS | 21427 | 11:05:46 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35590/tests/dromaeo/cssquery-mootools.html) 11:05:47 INFO - PROCESS | 21427 | RSS: Main: 154681344 11:05:47 INFO - PROCESS | 21427 | 11:08:48 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35590/tests/dromaeo/cssquery-prototype.html) 11:08:49 INFO - PROCESS | 21427 | RSS: Main: 151928832 11:08:49 INFO - PROCESS | 21427 | 11:11:51 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35590/tests/dromaeo/cssquery-yui.html) 11:11:52 INFO - PROCESS | 21427 | RSS: Main: 152915968 11:11:52 INFO - PROCESS | 21427 | 11:14:54 INFO - PROCESS | 21427 | Cycle 1(1): loaded http://localhost:35590/tests/dromaeo/cssquery-yui.html (next: http://localhost:35590/tests/dromaeo/cssquery-dojo.html) 11:14:55 INFO - PROCESS | 21427 | RSS: Main: 154271744 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | __start_tp_report 11:14:55 INFO - PROCESS | 21427 | _x_x_mozilla_page_load 11:14:55 INFO - PROCESS | 21427 | _x_x_mozilla_page_load_details 11:14:55 INFO - PROCESS | 21427 | |i|pagename|runs| 11:14:55 INFO - PROCESS | 21427 | |0;dojo.html;3200.919977000575;3303.7687361884678;3312.602487701476;3316.1543806329396;3319.2531680371912;5271.42014378418;5544.473275038875;5563.86090347741;5586.217929489864;5591.944080559193;5535.25274087998;5564.527015203703;5581.441855814416;5587.552995760339;5591.496765291123;5019.196928491442;5059.721715305656;5078.5175408336145;5084.211947148179;5152.201408781626;4993.6254780891395;5001.699898006132;5006.899862002758;5017.222330538754;5054.671446355994;4930.580900623451;5048.116579598593;5097.006083813658;5104.464031276718;5150.381954165506;5046.167382381903;5046.394432668067;5063.341765570489;5076.64463487556;5090.0583392072585;5012.821986833092;5023.296738456619;5043.445221025684;5075.51782580658;5089.491050894918;5221.634485586011;5270.6047046471285;5325.4142044375085;5402.432744561843;5412.864678383033;5920.289565252154;5984.431479009487;5985.34161242263;5996.550258730613;6002.759889604411;6005.54958378119;6016.669083200422;6024.78913238039;6029.0052141397055;6031.577789554733;5383.084875571162;5443.891122177613;5507.7246137693355;5548.861278468071;5604.495595396434;5960.254968128984;6004.699765011819;6049.153118563405;6061.54538409621;6112.2970858351855;5737.3975732548315;5793.391693872083;5794.8551286217335;5799.3040835100055;5805.6806875621405;5754.510866576305;5788.594798364074;5869.5010924071075;5885.676287804126;5928.851778705567;5809.8547536311935;5861.531077513789;5862.091375836752;5882.470577647947;5911.674857882857;5734.942650573525;5834.299884013861;5851.268591426072;5868.882622347529;5874.412558744177;4451.043025749479;4501.0547784964865;4519.841805536857;4522.5025247222775;4562.817487300537;4032.3749818778138;4058.4521089652517;4080.2859499587453;4098.467199264077;4119.443875076886;5422.810201642924;5491.533219676372;5593.049181639131;5612.158176273591;5613.943860561342;5896.233489646319;5931.4958228550195;5974.820755377345;6014.879702405928;6019.638821670714;5582.49757521825;5582.525485333711;5588.804391846266;5593;5598.1322894951345;4918.409790825124;5008.499150084962;5129.563987061141;5148.639595228298;5195.766190521435;6064.848378790477;6135.177648498111;6139.592526148031;6139.8601398601395;6143.051335358963;5903.26209223847;5991.520678345809;6003.099535069775;6003.609765365237;6054.666993315233;5945.970270148621;5986.102084687158;6076.726547305293;6176.629402235881;6176.629402235881;5756.42435756421;5788.623739456922;5799.623024503394;5814.5348372130975;5958.672273025025;5848.298204215522;5870.207521984477;5885.676287804212;5887.793927212527;5933.902228087818;5684.261046063985;5746.109353050284;5773.884522309614;5799.82600521985;5918.763249469973;5752.626079304831;5769.538436924952;5785.623934444247;5815.854603634943;5886.146508756292;5625.915611265752;5646;5660.122680984454;5665.518430933252;5675.432456754292;5719.28508936383;5722.2561067061015;5797.391273916178;5827.067669172912;5844.12338149281;5658.971705141613;5664.207011018543;5691.943080569141;5697.8860422790485;5761.798337058183 11:14:55 INFO - PROCESS | 21427 | |1;ext.html;580.5993864233678;583.5506659871899;586.4018700925058;593.7565598104778;605.7243954000933;38526.22947541051;39537.60462395383;39653.801730991305;39655.40516892249;39667.80166099169;42176.578234217646;42223.155536889244;42238.15523689525;42324;42350.57649423505;8644.5245511497;8730.17063378978;8789.64841406343;8791.164839340252;8801.251893589053;8639.568021598927;8675.045744968049;8719.956400218021;8726.258268047191;8769.342299327544;8569.442986205908;8581.742547723577;8656.740297791044;8696.913030869706;8698.217160455557;8683.478991260514;8710.041895391501;8736.563171841382;8747.868781968244;8763.07987661296;8497.320214382835;8637.69768058115;8644.438111522732;8646;8666.090060543615;38497.422538661944;38914.80542597269;38930.61069389298;39030.414543781866;39187.412188817194;3297.6453934645233;3353.765236433451;3601.099725068733;3777.301199278115;3980.0845805464614;29268.70731292681;29339.919308472516;29457.11628651144;30439.695603043907;30675.2331191722;3439.501272315525;3441.174118211636;3620.7103431725664;3689.1699367642336;3880.4567360569545;271312;272718;272789;272876;272988;56535;57227;57908.710456448294;58748.4125158743;59398.70300648469;55359.723201383735;55817.76728930879;55852;55901.44098559044;55920.44079559152;12765.936170319275;12868.420921058574;13053.021023423282;13070.150440221545;13092.083554151119;9640.807183856283;9725.854112188323;9751.171150452292;9763.951180244054;9798.510074496247;19863;20096.19615215375;20130.69803952942;20325.79674203239;20377;7838.882416763753;8056;8064.879026814602;8082.343119660455;8119;894.6019021535354;927.638221093774;1039.1790485516358;1059.708580140452;1080.346390433792;27646.308842279104;28360.85819570889;28362.71637283642;28725.138245852657;28738.425231495254;997.07272236819;1007.3502590828874;1018.0582960761266;1107.7839821234943;1108.107973081677;14147.787783183261;14257;14363.712725745427;14414.855851441562;14491.855081449261;370504;370693;373842;376093;376481;51269.743651281504;51539.48460515347;51657.7417112912;51763.74118129461;51787.223191652156;1283.2428866968346;1286.1254347043912;1293.780057390246;1295;1307.7646023715822;25829;26554.203373898814;26835.865820670773;27020.729792701823;27197.728022720312;41418;42169.578304216564;42312;42350.36474452824;42394.57605424029;278684;282438;283039;283886;284131;31924.36151277008;44992.100157996;45483.54516454793;45614.54385456103;46180.53819461897;41814.37278440765;42392.788036060854;42518.14963700771;42575.787121065434;42709.5729042718;36474.635253648186;36757.26485470329;37233.25533489369;38368.2326353477;42699.35950960676;35795.46306805452;36470;36972;37148.62851371452;37469.4379584301;35851;36377.090572734836;36535.634643653226;36562.63437365699;36638.450423244205;31946.84026579852;32443.351132976735;32734.50898236481;33126;33186;24322.27033189007;25115.87442062778;26690.19929402121;27029.459410812065;27108.45783084367 11:14:55 INFO - PROCESS | 21427 | |2;jquery.html;355.9537260156179;361.09905785066263;361.78112242093533;363.7708243806402;365.11095482500116;16342.918285408572;17542.473725788215;17556.56108597284;18071.548211294725;18907.810921890796;9867.5559599818;10008.249381296413;15950;16006.119663418507;16098.919505402486;5029.346184995946;5300.628955973083;5529.391766905637;5560.582956278275;5574.358948720908;5474.972625136868;5546.972265138689;5547.500724934755;5549.139883318092;5552.694601796899;5093.312402825627;5103.106956282654;5241.213817927303;5336.43967383423;5353.250544923714;5281.577473802125;5309.681419114865;5311;5319.707416092114;5378.650387724805;5175.715335656538;5367.838964831061;5370.489803468664;5371.838844834661;5385.892282154335;12016.339101349422;12213.938930305381;14625.903057270642;19618.607627847505;19680.50798730029;1892.829645331913;1914.74150989616;1940.3790786948182;1968.6456437841182;2101.3905967269475;9750.658726944523;9794.461304628243;9804.852927206097;9920.751981200456;9933.205343572497;1692.8222536633723;1842.1526097994938;1863.9347622833136;1876.9718454223198;1879.473747350744;54631;54845.45154548444;56159.71920140414;56950;61561;9867.259955503367;10002.099811017044;10024.997500249916;10047.849282260771;10160.33957792741;12825.615231543068;12853.100282980102;12916.41876115577;12933.741325173443;12952.870471295355;6819.829504262334;6835.624040677811;6935.202451718016;6968.79093627192;7006.649667516604;5932.40675932412;5963.731632076567;6299.6535190564955;6568.6058836469965;6676.165479315086;4310.245707001262;4347.7173983690955;4380.934285985712;4438.800253988578;4495.955040449554;1828.1133650179652;1878.9060546972871;1886.4057821786093;1921.4331772127257;1942.553212761073;416.8951192646068;423.20437577354375;435.0580992152019;446.6069858524478;462.77555385637936;10696.358218506915;11215.887841121485;11439.771204576029;11453.59912403062;11474.598389056342;877.2148926710686;884.7743825324501;906.9546522673971;912.9543522823832;987.2398253345028;9062.50156241413;9073.274138068939;9082.500462474494;9155.450672959643;9226;501942;504065;511966;528012;533862;77739;81092;81111;81393.59303203564;81662.18337816665;1129.6215767717742;1138.3738943580997;1140.2303445174473;1140.7604403075447;1143.7426579019655;14541.418343266574;14608.123512589278;14640.560783176521;14655.48705795292;14796.260186990392;32968;33079.17302067467;33643.822466214544;33664;33768.324633507684;45765.31352029656;48918.26622600593;50083.74958125186;50819.49180508296;52414;9378.015308392793;9574.32979691415;9866.703998880044;9870.506474676382;9885.258605604464;11499.54001839917;11507.94246028798;11903.821442678194;17452.469391938354;17570.121493925;13833.30833458303;13876.167429954236;13944.442222310994;13963.162210267417;14390.496332628307;14177.220252885778;14242.359093841009;14318.498852540528;14615.196164210645;14819.481318153812;13853.930730346687;14057.859421405656;14089;14157.575272741835;14334.713305733618;9760.511974401394;9815.165710914367;9835.262355323237;9862.605495780088;9877.209823214269;10187.083162515113;11714.824277635671;13083.149595276658;13647.181169129884;13649.658758531115 11:14:55 INFO - PROCESS | 21427 | |3;mootools.html;1471.6247356923996;1619.4331983805669;1643.1127191316682;1701.9404320848769;1752.7195648696206;6894.517383783137;7193.532420392671;7251.601161936092;7372.889406658905;7620.390368770485;7487.962560187191;7492.100947886248;7510.361619262356;7549.584772837492;7568.735094271701;2209.0501084533603;2233.251860626684;2246.6854640350366;2250.3811451850706;2253.278950735765;2208.55828834233;2241.8766967816764;2281.1445707859552;2282.338121944634;2288.199130304397;2162.23240749534;2182.563487302538;2190.5837890800776;2205.59196548639;2222.6443768996965;2190.835687323457;2192.2217612747404;2239.9328020159423;2241.3051953894264;2253.7182852143565;2230.4869879927705;2254.7519772824976;2258.5144193998367;2265.4223173090754;2267.183813827021;7463.664135113933;7493.925060749431;7508.887366689504;7520.736774212876;7527.698892044312;4303.419038429804;4364.236258654722;4365.672574556889;4370.344448332744;4378.321360189176;2896.8551572421507;2965.555166724987;2972.078655616766;2977.7766667500023;2988.5367767995995;960.0543464687278;985.3742873275521;989.0258095775655;990.2919412620012;1052.026875140492;10064.14454771338;10095.697129086138;10134.239932005055;10143.23925705575;10170.745731356701;3828.8085595720104;3869.2454971280895;3881.86413475527;3924.823382947774;3935.960640393617;8222.136675648972;8233.17668233172;8240.299574536231;8248.83502329962;8252.05101413333;4286.249906266391;4287.485501739811;4291.806868690916;4293.785310734514;4297.39836422901;3927.2145570885937;3948.0919388540797;3961.6830653547645;3980.343243364812;3989.0226894411053;3384.1877949291993;3397.2016576104597;3422.418188907892;3435.7766745161484;3454.4127498325347;1024.1192574386023;1029.4080903480378;1032.210359075308;1032.912202462784;1033.2818691009677;954.5465903695689;962.8748262725801;1040.427764729396;1069.4064794039382;1310.0829419406455;7008.229094799568;7044.964775176194;7064.152301723826;7070.540414873017;7091.503594748421;1114.2924243105685;1115.3921112993437;1128.8081026225561;1130.152385710717;1158.2760774515928;5544.140658197985;5596.664200148004;5610.13042978339;5655.717214139277;5676.77292908279;8274.8345033099;8641.351898607629;8650.87023694645;8752.47485150893;8752.912470875337;8485.32117430604;8523.957380213184;8569.742907712778;8640.481571105754;8662.523561204194;6829.180498340231;6863.553868998499;7066.6819993100435;7100.9644951775945;7181.6409179540815;6851.623160726208;6885.414739747178;6895.793126206222;6897.310268973263;6897.689603967934;7838.882416763867;7974.202579741979;8114.797130071795;8131.7560473185895;8152.144024877302;8191.426600137933;8258.710945116893;8312.085670576353;8315.417920745731;8366.707165249187;6249.593776404519;6319.431251187415;6322.399372059647;6396.0405939109505;6398.93601064002;6769.966150169218;6781.491388145811;6818.795436136924;6820.590764554143;6846.315368463114;6016.278046634432;6481.319461456479;6517.283098859027;6588.341165883373;6646.169228846395;6451.1936007999;6497.122888410004;6535.477161826947;6562.278149403657;6647.4682025438815;6437.806865794034;6465.644389558432;6511.218653761579;6532.281449040506;6551.082848401323;5909.409059094056;5921.881562368814;5968.253968253968;5984.730687119177;5986.820395388146;5985.880282394241;6030.944584697572;6037.426444487766;6053.697315134137;6060.636361818305 11:14:55 INFO - PROCESS | 21427 | |4;prototype.html;329.28052205930044;336.15457125329795;345.6906069068184;346.33158005050245;346.83525325470407;6280.152179455772;6293.27627322858;6319.6524191169465;6331.841703957398;6477.060826180201;6351.491880649549;6373.298937116913;6381.999999999988;6386;6404.96797516013;4745.57289843914;4756.643251756115;4783.234682450809;4795.160846851787;4803.903921921559;4799.112164249607;4805.735684537349;4811.061842940628;4811.30236115763;4822.300766388871;4647.953520464803;4725.196716558176;4744.620430365562;4756.785944632483;4758.78585463655;4730.361401210844;4737.265723812815;4746.050789842046;4751.95248047522;4754.286856971482;4059.512858457004;4061.8375264989363;4066.1257829566784;4066.4916885389325;4072.938905916384;6023.668698221596;6025.397460253939;6032.909506357408;6037.969810150921;6049.062395328687;5409.43200963901;5531.280933478622;5532.75102620383;5534.4742249486235;5537.889242215173;6738.561993470409;6775.932240677579;6798.490113241527;6809.455243580502;6814.522983391164;4492.775361231958;4499.302608095718;4504.481984571784;4508.233600287959;4514.706544074625;6804.08144900442;6972.058772065757;7017.157941047056;7067.89398159028;7095.042169307129;4733.077049975291;4765.761711914391;4772.880677983008;4772.952270477251;4775.2598347256235;4797.232442809134;4800.703809971288;4818.951810481921;4820.276958456189;4846.248831431134;5585.441455854382;5597.020521408818;5601.831945041656;5614.073677843192;5618.297712785902;6564.606123632598;6740.258571557223;6781.796546103625;6808.965955170292;6826.965865170741;1659.1289572974285;1672.1388484930271;1698.7791587093598;1704.4119778676336;1708.6668099720684;1090.8091084060259;1098.873629532598;1102.1733699725205;1106.7841770854607;1124.128800179867;6268.279147897959;6322.589031713016;6332.4934005279465;6336.778212762531;6344.270408902943;6838.555493892881;6862.622555759481;6868.519203655696;6877.65611719422;6900.827479313058;6180.876382472416;6236.688165591702;6292.622442653455;6322.083297921776;6334.778282760081;3748.306563285801;3765.7363984521367;3767.472553842464;3768.6796622286865;3774.5470543534952;7188;7206.387457066208;7215.5670659759535;7216.314450127229;7218.3503484686635;7006.0892084029765;7095.645217739092;7110.92889071113;7115.857682846314;7116.5018448709125;7336.413086953137;7341.74303899361;7353.963230183922;7373.741919032916;7373.963130184422;7039;7052.823679408056;7062.3996960258955;7075;7079.929200707927;6786.558873673195;6956.79129626112;6959.791206263821;6974.302569743188;6982.301769822977;7299.963500182465;7316.366108200937;7320.121585409572;7323.597202153933;7329.413646908128;4638.5593368629925;4707.529247075265;4709.81160753566;4732.408448943882;4734.573888349927;6837.692303846438;6899.20659124187;6984.231734509099;7033.366996970297;7061.682224299816;6681.198256209092;6705.396514313735;6751.392374686302;6780.72877084911;6791.694373753292;6683.365080317362;6724;6804.285550017177;6817.352351526597;6848.1097457330225;6607.57050791697;6623.973284140966;6673.165854268216;6697.765578204934;6715.56348837324;6796.898046529405;6802.115724955724;6842.0763196969765;6866.622335771581;6872.553284036521;6642.103316052464;6652.467802575879;6653.135092437952;6705.798826035227;6741.22475915276 11:14:55 INFO - PROCESS | 21427 | |5;yui.html;662.2417332154683;679.4971720926516;709.7409445552375;744.3115118515371;873.7335112790598;13116.147450415729;13435.932820335885;13436.193828370304;13460.798088028663;13510;14430.062045967004;14547.854521454783;14580.343884525195;14602.707945841077;14663.046901951393;735.3602365941638;736.2159300345129;762.5005621318046;776.0997243197892;780.379598219417;765.6592816196795;770.4914756260869;771.0670089192084;773.0452890680006;776.0687175389527;803.2529747334976;808.9959550202241;810.6109067647533;811.5171472973572;813.6175997281298;799.4164260090108;799.9000124984348;802.1537278171527;802.5826570183531;803.8954935858301;590.6898878088995;592.0881841963371;592.2715060475639;595.2291782142094;595.6694034810679;12183.634490965285;12191.634250972485;12195.817062744067;12296.262224266484;12315.5073797048;11668.1832271741;11781.469833857496;11994.400279985966;12214.267143971301;12483.251004939733;10002.849957250646;10108.747281317952;10162.288639795217;10174.796504069951;10210.693679189637;3370.9767367750287;3448.586169659657;3477.530533377987;3490.336836001177;3493.8777142800136;46868.76565617184;47086.76456617729;47448.52551474475;47460.28809567825;47702.52297477015;8940.418872773249;9175;9543.188828949478;9576.994415586403;9589.856152157723;16844.07357595344;16859.915700421418;16860.156992150343;16877;16895.577610559587;6718.160229971254;7061.364477197077;7076.681549330293;7081.539699919592;7094.432445404355;4023.295923213426;4114.6091121343425;4154.771487568152;4258.659307255412;4321.524632290446;3032.9848350758107;3075.0774767570088;3079.615048118985;3081.445339838806;3092.8608212630484;558.9720513974285;561.7809054468761;563.5829486180279;633.2116514938931;657.5331514624575;639.1563136659564;639.354252205276;640.4204195203348;695.5861262548775;696.8432102776835;7815.25755053269;8057.476264042818;8142.267195952392;8172.959135204286;8188.918110818935;480.37551183462057;578.4186892173423;622.3993845938691;628.9654069026247;688.2119972631409;4070.3894415837863;4095.2423801596206;4113.239050775616;4156.8337266509;4172.582741725864;54236.45763542393;54300;54519.72740136353;54742.452575474534;55466;49652.50347496479;50328.49671503238;50479.49520504822;50535;50540.24189637158;44583.331250031275;45691;45824.312635310496;45931.77034114808;46396;7823.84352312962;8011.319037881845;8325.791855203668;8350.206730360605;8458.534780587126;33410.33179336448;33798.32403351968;34604.65395346115;34708.305833883685;34785.82607086949;43677.126457471306;43838.12323753443;43992;44039.77980110079;44064;10228.232882533692;10459.68620941373;10495.47522623881;10580.788384232426;10919.235653504178;11608.6517404478;11771;12141.75716485683;12270;12669.239845609292;10994.501256499956;10999.34003959765;11104.500297486471;11461.312321260752;11488.080953523531;10921.290116142425;11512.251703639236;11572.305661660328;11726.296422214695;12059.457324420247;11314.321140731583;11381.203315767816;11479.36863472517;11735.354555499529;11759.47082381312;9615.759606009626;9986.60053597848;10016.298859079794;10060.144887684628;10384.532696028848;8643.956780216058;8840.469571825712;8865.734027979172;9780.623386936724;9922 11:14:55 INFO - PROCESS | 21427 | __end_tp_report 11:14:55 INFO - PROCESS | 21427 | __start_cc_report 11:14:55 INFO - PROCESS | 21427 | _x_x_mozilla_cycle_collect,298 11:14:55 INFO - PROCESS | 21427 | __end_cc_report 11:14:55 INFO - PROCESS | 21427 | __startTimestamp1450984495010__endTimestamp 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | ------- Summary: start ------- 11:14:55 INFO - PROCESS | 21427 | Number of tests: 6 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#0] dojo.html Cycles:165 Average:5491.69 Median:5684.26 stddev:609.27 (10.7%) stddev-sans-first:584.03 11:14:55 INFO - PROCESS | 21427 | Values: 3200.9 3303.8 3312.6 3316.2 3319.3 5271.4 5544.5 5563.9 5586.2 5591.9 5535.3 5564.5 5581.4 5587.6 5591.5 5019.2 5059.7 5078.5 5084.2 5152.2 4993.6 5001.7 5006.9 5017.2 5054.7 4930.6 5048.1 5097.0 5104.5 5150.4 5046.2 5046.4 5063.3 5076.6 5090.1 5012.8 5023.3 5043.4 5075.5 5089.5 5221.6 5270.6 5325.4 5402.4 5412.9 5920.3 5984.4 5985.3 5996.6 6002.8 6005.5 6016.7 6024.8 6029.0 6031.6 5383.1 5443.9 5507.7 5548.9 5604.5 5960.3 6004.7 6049.2 6061.5 6112.3 5737.4 5793.4 5794.9 5799.3 5805.7 5754.5 5788.6 5869.5 5885.7 5928.9 5809.9 5861.5 5862.1 5882.5 5911.7 5734.9 5834.3 5851.3 5868.9 5874.4 4451.0 4501.1 4519.8 4522.5 4562.8 4032.4 4058.5 4080.3 4098.5 4119.4 5422.8 5491.5 5593.0 5612.2 5613.9 5896.2 5931.5 5974.8 6014.9 6019.6 5582.5 5582.5 5588.8 5593.0 5598.1 4918.4 5008.5 5129.6 5148.6 5195.8 6064.8 6135.2 6139.6 6139.9 6143.1 5903.3 5991.5 6003.1 6003.6 6054.7 5946.0 5986.1 6076.7 6176.6 6176.6 5756.4 5788.6 5799.6 5814.5 5958.7 5848.3 5870.2 5885.7 5887.8 5933.9 5684.3 5746.1 5773.9 5799.8 5918.8 5752.6 5769.5 5785.6 5815.9 5886.1 5625.9 5646.0 5660.1 5665.5 5675.4 5719.3 5722.3 5797.4 5827.1 5844.1 5659.0 5664.2 5691.9 5697.9 5761.8 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#1] ext.html Cycles:180 Average:47686.40 Median:38511.83 stddev:82012.31 (213.0%) stddev-sans-first:82166.11 11:14:55 INFO - PROCESS | 21427 | Values: 580.6 583.6 586.4 593.8 605.7 38526.2 39537.6 39653.8 39655.4 39667.8 42176.6 42223.2 42238.2 42324.0 42350.6 8644.5 8730.2 8789.6 8791.2 8801.3 8639.6 8675.0 8720.0 8726.3 8769.3 8569.4 8581.7 8656.7 8696.9 8698.2 8683.5 8710.0 8736.6 8747.9 8763.1 8497.3 8637.7 8644.4 8646.0 8666.1 38497.4 38914.8 38930.6 39030.4 39187.4 3297.6 3353.8 3601.1 3777.3 3980.1 29268.7 29339.9 29457.1 30439.7 30675.2 3439.5 3441.2 3620.7 3689.2 3880.5 271312.0 272718.0 272789.0 272876.0 272988.0 56535.0 57227.0 57908.7 58748.4 59398.7 55359.7 55817.8 55852.0 55901.4 55920.4 12765.9 12868.4 13053.0 13070.2 13092.1 9640.8 9725.9 9751.2 9764.0 9798.5 19863.0 20096.2 20130.7 20325.8 20377.0 7838.9 8056.0 8064.9 8082.3 8119.0 894.6 927.6 1039.2 1059.7 1080.3 27646.3 28360.9 28362.7 28725.1 28738.4 997.1 1007.4 1018.1 1107.8 1108.1 14147.8 14257.0 14363.7 14414.9 14491.9 370504.0 370693.0 373842.0 376093.0 376481.0 51269.7 51539.5 51657.7 51763.7 51787.2 1283.2 1286.1 1293.8 1295.0 1307.8 25829.0 26554.2 26835.9 27020.7 27197.7 41418.0 42169.6 42312.0 42350.4 42394.6 278684.0 282438.0 283039.0 283886.0 284131.0 31924.4 44992.1 45483.5 45614.5 46180.5 41814.4 42392.8 42518.1 42575.8 42709.6 36474.6 36757.3 37233.3 38368.2 42699.4 35795.5 36470.0 36972.0 37148.6 37469.4 35851.0 36377.1 36535.6 36562.6 36638.5 31946.8 32443.4 32734.5 33126.0 33186.0 24322.3 25115.9 26690.2 27029.5 27108.5 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#2] jquery.html Cycles:180 Average:27571.55 Median:4328.98 stddev:84448.32 (1950.8%) stddev-sans-first:84660.49 11:14:55 INFO - PROCESS | 21427 | Values: 356.0 361.1 361.8 363.8 365.1 16342.9 17542.5 17556.6 18071.5 18907.8 9867.6 10008.2 15950.0 16006.1 16098.9 5029.3 5300.6 5529.4 5560.6 5574.4 5475.0 5547.0 5547.5 5549.1 5552.7 5093.3 5103.1 5241.2 5336.4 5353.3 5281.6 5309.7 5311.0 5319.7 5378.7 5175.7 5367.8 5370.5 5371.8 5385.9 12016.3 12213.9 14625.9 19618.6 19680.5 1892.8 1914.7 1940.4 1968.6 2101.4 9750.7 9794.5 9804.9 9920.8 9933.2 1692.8 1842.2 1863.9 1877.0 1879.5 54631.0 54845.5 56159.7 56950.0 61561.0 9867.3 10002.1 10025.0 10047.8 10160.3 12825.6 12853.1 12916.4 12933.7 12952.9 6819.8 6835.6 6935.2 6968.8 7006.6 5932.4 5963.7 6299.7 6568.6 6676.2 4310.2 4347.7 4380.9 4438.8 4496.0 1828.1 1878.9 1886.4 1921.4 1942.6 416.9 423.2 435.1 446.6 462.8 10696.4 11215.9 11439.8 11453.6 11474.6 877.2 884.8 907.0 913.0 987.2 9062.5 9073.3 9082.5 9155.5 9226.0 501942.0 504065.0 511966.0 528012.0 533862.0 77739.0 81092.0 81111.0 81393.6 81662.2 1129.6 1138.4 1140.2 1140.8 1143.7 14541.4 14608.1 14640.6 14655.5 14796.3 32968.0 33079.2 33643.8 33664.0 33768.3 45765.3 48918.3 50083.7 50819.5 52414.0 9378.0 9574.3 9866.7 9870.5 9885.3 11499.5 11507.9 11903.8 17452.5 17570.1 13833.3 13876.2 13944.4 13963.2 14390.5 14177.2 14242.4 14318.5 14615.2 14819.5 13853.9 14057.9 14089.0 14157.6 14334.7 9760.5 9815.2 9835.3 9862.6 9877.2 10187.1 11714.8 13083.1 13647.2 13649.7 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#3] mootools.html Cycles:180 Average:5146.35 Median:6023.61 stddev:2629.41 (43.7%) stddev-sans-first:2622.28 11:14:55 INFO - PROCESS | 21427 | Values: 1471.6 1619.4 1643.1 1701.9 1752.7 6894.5 7193.5 7251.6 7372.9 7620.4 7488.0 7492.1 7510.4 7549.6 7568.7 2209.1 2233.3 2246.7 2250.4 2253.3 2208.6 2241.9 2281.1 2282.3 2288.2 2162.2 2182.6 2190.6 2205.6 2222.6 2190.8 2192.2 2239.9 2241.3 2253.7 2230.5 2254.8 2258.5 2265.4 2267.2 7463.7 7493.9 7508.9 7520.7 7527.7 4303.4 4364.2 4365.7 4370.3 4378.3 2896.9 2965.6 2972.1 2977.8 2988.5 960.1 985.4 989.0 990.3 1052.0 10064.1 10095.7 10134.2 10143.2 10170.7 3828.8 3869.2 3881.9 3924.8 3936.0 8222.1 8233.2 8240.3 8248.8 8252.1 4286.2 4287.5 4291.8 4293.8 4297.4 3927.2 3948.1 3961.7 3980.3 3989.0 3384.2 3397.2 3422.4 3435.8 3454.4 1024.1 1029.4 1032.2 1032.9 1033.3 954.5 962.9 1040.4 1069.4 1310.1 7008.2 7045.0 7064.2 7070.5 7091.5 1114.3 1115.4 1128.8 1130.2 1158.3 5544.1 5596.7 5610.1 5655.7 5676.8 8274.8 8641.4 8650.9 8752.5 8752.9 8485.3 8524.0 8569.7 8640.5 8662.5 6829.2 6863.6 7066.7 7101.0 7181.6 6851.6 6885.4 6895.8 6897.3 6897.7 7838.9 7974.2 8114.8 8131.8 8152.1 8191.4 8258.7 8312.1 8315.4 8366.7 6249.6 6319.4 6322.4 6396.0 6398.9 6770.0 6781.5 6818.8 6820.6 6846.3 6016.3 6481.3 6517.3 6588.3 6646.2 6451.2 6497.1 6535.5 6562.3 6647.5 6437.8 6465.6 6511.2 6532.3 6551.1 5909.4 5921.9 5968.3 5984.7 5986.8 5985.9 6030.9 6037.4 6053.7 6060.6 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#4] prototype.html Cycles:180 Average:5619.14 Median:6333.64 stddev:1726.90 (27.3%) stddev-sans-first:1685.49 11:14:55 INFO - PROCESS | 21427 | Values: 329.3 336.2 345.7 346.3 346.8 6280.2 6293.3 6319.7 6331.8 6477.1 6351.5 6373.3 6382.0 6386.0 6405.0 4745.6 4756.6 4783.2 4795.2 4803.9 4799.1 4805.7 4811.1 4811.3 4822.3 4648.0 4725.2 4744.6 4756.8 4758.8 4730.4 4737.3 4746.1 4752.0 4754.3 4059.5 4061.8 4066.1 4066.5 4072.9 6023.7 6025.4 6032.9 6038.0 6049.1 5409.4 5531.3 5532.8 5534.5 5537.9 6738.6 6775.9 6798.5 6809.5 6814.5 4492.8 4499.3 4504.5 4508.2 4514.7 6804.1 6972.1 7017.2 7067.9 7095.0 4733.1 4765.8 4772.9 4773.0 4775.3 4797.2 4800.7 4819.0 4820.3 4846.2 5585.4 5597.0 5601.8 5614.1 5618.3 6564.6 6740.3 6781.8 6809.0 6827.0 1659.1 1672.1 1698.8 1704.4 1708.7 1090.8 1098.9 1102.2 1106.8 1124.1 6268.3 6322.6 6332.5 6336.8 6344.3 6838.6 6862.6 6868.5 6877.7 6900.8 6180.9 6236.7 6292.6 6322.1 6334.8 3748.3 3765.7 3767.5 3768.7 3774.5 7188.0 7206.4 7215.6 7216.3 7218.4 7006.1 7095.6 7110.9 7115.9 7116.5 7336.4 7341.7 7354.0 7373.7 7374.0 7039.0 7052.8 7062.4 7075.0 7079.9 6786.6 6956.8 6959.8 6974.3 6982.3 7300.0 7316.4 7320.1 7323.6 7329.4 4638.6 4707.5 4709.8 4732.4 4734.6 6837.7 6899.2 6984.2 7033.4 7061.7 6681.2 6705.4 6751.4 6780.7 6791.7 6683.4 6724.0 6804.3 6817.4 6848.1 6607.6 6624.0 6673.2 6697.8 6715.6 6796.9 6802.1 6842.1 6866.6 6872.6 6642.1 6652.5 6653.1 6705.8 6741.2 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - PROCESS | 21427 | [#5] yui.html Cycles:180 Average:13480.76 Median:45878.04 stddev:15538.22 (33.9%) stddev-sans-first:15551.99 11:14:55 INFO - PROCESS | 21427 | Values: 662.2 679.5 709.7 744.3 873.7 13116.1 13435.9 13436.2 13460.8 13510.0 14430.1 14547.9 14580.3 14602.7 14663.0 735.4 736.2 762.5 776.1 780.4 765.7 770.5 771.1 773.0 776.1 803.3 809.0 810.6 811.5 813.6 799.4 799.9 802.2 802.6 803.9 590.7 592.1 592.3 595.2 595.7 12183.6 12191.6 12195.8 12296.3 12315.5 11668.2 11781.5 11994.4 12214.3 12483.3 10002.8 10108.7 10162.3 10174.8 10210.7 3371.0 3448.6 3477.5 3490.3 3493.9 46868.8 47086.8 47448.5 47460.3 47702.5 8940.4 9175.0 9543.2 9577.0 9589.9 16844.1 16859.9 16860.2 16877.0 16895.6 6718.2 7061.4 7076.7 7081.5 7094.4 4023.3 4114.6 4154.8 4258.7 4321.5 3033.0 3075.1 3079.6 3081.4 3092.9 559.0 561.8 563.6 633.2 657.5 639.2 639.4 640.4 695.6 696.8 7815.3 8057.5 8142.3 8173.0 8188.9 480.4 578.4 622.4 629.0 688.2 4070.4 4095.2 4113.2 4156.8 4172.6 54236.5 54300.0 54519.7 54742.5 55466.0 49652.5 50328.5 50479.5 50535.0 50540.2 44583.3 45691.0 45824.3 45931.8 46396.0 7823.8 8011.3 8325.8 8350.2 8458.5 33410.3 33798.3 34604.7 34708.3 34785.8 43677.1 43838.1 43992.0 44039.8 44064.0 10228.2 10459.7 10495.5 10580.8 10919.2 11608.7 11771.0 12141.8 12270.0 12669.2 10994.5 10999.3 11104.5 11461.3 11488.1 10921.3 11512.3 11572.3 11726.3 12059.5 11314.3 11381.2 11479.4 11735.4 11759.5 9615.8 9986.6 10016.3 10060.1 10384.5 8644.0 8840.5 8865.7 9780.6 9922.0 11:14:55 INFO - PROCESS | 21427 | -------- Summary: end -------- 11:14:55 INFO - PROCESS | 21427 | 11:14:55 INFO - TEST-INFO | 21427: exit 0 11:14:55 INFO - TEST-OK | dromaeo_css | took 1111121ms 11:14:55 INFO - TEST-START | kraken 11:14:55 INFO - operating with platform_type : linux_ 11:14:55 INFO - Initialising browser for kraken test... 11:14:55 INFO - TEST-INFO | started process 21665 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY5sZ2i/profile http://localhost:35590/getInfo.html) 11:15:00 INFO - PROCESS | 21665 | __metrics Screen width/height:1600/1200 11:15:00 INFO - PROCESS | 21665 | colorDepth:24 11:15:00 INFO - PROCESS | 21665 | Browser inner width/height: 1024/697 11:15:00 INFO - PROCESS | 21665 | __metrics 11:15:00 INFO - PROCESS | 21665 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:15:01 INFO - TEST-INFO | 21665: exit 0 11:15:01 INFO - Browser initialized. 11:15:01 INFO - Running cycle 1/1 for kraken test... 11:15:01 INFO - TEST-INFO | started process 21788 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY5sZ2i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:13 INFO - PROCESS | 21788 | RSS: Main: 149037056 11:15:13 INFO - PROCESS | 21788 | 11:15:15 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35590/tests/kraken/driver.html?testName=audio-beat-detection) 11:15:16 INFO - PROCESS | 21788 | RSS: Main: 150462464 11:15:16 INFO - PROCESS | 21788 | 11:15:19 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35590/tests/kraken/driver.html?testName=audio-dft) 11:15:19 INFO - PROCESS | 21788 | RSS: Main: 151072768 11:15:19 INFO - PROCESS | 21788 | 11:15:22 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35590/tests/kraken/driver.html?testName=audio-fft) 11:15:23 INFO - PROCESS | 21788 | RSS: Main: 145895424 11:15:23 INFO - PROCESS | 21788 | 11:15:25 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35590/tests/kraken/driver.html?testName=audio-oscillator) 11:15:25 INFO - PROCESS | 21788 | RSS: Main: 146006016 11:15:25 INFO - PROCESS | 21788 | 11:15:28 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:28 INFO - PROCESS | 21788 | RSS: Main: 147529728 11:15:28 INFO - PROCESS | 21788 | 11:15:31 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35590/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:32 INFO - PROCESS | 21788 | RSS: Main: 146485248 11:15:32 INFO - PROCESS | 21788 | 11:15:35 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35590/tests/kraken/driver.html?testName=imaging-desaturate) 11:15:36 INFO - PROCESS | 21788 | RSS: Main: 147537920 11:15:36 INFO - PROCESS | 21788 | 11:15:39 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35590/tests/kraken/driver.html?testName=json-parse-financial) 11:15:39 INFO - PROCESS | 21788 | RSS: Main: 146628608 11:15:39 INFO - PROCESS | 21788 | 11:15:41 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:15:41 INFO - PROCESS | 21788 | RSS: Main: 147906560 11:15:41 INFO - PROCESS | 21788 | 11:15:43 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:15:44 INFO - PROCESS | 21788 | RSS: Main: 148471808 11:15:44 INFO - PROCESS | 21788 | 11:15:46 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:15:46 INFO - PROCESS | 21788 | RSS: Main: 148766720 11:15:46 INFO - PROCESS | 21788 | 11:15:49 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:15:49 INFO - PROCESS | 21788 | RSS: Main: 146518016 11:15:49 INFO - PROCESS | 21788 | 11:15:52 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:15:53 INFO - PROCESS | 21788 | RSS: Main: 148422656 11:15:53 INFO - PROCESS | 21788 | 11:15:54 INFO - PROCESS | 21788 | Cycle 1(1): loaded http://localhost:35590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35590/tests/kraken/driver.html?testName=ai-astar) 11:15:55 INFO - PROCESS | 21788 | RSS: Main: 148090880 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | __start_tp_report 11:15:55 INFO - PROCESS | 21788 | _x_x_mozilla_page_load 11:15:55 INFO - PROCESS | 21788 | _x_x_mozilla_page_load_details 11:15:55 INFO - PROCESS | 21788 | |i|pagename|runs| 11:15:55 INFO - PROCESS | 21788 | |0;ai-astar;113;106;113;110;111;122;112;111;111;110 11:15:55 INFO - PROCESS | 21788 | |1;audio-beat-detection;151;124;153;173;126;162;153;129;166;125 11:15:55 INFO - PROCESS | 21788 | |2;audio-dft;162;163;163;165;161;162;163;163;173;163 11:15:55 INFO - PROCESS | 21788 | |3;audio-fft;74;73;74;74;73;73;141;71;73;72 11:15:55 INFO - PROCESS | 21788 | |4;audio-oscillator;93;94;138;92;94;93;136;92;94;147 11:15:55 INFO - PROCESS | 21788 | |5;imaging-gaussian-blur;110;111;109;110;109;110;110;110;111;111 11:15:55 INFO - PROCESS | 21788 | |6;imaging-darkroom;146;146;148;147;149;148;149;147;148;146 11:15:55 INFO - PROCESS | 21788 | |7;imaging-desaturate;99;95;96;97;96;95;95;97;95;96 11:15:55 INFO - PROCESS | 21788 | |8;json-parse-financial;60;60;62;60;60;60;61;62;61;60 11:15:55 INFO - PROCESS | 21788 | |9;json-stringify-tinderbox;70;69;70;69;71;70;69;69;68;70 11:15:55 INFO - PROCESS | 21788 | |10;stanford-crypto-aes;84;93;85;84;85;86;86;84;85;85 11:15:55 INFO - PROCESS | 21788 | |11;stanford-crypto-ccm;119;116;120;126;132;118;118;123;127;117 11:15:55 INFO - PROCESS | 21788 | |12;stanford-crypto-pbkdf2;146;150;165;151;144;140;164;146;156;147 11:15:55 INFO - PROCESS | 21788 | |13;stanford-crypto-sha256-iterative;69;71;71;71;68;68;67;69;70;68 11:15:55 INFO - PROCESS | 21788 | __end_tp_report 11:15:55 INFO - PROCESS | 21788 | __start_cc_report 11:15:55 INFO - PROCESS | 21788 | _x_x_mozilla_cycle_collect,714 11:15:55 INFO - PROCESS | 21788 | __end_cc_report 11:15:55 INFO - PROCESS | 21788 | __startTimestamp1450984555118__endTimestamp 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | ------- Summary: start ------- 11:15:55 INFO - PROCESS | 21788 | Number of tests: 14 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.07 (3.6%) stddev-sans-first:4.29 11:15:55 INFO - PROCESS | 21788 | Values: 113.0 106.0 113.0 110.0 111.0 122.0 112.0 111.0 111.0 110.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:18.62 (12.2%) stddev-sans-first:19.67 11:15:55 INFO - PROCESS | 21788 | Values: 151.0 124.0 153.0 173.0 126.0 162.0 153.0 129.0 166.0 125.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.39 (2.1%) stddev-sans-first:3.54 11:15:55 INFO - PROCESS | 21788 | Values: 162.0 163.0 163.0 165.0 161.0 162.0 163.0 163.0 173.0 163.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:21.52 (29.5%) stddev-sans-first:22.73 11:15:55 INFO - PROCESS | 21788 | Values: 74.0 73.0 74.0 74.0 73.0 73.0 141.0 71.0 73.0 72.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:22.97 (24.7%) stddev-sans-first:23.78 11:15:55 INFO - PROCESS | 21788 | Values: 93.0 94.0 138.0 92.0 94.0 93.0 136.0 92.0 94.0 147.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 11:15:55 INFO - PROCESS | 21788 | Values: 110.0 111.0 109.0 110.0 109.0 110.0 110.0 110.0 111.0 111.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:1.17 (0.8%) stddev-sans-first:1.13 11:15:55 INFO - PROCESS | 21788 | Values: 146.0 146.0 148.0 147.0 149.0 148.0 149.0 147.0 148.0 146.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.29 (1.3%) stddev-sans-first:0.83 11:15:55 INFO - PROCESS | 21788 | Values: 99.0 95.0 96.0 97.0 96.0 95.0 95.0 97.0 95.0 96.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 11:15:55 INFO - PROCESS | 21788 | Values: 60.0 60.0 62.0 60.0 60.0 60.0 61.0 62.0 61.0 60.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 11:15:55 INFO - PROCESS | 21788 | Values: 70.0 69.0 70.0 69.0 71.0 70.0 69.0 69.0 68.0 70.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:2.76 11:15:55 INFO - PROCESS | 21788 | Values: 84.0 93.0 85.0 84.0 85.0 86.0 86.0 84.0 85.0 85.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:121.50 stddev:5.23 (4.3%) stddev-sans-first:5.46 11:15:55 INFO - PROCESS | 21788 | Values: 119.0 116.0 120.0 126.0 132.0 118.0 118.0 123.0 127.0 117.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:150.50 stddev:8.35 (5.5%) stddev-sans-first:8.66 11:15:55 INFO - PROCESS | 21788 | Values: 146.0 150.0 165.0 151.0 144.0 140.0 164.0 146.0 156.0 147.0 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - PROCESS | 21788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.48 (2.1%) stddev-sans-first:1.56 11:15:55 INFO - PROCESS | 21788 | Values: 69.0 71.0 71.0 71.0 68.0 68.0 67.0 69.0 70.0 68.0 11:15:55 INFO - PROCESS | 21788 | -------- Summary: end -------- 11:15:55 INFO - PROCESS | 21788 | 11:15:55 INFO - TEST-INFO | 21788: exit 0 11:15:56 INFO - TEST-OK | kraken | took 60295ms 11:15:56 INFO - TEST-START | v8_7 11:15:56 INFO - operating with platform_type : linux_ 11:15:56 INFO - Initialising browser for v8_7 test... 11:15:56 INFO - TEST-INFO | started process 22076 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIEL2QZ/profile http://localhost:35590/getInfo.html) 11:16:00 INFO - PROCESS | 22076 | __metrics Screen width/height:1600/1200 11:16:00 INFO - PROCESS | 22076 | colorDepth:24 11:16:00 INFO - PROCESS | 22076 | Browser inner width/height: 1024/697 11:16:00 INFO - PROCESS | 22076 | __metrics 11:16:00 INFO - PROCESS | 22076 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:16:01 INFO - TEST-INFO | 22076: exit 0 11:16:01 INFO - Browser initialized. 11:16:01 INFO - Running cycle 1/1 for v8_7 test... 11:16:01 INFO - TEST-INFO | started process 22200 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIEL2QZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:13 INFO - PROCESS | 22200 | RSS: Main: 149045248 11:16:13 INFO - PROCESS | 22200 | 11:16:34 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:35590/tests/v8_7/run.html (next: http://localhost:35590/tests/v8_7/run.html) 11:16:35 INFO - PROCESS | 22200 | RSS: Main: 144879616 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | __start_tp_report 11:16:35 INFO - PROCESS | 22200 | _x_x_mozilla_page_load 11:16:35 INFO - PROCESS | 22200 | _x_x_mozilla_page_load_details 11:16:35 INFO - PROCESS | 22200 | |i|pagename|runs| 11:16:35 INFO - PROCESS | 22200 | |0;Richards;167.3080140538732 11:16:35 INFO - PROCESS | 22200 | |1;DeltaBlue;193.83601473153712 11:16:35 INFO - PROCESS | 22200 | |2;Encrypt;278.78449958182324 11:16:35 INFO - PROCESS | 22200 | |3;Decrypt;5164.948453608247 11:16:35 INFO - PROCESS | 22200 | |4;RayTrace;1031.9917440660474 11:16:35 INFO - PROCESS | 22200 | |5;Earley;709.7232079488999 11:16:35 INFO - PROCESS | 22200 | |6;Boyer;12216.867469879518 11:16:35 INFO - PROCESS | 22200 | |7;RegExp;25025 11:16:35 INFO - PROCESS | 22200 | |8;Splay;805.9581320450885 11:16:35 INFO - PROCESS | 22200 | |9;NavierStokes;4845.410628019324 11:16:35 INFO - PROCESS | 22200 | __end_tp_report 11:16:35 INFO - PROCESS | 22200 | __startTimestamp1450984595230__endTimestamp 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | ------- Summary: start ------- 11:16:35 INFO - PROCESS | 22200 | Number of tests: 10 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 167.3 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#1] DeltaBlue Cycles:1 Average:193.84 Median:193.84 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 193.8 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 278.8 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 5164.9 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#4] RayTrace Cycles:1 Average:1031.99 Median:1031.99 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 1032.0 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#5] Earley Cycles:1 Average:709.72 Median:709.72 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 709.7 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 12216.9 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 25025.0 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#8] Splay Cycles:1 Average:805.96 Median:805.96 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 806.0 11:16:35 INFO - PROCESS | 22200 | 11:16:35 INFO - PROCESS | 22200 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 11:16:35 INFO - PROCESS | 22200 | Values: 4845.4 11:16:35 INFO - PROCESS | 22200 | -------- Summary: end -------- 11:16:35 INFO - PROCESS | 22200 | 11:16:36 INFO - TEST-INFO | 22200: exit 0 11:16:36 INFO - TEST-OK | v8_7 | took 40144ms 11:16:36 INFO - SUITE-END | took 1211s 11:16:36 INFO - Completed test suite (00:20:11) 11:16:36 INFO - Working with test: dromaeo_css 11:16:36 INFO - Generating results file: dromaeo_css 11:16:36 INFO - Working with test: kraken 11:16:36 INFO - Generating results file: kraken 11:16:36 INFO - javascript benchmark 11:16:36 INFO - Working with test: v8_7 11:16:36 INFO - Generating results file: v8_7 11:16:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:16:36 INFO - process_Request line: dromaeo_css 6924.93 graph.html#tests=[[72,64,43]] 11:16:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:36 INFO - process_Request line: kraken 1520.10 graph.html#tests=[[232,64,43]] 11:16:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:16:36 INFO - process_Request line: v8_7 20816.15 graph.html#tests=[[230,64,43]] 11:16:36 INFO - RETURN: dromaeo_css: 6924.93 11:16:36 INFO - RETURN: kraken: 1520.10 11:16:36 INFO - RETURN: v8_7: 20816.15 11:16:36 INFO - javascript benchmark 11:16:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3200.919977000575, 3303.7687361884678, 3312.602487701476, 3316.1543806329396, 3319.2531680371912, 5271.42014378418, 5544.473275038875, 5563.86090347741, 5586.217929489864, 5591.944080559193, 5535.25274087998, 5564.527015203703, 5581.441855814416, 5587.552995760339, 5591.496765291123, 5019.196928491442, 5059.721715305656, 5078.5175408336145, 5084.211947148179, 5152.201408781626, 4993.6254780891395, 5001.699898006132, 5006.899862002758, 5017.222330538754, 5054.671446355994, 4930.580900623451, 5048.116579598593, 5097.006083813658, 5104.464031276718, 5150.381954165506, 5046.167382381903, 5046.394432668067, 5063.341765570489, 5076.64463487556, 5090.0583392072585, 5012.821986833092, 5023.296738456619, 5043.445221025684, 5075.51782580658, 5089.491050894918, 5221.634485586011, 5270.6047046471285, 5325.4142044375085, 5402.432744561843, 5412.864678383033, 5920.289565252154, 5984.431479009487, 5985.34161242263, 5996.550258730613, 6002.759889604411, 6005.54958378119, 6016.669083200422, 6024.78913238039, 6029.0052141397055, 6031.577789554733, 5383.084875571162, 5443.891122177613, 5507.7246137693355, 5548.861278468071, 5604.495595396434, 5960.254968128984, 6004.699765011819, 6049.153118563405, 6061.54538409621, 6112.2970858351855, 5737.3975732548315, 5793.391693872083, 5794.8551286217335, 5799.3040835100055, 5805.6806875621405, 5754.510866576305, 5788.594798364074, 5869.5010924071075, 5885.676287804126, 5928.851778705567, 5809.8547536311935, 5861.531077513789, 5862.091375836752, 5882.470577647947, 5911.674857882857, 5734.942650573525, 5834.299884013861, 5851.268591426072, 5868.882622347529, 5874.412558744177, 4451.043025749479, 4501.0547784964865, 4519.841805536857, 4522.5025247222775, 4562.817487300537, 4032.3749818778138, 4058.4521089652517, 4080.2859499587453, 4098.467199264077, 4119.443875076886, 5422.810201642924, 5491.533219676372, 5593.049181639131, 5612.158176273591, 5613.943860561342, 5896.233489646319, 5931.4958228550195, 5974.820755377345, 6014.879702405928, 6019.638821670714, 5582.49757521825, 5582.525485333711, 5588.804391846266, 5593.0, 5598.1322894951345, 4918.409790825124, 5008.499150084962, 5129.563987061141, 5148.639595228298, 5195.766190521435, 6064.848378790477, 6135.177648498111, 6139.592526148031, 6139.8601398601395, 6143.051335358963, 5903.26209223847, 5991.520678345809, 6003.099535069775, 6003.609765365237, 6054.666993315233, 5945.970270148621, 5986.102084687158, 6076.726547305293, 6176.629402235881, 6176.629402235881, 5756.42435756421, 5788.623739456922, 5799.623024503394, 5814.5348372130975, 5958.672273025025, 5848.298204215522, 5870.207521984477, 5885.676287804212, 5887.793927212527, 5933.902228087818, 5684.261046063985, 5746.109353050284, 5773.884522309614, 5799.82600521985, 5918.763249469973, 5752.626079304831, 5769.538436924952, 5785.623934444247, 5815.854603634943, 5886.146508756292, 5625.915611265752, 5646.0, 5660.122680984454, 5665.518430933252, 5675.432456754292, 5719.28508936383, 5722.2561067061015, 5797.391273916178, 5827.067669172912, 5844.12338149281, 5658.971705141613, 5664.207011018543, 5691.943080569141, 5697.8860422790485, 5761.798337058183], "unit": "score", "name": "dojo.html", "value": 5452.1067141174935}, {"lowerIsBetter": false, "replicates": [580.5993864233678, 583.5506659871899, 586.4018700925058, 593.7565598104778, 605.7243954000933, 38526.22947541051, 39537.60462395383, 39653.801730991305, 39655.40516892249, 39667.80166099169, 42176.578234217646, 42223.155536889244, 42238.15523689525, 42324.0, 42350.57649423505, 8644.5245511497, 8730.17063378978, 8789.64841406343, 8791.164839340252, 8801.251893589053, 8639.568021598927, 8675.045744968049, 8719.956400218021, 8726.258268047191, 8769.342299327544, 8569.442986205908, 8581.742547723577, 8656.740297791044, 8696.913030869706, 8698.217160455557, 8683.478991260514, 8710.041895391501, 8736.563171841382, 8747.868781968244, 8763.07987661296, 8497.320214382835, 8637.69768058115, 8644.438111522732, 8646.0, 8666.090060543615, 38497.422538661944, 38914.80542597269, 38930.61069389298, 39030.414543781866, 39187.412188817194, 3297.6453934645233, 3353.765236433451, 3601.099725068733, 3777.301199278115, 3980.0845805464614, 29268.70731292681, 29339.919308472516, 29457.11628651144, 30439.695603043907, 30675.2331191722, 3439.501272315525, 3441.174118211636, 3620.7103431725664, 3689.1699367642336, 3880.4567360569545, 271312.0, 272718.0, 272789.0, 272876.0, 272988.0, 56535.0, 57227.0, 57908.710456448294, 58748.4125158743, 59398.70300648469, 55359.723201383735, 55817.76728930879, 55852.0, 55901.44098559044, 55920.44079559152, 12765.936170319275, 12868.420921058574, 13053.021023423282, 13070.150440221545, 13092.083554151119, 9640.807183856283, 9725.854112188323, 9751.171150452292, 9763.951180244054, 9798.510074496247, 19863.0, 20096.19615215375, 20130.69803952942, 20325.79674203239, 20377.0, 7838.882416763753, 8056.0, 8064.879026814602, 8082.343119660455, 8119.0, 894.6019021535354, 927.638221093774, 1039.1790485516358, 1059.708580140452, 1080.346390433792, 27646.308842279104, 28360.85819570889, 28362.71637283642, 28725.138245852657, 28738.425231495254, 997.07272236819, 1007.3502590828874, 1018.0582960761266, 1107.7839821234943, 1108.107973081677, 14147.787783183261, 14257.0, 14363.712725745427, 14414.855851441562, 14491.855081449261, 370504.0, 370693.0, 373842.0, 376093.0, 376481.0, 51269.743651281504, 51539.48460515347, 51657.7417112912, 51763.74118129461, 51787.223191652156, 1283.2428866968346, 1286.1254347043912, 1293.780057390246, 1295.0, 1307.7646023715822, 25829.0, 26554.203373898814, 26835.865820670773, 27020.729792701823, 27197.728022720312, 41418.0, 42169.578304216564, 42312.0, 42350.36474452824, 42394.57605424029, 278684.0, 282438.0, 283039.0, 283886.0, 284131.0, 31924.36151277008, 44992.100157996, 45483.54516454793, 45614.54385456103, 46180.53819461897, 41814.37278440765, 42392.788036060854, 42518.14963700771, 42575.787121065434, 42709.5729042718, 36474.635253648186, 36757.26485470329, 37233.25533489369, 38368.2326353477, 42699.35950960676, 35795.46306805452, 36470.0, 36972.0, 37148.62851371452, 37469.4379584301, 35851.0, 36377.090572734836, 36535.634643653226, 36562.63437365699, 36638.450423244205, 31946.84026579852, 32443.351132976735, 32734.50898236481, 33126.0, 33186.0, 24322.27033189007, 25115.87442062778, 26690.19929402121, 27029.459410812065, 27108.45783084367], "unit": "score", "name": "ext.html", "value": 18421.152038419863}, {"lowerIsBetter": false, "replicates": [355.9537260156179, 361.09905785066263, 361.78112242093533, 363.7708243806402, 365.11095482500116, 16342.918285408572, 17542.473725788215, 17556.56108597284, 18071.548211294725, 18907.810921890796, 9867.5559599818, 10008.249381296413, 15950.0, 16006.119663418507, 16098.919505402486, 5029.346184995946, 5300.628955973083, 5529.391766905637, 5560.582956278275, 5574.358948720908, 5474.972625136868, 5546.972265138689, 5547.500724934755, 5549.139883318092, 5552.694601796899, 5093.312402825627, 5103.106956282654, 5241.213817927303, 5336.43967383423, 5353.250544923714, 5281.577473802125, 5309.681419114865, 5311.0, 5319.707416092114, 5378.650387724805, 5175.715335656538, 5367.838964831061, 5370.489803468664, 5371.838844834661, 5385.892282154335, 12016.339101349422, 12213.938930305381, 14625.903057270642, 19618.607627847505, 19680.50798730029, 1892.829645331913, 1914.74150989616, 1940.3790786948182, 1968.6456437841182, 2101.3905967269475, 9750.658726944523, 9794.461304628243, 9804.852927206097, 9920.751981200456, 9933.205343572497, 1692.8222536633723, 1842.1526097994938, 1863.9347622833136, 1876.9718454223198, 1879.473747350744, 54631.0, 54845.45154548444, 56159.71920140414, 56950.0, 61561.0, 9867.259955503367, 10002.099811017044, 10024.997500249916, 10047.849282260771, 10160.33957792741, 12825.615231543068, 12853.100282980102, 12916.41876115577, 12933.741325173443, 12952.870471295355, 6819.829504262334, 6835.624040677811, 6935.202451718016, 6968.79093627192, 7006.649667516604, 5932.40675932412, 5963.731632076567, 6299.6535190564955, 6568.6058836469965, 6676.165479315086, 4310.245707001262, 4347.7173983690955, 4380.934285985712, 4438.800253988578, 4495.955040449554, 1828.1133650179652, 1878.9060546972871, 1886.4057821786093, 1921.4331772127257, 1942.553212761073, 416.8951192646068, 423.20437577354375, 435.0580992152019, 446.6069858524478, 462.77555385637936, 10696.358218506915, 11215.887841121485, 11439.771204576029, 11453.59912403062, 11474.598389056342, 877.2148926710686, 884.7743825324501, 906.9546522673971, 912.9543522823832, 987.2398253345028, 9062.50156241413, 9073.274138068939, 9082.500462474494, 9155.450672959643, 9226.0, 501942.0, 504065.0, 511966.0, 528012.0, 533862.0, 77739.0, 81092.0, 81111.0, 81393.59303203564, 81662.18337816665, 1129.6215767717742, 1138.3738943580997, 1140.2303445174473, 1140.7604403075447, 1143.7426579019655, 14541.418343266574, 14608.123512589278, 14640.560783176521, 14655.48705795292, 14796.260186990392, 32968.0, 33079.17302067467, 33643.822466214544, 33664.0, 33768.324633507684, 45765.31352029656, 48918.26622600593, 50083.74958125186, 50819.49180508296, 52414.0, 9378.015308392793, 9574.32979691415, 9866.703998880044, 9870.506474676382, 9885.258605604464, 11499.54001839917, 11507.94246028798, 11903.821442678194, 17452.469391938354, 17570.121493925, 13833.30833458303, 13876.167429954236, 13944.442222310994, 13963.162210267417, 14390.496332628307, 14177.220252885778, 14242.359093841009, 14318.498852540528, 14615.196164210645, 14819.481318153812, 13853.930730346687, 14057.859421405656, 14089.0, 14157.575272741835, 14334.713305733618, 9760.511974401394, 9815.165710914367, 9835.262355323237, 9862.605495780088, 9877.209823214269, 10187.083162515113, 11714.824277635671, 13083.149595276658, 13647.181169129884, 13649.658758531115], "unit": "score", "name": "jquery.html", "value": 8309.243687857852}, {"lowerIsBetter": false, "replicates": [1471.6247356923996, 1619.4331983805669, 1643.1127191316682, 1701.9404320848769, 1752.7195648696206, 6894.517383783137, 7193.532420392671, 7251.601161936092, 7372.889406658905, 7620.390368770485, 7487.962560187191, 7492.100947886248, 7510.361619262356, 7549.584772837492, 7568.735094271701, 2209.0501084533603, 2233.251860626684, 2246.6854640350366, 2250.3811451850706, 2253.278950735765, 2208.55828834233, 2241.8766967816764, 2281.1445707859552, 2282.338121944634, 2288.199130304397, 2162.23240749534, 2182.563487302538, 2190.5837890800776, 2205.59196548639, 2222.6443768996965, 2190.835687323457, 2192.2217612747404, 2239.9328020159423, 2241.3051953894264, 2253.7182852143565, 2230.4869879927705, 2254.7519772824976, 2258.5144193998367, 2265.4223173090754, 2267.183813827021, 7463.664135113933, 7493.925060749431, 7508.887366689504, 7520.736774212876, 7527.698892044312, 4303.419038429804, 4364.236258654722, 4365.672574556889, 4370.344448332744, 4378.321360189176, 2896.8551572421507, 2965.555166724987, 2972.078655616766, 2977.7766667500023, 2988.5367767995995, 960.0543464687278, 985.3742873275521, 989.0258095775655, 990.2919412620012, 1052.026875140492, 10064.14454771338, 10095.697129086138, 10134.239932005055, 10143.23925705575, 10170.745731356701, 3828.8085595720104, 3869.2454971280895, 3881.86413475527, 3924.823382947774, 3935.960640393617, 8222.136675648972, 8233.17668233172, 8240.299574536231, 8248.83502329962, 8252.05101413333, 4286.249906266391, 4287.485501739811, 4291.806868690916, 4293.785310734514, 4297.39836422901, 3927.2145570885937, 3948.0919388540797, 3961.6830653547645, 3980.343243364812, 3989.0226894411053, 3384.1877949291993, 3397.2016576104597, 3422.418188907892, 3435.7766745161484, 3454.4127498325347, 1024.1192574386023, 1029.4080903480378, 1032.210359075308, 1032.912202462784, 1033.2818691009677, 954.5465903695689, 962.8748262725801, 1040.427764729396, 1069.4064794039382, 1310.0829419406455, 7008.229094799568, 7044.964775176194, 7064.152301723826, 7070.540414873017, 7091.503594748421, 1114.2924243105685, 1115.3921112993437, 1128.8081026225561, 1130.152385710717, 1158.2760774515928, 5544.140658197985, 5596.664200148004, 5610.13042978339, 5655.717214139277, 5676.77292908279, 8274.8345033099, 8641.351898607629, 8650.87023694645, 8752.47485150893, 8752.912470875337, 8485.32117430604, 8523.957380213184, 8569.742907712778, 8640.481571105754, 8662.523561204194, 6829.180498340231, 6863.553868998499, 7066.6819993100435, 7100.9644951775945, 7181.6409179540815, 6851.623160726208, 6885.414739747178, 6895.793126206222, 6897.310268973263, 6897.689603967934, 7838.882416763867, 7974.202579741979, 8114.797130071795, 8131.7560473185895, 8152.144024877302, 8191.426600137933, 8258.710945116893, 8312.085670576353, 8315.417920745731, 8366.707165249187, 6249.593776404519, 6319.431251187415, 6322.399372059647, 6396.0405939109505, 6398.93601064002, 6769.966150169218, 6781.491388145811, 6818.795436136924, 6820.590764554143, 6846.315368463114, 6016.278046634432, 6481.319461456479, 6517.283098859027, 6588.341165883373, 6646.169228846395, 6451.1936007999, 6497.122888410004, 6535.477161826947, 6562.278149403657, 6647.4682025438815, 6437.806865794034, 6465.644389558432, 6511.218653761579, 6532.281449040506, 6551.082848401323, 5909.409059094056, 5921.881562368814, 5968.253968253968, 5984.730687119177, 5986.820395388146, 5985.880282394241, 6030.944584697572, 6037.426444487766, 6053.697315134137, 6060.636361818305], "unit": "score", "name": "mootools.html", "value": 4258.6224230106445}, {"lowerIsBetter": false, "replicates": [329.28052205930044, 336.15457125329795, 345.6906069068184, 346.33158005050245, 346.83525325470407, 6280.152179455772, 6293.27627322858, 6319.6524191169465, 6331.841703957398, 6477.060826180201, 6351.491880649549, 6373.298937116913, 6381.999999999988, 6386.0, 6404.96797516013, 4745.57289843914, 4756.643251756115, 4783.234682450809, 4795.160846851787, 4803.903921921559, 4799.112164249607, 4805.735684537349, 4811.061842940628, 4811.30236115763, 4822.300766388871, 4647.953520464803, 4725.196716558176, 4744.620430365562, 4756.785944632483, 4758.78585463655, 4730.361401210844, 4737.265723812815, 4746.050789842046, 4751.95248047522, 4754.286856971482, 4059.512858457004, 4061.8375264989363, 4066.1257829566784, 4066.4916885389325, 4072.938905916384, 6023.668698221596, 6025.397460253939, 6032.909506357408, 6037.969810150921, 6049.062395328687, 5409.43200963901, 5531.280933478622, 5532.75102620383, 5534.4742249486235, 5537.889242215173, 6738.561993470409, 6775.932240677579, 6798.490113241527, 6809.455243580502, 6814.522983391164, 4492.775361231958, 4499.302608095718, 4504.481984571784, 4508.233600287959, 4514.706544074625, 6804.08144900442, 6972.058772065757, 7017.157941047056, 7067.89398159028, 7095.042169307129, 4733.077049975291, 4765.761711914391, 4772.880677983008, 4772.952270477251, 4775.2598347256235, 4797.232442809134, 4800.703809971288, 4818.951810481921, 4820.276958456189, 4846.248831431134, 5585.441455854382, 5597.020521408818, 5601.831945041656, 5614.073677843192, 5618.297712785902, 6564.606123632598, 6740.258571557223, 6781.796546103625, 6808.965955170292, 6826.965865170741, 1659.1289572974285, 1672.1388484930271, 1698.7791587093598, 1704.4119778676336, 1708.6668099720684, 1090.8091084060259, 1098.873629532598, 1102.1733699725205, 1106.7841770854607, 1124.128800179867, 6268.279147897959, 6322.589031713016, 6332.4934005279465, 6336.778212762531, 6344.270408902943, 6838.555493892881, 6862.622555759481, 6868.519203655696, 6877.65611719422, 6900.827479313058, 6180.876382472416, 6236.688165591702, 6292.622442653455, 6322.083297921776, 6334.778282760081, 3748.306563285801, 3765.7363984521367, 3767.472553842464, 3768.6796622286865, 3774.5470543534952, 7188.0, 7206.387457066208, 7215.5670659759535, 7216.314450127229, 7218.3503484686635, 7006.0892084029765, 7095.645217739092, 7110.92889071113, 7115.857682846314, 7116.5018448709125, 7336.413086953137, 7341.74303899361, 7353.963230183922, 7373.741919032916, 7373.963130184422, 7039.0, 7052.823679408056, 7062.3996960258955, 7075.0, 7079.929200707927, 6786.558873673195, 6956.79129626112, 6959.791206263821, 6974.302569743188, 6982.301769822977, 7299.963500182465, 7316.366108200937, 7320.121585409572, 7323.597202153933, 7329.413646908128, 4638.5593368629925, 4707.529247075265, 4709.81160753566, 4732.408448943882, 4734.573888349927, 6837.692303846438, 6899.20659124187, 6984.231734509099, 7033.366996970297, 7061.682224299816, 6681.198256209092, 6705.396514313735, 6751.392374686302, 6780.72877084911, 6791.694373753292, 6683.365080317362, 6724.0, 6804.285550017177, 6817.352351526597, 6848.1097457330225, 6607.57050791697, 6623.973284140966, 6673.165854268216, 6697.765578204934, 6715.56348837324, 6796.898046529405, 6802.115724955724, 6842.0763196969765, 6866.622335771581, 6872.553284036521, 6642.103316052464, 6652.467802575879, 6653.135092437952, 6705.798826035227, 6741.22475915276], "unit": "score", "name": "prototype.html", "value": 5050.721861312755}, {"lowerIsBetter": false, "replicates": [662.2417332154683, 679.4971720926516, 709.7409445552375, 744.3115118515371, 873.7335112790598, 13116.147450415729, 13435.932820335885, 13436.193828370304, 13460.798088028663, 13510.0, 14430.062045967004, 14547.854521454783, 14580.343884525195, 14602.707945841077, 14663.046901951393, 735.3602365941638, 736.2159300345129, 762.5005621318046, 776.0997243197892, 780.379598219417, 765.6592816196795, 770.4914756260869, 771.0670089192084, 773.0452890680006, 776.0687175389527, 803.2529747334976, 808.9959550202241, 810.6109067647533, 811.5171472973572, 813.6175997281298, 799.4164260090108, 799.9000124984348, 802.1537278171527, 802.5826570183531, 803.8954935858301, 590.6898878088995, 592.0881841963371, 592.2715060475639, 595.2291782142094, 595.6694034810679, 12183.634490965285, 12191.634250972485, 12195.817062744067, 12296.262224266484, 12315.5073797048, 11668.1832271741, 11781.469833857496, 11994.400279985966, 12214.267143971301, 12483.251004939733, 10002.849957250646, 10108.747281317952, 10162.288639795217, 10174.796504069951, 10210.693679189637, 3370.9767367750287, 3448.586169659657, 3477.530533377987, 3490.336836001177, 3493.8777142800136, 46868.76565617184, 47086.76456617729, 47448.52551474475, 47460.28809567825, 47702.52297477015, 8940.418872773249, 9175.0, 9543.188828949478, 9576.994415586403, 9589.856152157723, 16844.07357595344, 16859.915700421418, 16860.156992150343, 16877.0, 16895.577610559587, 6718.160229971254, 7061.364477197077, 7076.681549330293, 7081.539699919592, 7094.432445404355, 4023.295923213426, 4114.6091121343425, 4154.771487568152, 4258.659307255412, 4321.524632290446, 3032.9848350758107, 3075.0774767570088, 3079.615048118985, 3081.445339838806, 3092.8608212630484, 558.9720513974285, 561.7809054468761, 563.5829486180279, 633.2116514938931, 657.5331514624575, 639.1563136659564, 639.354252205276, 640.4204195203348, 695.5861262548775, 696.8432102776835, 7815.25755053269, 8057.476264042818, 8142.267195952392, 8172.959135204286, 8188.918110818935, 480.37551183462057, 578.4186892173423, 622.3993845938691, 628.9654069026247, 688.2119972631409, 4070.3894415837863, 4095.2423801596206, 4113.239050775616, 4156.8337266509, 4172.582741725864, 54236.45763542393, 54300.0, 54519.72740136353, 54742.452575474534, 55466.0, 49652.50347496479, 50328.49671503238, 50479.49520504822, 50535.0, 50540.24189637158, 44583.331250031275, 45691.0, 45824.312635310496, 45931.77034114808, 46396.0, 7823.84352312962, 8011.319037881845, 8325.791855203668, 8350.206730360605, 8458.534780587126, 33410.33179336448, 33798.32403351968, 34604.65395346115, 34708.305833883685, 34785.82607086949, 43677.126457471306, 43838.12323753443, 43992.0, 44039.77980110079, 44064.0, 10228.232882533692, 10459.68620941373, 10495.47522623881, 10580.788384232426, 10919.235653504178, 11608.6517404478, 11771.0, 12141.75716485683, 12270.0, 12669.239845609292, 10994.501256499956, 10999.34003959765, 11104.500297486471, 11461.312321260752, 11488.080953523531, 10921.290116142425, 11512.251703639236, 11572.305661660328, 11726.296422214695, 12059.457324420247, 11314.321140731583, 11381.203315767816, 11479.36863472517, 11735.354555499529, 11759.47082381312, 9615.759606009626, 9986.60053597848, 10016.298859079794, 10060.144887684628, 10384.532696028848, 8643.956780216058, 8840.469571825712, 8865.734027979172, 9780.623386936724, 9922.0], "unit": "score", "name": "yui.html", "value": 6143.110512580403}], "name": "dromaeo_css", "value": 6924.92756850741}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 113.0, 110.0, 111.0, 122.0, 112.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 153.0, 173.0, 126.0, 162.0, 153.0, 129.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 165.0, 161.0, 162.0, 163.0, 163.0, 173.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 74.0, 73.0, 73.0, 141.0, 71.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 138.0, 92.0, 94.0, 93.0, 136.0, 92.0, 94.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 147.0, 149.0, 148.0, 149.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [99.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 62.0, 61.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 69.0, 71.0, 70.0, 69.0, 69.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [84.0, 93.0, 85.0, 84.0, 85.0, 86.0, 86.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 120.0, 126.0, 132.0, 118.0, 118.0, 123.0, 127.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [146.0, 150.0, 165.0, 151.0, 144.0, 140.0, 164.0, 146.0, 156.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 71.0, 68.0, 68.0, 67.0, 69.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1520.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [193.83601473153712], "unit": "score", "name": "DeltaBlue", "value": 341.1027619999999}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1031.9917440660474], "unit": "score", "name": "RayTrace", "value": 717.049341}, {"lowerIsBetter": false, "replicates": [709.7232079488999], "unit": "score", "name": "Earley", "value": 939.0463669999997}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [805.9581320450885], "unit": "score", "name": "Splay", "value": 101.11071128871131}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20816.154159642607}]} 11:16:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20816.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6924.93"}}} 11:16:36 INFO - Return code: 0 11:16:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:16:36 INFO - # TBPL SUCCESS # 11:16:36 INFO - Running post-action listener: _resource_record_post_action 11:16:36 INFO - Running post-run listener: _resource_record_post_run 11:16:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558403584; Read time: 20; Write time: 646808 11:16:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 239357952; Read time: 0; Write time: 446252 11:16:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319045632; Read time: 20; Write time: 200556 11:16:37 INFO - Running post-run listener: _upload_blobber_files 11:16:37 INFO - Blob upload gear active. 11:16:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:16:37 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 11:16:37 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:16:37 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:16:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:38 INFO - (blobuploader) - INFO - Done attempting. 11:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:39 INFO - (blobuploader) - INFO - Done attempting. 11:16:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:39 INFO - Return code: 0 11:16:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:16:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd75ea11d89e892df53910b3438b0a893b651236d487e36222eb64dd09d82c240a5a092eccd13122715411b9e2c5e1f5e9a7a3f7b66c88a6a0df48be1d3084f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adcb54914ed7771294b18fb70b5adbc292389bd8809e094c5a608074d93ee950b53edba0e1baa3d5c4862bc19f6636f06ae6656b128634a59b37b7714a32e74b"} 11:16:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:16:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:16:39 INFO - Contents: 11:16:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd75ea11d89e892df53910b3438b0a893b651236d487e36222eb64dd09d82c240a5a092eccd13122715411b9e2c5e1f5e9a7a3f7b66c88a6a0df48be1d3084f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adcb54914ed7771294b18fb70b5adbc292389bd8809e094c5a608074d93ee950b53edba0e1baa3d5c4862bc19f6636f06ae6656b128634a59b37b7714a32e74b"} 11:16:39 INFO - Copying logs to upload dir... 11:16:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.054801 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-24 11:16:39.173001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 11:16:39.176828) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd75ea11d89e892df53910b3438b0a893b651236d487e36222eb64dd09d82c240a5a092eccd13122715411b9e2c5e1f5e9a7a3f7b66c88a6a0df48be1d3084f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adcb54914ed7771294b18fb70b5adbc292389bd8809e094c5a608074d93ee950b53edba0e1baa3d5c4862bc19f6636f06ae6656b128634a59b37b7714a32e74b"} build_url:https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd75ea11d89e892df53910b3438b0a893b651236d487e36222eb64dd09d82c240a5a092eccd13122715411b9e2c5e1f5e9a7a3f7b66c88a6a0df48be1d3084f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adcb54914ed7771294b18fb70b5adbc292389bd8809e094c5a608074d93ee950b53edba0e1baa3d5c4862bc19f6636f06ae6656b128634a59b37b7714a32e74b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 11:16:39.205599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 11:16:39.206423) ========= 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=01deea79d00cc2c334834894000001d2-1450983333.334706-1883191274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 11:16:39.288682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 11:16:39.289192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 11:16:39.289624) ========= ========= Total master_lag: 0.24 =========