builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1451393510.2 results: success (0) buildid: 20151229023006 builduid: e65b0f7f08304a169fb6eaed3ff44046 revision: 0eef62c740a78b1bbf5a8d516e6207703209e705 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.203895) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.204395) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.204713) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.230895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.231198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.250203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.250628) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.299992) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.300281) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.300690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.300960) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 04:51:51-- 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% 42.8M=0s 2015-12-29 04:51:51 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.481541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.794860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.795272) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019600 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.845713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:50.846209) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0eef62c740a78b1bbf5a8d516e6207703209e705 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0eef62c740a78b1bbf5a8d516e6207703209e705 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 04:51:51,868 truncating revision to first 12 chars 2015-12-29 04:51:51,868 Setting DEBUG logging. 2015-12-29 04:51:51,868 attempt 1/10 2015-12-29 04:51:51,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0eef62c740a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 04:51:52,113 unpacking tar archive at: b2g-inbound-0eef62c740a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:51.390700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:51.391060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:51.400389) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:51.400786) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 04:51:51.401251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-29 04:51:51.401586) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:52 INFO - MultiFileLogger online at 20151229 04:51:52 in /builds/slave/test-pgo 04:51:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:51:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:51:52 INFO - {'append_to_log': False, 04:51:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:51:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:51:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:51:52 INFO - 'branch': 'B2G-Inbound', 04:51:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:52 INFO - 'config_files': ('talos/linux_config.py',), 04:51:52 INFO - 'default_actions': ('clobber', 04:51:52 INFO - 'read-buildbot-config', 04:51:52 INFO - 'download-and-extract', 04:51:52 INFO - 'populate-webroot', 04:51:52 INFO - 'create-virtualenv', 04:51:52 INFO - 'install', 04:51:52 INFO - 'run-tests'), 04:51:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:52 INFO - 'download_minidump_stackwalk': True, 04:51:52 INFO - 'download_symbols': 'ondemand', 04:51:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:52 INFO - 'installer_path': 'installer.exe', 04:51:52 INFO - 'log_level': 'info', 04:51:52 INFO - 'log_name': 'talos', 04:51:52 INFO - 'log_to_console': True, 04:51:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:52 INFO - 'opt_config_files': (), 04:51:52 INFO - 'pip_index': False, 04:51:52 INFO - 'sps_profile': False, 04:51:52 INFO - 'sps_profile_interval': 0, 04:51:52 INFO - 'suite': 'dromaeojs', 04:51:52 INFO - 'system_bits': '32', 04:51:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:52 INFO - 'title': 'talos-linux64-ix-048', 04:51:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:52 INFO - 'use_talos_json': True, 04:51:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:51:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:52 INFO - 'work_dir': 'build'} 04:51:52 INFO - ##### 04:51:52 INFO - ##### Running clobber step. 04:51:52 INFO - ##### 04:51:52 INFO - Running pre-action listener: _resource_record_pre_action 04:51:52 INFO - Running main action method: clobber 04:51:52 INFO - rmtree: /builds/slave/test-pgo/build 04:51:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:51:52 INFO - Running post-action listener: _resource_record_post_action 04:51:52 INFO - ##### 04:51:52 INFO - ##### Running read-buildbot-config step. 04:51:52 INFO - ##### 04:51:52 INFO - Running pre-action listener: _resource_record_pre_action 04:51:52 INFO - Running main action method: read_buildbot_config 04:51:52 INFO - Using buildbot properties: 04:51:52 INFO - { 04:51:52 INFO - "project": "", 04:51:52 INFO - "product": "firefox", 04:51:52 INFO - "script_repo_revision": "production", 04:51:52 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:51:52 INFO - "repository": "", 04:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:51:52 INFO - "buildid": "20151229023006", 04:51:52 INFO - "pgo_build": "True", 04:51:52 INFO - "basedir": "/builds/slave/test-pgo", 04:51:52 INFO - "buildnumber": 2, 04:51:52 INFO - "slavename": "talos-linux64-ix-048", 04:51:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:51:52 INFO - "platform": "ubuntu64_hw", 04:51:52 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:51:52 INFO - "branch": "b2g-inbound", 04:51:52 INFO - "repo_path": "integration/b2g-inbound", 04:51:52 INFO - "revision": "0eef62c740a78b1bbf5a8d516e6207703209e705", 04:51:52 INFO - "stage_platform": "linux64-pgo", 04:51:52 INFO - "builduid": "e65b0f7f08304a169fb6eaed3ff44046", 04:51:52 INFO - "slavebuilddir": "test" 04:51:52 INFO - } 04:51:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:51:52 INFO - Running post-action listener: _resource_record_post_action 04:51:52 INFO - ##### 04:51:52 INFO - ##### Running download-and-extract step. 04:51:52 INFO - ##### 04:51:52 INFO - Running pre-action listener: _resource_record_pre_action 04:51:52 INFO - Running main action method: download_and_extract 04:51:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:52 INFO - https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/test_packages.json 04:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/test_packages.json 04:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:51:56 INFO - Downloaded 1302 bytes. 04:51:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:51:56 INFO - Using the following test package requirements: 04:51:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:51:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'jsshell-linux-x86_64.zip'], 04:51:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:51:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:51:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:51:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:51:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:51:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:51:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:51:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:56 INFO - https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:51:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:51:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:51:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:00 INFO - Downloaded 23192593 bytes. 04:52:00 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 04:52:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:00 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 04:52:02 INFO - Return code: 0 04:52:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:02 INFO - https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:03 INFO - Downloaded 23192593 bytes. 04:52:03 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 04:52:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:52:03 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 04:52:04 INFO - Return code: 0 04:52: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')]} 04:52:04 INFO - https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:52:05 INFO - Downloaded 11132270 bytes. 04:52:05 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 04:52:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:05 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 04:52:05 INFO - Return code: 0 04:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:05 INFO - https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:52:07 INFO - Downloaded 54894591 bytes. 04:52:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:07 INFO - mkdir: /builds/slave/test-pgo/properties 04:52:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:52:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:52:07 INFO - Contents: 04:52:07 INFO - build_url:https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:52:07 INFO - Running post-action listener: _resource_record_post_action 04:52:07 INFO - Running post-action listener: set_extra_try_arguments 04:52:07 INFO - ##### 04:52:07 INFO - ##### Running populate-webroot step. 04:52:07 INFO - ##### 04:52:07 INFO - Running pre-action listener: _resource_record_pre_action 04:52:07 INFO - Running main action method: populate_webroot 04:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:07 INFO - '--tppagecycles', 04:52:07 INFO - '7'], 04:52:07 INFO - 'tests': ['tsvgm']}}, 04:52:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:52:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:52:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'tests': ['damp', 'tps']}, 04:52:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['damp', 'tps']}, 04:52:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:07 INFO - 'other': {'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'other_l64': {'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'other_nol64': {'tests': ['a11yr', 04:52:07 INFO - 'ts_paint', 04:52:07 INFO - 'tpaint', 04:52:07 INFO - 'sessionrestore', 04:52:07 INFO - 'sessionrestore_no_auto_restore']}, 04:52:07 INFO - 'svgr': {'tests': ['tsvgx', 04:52:07 INFO - 'tsvgr_opacity', 04:52:07 INFO - 'tart', 04:52:07 INFO - 'tscrollx', 04:52:07 INFO - 'cart']}, 04:52:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['tsvgx', 04:52:07 INFO - 'tsvgr_opacity', 04:52:07 INFO - 'tart', 04:52:07 INFO - 'tscrollx', 04:52:07 INFO - 'cart']}, 04:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'tests': ['tp5o']}, 04:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'talos_options': ['--e10s'], 04:52:07 INFO - 'tests': ['tp5o']}, 04:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'talos_options': ['--xperf_path', 04:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:07 INFO - 'tests': ['tp5n']}, 04:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:07 INFO - 'talos_options': ['--e10s', 04:52:07 INFO - '--xperf_path', 04:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:07 INFO - 'tests': ['tp5n']}}, 04:52:07 INFO - 'talos.zip': {'path': '', 04:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:07 INFO - Running post-action listener: _resource_record_post_action 04:52:07 INFO - ##### 04:52:07 INFO - ##### Running create-virtualenv step. 04:52:07 INFO - ##### 04:52:07 INFO - Running pre-action listener: _resource_record_pre_action 04:52:07 INFO - Running main action method: create_virtualenv 04:52:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:52:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:07 INFO - Using real prefix '/usr' 04:52:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:52:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:09 INFO - Installing pip.................done. 04:52:09 INFO - Return code: 0 04:52:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:09 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 04:52:09 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 04:52:09 INFO - Using env: {'DISPLAY': ':0', 04:52:09 INFO - 'HOME': '/home/cltbld', 04:52:09 INFO - 'LANG': 'en_US.UTF-8', 04:52:09 INFO - 'LANGUAGE': 'en_US:en', 04:52:09 INFO - 'LOGNAME': 'cltbld', 04:52:09 INFO - 'MAIL': '/var/mail/cltbld', 04:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:09 INFO - 'MOZ_NO_REMOTE': '1', 04:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:09 INFO - 'NO_EM_RESTART': '1', 04:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:09 INFO - 'SHELL': '/bin/bash', 04:52:09 INFO - 'SHLVL': '1', 04:52:09 INFO - 'TERM': 'linux', 04:52:09 INFO - 'TMOUT': '86400', 04:52:09 INFO - 'USER': 'cltbld', 04:52:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:09 INFO - '_': '/tools/buildbot/bin/python'} 04:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:52:09 INFO - Cleaning up... 04:52:09 INFO - Return code: 0 04:52:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:09 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:09 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 04:52:09 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 04:52:09 INFO - Using env: {'DISPLAY': ':0', 04:52:09 INFO - 'HOME': '/home/cltbld', 04:52:09 INFO - 'LANG': 'en_US.UTF-8', 04:52:09 INFO - 'LANGUAGE': 'en_US:en', 04:52:09 INFO - 'LOGNAME': 'cltbld', 04:52:09 INFO - 'MAIL': '/var/mail/cltbld', 04:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:09 INFO - 'MOZ_NO_REMOTE': '1', 04:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:09 INFO - 'NO_EM_RESTART': '1', 04:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:09 INFO - 'SHELL': '/bin/bash', 04:52:09 INFO - 'SHLVL': '1', 04:52:09 INFO - 'TERM': 'linux', 04:52:09 INFO - 'TMOUT': '86400', 04:52:09 INFO - 'USER': 'cltbld', 04:52:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:09 INFO - '_': '/tools/buildbot/bin/python'} 04:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:10 INFO - Downloading/unpacking psutil>=0.7.1 04:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:52:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:52:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:11 INFO - Installing collected packages: psutil 04:52:11 INFO - Running setup.py install for psutil 04:52:11 INFO - building 'psutil._psutil_linux' extension 04:52:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:52:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:52:12 INFO - building 'psutil._psutil_posix' extension 04:52:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:52:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:12 INFO - Successfully installed psutil 04:52:12 INFO - Cleaning up... 04:52:12 INFO - Return code: 0 04:52:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:12 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:12 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 04:52:12 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 04:52:12 INFO - Using env: {'DISPLAY': ':0', 04:52:12 INFO - 'HOME': '/home/cltbld', 04:52:12 INFO - 'LANG': 'en_US.UTF-8', 04:52:12 INFO - 'LANGUAGE': 'en_US:en', 04:52:12 INFO - 'LOGNAME': 'cltbld', 04:52:12 INFO - 'MAIL': '/var/mail/cltbld', 04:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:12 INFO - 'MOZ_NO_REMOTE': '1', 04:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:12 INFO - 'NO_EM_RESTART': '1', 04:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:12 INFO - 'SHELL': '/bin/bash', 04:52:12 INFO - 'SHLVL': '1', 04:52:12 INFO - 'TERM': 'linux', 04:52:12 INFO - 'TMOUT': '86400', 04:52:12 INFO - 'USER': 'cltbld', 04:52:12 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:12 INFO - '_': '/tools/buildbot/bin/python'} 04:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:52:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:14 INFO - Installing collected packages: mozsystemmonitor 04:52:14 INFO - Running setup.py install for mozsystemmonitor 04:52:14 INFO - Successfully installed mozsystemmonitor 04:52:14 INFO - Cleaning up... 04:52:14 INFO - Return code: 0 04:52:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:14 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:14 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 04:52:14 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 04:52:14 INFO - Using env: {'DISPLAY': ':0', 04:52:14 INFO - 'HOME': '/home/cltbld', 04:52:14 INFO - 'LANG': 'en_US.UTF-8', 04:52:14 INFO - 'LANGUAGE': 'en_US:en', 04:52:14 INFO - 'LOGNAME': 'cltbld', 04:52:14 INFO - 'MAIL': '/var/mail/cltbld', 04:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:14 INFO - 'MOZ_NO_REMOTE': '1', 04:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:14 INFO - 'NO_EM_RESTART': '1', 04:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:14 INFO - 'SHELL': '/bin/bash', 04:52:14 INFO - 'SHLVL': '1', 04:52:14 INFO - 'TERM': 'linux', 04:52:14 INFO - 'TMOUT': '86400', 04:52:14 INFO - 'USER': 'cltbld', 04:52:14 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:14 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:52:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:52:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:52:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:17 INFO - Downloading docopt-0.6.1.tar.gz 04:52:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:52:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:17 INFO - Running setup.py install for blobuploader 04:52:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:52:17 INFO - Running setup.py install for requests 04:52:17 INFO - Running setup.py install for docopt 04:52:17 INFO - Successfully installed blobuploader requests docopt 04:52:17 INFO - Cleaning up... 04:52:17 INFO - Return code: 0 04:52:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:17 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:17 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 04:52:17 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 04:52:17 INFO - Using env: {'DISPLAY': ':0', 04:52:17 INFO - 'HOME': '/home/cltbld', 04:52:17 INFO - 'LANG': 'en_US.UTF-8', 04:52:17 INFO - 'LANGUAGE': 'en_US:en', 04:52:17 INFO - 'LOGNAME': 'cltbld', 04:52:17 INFO - 'MAIL': '/var/mail/cltbld', 04:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:17 INFO - 'MOZ_NO_REMOTE': '1', 04:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:17 INFO - 'NO_EM_RESTART': '1', 04:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:17 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:17 INFO - 'SHELL': '/bin/bash', 04:52:17 INFO - 'SHLVL': '1', 04:52:17 INFO - 'TERM': 'linux', 04:52:17 INFO - 'TMOUT': '86400', 04:52:17 INFO - 'USER': 'cltbld', 04:52:17 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:17 INFO - '_': '/tools/buildbot/bin/python'} 04:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:17 INFO - Running setup.py (path:/tmp/pip-jn7W3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:17 INFO - Running setup.py (path:/tmp/pip-DZ0j4I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:18 INFO - Running setup.py (path:/tmp/pip-nc5gbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:18 INFO - Running setup.py (path:/tmp/pip-VgFfSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:18 INFO - Running setup.py (path:/tmp/pip-h2uaUT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:18 INFO - Running setup.py (path:/tmp/pip-S4e7gp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:18 INFO - Running setup.py (path:/tmp/pip-gOqZ8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:18 INFO - Running setup.py (path:/tmp/pip-GIMBAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:18 INFO - Running setup.py (path:/tmp/pip-fyyRwf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:18 INFO - Running setup.py (path:/tmp/pip-eTwZGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:18 INFO - Running setup.py (path:/tmp/pip-wnTuzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:18 INFO - Running setup.py (path:/tmp/pip-FtcpTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:18 INFO - Running setup.py (path:/tmp/pip-wsILV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:18 INFO - Running setup.py (path:/tmp/pip-Sz052a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:18 INFO - Running setup.py (path:/tmp/pip-QdnYS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:18 INFO - Running setup.py (path:/tmp/pip-JXmO7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:19 INFO - Running setup.py (path:/tmp/pip-az8nYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:19 INFO - Running setup.py install for manifestparser 04:52:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Running setup.py install for mozcrash 04:52:19 INFO - Running setup.py install for mozdebug 04:52:19 INFO - Running setup.py install for mozdevice 04:52:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Running setup.py install for mozfile 04:52:19 INFO - Running setup.py install for mozhttpd 04:52:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Running setup.py install for mozinfo 04:52:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Running setup.py install for mozInstall 04:52:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:52:19 INFO - Running setup.py install for mozleak 04:52:20 INFO - Running setup.py install for mozlog 04:52:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Running setup.py install for moznetwork 04:52:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Running setup.py install for mozprocess 04:52:20 INFO - Running setup.py install for mozprofile 04:52:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Running setup.py install for mozrunner 04:52:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Running setup.py install for mozscreenshot 04:52:20 INFO - Running setup.py install for moztest 04:52:20 INFO - Running setup.py install for mozversion 04:52:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:52:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:20 INFO - Cleaning up... 04:52:20 INFO - Return code: 0 04:52:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:20 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 04:52:20 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 04:52:20 INFO - Using env: {'DISPLAY': ':0', 04:52:20 INFO - 'HOME': '/home/cltbld', 04:52:20 INFO - 'LANG': 'en_US.UTF-8', 04:52:20 INFO - 'LANGUAGE': 'en_US:en', 04:52:20 INFO - 'LOGNAME': 'cltbld', 04:52:20 INFO - 'MAIL': '/var/mail/cltbld', 04:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:20 INFO - 'MOZ_NO_REMOTE': '1', 04:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:20 INFO - 'NO_EM_RESTART': '1', 04:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:20 INFO - 'SHELL': '/bin/bash', 04:52:20 INFO - 'SHLVL': '1', 04:52:20 INFO - 'TERM': 'linux', 04:52:20 INFO - 'TMOUT': '86400', 04:52:20 INFO - 'USER': 'cltbld', 04:52:20 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:20 INFO - '_': '/tools/buildbot/bin/python'} 04:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:21 INFO - Running setup.py (path:/tmp/pip-KB8r9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:21 INFO - Running setup.py (path:/tmp/pip-ry7nj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:21 INFO - Running setup.py (path:/tmp/pip-LwgAyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:21 INFO - Running setup.py (path:/tmp/pip-jGmcph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:52:21 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)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:21 INFO - Running setup.py (path:/tmp/pip-0Mam_1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:21 INFO - Running setup.py (path:/tmp/pip-iw06P2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:21 INFO - Running setup.py (path:/tmp/pip-qAWxHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:21 INFO - Running setup.py (path:/tmp/pip-U2x1yr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:21 INFO - Running setup.py (path:/tmp/pip-Y7yR1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:21 INFO - Running setup.py (path:/tmp/pip-M8vP3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:21 INFO - Running setup.py (path:/tmp/pip-x1kxA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:21 INFO - Running setup.py (path:/tmp/pip-MjUPc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:22 INFO - Running setup.py (path:/tmp/pip-RoYkLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:22 INFO - Running setup.py (path:/tmp/pip-PxsQ5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:22 INFO - Running setup.py (path:/tmp/pip-PMif1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:22 INFO - Running setup.py (path:/tmp/pip-ColJ_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:22 INFO - Running setup.py (path:/tmp/pip-ow4Bcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:22 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)) 04:52:22 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)) 04:52:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:24 INFO - Downloading blessings-1.5.1.tar.gz 04:52:24 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 04:52:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:24 INFO - Installing collected packages: blessings 04:52:24 INFO - Running setup.py install for blessings 04:52:24 INFO - Successfully installed blessings 04:52:24 INFO - Cleaning up... 04:52:24 INFO - Return code: 0 04:52:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:52:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:52:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:52:24 INFO - Reading from file tmpfile_stdout 04:52:24 INFO - Current package versions: 04:52:24 INFO - argparse == 1.2.1 04:52:24 INFO - blessings == 1.5.1 04:52:24 INFO - blobuploader == 1.2.4 04:52:24 INFO - docopt == 0.6.1 04:52:24 INFO - manifestparser == 1.1 04:52:24 INFO - mozInstall == 1.12 04:52:24 INFO - mozcrash == 0.16 04:52:24 INFO - mozdebug == 0.1 04:52:24 INFO - mozdevice == 0.47 04:52:24 INFO - mozfile == 1.2 04:52:24 INFO - mozhttpd == 0.7 04:52:24 INFO - mozinfo == 0.9 04:52:24 INFO - mozleak == 0.1 04:52:24 INFO - mozlog == 3.1 04:52:24 INFO - moznetwork == 0.27 04:52:24 INFO - mozprocess == 0.22 04:52:24 INFO - mozprofile == 0.28 04:52:24 INFO - mozrunner == 6.11 04:52:24 INFO - mozscreenshot == 0.1 04:52:24 INFO - mozsystemmonitor == 0.0 04:52:24 INFO - moztest == 0.7 04:52:24 INFO - mozversion == 1.4 04:52:24 INFO - psutil == 3.1.1 04:52:24 INFO - requests == 1.2.3 04:52:24 INFO - wsgiref == 0.1.2 04:52:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:24 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:24 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 04:52:24 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 04:52:24 INFO - Using env: {'DISPLAY': ':0', 04:52:24 INFO - 'HOME': '/home/cltbld', 04:52:24 INFO - 'LANG': 'en_US.UTF-8', 04:52:24 INFO - 'LANGUAGE': 'en_US:en', 04:52:24 INFO - 'LOGNAME': 'cltbld', 04:52:24 INFO - 'MAIL': '/var/mail/cltbld', 04:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:24 INFO - 'MOZ_NO_REMOTE': '1', 04:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:24 INFO - 'NO_EM_RESTART': '1', 04:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:24 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:24 INFO - 'SHELL': '/bin/bash', 04:52:24 INFO - 'SHLVL': '1', 04:52:24 INFO - 'TERM': 'linux', 04:52:24 INFO - 'TMOUT': '86400', 04:52:24 INFO - 'USER': 'cltbld', 04:52:24 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:24 INFO - '_': '/tools/buildbot/bin/python'} 04:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:52:24 INFO - Cleaning up... 04:52:24 INFO - Return code: 0 04:52:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:24 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:24 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 04:52:24 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 04:52:24 INFO - Using env: {'DISPLAY': ':0', 04:52:24 INFO - 'HOME': '/home/cltbld', 04:52:24 INFO - 'LANG': 'en_US.UTF-8', 04:52:24 INFO - 'LANGUAGE': 'en_US:en', 04:52:24 INFO - 'LOGNAME': 'cltbld', 04:52:24 INFO - 'MAIL': '/var/mail/cltbld', 04:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:24 INFO - 'MOZ_NO_REMOTE': '1', 04:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:24 INFO - 'NO_EM_RESTART': '1', 04:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:24 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:24 INFO - 'SHELL': '/bin/bash', 04:52:24 INFO - 'SHLVL': '1', 04:52:24 INFO - 'TERM': 'linux', 04:52:24 INFO - 'TMOUT': '86400', 04:52:24 INFO - 'USER': 'cltbld', 04:52:24 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:24 INFO - '_': '/tools/buildbot/bin/python'} 04:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:24 INFO - Downloading/unpacking jsonschema 04:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:26 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 04:52:26 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:52:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:26 INFO - warning: no files found matching '*.txt' 04:52:26 INFO - no previously-included directories found matching 'build' 04:52:26 INFO - no previously-included directories found matching 'dist' 04:52:26 INFO - no previously-included directories found matching '.git*' 04:52:26 INFO - Installing collected packages: jsonschema, functools32 04:52:26 INFO - Running setup.py install for functools32 04:52:27 INFO - warning: no files found matching '*.txt' 04:52:27 INFO - no previously-included directories found matching 'build' 04:52:27 INFO - no previously-included directories found matching 'dist' 04:52:27 INFO - no previously-included directories found matching '.git*' 04:52:27 INFO - Successfully installed jsonschema functools32 04:52:27 INFO - Cleaning up... 04:52:27 INFO - Return code: 0 04:52:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:27 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 0x7fa7a4183f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a0360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:27 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 04:52:27 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 04:52:27 INFO - Using env: {'DISPLAY': ':0', 04:52:27 INFO - 'HOME': '/home/cltbld', 04:52:27 INFO - 'LANG': 'en_US.UTF-8', 04:52:27 INFO - 'LANGUAGE': 'en_US:en', 04:52:27 INFO - 'LOGNAME': 'cltbld', 04:52:27 INFO - 'MAIL': '/var/mail/cltbld', 04:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:27 INFO - 'MOZ_NO_REMOTE': '1', 04:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:27 INFO - 'NO_EM_RESTART': '1', 04:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:27 INFO - 'SHELL': '/bin/bash', 04:52:27 INFO - 'SHLVL': '1', 04:52:27 INFO - 'TERM': 'linux', 04:52:27 INFO - 'TMOUT': '86400', 04:52:27 INFO - 'USER': 'cltbld', 04:52:27 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:27 INFO - '_': '/tools/buildbot/bin/python'} 04:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:27 INFO - Downloading/unpacking flake8 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:52:28 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 04:52:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:52:29 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 04:52:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:29 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 04:52:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:52:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:52:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:29 INFO - no previously-included directories found matching 'docs/_build' 04:52:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:52:29 INFO - Running setup.py install for pep8 04:52:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:29 INFO - no previously-included directories found matching 'docs/_build' 04:52:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:52:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:52:29 INFO - Cleaning up... 04:52:29 INFO - Return code: 0 04:52:29 INFO - Running post-action listener: _resource_record_post_action 04:52:29 INFO - Running post-action listener: _start_resource_monitoring 04:52:29 INFO - Starting resource monitoring. 04:52:29 INFO - ##### 04:52:29 INFO - ##### Running install step. 04:52:29 INFO - ##### 04:52:29 INFO - Running pre-action listener: _resource_record_pre_action 04:52:29 INFO - Running main action method: install 04:52:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:52:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:52:30 INFO - Reading from file tmpfile_stdout 04:52:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:52:30 INFO - Reading from file tmpfile_stdout 04:52:30 INFO - Output received: 04:52:30 INFO - Usage: mozinstall [options] installer 04:52:30 INFO - Options: 04:52:30 INFO - -h, --help show this help message and exit 04:52:30 INFO - -d DEST, --destination=DEST 04:52:30 INFO - Directory to install application into. [default: 04:52:30 INFO - "/builds/slave/test-pgo"] 04:52:30 INFO - --app=APP Application being installed. [default: firefox] 04:52:30 INFO - mkdir: /builds/slave/test-pgo/build/application 04:52:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:52:46 INFO - Reading from file tmpfile_stdout 04:52:46 INFO - Output received: 04:52:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - ##### 04:52:46 INFO - ##### Running run-tests step. 04:52:46 INFO - ##### 04:52:46 INFO - Running pre-action listener: _resource_record_pre_action 04:52:46 INFO - Running main action method: run_tests 04:52:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:52:46 INFO - Python 2.7.3 04:52:46 INFO - Return code: 0 04:52:46 INFO - grabbing minidump binary from tooltool 04:52: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')]} 04:52:46 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 0x2a2f540>, '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 0x2a30440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a308f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:52:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:52:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:52:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:46 INFO - Return code: 0 04:52:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:52:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:52:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:52:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:52:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:52:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:52:47 INFO - Return code: 0 04:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:52:47 INFO - Using env: {'DISPLAY': ':0', 04:52:47 INFO - 'HOME': '/home/cltbld', 04:52:47 INFO - 'LANG': 'en_US.UTF-8', 04:52:47 INFO - 'LANGUAGE': 'en_US:en', 04:52:47 INFO - 'LOGNAME': 'cltbld', 04:52:47 INFO - 'MAIL': '/var/mail/cltbld', 04:52:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:52:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:47 INFO - 'MOZ_NO_REMOTE': '1', 04:52:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:47 INFO - 'NO_EM_RESTART': '1', 04:52:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:52:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:52:47 INFO - 'SHELL': '/bin/bash', 04:52:47 INFO - 'SHLVL': '1', 04:52:47 INFO - 'TERM': 'linux', 04:52:47 INFO - 'TMOUT': '86400', 04:52:47 INFO - 'USER': 'cltbld', 04:52:47 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861', 04:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:47 INFO - '_': '/tools/buildbot/bin/python'} 04:52:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:52:47 INFO - mozversion application_buildid: 20151229023006 04:52:47 INFO - mozversion application_changeset: 0eef62c740a78b1bbf5a8d516e6207703209e705 04:52:47 INFO - mozversion application_display_name: Nightly 04:52:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:47 INFO - mozversion application_name: Firefox 04:52:47 INFO - mozversion application_remotingname: firefox 04:52:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:52:47 INFO - mozversion application_vendor: Mozilla 04:52:47 INFO - mozversion application_version: 46.0a1 04:52:47 INFO - mozversion platform_buildid: 20151229023006 04:52:47 INFO - mozversion platform_changeset: 0eef62c740a78b1bbf5a8d516e6207703209e705 04:52:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:52:47 INFO - mozversion platform_version: 46.0a1 04:52:47 INFO - using testdate: 1451393567 04:52:47 INFO - actual date: 1451393567 04:52:47 INFO - starting webserver on 'localhost:49234' 04:52:47 INFO - SUITE-START | Running 3 tests 04:52:47 INFO - TEST-START | dromaeo_css 04:52:47 INFO - operating with platform_type : linux_ 04:52:47 INFO - Initialising browser for dromaeo_css test... 04:52:47 INFO - TEST-INFO | started process 25590 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_RgSQW/profile http://localhost:49234/getInfo.html) 04:52:51 INFO - PROCESS | 25590 | __metrics Screen width/height:1600/1200 04:52:51 INFO - PROCESS | 25590 | colorDepth:24 04:52:51 INFO - PROCESS | 25590 | Browser inner width/height: 1024/697 04:52:51 INFO - PROCESS | 25590 | __metrics 04:52:51 INFO - PROCESS | 25590 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:52:51 INFO - PROCESS | 25590 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:52 INFO - TEST-INFO | 25590: exit 0 04:52:52 INFO - Browser initialized. 04:52:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:52 INFO - TEST-INFO | started process 25684 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_RgSQW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:04 INFO - PROCESS | 25684 | RSS: Main: 148512768 04:53:04 INFO - PROCESS | 25684 | 04:53:55 INFO - PROCESS | 25684 | 1451393635853 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] 04:56:04 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 04:56:05 INFO - PROCESS | 25684 | RSS: Main: 258600960 04:56:05 INFO - PROCESS | 25684 | 04:59:08 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 04:59:08 INFO - PROCESS | 25684 | RSS: Main: 236695552 04:59:08 INFO - PROCESS | 25684 | 05:02:10 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 05:02:11 INFO - PROCESS | 25684 | RSS: Main: 217612288 05:02:11 INFO - PROCESS | 25684 | 05:05:13 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 05:05:13 INFO - PROCESS | 25684 | RSS: Main: 205705216 05:05:13 INFO - PROCESS | 25684 | 05:08:16 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 05:08:16 INFO - PROCESS | 25684 | RSS: Main: 215359488 05:08:16 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 05:11:19 INFO - PROCESS | 25684 | RSS: Main: 270721024 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | __start_tp_report 05:11:19 INFO - PROCESS | 25684 | _x_x_mozilla_page_load 05:11:19 INFO - PROCESS | 25684 | _x_x_mozilla_page_load_details 05:11:19 INFO - PROCESS | 25684 | |i|pagename|runs| 05:11:19 INFO - PROCESS | 25684 | |0;dojo.html;3121.079281611924;3166.3034132490843;3198.7441004719626;3207.5349074384217;3234.708876201142;5191.1953647184655;5298.523132918037;5314.654547454413;5318.414974352823;5376.973115134424;5207.557357624597;5342.492463215998;5352.4915133062295;5361.678299302044;5448.891022179564;4873.829415970442;4890.682105663138;4894.437139728923;4911.607071434277;4917.4836642152595;4919.13915064864;4935.777889994959;4977.776000079987;4996.700197988114;5001.974990125044;4796.016816552598;4846.5880400166025;4905.141600219948;4940.55535001848;4962.62780291476;4893.339399181101;4895.094407534618;4910.153367503605;4919.7540122993705;4949.554540091409;4819.108464933964;4869.659123861331;4874.488178741217;4903.362562866804;4923.384576927884;5099.59203263738;5148.5623721983675;5184.300119483859;5249.632525723201;5255.159174532095;5669.886602267931;5680.488756011938;5702.771889124471;5704.172894930253;5717.9714101429645;5721.71391430431;5734.541236701054;5737.3688894221605;5739.971300143514;5744.942550574483;5303.284056652341;5340.145576707708;5413.810516631938;5417.10617748075;5444.156155795858;5863.296404431496;5867.530597552186;5871.031279838779;5912.852178695481;5923;5591.189277554732;5635.098384258499;5644.774209031675;5657.9434205658235;5688.345840228344;5615.691136987423;5673.319201695823;5700.059490184073;5721.742521586539;5741.25363702716;5769.48074673273;5776.422357764274;5781.710914454345;5782.132680098019;5817.767289308465;5765.798197063083;5768.105943578752;5774.566907481955;5787.392323806024;5789.160571717078;4375.059362237071;4416.734995900256;4444.644428445717;4449.087936972913;4511.842085526991;3966.2265858157384;4004.739691920016;4005.7997100144876;4019.799010049486;4033.495813023372;5346.5455436287575;5387.838364849061;5395.487428694268;5395.514403703607;5397.865053373618;5564.248826408464;5619.662820230799;5672.376038635747;5808.506276966421;5881.529477641779;5280.973595132076;5357.866053348619;5358.740695936452;5391.2182733504205;5396.676199428047;4883.243097319921;4919.581835544019;4953.479884612136;4958.752062396866;4962.950370496321;5765.56758243125;5908.261467316585;5916.822495325233;5924.170616113747;5924.348321684612;5665.886682266249;5682.801101961411;5724.3703192647945;5779.479846813807;5810.94189058104;5836.182934389274;5852.824415267549;5855.6486610801785;5862.589618726648;5873.500752436091;5549.306336707911;5551.25058117149;5603.38362780102;5611.80358687444;5625.8593535161945;5730.426957304237;5736.627119237236;5747.109198074305;5825.825225243249;5847.502962248256;5630.774769009194;5654;5655.575831812713;5664.915026274692;5668.603197776281;5377.731113444391;5632.5493960482245;5633.464820842013;5637.098064309855;5639.802606908738;5373.032854086302;5390.838274851761;5470.507654310972;5532.419095994863;5570.832875013756;5629.634073785354;5660.716964151694;5666.9716651416475;5671.858203544944;5714.514266287412;5322.41453440129;5538.224648549287;5540.473655002768;5556.083246264321;5565.220869078251 05:11:19 INFO - PROCESS | 25684 | |1;ext.html;546.3509556464062;575.6200907401114;589.3782059926779;589.9321578018527;605.9151718759372;27721.861390693044;35613.931582052515;35908.64091359092;36067;36116.09709757254;39310.60689393112;39791.60208397915;39802.80098599503;39921.201575968465;39945.400818987735;7392.075990501187;7483.73806916758;8352.415330926837;8583;8588.613512391927;10041.347312424705;10171.796564068714;10187.235957303195;10188.949055254714;10209.642662506814;9866.60533578656;10004.699859004206;10010.699679009605;10018.048285412875;10030.699079027641;7550.056242969629;7664.156942736295;9836.360636558673;9895;10048.949755251177;9784.853227201598;9874.210063194927;9912.35569687968;9919.206463482977;9927.553260103312;35686.46470302947;35866.10334741626;35910;36000;36073.45889811629;3061.234691327168;3117.2051126962706;3164.5727826743323;3808.314503389389;3872;28010;28074.438511229662;28474.145775626763;28606.14181574556;28688;3868.2456920900436;3923.9607603923882;3946.7631942083567;3978.741381810173;4055.168690418457;269936;270592;273007;274680;275154.24845751486;49780;50649.74675126601;50733.492665073616;55487.44512554823;55771.44228557744;45805.31292030622;59616.70191649101;60152.69923650354;60440.69779651162;60557.39442605606;11992.100592455427;12051.397430128458;12088.758224835454;12101.878981210075;12108.939455302843;9330.440173589606;9357.766055848659;9364.344495885223;9376.812463750686;9379.390339627902;17848;18040.458786236435;18075.36736214226;18161.636767264845;18382.08089595515;7374.483786135026;7534.3595794357;7561.621918904033;7617.390608751398;7620.504667196615;891.888513935758;928.2991341537096;946.7017889364828;964.0696727657704;1020.8621836052187;27094.322641934108;27874.721252787214;28081.859590701915;28168.718312817018;28362.574561381596;961.5000199896015;977.9951100244454;989.7129832348683;997.486294558303;1075.2043487818958;14758.188299643409;14784.704305913821;15099.773503397459;15352.385904563693;15380.230988450532;379490;384763;384891;385429;385713;52432.47567524352;53002;53325.46674533205;53327.73336133295;53341.733291333294;1272.2557303977092;1293.6959814443599;1297.6431481342706;1309.306067784076;1313.7963615639592;25893;27421.17736467909;27932.58101128444;28638;29734.40531189321;44710.3293450605;45573;45666;45666.54333456623;45680;297273;299617;300146;300202;300302;35827.283454331286;36089.458658120675;36653.26693466063;41878;42314.36528452014;39683;39689;39974;40063.39904901487;40131.59868401279;31473.8426307867;33130;33561.16097097592;33661.66338336683;37370.626293737805;29026.548672565867;32240.67759322377;32418;33097.338053238316;35524.28951420906;31627;32179;32310.83844580762;32757.672423276417;33087.50368744519;29213.7078629211;31827;32409;32481.51277730883;34064.82967585146;23244.070237191;23406.882965585064;23536.176233831735;23569;23697.881510592335 05:11:19 INFO - PROCESS | 25684 | |2;jquery.html;353.3198592709035;353.4962678183588;354.7162270183853;355.9252556963039;356.61485595556803;13849.09980851244;14061;16157.838421615781;16371.181440927965;17074.268117101266;14838.925805370985;14922;15068.924655376735;15080.095194288351;15080.698386032273;5111.131107711698;5112.846614601549;5118.334616499868;5123.5388815006645;5258.605604579653;3824.3116239076953;3890.727649064567;5347.144456886899;5779.739911703983;5940.3762604926505;5816.941830581683;5820.185174075633;5862.091375836731;5878.823635290927;5888.852778680524;5765.827025189251;5946.464818166364;5952.613080149777;5954.4640982311585;5956.910646340309;5173.094708426011;5174.844754657329;5184.118699821001;5197.974010129925;5200.479952004769;11395.259308144945;11593.89857963492;11611.94194029033;11708.180427370087;11803.645890623295;2137.6259154647873;2149.7420309562954;2178;2209.5139069404704;2540.796736261095;9222.723318300395;9269.44383337002;9391.859122113174;9394.34239603228;9518.666846660333;1711.3753479979841;1747.1700942052423;1815.6096439265489;1823.772028496438;1839.4021942868621;55691.721541392035;58471.41528584745;59648.40351596472;59674.70162649159;64356.356436435504;9568.95215523918;9646.42121472714;9690.321677482509;9788.168005719452;9813.067758562926;12744.299063551594;12748.36258187087;12760.489580416679;12762.425690843935;12794.104412691022;6858.725650974005;6861.073755043105;6861.279565645636;6880.724771009203;6905.274946130584;6503.9349606504275;6508.576942498722;6564.868702626016;6565.441937435371;6573.309802470767;4156.189543039079;4237.067845074141;4256.7445953242905;4293.484781826201;4361;1668.5328108129743;1682.803940857193;1690.1549225387307;1713.6658351621313;1727.7494763259508;387.94956655634587;393.34508044106815;401.83926429428465;817.1052697296451;860.7546849147963;8777.551703968773;9531.380460270198;9944.154746846454;10151.137153342048;10214.285000049926;420.51430597659754;441.55182489772903;444.3179719131183;447.5993985383064;449.66499957531846;5614.719264036782;5722.799702010409;5751.281089863767;5803.65178089316;5809.738561764731;578436;586890;597381;599793;603706;78621;79187;81329;81371.18628813636;81837.36114305102;400.8336540335728;409.6947773908517;474.7246596973816;479.18777671845885;480.4570834956547;9525.904301053757;9701.563429645541;9823.214142868695;9965.701028969142;10038.397696138256;32886.83556582202;33391.165220869676;33589.83205083959;35187.64812351844;36395.27209455849;40369.798151009054;40546.59453405546;41773.582264178185;42359.576404235566;47082.05835883332;8905;8989.505577193317;9157.313201510047;9223;9226.630934762803;15393.69212615719;16475.752863706814;16974.57563560921;17086.829131708524;17507.38724144649;13689.794653080411;14040.1575905446;14267;14397.64005899861;14398.496052638107;8975.685850995184;9605.47169905662;9624.326297159132;9857.802843942938;9860.211183105477;9666.468344241135;9753;9894.604215831574;9976.850347244943;9981.600735970771;14589.832813375117;14642.853571464575;15099.849001510283;15141.621459463602;15226.46707365237;14890.925545372203;15157.772633410728;15175.468858589897;15525.689486210438;15836.52490425289 05:11:19 INFO - PROCESS | 25684 | |3;mootools.html;1263.0968857267053;1385.612028631983;1388.9930550347249;1481.9555413337596;1701.1409238334647;6424.2290925089;7107.751228706997;7221.169565499962;7242.601656908868;7246.746363877265;7037.3666370026685;7204.279572042793;7211.098612673416;7211.242819503942;7219.891701624467;2144.0566150893596;2174.1738139506965;2195.82433405328;2202.515446601745;2202.944926376845;2163.697082408464;2188.3106821351303;2236.798688118069;2241.1483636218213;2241.293992392399;2135.893205339735;2166.7183266175375;2176.086043861582;2192.583409152264;2196.9340919772353;2164.9025793839237;2190.6823510591034;2198.296545105567;2198.9670154947607;2200.6038912995655;2145.6459684152096;2180.6728990651372;2181.3892110209167;2182.2907555044676;2183.1049269799305;7098.645067746644;7148.320909513588;7153.6065516396575;7154.499185057048;7161.0332605098165;4361.367601697768;4395.296752519582;4410.75740834254;4417.094495628388;4423.977880110579;2931.267183204199;2964.3774807290497;2964.659064207622;2977.598024266718;3010.8494575271147;900.2887718702217;920.9263258939269;925.8009527951456;926.6941909169958;960.348201094124;9637.566309516089;9638.903610963871;9649.083337083037;9649.372790768577;9660.17888479473;4067.7355971861734;4102.589741025873;4162.250794856895;4172.290710579209;4203.936940945889;8361.163883611713;8410.747677569683;8439.746807595782;8441.493510389397;8452.1547845215;4418.425604671436;4457.331400289918;4485.708428952108;4492.393526873896;4513.638908887281;3566.892993210208;3642.5264715586804;3979.1047014421524;4016.4176194452225;4069;3400.7619466637098;3407.778494397906;3410.4543273076188;3431.9656803432144;3438.638942911008;1072.0780129088978;1074.6561100447939;1079.3955384984433;1082.1234799812178;1091.612477570467;1241.90064794818;1250.0686988193672;1260.6785269756153;1263.6082814327588;1266.9429875655433;6514.54398192122;6583.3416658334745;6591.571547849375;6617.272100068989;6620.470362371095;408.3976135200615;434.01262128656924;462.95370462953434;465.89051572880345;466.68498763335293;5273.1299335609965;5325.520703136736;5332.146856503018;5337.492938170868;5346.251524786533;8306.169383061646;8330.291925186306;8410.663573457115;8539.359548033797;8695.869561956575;8689;8801.295896328278;8807.07525709804;8812.383133180616;8812.8678069829;6896.517243792987;6909.963505474219;6990.580565166107;7004;7020.438364930793;6707.1616047994;6733.094805013178;6733.629650369081;6754.729810807513;6762.357576030269;7666.386689064973;7681.308682218627;7766.805829854299;7917.881231781413;7922.881156782538;7881.487703299267;7992.720254791055;8034.799130021563;8078.555679437687;8128.918710813053;5779.335376431764;5879.970600146972;6412.9679351602945;6415.615063096229;6469.126667899774;6693.899591506229;6708.8993665094085;6714.664266786739;6720.294369091371;6733.629650369081;6340.841478963062;6362.23653161605;6417.711202995783;6536.444402225864;6593.175853018372;6403;6460.612363258219;6549.541532092899;6581;6606.504512161703;6347.873042539216;6381.680915954091;6382.266039405342;6384.744610215539;6390.297067322498;5505.587080968863;5520.641158324696;5578.804741834017;5581.302337207849;5581.944180558143;5866.120081987565;5900.144479050427;5911.881762364815;5915.024021036481;5916.763329466945 05:11:19 INFO - PROCESS | 25684 | |4;prototype.html;326.5037143541818;327.5332650972364;328.50887922555773;330.21738479802866;334.07794487215295;5909.113632955059;5930.080837470194;5932.406759324065;5959.255093113361;6027.578069535123;5911.290645122581;5916.467517923386;5921.378255283187;5926.88146237075;5927.051671732524;4560.589546940775;4567.429071366079;4568.2462393705;4571.062932098912;4572.862814115565;4474.060447306069;4551.908961820778;4564.452265728118;4569.223232050543;4579.519150489201;4513.52607976161;4518.751468669222;4522.3668686383935;4525.434320709911;4529.456465224162;4309.138172365508;4505.932411013838;4510.954890451087;4515.9774201128785;4525.932111018337;3840.443135745329;3874.8450061997487;3941.625545573195;3956.3076461619103;3962.0491082140366;5574.721263936787;5592.412796656374;5603.159526071081;5607.775688972436;5624.521915637176;5003.824866129668;5101.005303965728;5153.587712982952;5260.684358938438;5272.551833094191;6090.969545152246;6144.938550614482;6278.843028924268;6288;6290.025046117859;4320.740755554645;4337.587929146726;4340.457442819647;4346.782660866944;4347.043650396908;6458.93541064588;6533.836654083639;6557.868842623121;6564.737410503574;6568.737250509974;4481.1933851906315;4487.214737420938;4493;4498.50516443191;4498.595126438636;4549.363089167519;4554.840580579664;4559.133764584718;4561.29299958507;4569.9314510282375;5254.369475662868;5255.5532779713385;5255.973720131451;5262.105442074857;5265.78936842522;6211.65835879022;6348.523860710465;6349.809505714744;6353.428191462791;6383.425491705769;1567.4513920127863;1588.1424031023348;1588.7537431698106;1591.3157342342672;1591.912444815523;1030.9587616495405;1034.007352941185;1034.534459493231;1038.657243109772;1047.251215380991;5970.194023806731;5982.4914882234625;5983.0128028875615;5988.580799344004;5988.730507127103;6520.673966301666;6522.902156467657;6532.608043517309;6544.640044797582;6550.7707230246715;5961.5826892118;5971.910421343683;5975.790847320323;5977.282726072812;5982.312034116132;3476.5480487536965;3577.6601222883783;3580.409232476612;3581.122624956902;3584.8386822593047;6859.279775623488;6876.449884009267;6884.0362349271145;6888.41448476875;6896.069030680894;6560.376764207393;6745.763898263537;6753.1220941277315;6756.864862702817;6758.729650814011;6390.7763228286785;6700.6984685688285;6858.897116543256;6869.523052543627;6872.759453419107;6616.470682345497;6616.8345791355605;6617.43751781104;6619.536632435684;6621.370969757865;6535.4444872184495;6544.44372228366;6545.050967609765;6552.737890484327;6552.803415897531;6683.097781799394;6804.353586409283;6861.313868613099;6868.038474613658;6871.415929646036;4390.275604525217;4415.624671902796;4417.845375411845;4419.513853476051;4421.447319085114;6608.70260838273;6618.007298905202;6618.602883826986;6620.801375958729;6624.867502650017;6261.655608941552;6389.329120442472;6438.098666186644;6453.257875344396;6464.676766161579;6432.807015789534;6440.645764482999;6447.3552644735155;6454.1609590752905;6457.903131452938;6253.530985176039;6271.3728627136925;6272.905906411316;6278.560500764903;6282.2147231596055;6286.842828929313;6451.1936007999;6466.224053113657;6469.320721324193;6475.935240647534;6309.432151106423;6314.842128946813;6323.715432805627;6324.367563243639;6324.683765811599 05:11:19 INFO - PROCESS | 25684 | |5;yui.html;651.2217899609965;667.9332066793321;675.8107729835647;689.2177378675202;751.8458715963228;13441.126326788752;13625.523106691267;13739.725205495884;13764.862351376483;13768.724625507484;11968.28190308582;14304.284785760723;14358;14468.638284042905;14485.63785905353;667.4226793823332;780.4965797060893;798.022422532396;802.9116797152309;802.9357651387904;672.6233309346757;784.2549577900988;804.2359758229676;804.3967024731452;804.5655346113122;823.472977294532;838.6016642094986;840.5083026429546;840.6217202258978;840.8570543007703;693.2686016252876;698.333091897237;827.1604321613567;835.7492752174354;839.0979696825937;614.4469977020673;614.9508039356841;616.100493279812;618.8793185328863;619.0961196652892;13075.738485230337;13169.275689837055;13227.537036203783;13229.404676789567;13234.801477977839;11523.769524609545;11749.823752643717;12201.755964880742;12499.500019999188;12765.55320563785;9616.807663846685;10114.696559103239;10444.321119127233;10541.156707463384;10688.412137332443;3523.154442933703;3549.148204430918;3550.218951830593;3562.447820587813;3693.169036966688;45375.773121134516;45761.31358029632;45778.54221457776;45853;46023.30965035494;10196.4391958443;10227.232957528066;10479.790404191874;10508.842367364496;10539.262251642465;18147.09264536768;18188.90905545464;18226.54433639143;18232.45302640923;18260.634787304447;7207.423406127497;7540.585267810214;7543.811404714926;7684.46208765381;7841.725539606086;4402.823887044547;4411.9558804411545;4429.15845989261;4430.977845110754;4439;2982.6271716035494;2995.655499617572;3009.849507524615;3010.3377257003426;3015.050259168399;527.8996990571856;547.2120146988403;557.6849080269635;557.7099908047793;559.183591955741;514.565192412411;566.9744861481244;583.2184872271177;583.270911360799;603.8318575748748;7553.357964572963;8134.877976830352;8186.345092392594;8268.173182681683;8460.238578527962;517.2319106127397;649.0977541217711;654.6105067484839;656.3895577113235;663.1478550063146;3868.787216703052;3956.5647778744315;3957.56466788653;4041.0907545802547;4046.8785936421955;48975.51024489781;49897.25154122691;49926;50089.499105009214;50102.74948625234;47886.76056619764;49593.752031239615;49609.25586116211;49657.50342496529;49675.75162124239;43711.72162087856;43961;44367.112657746664;45485.54514454879;46068.53931460642;7964.2035796422215;8125.071322606451;8126.390520711088;8281.29608983243;8405.849107383308;34724;35207.31901987365;35213.119672008404;35372.29255414929;35997;40352.3947140799;40668.79665601653;43835.34246986234;44425.77787111044;44540;9363.391379560308;9576.66481673166;9850.412331330388;9861.852072219066;9883.456409897524;9536.856947145938;9819.803603928025;9871.25965552572;10293.948530257301;10303.433311167957;9774.609015639579;10092.14216791581;10106.949465252626;10326.638567650096;11074.058705010164;9219.216366608913;9269.212116970133;9594.568244429158;9664.71005869825;9706.126448619658;10348.896511034793;10431.791364172523;10494.790104198026;10740.892591073989;10802.189835762507;8755.124487551195;8947.686830960885;9159.633614655339;9418.57616407277;9769.071938165864;8668.176523230282;8918.955405222932;8931.508767017876;9010.459372437675;9239.39943903644 05:11:19 INFO - PROCESS | 25684 | __end_tp_report 05:11:19 INFO - PROCESS | 25684 | __start_cc_report 05:11:19 INFO - PROCESS | 25684 | _x_x_mozilla_cycle_collect,946 05:11:19 INFO - PROCESS | 25684 | __end_cc_report 05:11:19 INFO - PROCESS | 25684 | __startTimestamp1451394679801__endTimestamp 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | ------- Summary: start ------- 05:11:19 INFO - PROCESS | 25684 | Number of tests: 6 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#0] dojo.html Cycles:165 Average:5324.67 Median:5540.47 stddev:580.18 (10.5%) stddev-sans-first:555.61 05:11:19 INFO - PROCESS | 25684 | Values: 3121.1 3166.3 3198.7 3207.5 3234.7 5191.2 5298.5 5314.7 5318.4 5377.0 5207.6 5342.5 5352.5 5361.7 5448.9 4873.8 4890.7 4894.4 4911.6 4917.5 4919.1 4935.8 4977.8 4996.7 5002.0 4796.0 4846.6 4905.1 4940.6 4962.6 4893.3 4895.1 4910.2 4919.8 4949.6 4819.1 4869.7 4874.5 4903.4 4923.4 5099.6 5148.6 5184.3 5249.6 5255.2 5669.9 5680.5 5702.8 5704.2 5718.0 5721.7 5734.5 5737.4 5740.0 5744.9 5303.3 5340.1 5413.8 5417.1 5444.2 5863.3 5867.5 5871.0 5912.9 5923.0 5591.2 5635.1 5644.8 5657.9 5688.3 5615.7 5673.3 5700.1 5721.7 5741.3 5769.5 5776.4 5781.7 5782.1 5817.8 5765.8 5768.1 5774.6 5787.4 5789.2 4375.1 4416.7 4444.6 4449.1 4511.8 3966.2 4004.7 4005.8 4019.8 4033.5 5346.5 5387.8 5395.5 5395.5 5397.9 5564.2 5619.7 5672.4 5808.5 5881.5 5281.0 5357.9 5358.7 5391.2 5396.7 4883.2 4919.6 4953.5 4958.8 4963.0 5765.6 5908.3 5916.8 5924.2 5924.3 5665.9 5682.8 5724.4 5779.5 5810.9 5836.2 5852.8 5855.6 5862.6 5873.5 5549.3 5551.3 5603.4 5611.8 5625.9 5730.4 5736.6 5747.1 5825.8 5847.5 5630.8 5654.0 5655.6 5664.9 5668.6 5377.7 5632.5 5633.5 5637.1 5639.8 5373.0 5390.8 5470.5 5532.4 5570.8 5629.6 5660.7 5667.0 5671.9 5714.5 5322.4 5538.2 5540.5 5556.1 5565.2 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#1] ext.html Cycles:180 Average:47550.85 Median:35955.00 stddev:84694.92 (235.6%) stddev-sans-first:84858.98 05:11:19 INFO - PROCESS | 25684 | Values: 546.4 575.6 589.4 589.9 605.9 27721.9 35613.9 35908.6 36067.0 36116.1 39310.6 39791.6 39802.8 39921.2 39945.4 7392.1 7483.7 8352.4 8583.0 8588.6 10041.3 10171.8 10187.2 10188.9 10209.6 9866.6 10004.7 10010.7 10018.0 10030.7 7550.1 7664.2 9836.4 9895.0 10048.9 9784.9 9874.2 9912.4 9919.2 9927.6 35686.5 35866.1 35910.0 36000.0 36073.5 3061.2 3117.2 3164.6 3808.3 3872.0 28010.0 28074.4 28474.1 28606.1 28688.0 3868.2 3924.0 3946.8 3978.7 4055.2 269936.0 270592.0 273007.0 274680.0 275154.2 49780.0 50649.7 50733.5 55487.4 55771.4 45805.3 59616.7 60152.7 60440.7 60557.4 11992.1 12051.4 12088.8 12101.9 12108.9 9330.4 9357.8 9364.3 9376.8 9379.4 17848.0 18040.5 18075.4 18161.6 18382.1 7374.5 7534.4 7561.6 7617.4 7620.5 891.9 928.3 946.7 964.1 1020.9 27094.3 27874.7 28081.9 28168.7 28362.6 961.5 978.0 989.7 997.5 1075.2 14758.2 14784.7 15099.8 15352.4 15380.2 379490.0 384763.0 384891.0 385429.0 385713.0 52432.5 53002.0 53325.5 53327.7 53341.7 1272.3 1293.7 1297.6 1309.3 1313.8 25893.0 27421.2 27932.6 28638.0 29734.4 44710.3 45573.0 45666.0 45666.5 45680.0 297273.0 299617.0 300146.0 300202.0 300302.0 35827.3 36089.5 36653.3 41878.0 42314.4 39683.0 39689.0 39974.0 40063.4 40131.6 31473.8 33130.0 33561.2 33661.7 37370.6 29026.5 32240.7 32418.0 33097.3 35524.3 31627.0 32179.0 32310.8 32757.7 33087.5 29213.7 31827.0 32409.0 32481.5 34064.8 23244.1 23406.9 23536.2 23569.0 23697.9 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#2] jquery.html Cycles:180 Average:29198.26 Median:476.96 stddev:97021.97 (20341.9%) stddev-sans-first:97269.96 05:11:19 INFO - PROCESS | 25684 | Values: 353.3 353.5 354.7 355.9 356.6 13849.1 14061.0 16157.8 16371.2 17074.3 14838.9 14922.0 15068.9 15080.1 15080.7 5111.1 5112.8 5118.3 5123.5 5258.6 3824.3 3890.7 5347.1 5779.7 5940.4 5816.9 5820.2 5862.1 5878.8 5888.9 5765.8 5946.5 5952.6 5954.5 5956.9 5173.1 5174.8 5184.1 5198.0 5200.5 11395.3 11593.9 11611.9 11708.2 11803.6 2137.6 2149.7 2178.0 2209.5 2540.8 9222.7 9269.4 9391.9 9394.3 9518.7 1711.4 1747.2 1815.6 1823.8 1839.4 55691.7 58471.4 59648.4 59674.7 64356.4 9569.0 9646.4 9690.3 9788.2 9813.1 12744.3 12748.4 12760.5 12762.4 12794.1 6858.7 6861.1 6861.3 6880.7 6905.3 6503.9 6508.6 6564.9 6565.4 6573.3 4156.2 4237.1 4256.7 4293.5 4361.0 1668.5 1682.8 1690.2 1713.7 1727.7 387.9 393.3 401.8 817.1 860.8 8777.6 9531.4 9944.2 10151.1 10214.3 420.5 441.6 444.3 447.6 449.7 5614.7 5722.8 5751.3 5803.7 5809.7 578436.0 586890.0 597381.0 599793.0 603706.0 78621.0 79187.0 81329.0 81371.2 81837.4 400.8 409.7 474.7 479.2 480.5 9525.9 9701.6 9823.2 9965.7 10038.4 32886.8 33391.2 33589.8 35187.6 36395.3 40369.8 40546.6 41773.6 42359.6 47082.1 8905.0 8989.5 9157.3 9223.0 9226.6 15393.7 16475.8 16974.6 17086.8 17507.4 13689.8 14040.2 14267.0 14397.6 14398.5 8975.7 9605.5 9624.3 9857.8 9860.2 9666.5 9753.0 9894.6 9976.9 9981.6 14589.8 14642.9 15099.8 15141.6 15226.5 14890.9 15157.8 15175.5 15525.7 15836.5 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#3] mootools.html Cycles:180 Average:5032.32 Median:5915.89 stddev:2588.17 (43.7%) stddev-sans-first:2579.92 05:11:19 INFO - PROCESS | 25684 | Values: 1263.1 1385.6 1389.0 1482.0 1701.1 6424.2 7107.8 7221.2 7242.6 7246.7 7037.4 7204.3 7211.1 7211.2 7219.9 2144.1 2174.2 2195.8 2202.5 2202.9 2163.7 2188.3 2236.8 2241.1 2241.3 2135.9 2166.7 2176.1 2192.6 2196.9 2164.9 2190.7 2198.3 2199.0 2200.6 2145.6 2180.7 2181.4 2182.3 2183.1 7098.6 7148.3 7153.6 7154.5 7161.0 4361.4 4395.3 4410.8 4417.1 4424.0 2931.3 2964.4 2964.7 2977.6 3010.8 900.3 920.9 925.8 926.7 960.3 9637.6 9638.9 9649.1 9649.4 9660.2 4067.7 4102.6 4162.3 4172.3 4203.9 8361.2 8410.7 8439.7 8441.5 8452.2 4418.4 4457.3 4485.7 4492.4 4513.6 3566.9 3642.5 3979.1 4016.4 4069.0 3400.8 3407.8 3410.5 3432.0 3438.6 1072.1 1074.7 1079.4 1082.1 1091.6 1241.9 1250.1 1260.7 1263.6 1266.9 6514.5 6583.3 6591.6 6617.3 6620.5 408.4 434.0 463.0 465.9 466.7 5273.1 5325.5 5332.1 5337.5 5346.3 8306.2 8330.3 8410.7 8539.4 8695.9 8689.0 8801.3 8807.1 8812.4 8812.9 6896.5 6910.0 6990.6 7004.0 7020.4 6707.2 6733.1 6733.6 6754.7 6762.4 7666.4 7681.3 7766.8 7917.9 7922.9 7881.5 7992.7 8034.8 8078.6 8128.9 5779.3 5880.0 6413.0 6415.6 6469.1 6693.9 6708.9 6714.7 6720.3 6733.6 6340.8 6362.2 6417.7 6536.4 6593.2 6403.0 6460.6 6549.5 6581.0 6606.5 6347.9 6381.7 6382.3 6384.7 6390.3 5505.6 5520.6 5578.8 5581.3 5581.9 5866.1 5900.1 5911.9 5915.0 5916.8 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#4] prototype.html Cycles:180 Average:5294.71 Median:5971.05 stddev:1616.15 (27.1%) stddev-sans-first:1577.08 05:11:19 INFO - PROCESS | 25684 | Values: 326.5 327.5 328.5 330.2 334.1 5909.1 5930.1 5932.4 5959.3 6027.6 5911.3 5916.5 5921.4 5926.9 5927.1 4560.6 4567.4 4568.2 4571.1 4572.9 4474.1 4551.9 4564.5 4569.2 4579.5 4513.5 4518.8 4522.4 4525.4 4529.5 4309.1 4505.9 4511.0 4516.0 4525.9 3840.4 3874.8 3941.6 3956.3 3962.0 5574.7 5592.4 5603.2 5607.8 5624.5 5003.8 5101.0 5153.6 5260.7 5272.6 6091.0 6144.9 6278.8 6288.0 6290.0 4320.7 4337.6 4340.5 4346.8 4347.0 6458.9 6533.8 6557.9 6564.7 6568.7 4481.2 4487.2 4493.0 4498.5 4498.6 4549.4 4554.8 4559.1 4561.3 4569.9 5254.4 5255.6 5256.0 5262.1 5265.8 6211.7 6348.5 6349.8 6353.4 6383.4 1567.5 1588.1 1588.8 1591.3 1591.9 1031.0 1034.0 1034.5 1038.7 1047.3 5970.2 5982.5 5983.0 5988.6 5988.7 6520.7 6522.9 6532.6 6544.6 6550.8 5961.6 5971.9 5975.8 5977.3 5982.3 3476.5 3577.7 3580.4 3581.1 3584.8 6859.3 6876.4 6884.0 6888.4 6896.1 6560.4 6745.8 6753.1 6756.9 6758.7 6390.8 6700.7 6858.9 6869.5 6872.8 6616.5 6616.8 6617.4 6619.5 6621.4 6535.4 6544.4 6545.1 6552.7 6552.8 6683.1 6804.4 6861.3 6868.0 6871.4 4390.3 4415.6 4417.8 4419.5 4421.4 6608.7 6618.0 6618.6 6620.8 6624.9 6261.7 6389.3 6438.1 6453.3 6464.7 6432.8 6440.6 6447.4 6454.2 6457.9 6253.5 6271.4 6272.9 6278.6 6282.2 6286.8 6451.2 6466.2 6469.3 6475.9 6309.4 6314.8 6323.7 6324.4 6324.7 05:11:19 INFO - PROCESS | 25684 | 05:11:19 INFO - PROCESS | 25684 | [#5] yui.html Cycles:180 Average:13129.10 Median:49786.50 stddev:14989.73 (30.1%) stddev-sans-first:15002.49 05:11:19 INFO - PROCESS | 25684 | Values: 651.2 667.9 675.8 689.2 751.8 13441.1 13625.5 13739.7 13764.9 13768.7 11968.3 14304.3 14358.0 14468.6 14485.6 667.4 780.5 798.0 802.9 802.9 672.6 784.3 804.2 804.4 804.6 823.5 838.6 840.5 840.6 840.9 693.3 698.3 827.2 835.7 839.1 614.4 615.0 616.1 618.9 619.1 13075.7 13169.3 13227.5 13229.4 13234.8 11523.8 11749.8 12201.8 12499.5 12765.6 9616.8 10114.7 10444.3 10541.2 10688.4 3523.2 3549.1 3550.2 3562.4 3693.2 45375.8 45761.3 45778.5 45853.0 46023.3 10196.4 10227.2 10479.8 10508.8 10539.3 18147.1 18188.9 18226.5 18232.5 18260.6 7207.4 7540.6 7543.8 7684.5 7841.7 4402.8 4412.0 4429.2 4431.0 4439.0 2982.6 2995.7 3009.8 3010.3 3015.1 527.9 547.2 557.7 557.7 559.2 514.6 567.0 583.2 583.3 603.8 7553.4 8134.9 8186.3 8268.2 8460.2 517.2 649.1 654.6 656.4 663.1 3868.8 3956.6 3957.6 4041.1 4046.9 48975.5 49897.3 49926.0 50089.5 50102.7 47886.8 49593.8 49609.3 49657.5 49675.8 43711.7 43961.0 44367.1 45485.5 46068.5 7964.2 8125.1 8126.4 8281.3 8405.8 34724.0 35207.3 35213.1 35372.3 35997.0 40352.4 40668.8 43835.3 44425.8 44540.0 9363.4 9576.7 9850.4 9861.9 9883.5 9536.9 9819.8 9871.3 10293.9 10303.4 9774.6 10092.1 10106.9 10326.6 11074.1 9219.2 9269.2 9594.6 9664.7 9706.1 10348.9 10431.8 10494.8 10740.9 10802.2 8755.1 8947.7 9159.6 9418.6 9769.1 8668.2 8919.0 8931.5 9010.5 9239.4 05:11:19 INFO - PROCESS | 25684 | -------- Summary: end -------- 05:11:19 INFO - PROCESS | 25684 | 05:11:20 INFO - TEST-INFO | 25684: exit 0 05:11:20 INFO - TEST-OK | dromaeo_css | took 1113269ms 05:11:20 INFO - TEST-START | kraken 05:11:20 INFO - operating with platform_type : linux_ 05:11:20 INFO - Initialising browser for kraken test... 05:11:20 INFO - TEST-INFO | started process 25878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAfbWIj/profile http://localhost:49234/getInfo.html) 05:11:24 INFO - PROCESS | 25878 | __metrics Screen width/height:1600/1200 05:11:24 INFO - PROCESS | 25878 | colorDepth:24 05:11:24 INFO - PROCESS | 25878 | Browser inner width/height: 1024/697 05:11:24 INFO - PROCESS | 25878 | __metrics 05:11:24 INFO - PROCESS | 25878 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:11:24 INFO - PROCESS | 25878 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:25 INFO - TEST-INFO | 25878: exit 0 05:11:25 INFO - Browser initialized. 05:11:25 INFO - Running cycle 1/1 for kraken test... 05:11:25 INFO - TEST-INFO | started process 25960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAfbWIj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:37 INFO - PROCESS | 25960 | RSS: Main: 148934656 05:11:37 INFO - PROCESS | 25960 | 05:11:39 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:40 INFO - PROCESS | 25960 | RSS: Main: 183898112 05:11:40 INFO - PROCESS | 25960 | 05:11:42 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 05:11:43 INFO - PROCESS | 25960 | RSS: Main: 173772800 05:11:43 INFO - PROCESS | 25960 | 05:11:46 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 05:11:46 INFO - PROCESS | 25960 | RSS: Main: 160903168 05:11:46 INFO - PROCESS | 25960 | 05:11:48 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 05:11:49 INFO - PROCESS | 25960 | RSS: Main: 161456128 05:11:49 INFO - PROCESS | 25960 | 05:11:51 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:52 INFO - PROCESS | 25960 | RSS: Main: 164470784 05:11:52 INFO - PROCESS | 25960 | 05:11:55 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 05:11:55 INFO - PROCESS | 25960 | RSS: Main: 165367808 05:11:55 INFO - PROCESS | 25960 | 05:11:59 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:59 INFO - PROCESS | 25960 | RSS: Main: 165818368 05:11:59 INFO - PROCESS | 25960 | 05:12:02 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 05:12:02 INFO - PROCESS | 25960 | RSS: Main: 165744640 05:12:02 INFO - PROCESS | 25960 | 05:12:04 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:05 INFO - PROCESS | 25960 | RSS: Main: 178589696 05:12:05 INFO - PROCESS | 25960 | 05:12:06 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:07 INFO - PROCESS | 25960 | RSS: Main: 174673920 05:12:07 INFO - PROCESS | 25960 | 05:12:09 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:10 INFO - PROCESS | 25960 | RSS: Main: 184643584 05:12:10 INFO - PROCESS | 25960 | 05:12:12 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:13 INFO - PROCESS | 25960 | RSS: Main: 192053248 05:12:13 INFO - PROCESS | 25960 | 05:12:15 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:16 INFO - PROCESS | 25960 | RSS: Main: 190218240 05:12:16 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 05:12:18 INFO - PROCESS | 25960 | RSS: Main: 248422400 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | __start_tp_report 05:12:18 INFO - PROCESS | 25960 | _x_x_mozilla_page_load 05:12:18 INFO - PROCESS | 25960 | _x_x_mozilla_page_load_details 05:12:18 INFO - PROCESS | 25960 | |i|pagename|runs| 05:12:18 INFO - PROCESS | 25960 | |0;ai-astar;108;111;103;111;111;110;99;110;109;103 05:12:18 INFO - PROCESS | 25960 | |1;audio-beat-detection;154;127;153;161;125;153;149;124;169;135 05:12:18 INFO - PROCESS | 25960 | |2;audio-dft;159;160;160;158;161;160;161;160;161;162 05:12:18 INFO - PROCESS | 25960 | |3;audio-fft;72;73;80;88;70;72;71;103;89;72 05:12:18 INFO - PROCESS | 25960 | |4;audio-oscillator;96;96;137;95;96;95;136;96;96;138 05:12:18 INFO - PROCESS | 25960 | |5;imaging-gaussian-blur;110;109;109;109;108;109;109;109;109;109 05:12:18 INFO - PROCESS | 25960 | |6;imaging-darkroom;146;146;147;145;146;145;146;145;145;146 05:12:18 INFO - PROCESS | 25960 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;97;96 05:12:18 INFO - PROCESS | 25960 | |8;json-parse-financial;58;58;59;57;58;58;58;67;56;57 05:12:18 INFO - PROCESS | 25960 | |9;json-stringify-tinderbox;68;69;67;67;67;68;67;68;67;67 05:12:18 INFO - PROCESS | 25960 | |10;stanford-crypto-aes;85;84;87;87;88;88;87;86;87;86 05:12:18 INFO - PROCESS | 25960 | |11;stanford-crypto-ccm;125;115;122;123;130;126;120;128;128;124 05:12:18 INFO - PROCESS | 25960 | |12;stanford-crypto-pbkdf2;146;154;153;158;162;145;154;171;155;142 05:12:18 INFO - PROCESS | 25960 | |13;stanford-crypto-sha256-iterative;71;69;69;68;70;69;69;67;70;68 05:12:18 INFO - PROCESS | 25960 | __end_tp_report 05:12:18 INFO - PROCESS | 25960 | __start_cc_report 05:12:18 INFO - PROCESS | 25960 | _x_x_mozilla_cycle_collect,922 05:12:18 INFO - PROCESS | 25960 | __end_cc_report 05:12:18 INFO - PROCESS | 25960 | __startTimestamp1451394738300__endTimestamp 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | ------- Summary: start ------- 05:12:18 INFO - PROCESS | 25960 | Number of tests: 14 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.50 stddev:4.28 (3.9%) stddev-sans-first:4.53 05:12:18 INFO - PROCESS | 25960 | Values: 108.0 111.0 103.0 111.0 111.0 110.0 99.0 110.0 109.0 103.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:153.00 stddev:16.06 (10.5%) stddev-sans-first:16.70 05:12:18 INFO - PROCESS | 25960 | Values: 154.0 127.0 153.0 161.0 125.0 153.0 149.0 124.0 169.0 135.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 05:12:18 INFO - PROCESS | 25960 | Values: 159.0 160.0 160.0 158.0 161.0 160.0 161.0 160.0 161.0 162.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.50 stddev:10.98 (15.2%) stddev-sans-first:11.36 05:12:18 INFO - PROCESS | 25960 | Values: 72.0 73.0 80.0 88.0 70.0 72.0 71.0 103.0 89.0 72.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:96.00 stddev:19.95 (20.8%) stddev-sans-first:20.68 05:12:18 INFO - PROCESS | 25960 | Values: 96.0 96.0 137.0 95.0 96.0 95.0 136.0 96.0 96.0 138.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 05:12:18 INFO - PROCESS | 25960 | Values: 110.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 109.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:12:18 INFO - PROCESS | 25960 | Values: 146.0 146.0 147.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:12:18 INFO - PROCESS | 25960 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.06 (5.3%) stddev-sans-first:3.24 05:12:18 INFO - PROCESS | 25960 | Values: 58.0 58.0 59.0 57.0 58.0 58.0 58.0 67.0 56.0 57.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 05:12:18 INFO - PROCESS | 25960 | Values: 68.0 69.0 67.0 67.0 67.0 68.0 67.0 68.0 67.0 67.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 05:12:18 INFO - PROCESS | 25960 | Values: 85.0 84.0 87.0 87.0 88.0 88.0 87.0 86.0 87.0 86.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:4.41 (3.5%) stddev-sans-first:4.66 05:12:18 INFO - PROCESS | 25960 | Values: 125.0 115.0 122.0 123.0 130.0 126.0 120.0 128.0 128.0 124.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.50 stddev:8.56 (5.5%) stddev-sans-first:8.58 05:12:18 INFO - PROCESS | 25960 | Values: 146.0 154.0 153.0 158.0 162.0 145.0 154.0 171.0 155.0 142.0 05:12:18 INFO - PROCESS | 25960 | 05:12:18 INFO - PROCESS | 25960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.15 (1.7%) stddev-sans-first:0.97 05:12:18 INFO - PROCESS | 25960 | Values: 71.0 69.0 69.0 68.0 70.0 69.0 69.0 67.0 70.0 68.0 05:12:18 INFO - PROCESS | 25960 | -------- Summary: end -------- 05:12:18 INFO - PROCESS | 25960 | 05:12:19 INFO - TEST-INFO | 25960: exit 0 05:12:19 INFO - TEST-OK | kraken | took 58711ms 05:12:19 INFO - TEST-START | v8_7 05:12:19 INFO - operating with platform_type : linux_ 05:12:19 INFO - Initialising browser for v8_7 test... 05:12:19 INFO - TEST-INFO | started process 26206 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp97XmBK/profile http://localhost:49234/getInfo.html) 05:12:23 INFO - PROCESS | 26206 | __metrics Screen width/height:1600/1200 05:12:23 INFO - PROCESS | 26206 | colorDepth:24 05:12:23 INFO - PROCESS | 26206 | Browser inner width/height: 1024/697 05:12:23 INFO - PROCESS | 26206 | __metrics 05:12:23 INFO - PROCESS | 26206 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:12:23 INFO - PROCESS | 26206 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:24 INFO - TEST-INFO | 26206: exit 0 05:12:24 INFO - Browser initialized. 05:12:24 INFO - Running cycle 1/1 for v8_7 test... 05:12:24 INFO - TEST-INFO | started process 26288 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp97XmBK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:35 INFO - PROCESS | 26288 | RSS: Main: 148676608 05:12:35 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | Cycle 1(1): loaded http://localhost:49234/tests/v8_7/run.html (next: http://localhost:49234/tests/v8_7/run.html) 05:12:57 INFO - PROCESS | 26288 | RSS: Main: 630009856 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | __start_tp_report 05:12:57 INFO - PROCESS | 26288 | _x_x_mozilla_page_load 05:12:57 INFO - PROCESS | 26288 | _x_x_mozilla_page_load_details 05:12:57 INFO - PROCESS | 26288 | |i|pagename|runs| 05:12:57 INFO - PROCESS | 26288 | |0;Richards;168.86187098953056 05:12:57 INFO - PROCESS | 26288 | |1;DeltaBlue;191.0949742021785 05:12:57 INFO - PROCESS | 26288 | |2;Encrypt;280.97780275358247 05:12:57 INFO - PROCESS | 26288 | |3;Decrypt;5170.103092783505 05:12:57 INFO - PROCESS | 26288 | |4;RayTrace;1122.334455667789 05:12:57 INFO - PROCESS | 26288 | |5;Earley;806.4516129032259 05:12:57 INFO - PROCESS | 26288 | |6;Boyer;11916.666666666666 05:12:57 INFO - PROCESS | 26288 | |7;RegExp;25974.358974358973 05:12:57 INFO - PROCESS | 26288 | |8;Splay;630.3939962476547 05:12:57 INFO - PROCESS | 26288 | |9;NavierStokes;4835.748792270531 05:12:57 INFO - PROCESS | 26288 | __end_tp_report 05:12:57 INFO - PROCESS | 26288 | __startTimestamp1451394777675__endTimestamp 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | ------- Summary: start ------- 05:12:57 INFO - PROCESS | 26288 | Number of tests: 10 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#0] Richards Cycles:1 Average:168.86 Median:168.86 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 168.9 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 191.1 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 281.0 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 5170.1 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#4] RayTrace Cycles:1 Average:1122.33 Median:1122.33 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 1122.3 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#5] Earley Cycles:1 Average:806.45 Median:806.45 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 806.5 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 11916.7 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 25974.4 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#8] Splay Cycles:1 Average:630.39 Median:630.39 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 630.4 05:12:57 INFO - PROCESS | 26288 | 05:12:57 INFO - PROCESS | 26288 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:12:57 INFO - PROCESS | 26288 | Values: 4835.7 05:12:57 INFO - PROCESS | 26288 | -------- Summary: end -------- 05:12:57 INFO - PROCESS | 26288 | 05:12:58 INFO - TEST-INFO | 26288: exit 0 05:12:58 INFO - TEST-OK | v8_7 | took 39278ms 05:12:58 INFO - SUITE-END | took 1211s 05:12:58 INFO - Completed test suite (00:20:11) 05:12:58 INFO - Working with test: dromaeo_css 05:12:58 INFO - Generating results file: dromaeo_css 05:12:58 INFO - Working with test: kraken 05:12:58 INFO - Generating results file: kraken 05:12:58 INFO - javascript benchmark 05:12:58 INFO - Working with test: v8_7 05:12:58 INFO - Generating results file: v8_7 05:12:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:12:58 INFO - process_Request line: dromaeo_css 6645.14 graph.html#tests=[[72,201,35]] 05:12:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:58 INFO - process_Request line: kraken 1510.20 graph.html#tests=[[232,201,35]] 05:12:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:58 INFO - process_Request line: v8_7 20854.94 graph.html#tests=[[230,201,35]] 05:12:58 INFO - RETURN: dromaeo_css: 6645.14 05:12:58 INFO - RETURN: kraken: 1510.20 05:12:58 INFO - RETURN: v8_7: 20854.94 05:12:58 INFO - javascript benchmark 05:12:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.079281611924, 3166.3034132490843, 3198.7441004719626, 3207.5349074384217, 3234.708876201142, 5191.1953647184655, 5298.523132918037, 5314.654547454413, 5318.414974352823, 5376.973115134424, 5207.557357624597, 5342.492463215998, 5352.4915133062295, 5361.678299302044, 5448.891022179564, 4873.829415970442, 4890.682105663138, 4894.437139728923, 4911.607071434277, 4917.4836642152595, 4919.13915064864, 4935.777889994959, 4977.776000079987, 4996.700197988114, 5001.974990125044, 4796.016816552598, 4846.5880400166025, 4905.141600219948, 4940.55535001848, 4962.62780291476, 4893.339399181101, 4895.094407534618, 4910.153367503605, 4919.7540122993705, 4949.554540091409, 4819.108464933964, 4869.659123861331, 4874.488178741217, 4903.362562866804, 4923.384576927884, 5099.59203263738, 5148.5623721983675, 5184.300119483859, 5249.632525723201, 5255.159174532095, 5669.886602267931, 5680.488756011938, 5702.771889124471, 5704.172894930253, 5717.9714101429645, 5721.71391430431, 5734.541236701054, 5737.3688894221605, 5739.971300143514, 5744.942550574483, 5303.284056652341, 5340.145576707708, 5413.810516631938, 5417.10617748075, 5444.156155795858, 5863.296404431496, 5867.530597552186, 5871.031279838779, 5912.852178695481, 5923.0, 5591.189277554732, 5635.098384258499, 5644.774209031675, 5657.9434205658235, 5688.345840228344, 5615.691136987423, 5673.319201695823, 5700.059490184073, 5721.742521586539, 5741.25363702716, 5769.48074673273, 5776.422357764274, 5781.710914454345, 5782.132680098019, 5817.767289308465, 5765.798197063083, 5768.105943578752, 5774.566907481955, 5787.392323806024, 5789.160571717078, 4375.059362237071, 4416.734995900256, 4444.644428445717, 4449.087936972913, 4511.842085526991, 3966.2265858157384, 4004.739691920016, 4005.7997100144876, 4019.799010049486, 4033.495813023372, 5346.5455436287575, 5387.838364849061, 5395.487428694268, 5395.514403703607, 5397.865053373618, 5564.248826408464, 5619.662820230799, 5672.376038635747, 5808.506276966421, 5881.529477641779, 5280.973595132076, 5357.866053348619, 5358.740695936452, 5391.2182733504205, 5396.676199428047, 4883.243097319921, 4919.581835544019, 4953.479884612136, 4958.752062396866, 4962.950370496321, 5765.56758243125, 5908.261467316585, 5916.822495325233, 5924.170616113747, 5924.348321684612, 5665.886682266249, 5682.801101961411, 5724.3703192647945, 5779.479846813807, 5810.94189058104, 5836.182934389274, 5852.824415267549, 5855.6486610801785, 5862.589618726648, 5873.500752436091, 5549.306336707911, 5551.25058117149, 5603.38362780102, 5611.80358687444, 5625.8593535161945, 5730.426957304237, 5736.627119237236, 5747.109198074305, 5825.825225243249, 5847.502962248256, 5630.774769009194, 5654.0, 5655.575831812713, 5664.915026274692, 5668.603197776281, 5377.731113444391, 5632.5493960482245, 5633.464820842013, 5637.098064309855, 5639.802606908738, 5373.032854086302, 5390.838274851761, 5470.507654310972, 5532.419095994863, 5570.832875013756, 5629.634073785354, 5660.716964151694, 5666.9716651416475, 5671.858203544944, 5714.514266287412, 5322.41453440129, 5538.224648549287, 5540.473655002768, 5556.083246264321, 5565.220869078251], "unit": "score", "name": "dojo.html", "value": 5287.543998131828}, {"lowerIsBetter": false, "replicates": [546.3509556464062, 575.6200907401114, 589.3782059926779, 589.9321578018527, 605.9151718759372, 27721.861390693044, 35613.931582052515, 35908.64091359092, 36067.0, 36116.09709757254, 39310.60689393112, 39791.60208397915, 39802.80098599503, 39921.201575968465, 39945.400818987735, 7392.075990501187, 7483.73806916758, 8352.415330926837, 8583.0, 8588.613512391927, 10041.347312424705, 10171.796564068714, 10187.235957303195, 10188.949055254714, 10209.642662506814, 9866.60533578656, 10004.699859004206, 10010.699679009605, 10018.048285412875, 10030.699079027641, 7550.056242969629, 7664.156942736295, 9836.360636558673, 9895.0, 10048.949755251177, 9784.853227201598, 9874.210063194927, 9912.35569687968, 9919.206463482977, 9927.553260103312, 35686.46470302947, 35866.10334741626, 35910.0, 36000.0, 36073.45889811629, 3061.234691327168, 3117.2051126962706, 3164.5727826743323, 3808.314503389389, 3872.0, 28010.0, 28074.438511229662, 28474.145775626763, 28606.14181574556, 28688.0, 3868.2456920900436, 3923.9607603923882, 3946.7631942083567, 3978.741381810173, 4055.168690418457, 269936.0, 270592.0, 273007.0, 274680.0, 275154.24845751486, 49780.0, 50649.74675126601, 50733.492665073616, 55487.44512554823, 55771.44228557744, 45805.31292030622, 59616.70191649101, 60152.69923650354, 60440.69779651162, 60557.39442605606, 11992.100592455427, 12051.397430128458, 12088.758224835454, 12101.878981210075, 12108.939455302843, 9330.440173589606, 9357.766055848659, 9364.344495885223, 9376.812463750686, 9379.390339627902, 17848.0, 18040.458786236435, 18075.36736214226, 18161.636767264845, 18382.08089595515, 7374.483786135026, 7534.3595794357, 7561.621918904033, 7617.390608751398, 7620.504667196615, 891.888513935758, 928.2991341537096, 946.7017889364828, 964.0696727657704, 1020.8621836052187, 27094.322641934108, 27874.721252787214, 28081.859590701915, 28168.718312817018, 28362.574561381596, 961.5000199896015, 977.9951100244454, 989.7129832348683, 997.486294558303, 1075.2043487818958, 14758.188299643409, 14784.704305913821, 15099.773503397459, 15352.385904563693, 15380.230988450532, 379490.0, 384763.0, 384891.0, 385429.0, 385713.0, 52432.47567524352, 53002.0, 53325.46674533205, 53327.73336133295, 53341.733291333294, 1272.2557303977092, 1293.6959814443599, 1297.6431481342706, 1309.306067784076, 1313.7963615639592, 25893.0, 27421.17736467909, 27932.58101128444, 28638.0, 29734.40531189321, 44710.3293450605, 45573.0, 45666.0, 45666.54333456623, 45680.0, 297273.0, 299617.0, 300146.0, 300202.0, 300302.0, 35827.283454331286, 36089.458658120675, 36653.26693466063, 41878.0, 42314.36528452014, 39683.0, 39689.0, 39974.0, 40063.39904901487, 40131.59868401279, 31473.8426307867, 33130.0, 33561.16097097592, 33661.66338336683, 37370.626293737805, 29026.548672565867, 32240.67759322377, 32418.0, 33097.338053238316, 35524.28951420906, 31627.0, 32179.0, 32310.83844580762, 32757.672423276417, 33087.50368744519, 29213.7078629211, 31827.0, 32409.0, 32481.51277730883, 34064.82967585146, 23244.070237191, 23406.882965585064, 23536.176233831735, 23569.0, 23697.881510592335], "unit": "score", "name": "ext.html", "value": 18037.24932018652}, {"lowerIsBetter": false, "replicates": [353.3198592709035, 353.4962678183588, 354.7162270183853, 355.9252556963039, 356.61485595556803, 13849.09980851244, 14061.0, 16157.838421615781, 16371.181440927965, 17074.268117101266, 14838.925805370985, 14922.0, 15068.924655376735, 15080.095194288351, 15080.698386032273, 5111.131107711698, 5112.846614601549, 5118.334616499868, 5123.5388815006645, 5258.605604579653, 3824.3116239076953, 3890.727649064567, 5347.144456886899, 5779.739911703983, 5940.3762604926505, 5816.941830581683, 5820.185174075633, 5862.091375836731, 5878.823635290927, 5888.852778680524, 5765.827025189251, 5946.464818166364, 5952.613080149777, 5954.4640982311585, 5956.910646340309, 5173.094708426011, 5174.844754657329, 5184.118699821001, 5197.974010129925, 5200.479952004769, 11395.259308144945, 11593.89857963492, 11611.94194029033, 11708.180427370087, 11803.645890623295, 2137.6259154647873, 2149.7420309562954, 2178.0, 2209.5139069404704, 2540.796736261095, 9222.723318300395, 9269.44383337002, 9391.859122113174, 9394.34239603228, 9518.666846660333, 1711.3753479979841, 1747.1700942052423, 1815.6096439265489, 1823.772028496438, 1839.4021942868621, 55691.721541392035, 58471.41528584745, 59648.40351596472, 59674.70162649159, 64356.356436435504, 9568.95215523918, 9646.42121472714, 9690.321677482509, 9788.168005719452, 9813.067758562926, 12744.299063551594, 12748.36258187087, 12760.489580416679, 12762.425690843935, 12794.104412691022, 6858.725650974005, 6861.073755043105, 6861.279565645636, 6880.724771009203, 6905.274946130584, 6503.9349606504275, 6508.576942498722, 6564.868702626016, 6565.441937435371, 6573.309802470767, 4156.189543039079, 4237.067845074141, 4256.7445953242905, 4293.484781826201, 4361.0, 1668.5328108129743, 1682.803940857193, 1690.1549225387307, 1713.6658351621313, 1727.7494763259508, 387.94956655634587, 393.34508044106815, 401.83926429428465, 817.1052697296451, 860.7546849147963, 8777.551703968773, 9531.380460270198, 9944.154746846454, 10151.137153342048, 10214.285000049926, 420.51430597659754, 441.55182489772903, 444.3179719131183, 447.5993985383064, 449.66499957531846, 5614.719264036782, 5722.799702010409, 5751.281089863767, 5803.65178089316, 5809.738561764731, 578436.0, 586890.0, 597381.0, 599793.0, 603706.0, 78621.0, 79187.0, 81329.0, 81371.18628813636, 81837.36114305102, 400.8336540335728, 409.6947773908517, 474.7246596973816, 479.18777671845885, 480.4570834956547, 9525.904301053757, 9701.563429645541, 9823.214142868695, 9965.701028969142, 10038.397696138256, 32886.83556582202, 33391.165220869676, 33589.83205083959, 35187.64812351844, 36395.27209455849, 40369.798151009054, 40546.59453405546, 41773.582264178185, 42359.576404235566, 47082.05835883332, 8905.0, 8989.505577193317, 9157.313201510047, 9223.0, 9226.630934762803, 15393.69212615719, 16475.752863706814, 16974.57563560921, 17086.829131708524, 17507.38724144649, 13689.794653080411, 14040.1575905446, 14267.0, 14397.64005899861, 14398.496052638107, 8975.685850995184, 9605.47169905662, 9624.326297159132, 9857.802843942938, 9860.211183105477, 9666.468344241135, 9753.0, 9894.604215831574, 9976.850347244943, 9981.600735970771, 14589.832813375117, 14642.853571464575, 15099.849001510283, 15141.621459463602, 15226.46707365237, 14890.925545372203, 15157.772633410728, 15175.468858589897, 15525.689486210438, 15836.52490425289], "unit": "score", "name": "jquery.html", "value": 7694.1993260197205}, {"lowerIsBetter": false, "replicates": [1263.0968857267053, 1385.612028631983, 1388.9930550347249, 1481.9555413337596, 1701.1409238334647, 6424.2290925089, 7107.751228706997, 7221.169565499962, 7242.601656908868, 7246.746363877265, 7037.3666370026685, 7204.279572042793, 7211.098612673416, 7211.242819503942, 7219.891701624467, 2144.0566150893596, 2174.1738139506965, 2195.82433405328, 2202.515446601745, 2202.944926376845, 2163.697082408464, 2188.3106821351303, 2236.798688118069, 2241.1483636218213, 2241.293992392399, 2135.893205339735, 2166.7183266175375, 2176.086043861582, 2192.583409152264, 2196.9340919772353, 2164.9025793839237, 2190.6823510591034, 2198.296545105567, 2198.9670154947607, 2200.6038912995655, 2145.6459684152096, 2180.6728990651372, 2181.3892110209167, 2182.2907555044676, 2183.1049269799305, 7098.645067746644, 7148.320909513588, 7153.6065516396575, 7154.499185057048, 7161.0332605098165, 4361.367601697768, 4395.296752519582, 4410.75740834254, 4417.094495628388, 4423.977880110579, 2931.267183204199, 2964.3774807290497, 2964.659064207622, 2977.598024266718, 3010.8494575271147, 900.2887718702217, 920.9263258939269, 925.8009527951456, 926.6941909169958, 960.348201094124, 9637.566309516089, 9638.903610963871, 9649.083337083037, 9649.372790768577, 9660.17888479473, 4067.7355971861734, 4102.589741025873, 4162.250794856895, 4172.290710579209, 4203.936940945889, 8361.163883611713, 8410.747677569683, 8439.746807595782, 8441.493510389397, 8452.1547845215, 4418.425604671436, 4457.331400289918, 4485.708428952108, 4492.393526873896, 4513.638908887281, 3566.892993210208, 3642.5264715586804, 3979.1047014421524, 4016.4176194452225, 4069.0, 3400.7619466637098, 3407.778494397906, 3410.4543273076188, 3431.9656803432144, 3438.638942911008, 1072.0780129088978, 1074.6561100447939, 1079.3955384984433, 1082.1234799812178, 1091.612477570467, 1241.90064794818, 1250.0686988193672, 1260.6785269756153, 1263.6082814327588, 1266.9429875655433, 6514.54398192122, 6583.3416658334745, 6591.571547849375, 6617.272100068989, 6620.470362371095, 408.3976135200615, 434.01262128656924, 462.95370462953434, 465.89051572880345, 466.68498763335293, 5273.1299335609965, 5325.520703136736, 5332.146856503018, 5337.492938170868, 5346.251524786533, 8306.169383061646, 8330.291925186306, 8410.663573457115, 8539.359548033797, 8695.869561956575, 8689.0, 8801.295896328278, 8807.07525709804, 8812.383133180616, 8812.8678069829, 6896.517243792987, 6909.963505474219, 6990.580565166107, 7004.0, 7020.438364930793, 6707.1616047994, 6733.094805013178, 6733.629650369081, 6754.729810807513, 6762.357576030269, 7666.386689064973, 7681.308682218627, 7766.805829854299, 7917.881231781413, 7922.881156782538, 7881.487703299267, 7992.720254791055, 8034.799130021563, 8078.555679437687, 8128.918710813053, 5779.335376431764, 5879.970600146972, 6412.9679351602945, 6415.615063096229, 6469.126667899774, 6693.899591506229, 6708.8993665094085, 6714.664266786739, 6720.294369091371, 6733.629650369081, 6340.841478963062, 6362.23653161605, 6417.711202995783, 6536.444402225864, 6593.175853018372, 6403.0, 6460.612363258219, 6549.541532092899, 6581.0, 6606.504512161703, 6347.873042539216, 6381.680915954091, 6382.266039405342, 6384.744610215539, 6390.297067322498, 5505.587080968863, 5520.641158324696, 5578.804741834017, 5581.302337207849, 5581.944180558143, 5866.120081987565, 5900.144479050427, 5911.881762364815, 5915.024021036481, 5916.763329466945], "unit": "score", "name": "mootools.html", "value": 4091.76225218232}, {"lowerIsBetter": false, "replicates": [326.5037143541818, 327.5332650972364, 328.50887922555773, 330.21738479802866, 334.07794487215295, 5909.113632955059, 5930.080837470194, 5932.406759324065, 5959.255093113361, 6027.578069535123, 5911.290645122581, 5916.467517923386, 5921.378255283187, 5926.88146237075, 5927.051671732524, 4560.589546940775, 4567.429071366079, 4568.2462393705, 4571.062932098912, 4572.862814115565, 4474.060447306069, 4551.908961820778, 4564.452265728118, 4569.223232050543, 4579.519150489201, 4513.52607976161, 4518.751468669222, 4522.3668686383935, 4525.434320709911, 4529.456465224162, 4309.138172365508, 4505.932411013838, 4510.954890451087, 4515.9774201128785, 4525.932111018337, 3840.443135745329, 3874.8450061997487, 3941.625545573195, 3956.3076461619103, 3962.0491082140366, 5574.721263936787, 5592.412796656374, 5603.159526071081, 5607.775688972436, 5624.521915637176, 5003.824866129668, 5101.005303965728, 5153.587712982952, 5260.684358938438, 5272.551833094191, 6090.969545152246, 6144.938550614482, 6278.843028924268, 6288.0, 6290.025046117859, 4320.740755554645, 4337.587929146726, 4340.457442819647, 4346.782660866944, 4347.043650396908, 6458.93541064588, 6533.836654083639, 6557.868842623121, 6564.737410503574, 6568.737250509974, 4481.1933851906315, 4487.214737420938, 4493.0, 4498.50516443191, 4498.595126438636, 4549.363089167519, 4554.840580579664, 4559.133764584718, 4561.29299958507, 4569.9314510282375, 5254.369475662868, 5255.5532779713385, 5255.973720131451, 5262.105442074857, 5265.78936842522, 6211.65835879022, 6348.523860710465, 6349.809505714744, 6353.428191462791, 6383.425491705769, 1567.4513920127863, 1588.1424031023348, 1588.7537431698106, 1591.3157342342672, 1591.912444815523, 1030.9587616495405, 1034.007352941185, 1034.534459493231, 1038.657243109772, 1047.251215380991, 5970.194023806731, 5982.4914882234625, 5983.0128028875615, 5988.580799344004, 5988.730507127103, 6520.673966301666, 6522.902156467657, 6532.608043517309, 6544.640044797582, 6550.7707230246715, 5961.5826892118, 5971.910421343683, 5975.790847320323, 5977.282726072812, 5982.312034116132, 3476.5480487536965, 3577.6601222883783, 3580.409232476612, 3581.122624956902, 3584.8386822593047, 6859.279775623488, 6876.449884009267, 6884.0362349271145, 6888.41448476875, 6896.069030680894, 6560.376764207393, 6745.763898263537, 6753.1220941277315, 6756.864862702817, 6758.729650814011, 6390.7763228286785, 6700.6984685688285, 6858.897116543256, 6869.523052543627, 6872.759453419107, 6616.470682345497, 6616.8345791355605, 6617.43751781104, 6619.536632435684, 6621.370969757865, 6535.4444872184495, 6544.44372228366, 6545.050967609765, 6552.737890484327, 6552.803415897531, 6683.097781799394, 6804.353586409283, 6861.313868613099, 6868.038474613658, 6871.415929646036, 4390.275604525217, 4415.624671902796, 4417.845375411845, 4419.513853476051, 4421.447319085114, 6608.70260838273, 6618.007298905202, 6618.602883826986, 6620.801375958729, 6624.867502650017, 6261.655608941552, 6389.329120442472, 6438.098666186644, 6453.257875344396, 6464.676766161579, 6432.807015789534, 6440.645764482999, 6447.3552644735155, 6454.1609590752905, 6457.903131452938, 6253.530985176039, 6271.3728627136925, 6272.905906411316, 6278.560500764903, 6282.2147231596055, 6286.842828929313, 6451.1936007999, 6466.224053113657, 6469.320721324193, 6475.935240647534, 6309.432151106423, 6314.842128946813, 6323.715432805627, 6324.367563243639, 6324.683765811599], "unit": "score", "name": "prototype.html", "value": 4764.818337270613}, {"lowerIsBetter": false, "replicates": [651.2217899609965, 667.9332066793321, 675.8107729835647, 689.2177378675202, 751.8458715963228, 13441.126326788752, 13625.523106691267, 13739.725205495884, 13764.862351376483, 13768.724625507484, 11968.28190308582, 14304.284785760723, 14358.0, 14468.638284042905, 14485.63785905353, 667.4226793823332, 780.4965797060893, 798.022422532396, 802.9116797152309, 802.9357651387904, 672.6233309346757, 784.2549577900988, 804.2359758229676, 804.3967024731452, 804.5655346113122, 823.472977294532, 838.6016642094986, 840.5083026429546, 840.6217202258978, 840.8570543007703, 693.2686016252876, 698.333091897237, 827.1604321613567, 835.7492752174354, 839.0979696825937, 614.4469977020673, 614.9508039356841, 616.100493279812, 618.8793185328863, 619.0961196652892, 13075.738485230337, 13169.275689837055, 13227.537036203783, 13229.404676789567, 13234.801477977839, 11523.769524609545, 11749.823752643717, 12201.755964880742, 12499.500019999188, 12765.55320563785, 9616.807663846685, 10114.696559103239, 10444.321119127233, 10541.156707463384, 10688.412137332443, 3523.154442933703, 3549.148204430918, 3550.218951830593, 3562.447820587813, 3693.169036966688, 45375.773121134516, 45761.31358029632, 45778.54221457776, 45853.0, 46023.30965035494, 10196.4391958443, 10227.232957528066, 10479.790404191874, 10508.842367364496, 10539.262251642465, 18147.09264536768, 18188.90905545464, 18226.54433639143, 18232.45302640923, 18260.634787304447, 7207.423406127497, 7540.585267810214, 7543.811404714926, 7684.46208765381, 7841.725539606086, 4402.823887044547, 4411.9558804411545, 4429.15845989261, 4430.977845110754, 4439.0, 2982.6271716035494, 2995.655499617572, 3009.849507524615, 3010.3377257003426, 3015.050259168399, 527.8996990571856, 547.2120146988403, 557.6849080269635, 557.7099908047793, 559.183591955741, 514.565192412411, 566.9744861481244, 583.2184872271177, 583.270911360799, 603.8318575748748, 7553.357964572963, 8134.877976830352, 8186.345092392594, 8268.173182681683, 8460.238578527962, 517.2319106127397, 649.0977541217711, 654.6105067484839, 656.3895577113235, 663.1478550063146, 3868.787216703052, 3956.5647778744315, 3957.56466788653, 4041.0907545802547, 4046.8785936421955, 48975.51024489781, 49897.25154122691, 49926.0, 50089.499105009214, 50102.74948625234, 47886.76056619764, 49593.752031239615, 49609.25586116211, 49657.50342496529, 49675.75162124239, 43711.72162087856, 43961.0, 44367.112657746664, 45485.54514454879, 46068.53931460642, 7964.2035796422215, 8125.071322606451, 8126.390520711088, 8281.29608983243, 8405.849107383308, 34724.0, 35207.31901987365, 35213.119672008404, 35372.29255414929, 35997.0, 40352.3947140799, 40668.79665601653, 43835.34246986234, 44425.77787111044, 44540.0, 9363.391379560308, 9576.66481673166, 9850.412331330388, 9861.852072219066, 9883.456409897524, 9536.856947145938, 9819.803603928025, 9871.25965552572, 10293.948530257301, 10303.433311167957, 9774.609015639579, 10092.14216791581, 10106.949465252626, 10326.638567650096, 11074.058705010164, 9219.216366608913, 9269.212116970133, 9594.568244429158, 9664.71005869825, 9706.126448619658, 10348.896511034793, 10431.791364172523, 10494.790104198026, 10740.892591073989, 10802.189835762507, 8755.124487551195, 8947.686830960885, 9159.633614655339, 9418.57616407277, 9769.071938165864, 8668.176523230282, 8918.955405222932, 8931.508767017876, 9010.459372437675, 9239.39943903644], "unit": "score", "name": "yui.html", "value": 6017.841900572993}], "name": "dromaeo_css", "value": 6645.141034085306}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 111.0, 111.0, 110.0, 99.0, 110.0, 109.0, 103.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 153.0, 161.0, 125.0, 153.0, 149.0, 124.0, 169.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 158.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 88.0, 70.0, 72.0, 71.0, 103.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 96.0, 95.0, 136.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 57.0, 58.0, 58.0, 58.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 87.0, 87.0, 88.0, 88.0, 87.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [125.0, 115.0, 122.0, 123.0, 130.0, 126.0, 120.0, 128.0, 128.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [146.0, 154.0, 153.0, 158.0, 162.0, 145.0, 154.0, 171.0, 155.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0, 67.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1510.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.86187098953056], "unit": "score", "name": "Richards", "value": 209.058444}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1122.334455667789], "unit": "score", "name": "RayTrace", "value": 659.3301990000002}, {"lowerIsBetter": false, "replicates": [806.4516129032259], "unit": "score", "name": "Earley", "value": 826.4141199999997}, {"lowerIsBetter": false, "replicates": [11916.666666666666], "unit": "score", "name": "Boyer", "value": 55.926965034964994}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [630.3939962476547], "unit": "score", "name": "Splay", "value": 129.26994940476195}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20854.943474603868}]} 05:12:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20854.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1510.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6645.14"}}} 05:12:58 INFO - Return code: 0 05:12:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:58 INFO - # TBPL SUCCESS # 05:12:58 INFO - Running post-action listener: _resource_record_post_action 05:12:58 INFO - Running post-run listener: _resource_record_post_run 05:12:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 555204608; Read time: 460; Write time: 579584 05:12:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246194176; Read time: 268; Write time: 313032 05:12:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 308719616; Read time: 192; Write time: 266504 05:12:59 INFO - Running post-run listener: _upload_blobber_files 05:12:59 INFO - Blob upload gear active. 05:12:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:12:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:12:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:12:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:13:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:01 INFO - (blobuploader) - INFO - Done attempting. 05:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:02 INFO - (blobuploader) - INFO - Done attempting. 05:13:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:02 INFO - Return code: 0 05:13:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:13:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/67a4ec84c5fcb59388cb6e331d2438f4046a4476c9b25df6e1790f26f792125d669cc68b9348bf928366da51bc0fbb6f8c32a284b9a3e804cba19e77da1ee0b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8bec13abdd53678a4a28af0728633e563df3a94a2ffa2cbdfa149037a952ac5ffe503d74ac64ad695a6c8acf9eca0b8cd84a8668cb236a67ef9f94f0208e716f"} 05:13:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:13:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:13:02 INFO - Contents: 05:13:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/67a4ec84c5fcb59388cb6e331d2438f4046a4476c9b25df6e1790f26f792125d669cc68b9348bf928366da51bc0fbb6f8c32a284b9a3e804cba19e77da1ee0b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8bec13abdd53678a4a28af0728633e563df3a94a2ffa2cbdfa149037a952ac5ffe503d74ac64ad695a6c8acf9eca0b8cd84a8668cb236a67ef9f94f0208e716f"} 05:13:02 INFO - Copying logs to upload dir... 05:13:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.742121 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-29 05:13:01.147480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 05:13:01.152918) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/67a4ec84c5fcb59388cb6e331d2438f4046a4476c9b25df6e1790f26f792125d669cc68b9348bf928366da51bc0fbb6f8c32a284b9a3e804cba19e77da1ee0b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8bec13abdd53678a4a28af0728633e563df3a94a2ffa2cbdfa149037a952ac5ffe503d74ac64ad695a6c8acf9eca0b8cd84a8668cb236a67ef9f94f0208e716f"} build_url:https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/RBl_JZZNS5O5SeCsl-Mriw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/67a4ec84c5fcb59388cb6e331d2438f4046a4476c9b25df6e1790f26f792125d669cc68b9348bf928366da51bc0fbb6f8c32a284b9a3e804cba19e77da1ee0b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/8bec13abdd53678a4a28af0728633e563df3a94a2ffa2cbdfa149037a952ac5ffe503d74ac64ad695a6c8acf9eca0b8cd84a8668cb236a67ef9f94f0208e716f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 05:13:01.177950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:13:01.178279) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fdc9337702648c539b2c5dbe000001aa-1451392345.645-261314861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 05:13:01.264287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 05:13:01.264616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 05:13:01.264923) ========= ========= Total master_lag: 0.22 =========