builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1452117637.24 results: success (0) buildid: 20160106113008 builduid: 020a9163bc894e9fbe17de485b53fa3d revision: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.240398) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.241230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.241829) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004335 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.263032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.263710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.278866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.279460) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.331750) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.332316) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.333031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.333581) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 14:00:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-06 14:00:37 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.450935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.451321) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.502340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:37.502873) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a6b63cd300eb05f28b54e4f5266406a29e13b7a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5a6b63cd300eb05f28b54e4f5266406a29e13b7a --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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 14:00:37,610 truncating revision to first 12 chars 2016-01-06 14:00:37,610 Setting DEBUG logging. 2016-01-06 14:00:37,610 attempt 1/10 2016-01-06 14:00:37,610 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a6b63cd300e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 14:00:37,860 unpacking tar archive at: fx-team-5a6b63cd300e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:38.060115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:38.060492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:38.071393) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:38.071794) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 14:00:38.072318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-06 14:00:38.072663) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:38 INFO - MultiFileLogger online at 20160106 14:00:38 in /builds/slave/test-pgo 14:00:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:00:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:00:38 INFO - {'append_to_log': False, 14:00:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:00:38 INFO - 'blob_upload_branch': 'Fx-Team', 14:00:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:00:38 INFO - 'branch': 'Fx-Team', 14:00:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:38 INFO - 'config_files': ('talos/linux_config.py',), 14:00:38 INFO - 'default_actions': ('clobber', 14:00:38 INFO - 'read-buildbot-config', 14:00:38 INFO - 'download-and-extract', 14:00:38 INFO - 'populate-webroot', 14:00:38 INFO - 'create-virtualenv', 14:00:38 INFO - 'install', 14:00:38 INFO - 'run-tests'), 14:00:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:38 INFO - 'download_minidump_stackwalk': True, 14:00:38 INFO - 'download_symbols': 'ondemand', 14:00:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:38 INFO - 'installer_path': 'installer.exe', 14:00:38 INFO - 'log_level': 'info', 14:00:38 INFO - 'log_name': 'talos', 14:00:38 INFO - 'log_to_console': True, 14:00:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:38 INFO - 'opt_config_files': (), 14:00:38 INFO - 'pip_index': False, 14:00:38 INFO - 'sps_profile': False, 14:00:38 INFO - 'sps_profile_interval': 0, 14:00:38 INFO - 'suite': 'dromaeojs', 14:00:38 INFO - 'system_bits': '32', 14:00:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:38 INFO - 'title': 'talos-linux64-ix-027', 14:00:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:38 INFO - 'use_talos_json': True, 14:00:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:00:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:38 INFO - 'work_dir': 'build'} 14:00:38 INFO - ##### 14:00:38 INFO - ##### Running clobber step. 14:00:38 INFO - ##### 14:00:38 INFO - Running pre-action listener: _resource_record_pre_action 14:00:38 INFO - Running main action method: clobber 14:00:38 INFO - rmtree: /builds/slave/test-pgo/build 14:00:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:00:39 INFO - Running post-action listener: _resource_record_post_action 14:00:39 INFO - ##### 14:00:39 INFO - ##### Running read-buildbot-config step. 14:00:39 INFO - ##### 14:00:39 INFO - Running pre-action listener: _resource_record_pre_action 14:00:39 INFO - Running main action method: read_buildbot_config 14:00:39 INFO - Using buildbot properties: 14:00:39 INFO - { 14:00:39 INFO - "project": "", 14:00:39 INFO - "product": "firefox", 14:00:39 INFO - "script_repo_revision": "production", 14:00:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:00:39 INFO - "repository": "", 14:00:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:00:39 INFO - "buildid": "20160106113008", 14:00:39 INFO - "pgo_build": "True", 14:00:39 INFO - "basedir": "/builds/slave/test-pgo", 14:00:39 INFO - "buildnumber": 878, 14:00:39 INFO - "slavename": "talos-linux64-ix-027", 14:00:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:00:39 INFO - "platform": "ubuntu64_hw", 14:00:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:00:39 INFO - "branch": "fx-team", 14:00:39 INFO - "repo_path": "integration/fx-team", 14:00:39 INFO - "revision": "5a6b63cd300eb05f28b54e4f5266406a29e13b7a", 14:00:39 INFO - "stage_platform": "linux64-pgo", 14:00:39 INFO - "builduid": "020a9163bc894e9fbe17de485b53fa3d", 14:00:39 INFO - "slavebuilddir": "test" 14:00:39 INFO - } 14:00:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:00:39 INFO - Running post-action listener: _resource_record_post_action 14:00:39 INFO - ##### 14:00:39 INFO - ##### Running download-and-extract step. 14:00:39 INFO - ##### 14:00:39 INFO - Running pre-action listener: _resource_record_pre_action 14:00:39 INFO - Running main action method: download_and_extract 14:00:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:39 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json 14:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json 14:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:00:39 INFO - Downloaded 1302 bytes. 14:00:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:00:39 INFO - Using the following test package requirements: 14:00:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'jsshell-linux-x86_64.zip'], 14:00:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:00:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:00:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:39 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:40 INFO - Downloaded 24101983 bytes. 14:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:00:42 INFO - Return code: 0 14:00:42 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 14:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:42 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:43 INFO - Downloaded 24101983 bytes. 14:00:43 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 14:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:00:43 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 14:00:44 INFO - Return code: 0 14:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:44 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:45 INFO - Downloaded 11132285 bytes. 14:00:45 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 14:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:45 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 14:00:45 INFO - Return code: 0 14:00:45 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')]} 14:00:45 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:00:47 INFO - Downloaded 55045913 bytes. 14:00:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:47 INFO - mkdir: /builds/slave/test-pgo/properties 14:00:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:00:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:00:47 INFO - Contents: 14:00:47 INFO - build_url:https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:00:47 INFO - Running post-action listener: _resource_record_post_action 14:00:47 INFO - Running post-action listener: set_extra_try_arguments 14:00:47 INFO - ##### 14:00:47 INFO - ##### Running populate-webroot step. 14:00:47 INFO - ##### 14:00:47 INFO - Running pre-action listener: _resource_record_pre_action 14:00:47 INFO - Running main action method: populate_webroot 14:00:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:47 INFO - '--tppagecycles', 14:00:47 INFO - '7'], 14:00:47 INFO - 'tests': ['tsvgm']}}, 14:00:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:00:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:00:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:00:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'tests': ['damp', 'tps']}, 14:00:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['damp', 'tps']}, 14:00:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:00:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:47 INFO - 'other': {'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'other_l64': {'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'other_nol64': {'tests': ['a11yr', 14:00:47 INFO - 'ts_paint', 14:00:47 INFO - 'tpaint', 14:00:47 INFO - 'sessionrestore', 14:00:47 INFO - 'sessionrestore_no_auto_restore']}, 14:00:47 INFO - 'svgr': {'tests': ['tsvgx', 14:00:47 INFO - 'tsvgr_opacity', 14:00:47 INFO - 'tart', 14:00:47 INFO - 'tscrollx', 14:00:47 INFO - 'cart']}, 14:00:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['tsvgx', 14:00:47 INFO - 'tsvgr_opacity', 14:00:47 INFO - 'tart', 14:00:47 INFO - 'tscrollx', 14:00:47 INFO - 'cart']}, 14:00:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'tests': ['tp5o']}, 14:00:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'talos_options': ['--e10s'], 14:00:47 INFO - 'tests': ['tp5o']}, 14:00:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'talos_options': ['--xperf_path', 14:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:47 INFO - 'tests': ['tp5n']}, 14:00:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:47 INFO - 'talos_options': ['--e10s', 14:00:47 INFO - '--xperf_path', 14:00:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:47 INFO - 'tests': ['tp5n']}}, 14:00:47 INFO - 'talos.zip': {'path': '', 14:00:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:47 INFO - Running post-action listener: _resource_record_post_action 14:00:47 INFO - ##### 14:00:47 INFO - ##### Running create-virtualenv step. 14:00:47 INFO - ##### 14:00:47 INFO - Running pre-action listener: _resource_record_pre_action 14:00:47 INFO - Running main action method: create_virtualenv 14:00:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:00:47 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 14:00:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:00:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:47 INFO - Using real prefix '/usr' 14:00:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:00:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:49 INFO - Installing pip.................done. 14:00:49 INFO - Return code: 0 14:00:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:00:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:00:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:00:49 INFO - Using env: {'DISPLAY': ':0', 14:00:49 INFO - 'HOME': '/home/cltbld', 14:00:49 INFO - 'LANG': 'en_US.UTF-8', 14:00:49 INFO - 'LANGUAGE': 'en_US:en', 14:00:49 INFO - 'LOGNAME': 'cltbld', 14:00:49 INFO - 'MAIL': '/var/mail/cltbld', 14:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:49 INFO - 'MOZ_NO_REMOTE': '1', 14:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:49 INFO - 'NO_EM_RESTART': '1', 14:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:49 INFO - 'SHELL': '/bin/bash', 14:00:49 INFO - 'SHLVL': '1', 14:00:49 INFO - 'TERM': 'linux', 14:00:49 INFO - 'TMOUT': '86400', 14:00:49 INFO - 'USER': 'cltbld', 14:00:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:49 INFO - '_': '/tools/buildbot/bin/python'} 14:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:50 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 14:00:50 INFO - Cleaning up... 14:00:50 INFO - Return code: 0 14:00:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:50 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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:00:50 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 14:00:50 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 14:00:50 INFO - Using env: {'DISPLAY': ':0', 14:00:50 INFO - 'HOME': '/home/cltbld', 14:00:50 INFO - 'LANG': 'en_US.UTF-8', 14:00:50 INFO - 'LANGUAGE': 'en_US:en', 14:00:50 INFO - 'LOGNAME': 'cltbld', 14:00:50 INFO - 'MAIL': '/var/mail/cltbld', 14:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:50 INFO - 'MOZ_NO_REMOTE': '1', 14:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:50 INFO - 'NO_EM_RESTART': '1', 14:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:50 INFO - 'SHELL': '/bin/bash', 14:00:50 INFO - 'SHLVL': '1', 14:00:50 INFO - 'TERM': 'linux', 14:00:50 INFO - 'TMOUT': '86400', 14:00:50 INFO - 'USER': 'cltbld', 14:00:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:50 INFO - '_': '/tools/buildbot/bin/python'} 14:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:50 INFO - Downloading/unpacking psutil>=0.7.1 14:00:50 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 14:00:50 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 14:00:50 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 14:00:50 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 14:00:50 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 14:00:50 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 14:00:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:00:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:52 INFO - Installing collected packages: psutil 14:00:52 INFO - Running setup.py install for psutil 14:00:52 INFO - building 'psutil._psutil_linux' extension 14:00:52 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 14:00:52 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 14:00:52 INFO - building 'psutil._psutil_posix' extension 14:00:52 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 14:00:52 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 14:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:52 INFO - Successfully installed psutil 14:00:52 INFO - Cleaning up... 14:00:52 INFO - Return code: 0 14:00:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:00: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')]} 14:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:52 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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:00:52 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 14:00:52 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 14:00:52 INFO - Using env: {'DISPLAY': ':0', 14:00:52 INFO - 'HOME': '/home/cltbld', 14:00:52 INFO - 'LANG': 'en_US.UTF-8', 14:00:52 INFO - 'LANGUAGE': 'en_US:en', 14:00:52 INFO - 'LOGNAME': 'cltbld', 14:00:52 INFO - 'MAIL': '/var/mail/cltbld', 14:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:52 INFO - 'MOZ_NO_REMOTE': '1', 14:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:52 INFO - 'NO_EM_RESTART': '1', 14:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:52 INFO - 'SHELL': '/bin/bash', 14:00:52 INFO - 'SHLVL': '1', 14:00:52 INFO - 'TERM': 'linux', 14:00:52 INFO - 'TMOUT': '86400', 14:00:52 INFO - 'USER': 'cltbld', 14:00:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:52 INFO - '_': '/tools/buildbot/bin/python'} 14:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:00:52 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 14:00:52 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 14:00:52 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 14:00:52 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 14:00:52 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 14:00:52 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 14:00:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:00:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:00:54 INFO - Installing collected packages: mozsystemmonitor 14:00:54 INFO - Running setup.py install for mozsystemmonitor 14:00:54 INFO - Successfully installed mozsystemmonitor 14:00:54 INFO - Cleaning up... 14:00:54 INFO - Return code: 0 14:00:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:54 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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:00:54 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 14:00:54 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 14:00:54 INFO - Using env: {'DISPLAY': ':0', 14:00:54 INFO - 'HOME': '/home/cltbld', 14:00:54 INFO - 'LANG': 'en_US.UTF-8', 14:00:54 INFO - 'LANGUAGE': 'en_US:en', 14:00:54 INFO - 'LOGNAME': 'cltbld', 14:00:54 INFO - 'MAIL': '/var/mail/cltbld', 14:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:54 INFO - 'MOZ_NO_REMOTE': '1', 14:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:54 INFO - 'NO_EM_RESTART': '1', 14:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:54 INFO - 'SHELL': '/bin/bash', 14:00:54 INFO - 'SHLVL': '1', 14:00:54 INFO - 'TERM': 'linux', 14:00:54 INFO - 'TMOUT': '86400', 14:00:54 INFO - 'USER': 'cltbld', 14:00:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:54 INFO - '_': '/tools/buildbot/bin/python'} 14:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00:56 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 14:00:56 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 14:00:56 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 14:00:56 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 14:00:56 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 14:00:56 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 14:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:00:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - Downloading docopt-0.6.1.tar.gz 14:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:57 INFO - Running setup.py install for blobuploader 14:00:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:00:57 INFO - Running setup.py install for requests 14:00:57 INFO - Running setup.py install for docopt 14:00:57 INFO - Successfully installed blobuploader requests docopt 14:00:57 INFO - Cleaning up... 14:00:58 INFO - Return code: 0 14:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:58 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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:00:58 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 14:00:58 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 14:00:58 INFO - Using env: {'DISPLAY': ':0', 14:00:58 INFO - 'HOME': '/home/cltbld', 14:00:58 INFO - 'LANG': 'en_US.UTF-8', 14:00:58 INFO - 'LANGUAGE': 'en_US:en', 14:00:58 INFO - 'LOGNAME': 'cltbld', 14:00:58 INFO - 'MAIL': '/var/mail/cltbld', 14:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:58 INFO - 'MOZ_NO_REMOTE': '1', 14:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:58 INFO - 'NO_EM_RESTART': '1', 14:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:00:58 INFO - 'SHELL': '/bin/bash', 14:00:58 INFO - 'SHLVL': '1', 14:00:58 INFO - 'TERM': 'linux', 14:00:58 INFO - 'TMOUT': '86400', 14:00:58 INFO - 'USER': 'cltbld', 14:00:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:58 INFO - '_': '/tools/buildbot/bin/python'} 14:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:58 INFO - Running setup.py (path:/tmp/pip-8TDFqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:58 INFO - Running setup.py (path:/tmp/pip-Id1nGV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:58 INFO - Running setup.py (path:/tmp/pip-DJr_la-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:58 INFO - Running setup.py (path:/tmp/pip-dnk53h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:58 INFO - Running setup.py (path:/tmp/pip-oLcUbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:58 INFO - Running setup.py (path:/tmp/pip-2YpqwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:58 INFO - Running setup.py (path:/tmp/pip-xvS4j7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:58 INFO - Running setup.py (path:/tmp/pip-zwzzFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:58 INFO - Running setup.py (path:/tmp/pip-XpPmOR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:58 INFO - Running setup.py (path:/tmp/pip-4r1MwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:58 INFO - Running setup.py (path:/tmp/pip-oQ49Ju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:59 INFO - Running setup.py (path:/tmp/pip-gDxGsk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:59 INFO - Running setup.py (path:/tmp/pip-PK6Bbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:59 INFO - Running setup.py (path:/tmp/pip-99G4TX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:59 INFO - Running setup.py (path:/tmp/pip-KdZp5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:59 INFO - Running setup.py (path:/tmp/pip-1WJm_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:59 INFO - Running setup.py (path:/tmp/pip-nqXA02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:00:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:59 INFO - Running setup.py install for manifestparser 14:00:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:00:59 INFO - Running setup.py install for mozcrash 14:00:59 INFO - Running setup.py install for mozdebug 14:00:59 INFO - Running setup.py install for mozdevice 14:00:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:00:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:00:59 INFO - Running setup.py install for mozfile 14:00:59 INFO - Running setup.py install for mozhttpd 14:01:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozinfo 14:01:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozInstall 14:01:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozleak 14:01:00 INFO - Running setup.py install for mozlog 14:01:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for moznetwork 14:01:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozprocess 14:01:00 INFO - Running setup.py install for mozprofile 14:01:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozrunner 14:01:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:01:00 INFO - Running setup.py install for mozscreenshot 14:01:01 INFO - Running setup.py install for moztest 14:01:01 INFO - Running setup.py install for mozversion 14:01:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:01:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:01 INFO - Cleaning up... 14:01:01 INFO - Return code: 0 14:01:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:01:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 14:01:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 14:01:01 INFO - Using env: {'DISPLAY': ':0', 14:01:01 INFO - 'HOME': '/home/cltbld', 14:01:01 INFO - 'LANG': 'en_US.UTF-8', 14:01:01 INFO - 'LANGUAGE': 'en_US:en', 14:01:01 INFO - 'LOGNAME': 'cltbld', 14:01:01 INFO - 'MAIL': '/var/mail/cltbld', 14:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:01 INFO - 'MOZ_NO_REMOTE': '1', 14:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:01 INFO - 'NO_EM_RESTART': '1', 14:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:01 INFO - 'SHELL': '/bin/bash', 14:01:01 INFO - 'SHLVL': '1', 14:01:01 INFO - 'TERM': 'linux', 14:01:01 INFO - 'TMOUT': '86400', 14:01:01 INFO - 'USER': 'cltbld', 14:01:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:01 INFO - '_': '/tools/buildbot/bin/python'} 14:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:01 INFO - Running setup.py (path:/tmp/pip-FvLC0W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:01 INFO - Running setup.py (path:/tmp/pip-M5ePUU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:01 INFO - Running setup.py (path:/tmp/pip-IqvY5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:01 INFO - Running setup.py (path:/tmp/pip-ssBzWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:01 INFO - Running setup.py (path:/tmp/pip-Hias7s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:01 INFO - Running setup.py (path:/tmp/pip-ndKg9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:01 INFO - Running setup.py (path:/tmp/pip-KWHlnZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:01 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)) 14:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:01 INFO - Running setup.py (path:/tmp/pip-F5uOlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:02 INFO - Running setup.py (path:/tmp/pip-Slr2vD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:02 INFO - Running setup.py (path:/tmp/pip-ePk_uw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:02 INFO - Running setup.py (path:/tmp/pip-lgL9Aj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:02 INFO - Running setup.py (path:/tmp/pip-iqgRPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:02 INFO - Running setup.py (path:/tmp/pip-lXO_k7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:02 INFO - Running setup.py (path:/tmp/pip-c4VNoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:02 INFO - Running setup.py (path:/tmp/pip-fMv2e4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:02 INFO - Running setup.py (path:/tmp/pip-1U2cd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:02 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)) 14:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:02 INFO - Running setup.py (path:/tmp/pip-C1n9pi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:02 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)) 14:01:02 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)) 14:01:02 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)) 14:01:02 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)) 14:01:02 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)) 14:01:02 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)) 14:01:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:04 INFO - Downloading blessings-1.5.1.tar.gz 14:01:04 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 14:01:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:04 INFO - Installing collected packages: blessings 14:01:04 INFO - Running setup.py install for blessings 14:01:04 INFO - Successfully installed blessings 14:01:04 INFO - Cleaning up... 14:01:04 INFO - Return code: 0 14:01:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:04 INFO - Reading from file tmpfile_stdout 14:01:04 INFO - Current package versions: 14:01:04 INFO - argparse == 1.2.1 14:01:04 INFO - blessings == 1.5.1 14:01:04 INFO - blobuploader == 1.2.4 14:01:04 INFO - docopt == 0.6.1 14:01:04 INFO - manifestparser == 1.1 14:01:04 INFO - mozInstall == 1.12 14:01:04 INFO - mozcrash == 0.16 14:01:04 INFO - mozdebug == 0.1 14:01:04 INFO - mozdevice == 0.47 14:01:04 INFO - mozfile == 1.2 14:01:04 INFO - mozhttpd == 0.7 14:01:04 INFO - mozinfo == 0.9 14:01:04 INFO - mozleak == 0.1 14:01:04 INFO - mozlog == 3.1 14:01:04 INFO - moznetwork == 0.27 14:01:04 INFO - mozprocess == 0.22 14:01:04 INFO - mozprofile == 0.28 14:01:04 INFO - mozrunner == 6.11 14:01:04 INFO - mozscreenshot == 0.1 14:01:04 INFO - mozsystemmonitor == 0.0 14:01:04 INFO - moztest == 0.7 14:01:04 INFO - mozversion == 1.4 14:01:04 INFO - psutil == 3.1.1 14:01:04 INFO - requests == 1.2.3 14:01:04 INFO - wsgiref == 0.1.2 14:01:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01: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')]} 14:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:01:04 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 14:01:04 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 14:01:04 INFO - Using env: {'DISPLAY': ':0', 14:01:04 INFO - 'HOME': '/home/cltbld', 14:01:04 INFO - 'LANG': 'en_US.UTF-8', 14:01:04 INFO - 'LANGUAGE': 'en_US:en', 14:01:04 INFO - 'LOGNAME': 'cltbld', 14:01:04 INFO - 'MAIL': '/var/mail/cltbld', 14:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:04 INFO - 'MOZ_NO_REMOTE': '1', 14:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:04 INFO - 'NO_EM_RESTART': '1', 14:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:04 INFO - 'SHELL': '/bin/bash', 14:01:04 INFO - 'SHLVL': '1', 14:01:04 INFO - 'TERM': 'linux', 14:01:04 INFO - 'TMOUT': '86400', 14:01:04 INFO - 'USER': 'cltbld', 14:01:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:04 INFO - '_': '/tools/buildbot/bin/python'} 14:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 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)) 14:01:05 INFO - Cleaning up... 14:01:05 INFO - Return code: 0 14:01:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:01: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')]} 14:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:01:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:01:05 INFO - Using env: {'DISPLAY': ':0', 14:01:05 INFO - 'HOME': '/home/cltbld', 14:01:05 INFO - 'LANG': 'en_US.UTF-8', 14:01:05 INFO - 'LANGUAGE': 'en_US:en', 14:01:05 INFO - 'LOGNAME': 'cltbld', 14:01:05 INFO - 'MAIL': '/var/mail/cltbld', 14:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:05 INFO - 'MOZ_NO_REMOTE': '1', 14:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:05 INFO - 'NO_EM_RESTART': '1', 14:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:05 INFO - 'SHELL': '/bin/bash', 14:01:05 INFO - 'SHLVL': '1', 14:01:05 INFO - 'TERM': 'linux', 14:01:05 INFO - 'TMOUT': '86400', 14:01:05 INFO - 'USER': 'cltbld', 14:01:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:05 INFO - '_': '/tools/buildbot/bin/python'} 14:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:05 INFO - Downloading/unpacking jsonschema 14:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:06 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 14:01:06 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:01:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:07 INFO - warning: no files found matching '*.txt' 14:01:07 INFO - no previously-included directories found matching 'build' 14:01:07 INFO - no previously-included directories found matching 'dist' 14:01:07 INFO - no previously-included directories found matching '.git*' 14:01:07 INFO - Installing collected packages: jsonschema, functools32 14:01:07 INFO - Running setup.py install for functools32 14:01:07 INFO - warning: no files found matching '*.txt' 14:01:07 INFO - no previously-included directories found matching 'build' 14:01:07 INFO - no previously-included directories found matching 'dist' 14:01:07 INFO - no previously-included directories found matching '.git*' 14:01:07 INFO - Successfully installed jsonschema functools32 14:01:07 INFO - Cleaning up... 14:01:07 INFO - Return code: 0 14:01:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:01:07 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')]} 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:07 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')]} 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:07 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 0x7f6807caaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, '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': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', '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 14:01:07 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 14:01:07 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 14:01:07 INFO - Using env: {'DISPLAY': ':0', 14:01:07 INFO - 'HOME': '/home/cltbld', 14:01:07 INFO - 'LANG': 'en_US.UTF-8', 14:01:07 INFO - 'LANGUAGE': 'en_US:en', 14:01:07 INFO - 'LOGNAME': 'cltbld', 14:01:07 INFO - 'MAIL': '/var/mail/cltbld', 14:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:07 INFO - 'MOZ_NO_REMOTE': '1', 14:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:07 INFO - 'NO_EM_RESTART': '1', 14:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:07 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:07 INFO - 'SHELL': '/bin/bash', 14:01:07 INFO - 'SHLVL': '1', 14:01:07 INFO - 'TERM': 'linux', 14:01:07 INFO - 'TMOUT': '86400', 14:01:07 INFO - 'USER': 'cltbld', 14:01:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:07 INFO - '_': '/tools/buildbot/bin/python'} 14:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:07 INFO - Downloading/unpacking flake8 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:09 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 14:01:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:09 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 14:01:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 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 14:01:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:01:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:10 INFO - no previously-included directories found matching 'docs/_build' 14:01:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:10 INFO - Running setup.py install for pep8 14:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:10 INFO - no previously-included directories found matching 'docs/_build' 14:01:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:01:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:10 INFO - Cleaning up... 14:01:10 INFO - Return code: 0 14:01:10 INFO - Running post-action listener: _resource_record_post_action 14:01:10 INFO - Running post-action listener: _start_resource_monitoring 14:01:10 INFO - Starting resource monitoring. 14:01:10 INFO - ##### 14:01:10 INFO - ##### Running install step. 14:01:10 INFO - ##### 14:01:10 INFO - Running pre-action listener: _resource_record_pre_action 14:01:10 INFO - Running main action method: install 14:01:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:10 INFO - Reading from file tmpfile_stdout 14:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:01:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:01:10 INFO - Reading from file tmpfile_stdout 14:01:10 INFO - Output received: 14:01:10 INFO - Usage: mozinstall [options] installer 14:01:10 INFO - Options: 14:01:10 INFO - -h, --help show this help message and exit 14:01:10 INFO - -d DEST, --destination=DEST 14:01:10 INFO - Directory to install application into. [default: 14:01:10 INFO - "/builds/slave/test-pgo"] 14:01:10 INFO - --app=APP Application being installed. [default: firefox] 14:01:10 INFO - mkdir: /builds/slave/test-pgo/build/application 14:01:10 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'] 14:01:10 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 14:01:26 INFO - Reading from file tmpfile_stdout 14:01:26 INFO - Output received: 14:01:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:01:26 INFO - Running post-action listener: _resource_record_post_action 14:01:26 INFO - ##### 14:01:26 INFO - ##### Running run-tests step. 14:01:26 INFO - ##### 14:01:26 INFO - Running pre-action listener: _resource_record_pre_action 14:01:26 INFO - Running main action method: run_tests 14:01:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:01:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:01:26 INFO - Python 2.7.3 14:01:26 INFO - Return code: 0 14:01:26 INFO - grabbing minidump binary from tooltool 14:01:26 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')]} 14:01:26 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 0x1648840>, '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 0x15b56b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b5b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:01:26 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 14:01:26 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 14:01:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:26 INFO - Return code: 0 14:01:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:01:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:01:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:01:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:01:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:01:27 INFO - Return code: 0 14:01:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:01:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 14:01:27 INFO - Using env: {'DISPLAY': ':0', 14:01:27 INFO - 'HOME': '/home/cltbld', 14:01:27 INFO - 'LANG': 'en_US.UTF-8', 14:01:27 INFO - 'LANGUAGE': 'en_US:en', 14:01:27 INFO - 'LOGNAME': 'cltbld', 14:01:27 INFO - 'MAIL': '/var/mail/cltbld', 14:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:27 INFO - 'MOZ_NO_REMOTE': '1', 14:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:27 INFO - 'NO_EM_RESTART': '1', 14:01:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:27 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:01:27 INFO - 'SHELL': '/bin/bash', 14:01:27 INFO - 'SHLVL': '1', 14:01:27 INFO - 'TERM': 'linux', 14:01:27 INFO - 'TMOUT': '86400', 14:01:27 INFO - 'USER': 'cltbld', 14:01:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314', 14:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:27 INFO - '_': '/tools/buildbot/bin/python'} 14:01:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:01:27 INFO - mozversion application_buildid: 20160106113008 14:01:27 INFO - mozversion application_changeset: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a 14:01:27 INFO - mozversion application_display_name: Nightly 14:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:27 INFO - mozversion application_name: Firefox 14:01:27 INFO - mozversion application_remotingname: firefox 14:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:01:27 INFO - mozversion application_vendor: Mozilla 14:01:27 INFO - mozversion application_version: 46.0a1 14:01:27 INFO - mozversion platform_buildid: 20160106113008 14:01:27 INFO - mozversion platform_changeset: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a 14:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:01:27 INFO - mozversion platform_version: 46.0a1 14:01:27 INFO - using testdate: 1452117687 14:01:27 INFO - actual date: 1452117687 14:01:27 INFO - starting webserver on 'localhost:39172' 14:01:27 INFO - SUITE-START | Running 3 tests 14:01:27 INFO - TEST-START | dromaeo_css 14:01:27 INFO - operating with platform_type : linux_ 14:01:27 INFO - Initialising browser for dromaeo_css test... 14:01:27 INFO - TEST-INFO | started process 1468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcB1vVQ/profile http://localhost:39172/getInfo.html) 14:01:31 INFO - PROCESS | 1468 | __metrics Screen width/height:1600/1200 14:01:31 INFO - PROCESS | 1468 | colorDepth:24 14:01:31 INFO - PROCESS | 1468 | Browser inner width/height: 1024/697 14:01:31 INFO - PROCESS | 1468 | __metrics 14:01:31 INFO - PROCESS | 1468 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:01:31 INFO - PROCESS | 1468 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:01:32 INFO - TEST-INFO | 1468: exit 0 14:01:32 INFO - Browser initialized. 14:01:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:32 INFO - TEST-INFO | started process 1561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcB1vVQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:44 INFO - PROCESS | 1561 | RSS: Main: 150290432 14:01:44 INFO - PROCESS | 1561 | 14:02:35 INFO - PROCESS | 1561 | 1452117755285 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] 14:04:44 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39172/tests/dromaeo/cssquery-ext.html) 14:04:46 INFO - PROCESS | 1561 | RSS: Main: 337051648 14:04:46 INFO - PROCESS | 1561 | 14:07:48 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-ext.html (next: http://localhost:39172/tests/dromaeo/cssquery-jquery.html) 14:07:49 INFO - PROCESS | 1561 | RSS: Main: 241528832 14:07:49 INFO - PROCESS | 1561 | 14:10:51 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39172/tests/dromaeo/cssquery-mootools.html) 14:10:51 INFO - PROCESS | 1561 | RSS: Main: 230522880 14:10:51 INFO - PROCESS | 1561 | 14:13:53 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39172/tests/dromaeo/cssquery-prototype.html) 14:13:54 INFO - PROCESS | 1561 | RSS: Main: 211865600 14:13:54 INFO - PROCESS | 1561 | 14:16:56 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39172/tests/dromaeo/cssquery-yui.html) 14:16:57 INFO - PROCESS | 1561 | RSS: Main: 215703552 14:16:57 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | Cycle 1(1): loaded http://localhost:39172/tests/dromaeo/cssquery-yui.html (next: http://localhost:39172/tests/dromaeo/cssquery-dojo.html) 14:20:00 INFO - PROCESS | 1561 | RSS: Main: 271687680 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | __start_tp_report 14:20:00 INFO - PROCESS | 1561 | _x_x_mozilla_page_load 14:20:00 INFO - PROCESS | 1561 | _x_x_mozilla_page_load_details 14:20:00 INFO - PROCESS | 1561 | |i|pagename|runs| 14:20:00 INFO - PROCESS | 1561 | |0;dojo.html;3148.370325934813;3177.809331440112;3180.109569320591;3194.0258221242525;3228.1768149121976;5134.64057515974;5219.660722053069;5233.502817232362;5282.630215884889;5292.126799078147;5180.093483640367;5257.921131183035;5331.093714068608;5335.1730481775385;5358.410574836765;4775.188218002931;4807.61539076873;4829.541193586612;4961.454240033593;4973.030259099477;4652.046330502239;4913.656044076916;4947.406311242656;4954.529319714639;4996;4763.2378819388905;4784.66507344486;4875.317455556225;4896.853094407174;4942.901141977176;4830.782614782343;4887.853364399074;4896.069746748107;4910.631702622318;4918.655694101414;4644.2801365788355;4733.029728905601;4833.637477189225;4866.780994855205;4919.926201106986;5113.335266415379;5152.458991805844;5171.5862730981435;5175.585953123741;5185.403678576937;5592.4407559244155;5622.662640241599;5624.578156638268;5632.46491583303;5633.352164501094;5565.6104072714925;5638.830835074954;5654.85862853432;5690.857728556778;5716.771329146829;5232.267482552407;5375.059364611177;5378.11261141915;5379.327584051994;5379.973100134474;5751.942480575224;5753.59724819267;5756.424357564294;5761.53907687384;5816.040353341651;5439.265699130646;5526.171074338801;5545.195946587723;5556.194351818964;5579.135234038649;5729.255196824386;5815.244018277597;5815.854603634858;5816.94183058164;5866.325372582122;5604.915926261109;5614.045612245928;5657.80197693087;5659.037963546125;5661.886762264731;5470;5571.220029195916;5573;5650.378458369576;5673.035583950738;4363.061941682554;4432.711873728262;4452.5547445255215;4478.395416618715;4487.080148569536;3900.180961998012;3913.0413048803225;3920.196359746245;3930.4104384342577;3948.565657777642;5119.667221630582;5214.348206474191;5216.765245563959;5222.843314700565;5228.032813929435;5579.581531385163;5593;5670.518005969457;5744.368119506851;5792.044312688359;5229.241759944863;5231.372235331784;5240.633155679142;5246.186841039645;5249.685018898878;4658.510856360102;4785.210440277385;4786.976065119652;4791.520847915181;4833.081714474239;5703.857403564861;5715.199872017921;5896.941030589725;5985.341612422717;6030.457258846637;5685.289338832646;5717.542596592346;5732.398098199796;5734.627249228787;5752.309722833287;5729.512991395778;5853.678047707417;5908.881822363614;5961.046232602763;5964.9105263420215;5448.727563621882;5449.836504904859;5450.945490545044;5453.291072160594;5484.149956756709;5577.358603760619;5582;5582.748776304995;5585.636933599303;5590.217369568182;5422.539084177889;5426.348838139291;5431.23962645222;5434.184872269191;5460.972695136499;5567.526760225426;5620.747066382104;5624.803131890364;5627.774889004394;5669.149627555899;5489.862753431196;5523.392426832965;5546.805861794818;5548.334199896039;5550.361708403424;5448.318960129984;5560.749766260609;5569.693666848362;5617.634853734494;5633.8309850704545;5410.918836217538;5502;5510.338759348743;5518.613697041169;5555.666660000413 14:20:00 INFO - PROCESS | 1561 | |1;ext.html;534.6791924845091;559.3399788249866;584.6755050946723;591.0926727473329;602.7890238416554;27656.446871062566;34867;35632;35684.2863142737;35777.82111089441;38799.41800872982;39179.21641567167;39333.40999885004;39381.21237575247;39532.20935581287;7381.9261807382045;7444.590547519884;8399.958000210007;8588.957055214747;8605.61274742635;9943.850842237372;10091.344062635904;10092.697219083439;10169.542370593304;10170.593176272978;9913.851292230622;9953.950230248838;9993.250506212027;10009.89990100097;10015.799684006315;7613.16255211929;7757.883631745528;7764.262395072459;9940.40357578544;10014.298999070068;9748.171405430547;9860.901390986142;9881.604735810559;9887.060729230712;9889.109980101754;35187.4721879172;35529.64470355315;35592.110197245274;35636.643633563595;35645.82177089124;3165.889193878203;3384.76306658534;3467.8959631211105;3544.432890737495;3863.8068096595057;28119.37723981024;28527.857360713064;28622.570661440095;31177.37645247105;31229.53155702666;3743.4384842273603;3959.802009899522;3966.504186976628;3980.7412518186516;4013.97993010036;269892;270841;271478;271617.6419117912;271653;60207.69896150579;60606;60824.69587652122;60835.69582152149;60869.34783912891;57859;58806.41193588095;64075.679621602525;64378.678106609164;64423.35576644267;14875.404983800743;14911.552653420415;15020.549383518512;15052.172130532927;15070.472533461276;10979.1765617579;11006;11042.889571104346;11045.33727976324;11049;19370.515737106685;19407.805921940882;19491;19569.217231310588;19579.902100489693;7761.728339508203;7857.685692572348;7911.446198766032;7911.920880791234;8094.959525202336;933.2813733425224;1040.7554224757175;1045.8744950605976;1099.741560733227;1105.8120119579692;28498;28511.85744071308;28580.14259572216;28624.856875715905;28664.426711466072;977.0571398600384;1031.6595523477235;1061.994690026545;1105.0219658021554;1135.28477059452;14814.333354999051;14896.97623758411;15112.168830714416;15155.696886062216;15202.619934501727;326858;333137;333754;333816;334149;53101.46898531043;53663.73168134134;53671.73164134155;53699;53731.731341343046;1228.269179837995;1230.39095647655;1261.7981123020456;1271.211848653822;1400.2508657868195;27595.58606620862;28317.558045396585;28645.14064578066;28924.710752892202;28963;42261;43039.354409683256;46765.76617116893;47126;48438.5156148434;214277;214924;215061;215492;215712;32419.35161296808;32875.835620821745;32904.34191316112;32931.176720582174;32955.50566741453;32549;36737.448938265414;39421;42789.78605106955;43805.123897522506;31516;38665.80667096759;38915.416268756555;40230.1953960925;41226.79386603048;35189.82405087958;35358.46962295619;36015;36187.276254474236;36313.273734524635;34321.65678343185;35353.58585656545;35373.115672108404;35416.822915885255;35438.29123417569;29178.70821291845;32437;32714.182145445604;32730.345393091528;32739.181520462178;23862.642060368762;24139.637905431784;24386.634200487362;24501.754982449947;24691.382715432257 14:20:00 INFO - PROCESS | 1561 | |2;jquery.html;353.4574428252633;356.5863598226057;359.7643543479021;365.79149884565794;368.80269056055016;14143.080699754535;14273.357698903548;16359.509214723563;16971.321147154114;17880.374186903446;15642.139682317467;15942.282597283122;16338.673226535491;16578.17109144544;16663.75004374932;4771.785269662856;5524.806631767889;5525.613207075507;5527.917081243784;5529.225908372831;4184.456020717303;4311.913761724763;5526.364468086182;5552.194931734896;5956.047032474805;6048.243969503812;6069.514438844882;6089.1170780236835;6091.695415229243;6103.81688549342;5937.2578427696535;6053.939460605426;6098.939010609882;6101;6115.571909966304;5234.842954711365;5373.274607927919;5378.46215378463;5401.864953376158;5405.972970135163;20476.590468190552;20477.897610511853;20562.383128506168;20896.05967731456;20976.895115524323;1998.5403357227774;2224.7504732190187;2237.53950282429;2287.4853158039473;2323.5933711600574;13191.208527488285;13200.801987970188;13280;13286.800697989442;13508.797368039488;1788.1148831328576;1816.2371803842418;1851.7963024067342;1925.8363039141689;1931.2950772967765;57147;59659;59807.102893456635;60066.399336006514;60314;9612.1829644481;9828.655997040069;10123.797524049625;10161.796764064677;10240;12075.154739168174;12084;12097.516099355928;12113.515459381702;12118;7584;7587.203343648947;7588.354989825816;7615.5430674159725;7678.923210767821;7278.490505664553;7332.266773322625;7344.081989751281;7359.264073592705;7407.925920740831;5981.282246130492;6000.699965001732;6077.8480537986015;6092.634441933498;6153.107799369156;1628.9511314660579;1707.1549582956516;1725.4133594577904;1739.6346767178782;1743.9128043597768;799.8440304140637;984.1487113646788;994.2791476179856;1010.4291075542442;1019.9439030853374;14848.703025939421;16644;18207.635847283243;18330.90834545819;18627.441176764718;894.3784070071238;905.7101727447285;913.7715571107224;926.4858003807817;971.2666936463066;9635.470049147223;9993.80012399748;10046.346987445793;10374.22193335503;10466;552878;577528;590770;599100;600506;62236.377636223966;80378;80713.59643201863;83372.58313708514;83373.16626833775;1007.9899201007896;1022.8261195596766;1072.3137192197;1091.6561283195767;1094.7482079121846;15879.603009924844;16050.759238611197;16142.354305828105;16177.191140442696;16264.593385164992;36524.63475365212;37047.25905481929;38009.42985855159;38461.80769096137;38532.22935541329;47472.72745452926;49822.75088624679;50684.49315506945;50755.74622126866;51901;9177.311701622539;9189.908100918905;9286.953565232401;9301.674441394518;9396.201322887631;13956.79064814049;17767.46697599074;18292.359767408077;18331.266749329876;18412;13956.302184890917;14210.360533776211;14231.71536569242;15010.249487525798;15041.473548425753;14231.928840355731;14512.492062777752;14573;14958;15068.246587670792;11044.558217671525;11714.297142171497;11772.938336273972;13641.795373069213;14130.293485325898;8778.385513014284;8872.556372181494;8883.200511953955;8897.599608017785;9434.103760142776;9363.859542106738;9474.52627368615;9483.715488535356;12847.743045138857;14503.347349369515 14:20:00 INFO - PROCESS | 1561 | |3;mootools.html;1318.3671837517986;1435.3397437178899;1438.5684294711584;1587.436205718163;1767.699491086515;6681.265060843303;6842.486813488989;7213.567185968839;7367.336939675428;7371.557706537598;7281.381082607972;7302.123745150576;7380.483366164371;7382.963085184567;7388.335049845513;1936.6804477261235;1963.6072785442968;2213.7786221377855;2252.986156229695;2254.413852398372;2260.547890421922;2301.0910690277415;2301.976980230201;2302.5049614332916;2302.82728795341;2172.4677454023786;2172.706684597575;2260.4800895793896;2263.3549438410055;2265.0600000999566;2216.9889150554304;2217.079911836586;2242.573910956913;2243.719535058118;2266.7733226677365;2202.31728164268;2237.865728056322;2284.0863654538316;2288.78256565626;2294.1740973249616;7457.179710231871;7535.982642343269;7538.3215510604305;7544.660490277951;7546.207648196915;4458.910821783546;4464.0402313502755;4523.86428407145;4524.049949510607;4536.183486972343;2899.362140329124;2988.0886329669443;2989.237744375192;2992.940141197164;3011.412774508972;882.841088604051;896.188949001155;899.5996781432265;906.4244204929851;920.4293338130335;10109.696709098665;10121.797564048678;10156.593736250541;10162.491875406275;10183.185345172442;4134.49091081753;4156.106437116035;4205.558416366238;4218.093109981369;4221.050263690707;8747.606357713918;8750.256228220673;8756.605952732143;8757.124287571192;8764.1674040966;4532.614727748112;4533.478649955297;4536.4102666653125;4538.682292239578;4541.727496350163;4127.4015267786;4146.253674338588;4159.417681524589;4160.438340824011;4165.66674666026;3353.865845366207;3398.04854640701;3470.5314782504543;3620.1854582719207;3651.434027725707;1186.400867561893;1186.7389174381622;1187.8455800745849;1194.7610477904454;1195.8505186851644;1011.206203130539;1011.6105299459614;1071.2019545438543;1141.520561364229;1322.9140105893086;6858.6570671466225;6915.51591388608;6924.61914594692;6985.93014069863;6998.370146686822;1080.0711388206137;1092.9234953553334;1102.7298311913632;1102.73534351755;1119.7088756923097;5512.944870551323;5589.888202235932;5624.100143976944;5630.493255607015;5636.04187288162;8523.190296921783;8618.052014278424;8716.08481109487;8732.214100730966;9113.954430227806;8594.355423343275;8616.181462761027;8660.090690477535;8663.653453861902;8677.435966662148;6962.851129563666;7000.719971201197;7007.614581198083;7079.610621415872;7083.504154709224;6947.930520694728;7008.264132266038;7011;7015.333543313377;7017.157941047107;7999.640016199169;8070.919290807017;8192.344612430872;8195.959020205099;8214.383921206054;8135.75592732219;8187.836243274982;8285.95857020711;8325.708600198965;8361.916380836114;6735.158105236846;6753.797386078229;6817.420519255918;6822.522423430312;6828.863422731418;6458.063580780855;6573.96713016451;6583.078369028244;6585.6377899216;7284.890726639211;6454.354564543508;6500.837479062872;6512.05575191604;6596;6625.238097618835;6364.904526432199;6505.707243173973;6512.869742605027;6542.607443553402;6609.1408116944485;6410.967945160244;6487;6501.317361676955;6501.772437964649;6506.316836732264;5985.191999080069;6095;6098.786542470993;6101.694915254308;6102.145699602148;5992.730327135202;6012.188354572252;6140.969295153495;6146.231721034871;6156.045812899008 14:20:00 INFO - PROCESS | 1561 | |4;prototype.html;324.54401565800055;330.7932542161149;342.44352926494446;344.30965913343744;350.11770338746345;5781.537477001841;5803.448672376123;5825.941740582598;5871.588988770788;5898.705064746756;5783.392743761908;5785.537157027438;5785.652860828342;5790.7683692652345;5792.189093526909;4527.999999999992;4535.047639995589;4539.296409056601;4541.43232095988;4544.363789069516;4446.888827779299;4508.842190523333;4521.434820647419;4523.886902827423;4536.092781443708;4468.575485328888;4475.1049790042125;4484.304932735415;4494.1910456117885;4496.505384407713;4253.51084625269;4315.8057887394825;4472.239719247719;4484.910301793979;4490.775461226942;3848.8460461581503;3908.237893610747;3914.941275880864;3940.1725637616137;3940.625640564142;5438.15708565173;5446.673199607996;5457.345118585756;5457.372402173761;5462.071447853875;4934.827281045146;5005.874853128665;5080.339555857715;5103.362079740033;5152.149895267276;6030.216071910668;6062.242219722535;6069.0592958091565;6072.301685306202;6080.452759251644;4318.4170137031415;4321.178975994582;4321.6326612238;4324.091940692459;4331.177076355514;6229.844253893689;6394.168758061469;6395.936040639627;6400.295967443578;6403.071554624554;4429.848239457764;4438.533953934791;4446.822127114944;4447.999200179934;4452.866414007585;4489.865304040884;4490.708103973231;4492.887677808016;4494.348319493721;4495.483019452739;5149.48505149482;5149.639525233198;5149.871253218625;5150.4334523202415;5157.974210129;5973.432523910222;6158.969205153946;6161.599496032743;6162.661053642093;6167.321594624587;1543.1589783567983;1548.3110016042979;1551.7129331073788;1552;1552.2781906413345;1011.7066050845319;1038.050184081572;1040.843873418978;1040.885502594714;1043.7547176413536;5815.41845815415;5824.271966004249;5826.038703613941;5828.125781132864;5829.621074630136;6305.085762564402;6332.240131184195;6380.393862583047;6386.648734319564;6389.424951754364;5770.913436298459;5804.245448091721;5820.796272130455;5824.504917082096;5826.038703613856;3296.489044198153;3390.1694084949345;3391.135260508604;3395.3548825723033;3400.2349471368743;6489.318621544764;6491.221053473613;6506.674666266667;6508.60948343101;6513.316101809337;6187.195664563578;6415.454686351619;6418.903716444257;6424.871502569922;6432.807015789534;6337.207849018872;6342.39747224013;6608.074869518367;6609.339066093352;6619.735210591522;6326.145970293951;6353.4599559038;6363.5863668861375;6366.3633636637815;6371.299157092809;6047.606905551125;6283.120363149072;6293.905591416224;6298.748050077946;6302.401271879165;6561.606303621798;6587.571807832475;6593.901091483727;6594.175728033996;6603.141591593062;4293.184294983943;4326.351047342924;4331.740095594275;4331.870043898688;4334.068175342317;6338.207724034496;6362.3319551448285;6410.775622853178;6416.422521973045;6418.101465794886;6038.5169186465855;6166.568340216142;6174.629522228681;6175.722092505938;6181.381861813962;6063.514918806573;6140.723667434887;6149;6151.046587778901;6158.107074474086;5997.250343707036;6030.396960303934;6070.908936366046;6092.116643086639;6101.054336577838;6036.63780173191;6192;6204.100405441276;6204.348543403058;6210.7515699373325;5960.83763666081;5974.581779275582;5975.043992961279;5977.163197152315;5977.432143946318 14:20:00 INFO - PROCESS | 1561 | |5;yui.html;718.8680554866983;761.2425636491691;797.7806103321586;807.6446363600015;827.6606591297569;13599.728005439898;13866.791998120023;13886;13892.305384730747;13906.860931390684;12945.158564693313;12998.54505092322;13030.674233144153;13065.542706005292;13870.306484675777;690.6926417744106;821.6795449774608;838.4424357802054;838.6645341863273;839.1859895900966;695.8817001109799;829.1128492513013;847.4830353484369;848.4315508609246;848.5884346092171;846.7290467050547;875.0942774228674;878.7495563764328;879.0725784297564;879.3888247667874;717.3507975282378;723.5188599581272;856.1908995998783;873.0614589316478;874.0516539554591;640.5068097564896;641.4996302883758;653.3531803514534;654.2933631677824;654.4077609763171;13495.59513214605;13582.25297608641;13621.25083120428;13625.25061121638;13628.11417257885;12060.638180854588;12413.317267550281;12696.80954785679;12862.935685321607;12884.87115128846;9949.552270147788;10014.898361180265;10117.544710487971;10494.108000819939;10510.842337364946;3657.085728567858;3657.305112028706;3664.76179048361;3667.9816600916824;3678.70570354371;45553.316700249525;46322.76838615819;46652.06695866097;46965.765171174266;47086.29370559444;9625.56684949179;9854.7805755934;9932.255080868963;9936.254780891462;9953.353032052893;18820.43538693814;18873.056347182584;18897.716534252;18930.81069189318;18945.052747362577;7490.138634057044;7490.775276741598;7643.4267429942975;7767.53394796314;7896.565688887166;4147.170565886774;4154.1068670236045;4203.201391735561;4248.171606536757;4322.308430651081;3129.937401251962;3201.3117179806454;3203.19920019995;3210.5826242588314;3212.839358032089;534.9438308977501;562.6230425614848;564.2241917363625;616.8026231605843;629.288903538998;603.8158361699724;614.2830787947697;620.5718054542351;650.2286736925811;666.4235436347622;7485.176630570633;7624.771256862303;7640.656170472342;8016.438849280611;8037.35701143907;563.0934195944526;580.8780156167168;583.8277708076128;602.3464540973006;612.4549151255297;3648.8540458381367;3802.4106263529197;3823.866164684223;3863.0728625130328;3996.900077498086;50317.49682503128;50973.745131274845;51022.74488627533;51186;51325.23012154821;47108.293375599394;47115.29327060097;47221.29168062482;47424.7628761854;48290.27564586534;44102.779486102365;44483;44775.32837007447;45047.774761125984;45129.774351128035;7580.469367144247;7682.500637458547;7893.723719669784;7922.7227047053075;7991.92008079935;33735.83132084324;34271.14322141966;35859;36114.09714757152;36251;38756.6124338753;40401.787946361655;40501.594984049785;42786.50247241332;43316.35025474557;10343;10457.529411176363;10476.68569942903;10668;10746.355218686904;10925.508352124014;11522.366269855238;11650.53397864076;11825.290482571074;11911.523539058688;9968.252381071303;9983.251256155963;10298.897011029794;10489.213309001703;10583.047525722723;9825.803483930424;10219.540120694437;10374.792504150026;10426.739331516772;10458.26792124544;9715.22278217755;9969.700908972452;10245.897541024793;10290.578571570766;10292.639757608447;9039.136315765789;9137.314701397288;9145.954270228607;9192.58633361487;9554.61781528731;8064.83870322602;8522.616482258438;8582.699605513777;8682.956585217033;8722.433041852513 14:20:00 INFO - PROCESS | 1561 | __end_tp_report 14:20:00 INFO - PROCESS | 1561 | __start_cc_report 14:20:00 INFO - PROCESS | 1561 | _x_x_mozilla_cycle_collect,1654 14:20:00 INFO - PROCESS | 1561 | __end_cc_report 14:20:00 INFO - PROCESS | 1561 | __startTimestamp1452118800298__endTimestamp 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | ------- Summary: start ------- 14:20:00 INFO - PROCESS | 1561 | Number of tests: 6 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#0] dojo.html Cycles:165 Average:5259.14 Median:5448.73 stddev:573.32 (10.5%) stddev-sans-first:550.64 14:20:00 INFO - PROCESS | 1561 | Values: 3148.4 3177.8 3180.1 3194.0 3228.2 5134.6 5219.7 5233.5 5282.6 5292.1 5180.1 5257.9 5331.1 5335.2 5358.4 4775.2 4807.6 4829.5 4961.5 4973.0 4652.0 4913.7 4947.4 4954.5 4996.0 4763.2 4784.7 4875.3 4896.9 4942.9 4830.8 4887.9 4896.1 4910.6 4918.7 4644.3 4733.0 4833.6 4866.8 4919.9 5113.3 5152.5 5171.6 5175.6 5185.4 5592.4 5622.7 5624.6 5632.5 5633.4 5565.6 5638.8 5654.9 5690.9 5716.8 5232.3 5375.1 5378.1 5379.3 5380.0 5751.9 5753.6 5756.4 5761.5 5816.0 5439.3 5526.2 5545.2 5556.2 5579.1 5729.3 5815.2 5815.9 5816.9 5866.3 5604.9 5614.0 5657.8 5659.0 5661.9 5470.0 5571.2 5573.0 5650.4 5673.0 4363.1 4432.7 4452.6 4478.4 4487.1 3900.2 3913.0 3920.2 3930.4 3948.6 5119.7 5214.3 5216.8 5222.8 5228.0 5579.6 5593.0 5670.5 5744.4 5792.0 5229.2 5231.4 5240.6 5246.2 5249.7 4658.5 4785.2 4787.0 4791.5 4833.1 5703.9 5715.2 5896.9 5985.3 6030.5 5685.3 5717.5 5732.4 5734.6 5752.3 5729.5 5853.7 5908.9 5961.0 5964.9 5448.7 5449.8 5450.9 5453.3 5484.1 5577.4 5582.0 5582.7 5585.6 5590.2 5422.5 5426.3 5431.2 5434.2 5461.0 5567.5 5620.7 5624.8 5627.8 5669.1 5489.9 5523.4 5546.8 5548.3 5550.4 5448.3 5560.7 5569.7 5617.6 5633.8 5410.9 5502.0 5510.3 5518.6 5555.7 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#1] ext.html Cycles:180 Average:44422.17 Median:18894.78 stddev:72431.75 (383.3%) stddev-sans-first:72559.98 14:20:00 INFO - PROCESS | 1561 | Values: 534.7 559.3 584.7 591.1 602.8 27656.4 34867.0 35632.0 35684.3 35777.8 38799.4 39179.2 39333.4 39381.2 39532.2 7381.9 7444.6 8400.0 8589.0 8605.6 9943.9 10091.3 10092.7 10169.5 10170.6 9913.9 9954.0 9993.3 10009.9 10015.8 7613.2 7757.9 7764.3 9940.4 10014.3 9748.2 9860.9 9881.6 9887.1 9889.1 35187.5 35529.6 35592.1 35636.6 35645.8 3165.9 3384.8 3467.9 3544.4 3863.8 28119.4 28527.9 28622.6 31177.4 31229.5 3743.4 3959.8 3966.5 3980.7 4014.0 269892.0 270841.0 271478.0 271617.6 271653.0 60207.7 60606.0 60824.7 60835.7 60869.3 57859.0 58806.4 64075.7 64378.7 64423.4 14875.4 14911.6 15020.5 15052.2 15070.5 10979.2 11006.0 11042.9 11045.3 11049.0 19370.5 19407.8 19491.0 19569.2 19579.9 7761.7 7857.7 7911.4 7911.9 8095.0 933.3 1040.8 1045.9 1099.7 1105.8 28498.0 28511.9 28580.1 28624.9 28664.4 977.1 1031.7 1062.0 1105.0 1135.3 14814.3 14897.0 15112.2 15155.7 15202.6 326858.0 333137.0 333754.0 333816.0 334149.0 53101.5 53663.7 53671.7 53699.0 53731.7 1228.3 1230.4 1261.8 1271.2 1400.3 27595.6 28317.6 28645.1 28924.7 28963.0 42261.0 43039.4 46765.8 47126.0 48438.5 214277.0 214924.0 215061.0 215492.0 215712.0 32419.4 32875.8 32904.3 32931.2 32955.5 32549.0 36737.4 39421.0 42789.8 43805.1 31516.0 38665.8 38915.4 40230.2 41226.8 35189.8 35358.5 36015.0 36187.3 36313.3 34321.7 35353.6 35373.1 35416.8 35438.3 29178.7 32437.0 32714.2 32730.3 32739.2 23862.6 24139.6 24386.6 24501.8 24691.4 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#2] jquery.html Cycles:180 Average:30211.35 Median:18708.03 stddev:95403.55 (510.0%) stddev-sans-first:95644.84 14:20:00 INFO - PROCESS | 1561 | Values: 353.5 356.6 359.8 365.8 368.8 14143.1 14273.4 16359.5 16971.3 17880.4 15642.1 15942.3 16338.7 16578.2 16663.8 4771.8 5524.8 5525.6 5527.9 5529.2 4184.5 4311.9 5526.4 5552.2 5956.0 6048.2 6069.5 6089.1 6091.7 6103.8 5937.3 6053.9 6098.9 6101.0 6115.6 5234.8 5373.3 5378.5 5401.9 5406.0 20476.6 20477.9 20562.4 20896.1 20976.9 1998.5 2224.8 2237.5 2287.5 2323.6 13191.2 13200.8 13280.0 13286.8 13508.8 1788.1 1816.2 1851.8 1925.8 1931.3 57147.0 59659.0 59807.1 60066.4 60314.0 9612.2 9828.7 10123.8 10161.8 10240.0 12075.2 12084.0 12097.5 12113.5 12118.0 7584.0 7587.2 7588.4 7615.5 7678.9 7278.5 7332.3 7344.1 7359.3 7407.9 5981.3 6000.7 6077.8 6092.6 6153.1 1629.0 1707.2 1725.4 1739.6 1743.9 799.8 984.1 994.3 1010.4 1019.9 14848.7 16644.0 18207.6 18330.9 18627.4 894.4 905.7 913.8 926.5 971.3 9635.5 9993.8 10046.3 10374.2 10466.0 552878.0 577528.0 590770.0 599100.0 600506.0 62236.4 80378.0 80713.6 83372.6 83373.2 1008.0 1022.8 1072.3 1091.7 1094.7 15879.6 16050.8 16142.4 16177.2 16264.6 36524.6 37047.3 38009.4 38461.8 38532.2 47472.7 49822.8 50684.5 50755.7 51901.0 9177.3 9189.9 9287.0 9301.7 9396.2 13956.8 17767.5 18292.4 18331.3 18412.0 13956.3 14210.4 14231.7 15010.2 15041.5 14231.9 14512.5 14573.0 14958.0 15068.2 11044.6 11714.3 11772.9 13641.8 14130.3 8778.4 8872.6 8883.2 8897.6 9434.1 9363.9 9474.5 9483.7 12847.7 14503.3 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#3] mootools.html Cycles:180 Average:5199.91 Median:6101.92 stddev:2649.92 (43.4%) stddev-sans-first:2641.29 14:20:00 INFO - PROCESS | 1561 | Values: 1318.4 1435.3 1438.6 1587.4 1767.7 6681.3 6842.5 7213.6 7367.3 7371.6 7281.4 7302.1 7380.5 7383.0 7388.3 1936.7 1963.6 2213.8 2253.0 2254.4 2260.5 2301.1 2302.0 2302.5 2302.8 2172.5 2172.7 2260.5 2263.4 2265.1 2217.0 2217.1 2242.6 2243.7 2266.8 2202.3 2237.9 2284.1 2288.8 2294.2 7457.2 7536.0 7538.3 7544.7 7546.2 4458.9 4464.0 4523.9 4524.0 4536.2 2899.4 2988.1 2989.2 2992.9 3011.4 882.8 896.2 899.6 906.4 920.4 10109.7 10121.8 10156.6 10162.5 10183.2 4134.5 4156.1 4205.6 4218.1 4221.1 8747.6 8750.3 8756.6 8757.1 8764.2 4532.6 4533.5 4536.4 4538.7 4541.7 4127.4 4146.3 4159.4 4160.4 4165.7 3353.9 3398.0 3470.5 3620.2 3651.4 1186.4 1186.7 1187.8 1194.8 1195.9 1011.2 1011.6 1071.2 1141.5 1322.9 6858.7 6915.5 6924.6 6985.9 6998.4 1080.1 1092.9 1102.7 1102.7 1119.7 5512.9 5589.9 5624.1 5630.5 5636.0 8523.2 8618.1 8716.1 8732.2 9114.0 8594.4 8616.2 8660.1 8663.7 8677.4 6962.9 7000.7 7007.6 7079.6 7083.5 6947.9 7008.3 7011.0 7015.3 7017.2 7999.6 8070.9 8192.3 8196.0 8214.4 8135.8 8187.8 8286.0 8325.7 8361.9 6735.2 6753.8 6817.4 6822.5 6828.9 6458.1 6574.0 6583.1 6585.6 7284.9 6454.4 6500.8 6512.1 6596.0 6625.2 6364.9 6505.7 6512.9 6542.6 6609.1 6411.0 6487.0 6501.3 6501.8 6506.3 5985.2 6095.0 6098.8 6101.7 6102.1 5992.7 6012.2 6141.0 6146.2 6156.0 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#4] prototype.html Cycles:180 Average:5138.65 Median:5822.53 stddev:1535.52 (26.4%) stddev-sans-first:1496.71 14:20:00 INFO - PROCESS | 1561 | Values: 324.5 330.8 342.4 344.3 350.1 5781.5 5803.4 5825.9 5871.6 5898.7 5783.4 5785.5 5785.7 5790.8 5792.2 4528.0 4535.0 4539.3 4541.4 4544.4 4446.9 4508.8 4521.4 4523.9 4536.1 4468.6 4475.1 4484.3 4494.2 4496.5 4253.5 4315.8 4472.2 4484.9 4490.8 3848.8 3908.2 3914.9 3940.2 3940.6 5438.2 5446.7 5457.3 5457.4 5462.1 4934.8 5005.9 5080.3 5103.4 5152.1 6030.2 6062.2 6069.1 6072.3 6080.5 4318.4 4321.2 4321.6 4324.1 4331.2 6229.8 6394.2 6395.9 6400.3 6403.1 4429.8 4438.5 4446.8 4448.0 4452.9 4489.9 4490.7 4492.9 4494.3 4495.5 5149.5 5149.6 5149.9 5150.4 5158.0 5973.4 6159.0 6161.6 6162.7 6167.3 1543.2 1548.3 1551.7 1552.0 1552.3 1011.7 1038.1 1040.8 1040.9 1043.8 5815.4 5824.3 5826.0 5828.1 5829.6 6305.1 6332.2 6380.4 6386.6 6389.4 5770.9 5804.2 5820.8 5824.5 5826.0 3296.5 3390.2 3391.1 3395.4 3400.2 6489.3 6491.2 6506.7 6508.6 6513.3 6187.2 6415.5 6418.9 6424.9 6432.8 6337.2 6342.4 6608.1 6609.3 6619.7 6326.1 6353.5 6363.6 6366.4 6371.3 6047.6 6283.1 6293.9 6298.7 6302.4 6561.6 6587.6 6593.9 6594.2 6603.1 4293.2 4326.4 4331.7 4331.9 4334.1 6338.2 6362.3 6410.8 6416.4 6418.1 6038.5 6166.6 6174.6 6175.7 6181.4 6063.5 6140.7 6149.0 6151.0 6158.1 5997.3 6030.4 6070.9 6092.1 6101.1 6036.6 6192.0 6204.1 6204.3 6210.8 5960.8 5974.6 5975.0 5977.2 5977.4 14:20:00 INFO - PROCESS | 1561 | 14:20:00 INFO - PROCESS | 1561 | [#5] yui.html Cycles:180 Average:13147.35 Median:47168.29 stddev:14902.69 (31.6%) stddev-sans-first:14915.27 14:20:00 INFO - PROCESS | 1561 | Values: 718.9 761.2 797.8 807.6 827.7 13599.7 13866.8 13886.0 13892.3 13906.9 12945.2 12998.5 13030.7 13065.5 13870.3 690.7 821.7 838.4 838.7 839.2 695.9 829.1 847.5 848.4 848.6 846.7 875.1 878.7 879.1 879.4 717.4 723.5 856.2 873.1 874.1 640.5 641.5 653.4 654.3 654.4 13495.6 13582.3 13621.3 13625.3 13628.1 12060.6 12413.3 12696.8 12862.9 12884.9 9949.6 10014.9 10117.5 10494.1 10510.8 3657.1 3657.3 3664.8 3668.0 3678.7 45553.3 46322.8 46652.1 46965.8 47086.3 9625.6 9854.8 9932.3 9936.3 9953.4 18820.4 18873.1 18897.7 18930.8 18945.1 7490.1 7490.8 7643.4 7767.5 7896.6 4147.2 4154.1 4203.2 4248.2 4322.3 3129.9 3201.3 3203.2 3210.6 3212.8 534.9 562.6 564.2 616.8 629.3 603.8 614.3 620.6 650.2 666.4 7485.2 7624.8 7640.7 8016.4 8037.4 563.1 580.9 583.8 602.3 612.5 3648.9 3802.4 3823.9 3863.1 3996.9 50317.5 50973.7 51022.7 51186.0 51325.2 47108.3 47115.3 47221.3 47424.8 48290.3 44102.8 44483.0 44775.3 45047.8 45129.8 7580.5 7682.5 7893.7 7922.7 7991.9 33735.8 34271.1 35859.0 36114.1 36251.0 38756.6 40401.8 40501.6 42786.5 43316.4 10343.0 10457.5 10476.7 10668.0 10746.4 10925.5 11522.4 11650.5 11825.3 11911.5 9968.3 9983.3 10298.9 10489.2 10583.0 9825.8 10219.5 10374.8 10426.7 10458.3 9715.2 9969.7 10245.9 10290.6 10292.6 9039.1 9137.3 9146.0 9192.6 9554.6 8064.8 8522.6 8582.7 8683.0 8722.4 14:20:00 INFO - PROCESS | 1561 | -------- Summary: end -------- 14:20:00 INFO - PROCESS | 1561 | 14:20:01 INFO - TEST-INFO | 1561: exit 0 14:20:01 INFO - TEST-OK | dromaeo_css | took 1113407ms 14:20:01 INFO - TEST-START | kraken 14:20:01 INFO - operating with platform_type : linux_ 14:20:01 INFO - Initialising browser for kraken test... 14:20:01 INFO - TEST-INFO | started process 1762 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwHFeTp/profile http://localhost:39172/getInfo.html) 14:20:04 INFO - PROCESS | 1762 | __metrics Screen width/height:1600/1200 14:20:04 INFO - PROCESS | 1762 | colorDepth:24 14:20:04 INFO - PROCESS | 1762 | Browser inner width/height: 1024/697 14:20:04 INFO - PROCESS | 1762 | __metrics 14:20:04 INFO - PROCESS | 1762 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:20:04 INFO - PROCESS | 1762 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:20:05 INFO - PROCESS | 1762 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:20:05 INFO - TEST-INFO | 1762: exit 0 14:20:05 INFO - Browser initialized. 14:20:05 INFO - Running cycle 1/1 for kraken test... 14:20:05 INFO - TEST-INFO | started process 1842 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwHFeTp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:17 INFO - PROCESS | 1842 | RSS: Main: 147668992 14:20:17 INFO - PROCESS | 1842 | 14:20:20 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39172/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:20 INFO - PROCESS | 1842 | RSS: Main: 181895168 14:20:20 INFO - PROCESS | 1842 | 14:20:23 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39172/tests/kraken/driver.html?testName=audio-dft) 14:20:23 INFO - PROCESS | 1842 | RSS: Main: 171782144 14:20:23 INFO - PROCESS | 1842 | 14:20:26 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39172/tests/kraken/driver.html?testName=audio-fft) 14:20:27 INFO - PROCESS | 1842 | RSS: Main: 157708288 14:20:27 INFO - PROCESS | 1842 | 14:20:29 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39172/tests/kraken/driver.html?testName=audio-oscillator) 14:20:29 INFO - PROCESS | 1842 | RSS: Main: 160030720 14:20:29 INFO - PROCESS | 1842 | 14:20:31 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39172/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:32 INFO - PROCESS | 1842 | RSS: Main: 160260096 14:20:32 INFO - PROCESS | 1842 | 14:20:35 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39172/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:35 INFO - PROCESS | 1842 | RSS: Main: 162570240 14:20:35 INFO - PROCESS | 1842 | 14:20:39 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39172/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:39 INFO - PROCESS | 1842 | RSS: Main: 161923072 14:20:39 INFO - PROCESS | 1842 | 14:20:42 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39172/tests/kraken/driver.html?testName=json-parse-financial) 14:20:43 INFO - PROCESS | 1842 | RSS: Main: 162422784 14:20:43 INFO - PROCESS | 1842 | 14:20:44 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39172/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:45 INFO - PROCESS | 1842 | RSS: Main: 178446336 14:20:45 INFO - PROCESS | 1842 | 14:20:47 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:47 INFO - PROCESS | 1842 | RSS: Main: 175923200 14:20:47 INFO - PROCESS | 1842 | 14:20:49 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:50 INFO - PROCESS | 1842 | RSS: Main: 188297216 14:20:50 INFO - PROCESS | 1842 | 14:20:52 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:53 INFO - PROCESS | 1842 | RSS: Main: 194101248 14:20:53 INFO - PROCESS | 1842 | 14:20:55 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:56 INFO - PROCESS | 1842 | RSS: Main: 192385024 14:20:56 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | Cycle 1(1): loaded http://localhost:39172/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39172/tests/kraken/driver.html?testName=ai-astar) 14:20:58 INFO - PROCESS | 1842 | RSS: Main: 250789888 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | __start_tp_report 14:20:58 INFO - PROCESS | 1842 | _x_x_mozilla_page_load 14:20:58 INFO - PROCESS | 1842 | _x_x_mozilla_page_load_details 14:20:58 INFO - PROCESS | 1842 | |i|pagename|runs| 14:20:58 INFO - PROCESS | 1842 | |0;ai-astar;109;110;104;110;110;111;98;110;109;110 14:20:58 INFO - PROCESS | 1842 | |1;audio-beat-detection;153;127;158;159;130;155;154;128;170;125 14:20:58 INFO - PROCESS | 1842 | |2;audio-dft;160;161;160;160;160;161;165;162;160;161 14:20:58 INFO - PROCESS | 1842 | |3;audio-fft;74;71;89;94;72;72;72;97;93;72 14:20:58 INFO - PROCESS | 1842 | |4;audio-oscillator;96;96;140;95;96;96;139;96;96;139 14:20:58 INFO - PROCESS | 1842 | |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 14:20:58 INFO - PROCESS | 1842 | |6;imaging-darkroom;145;146;145;146;145;146;144;145;146;145 14:20:58 INFO - PROCESS | 1842 | |7;imaging-desaturate;96;96;95;96;95;97;95;96;96;95 14:20:58 INFO - PROCESS | 1842 | |8;json-parse-financial;57;57;57;58;54;56;57;57;66;54 14:20:58 INFO - PROCESS | 1842 | |9;json-stringify-tinderbox;67;68;68;67;67;67;67;67;68;67 14:20:58 INFO - PROCESS | 1842 | |10;stanford-crypto-aes;91;83;91;84;85;85;93;87;86;87 14:20:58 INFO - PROCESS | 1842 | |11;stanford-crypto-ccm;116;121;118;116;113;119;127;117;125;118 14:20:58 INFO - PROCESS | 1842 | |12;stanford-crypto-pbkdf2;143;153;157;152;152;143;154;150;150;144 14:20:58 INFO - PROCESS | 1842 | |13;stanford-crypto-sha256-iterative;77;73;70;71;71;68;66;69;69;69 14:20:58 INFO - PROCESS | 1842 | __end_tp_report 14:20:58 INFO - PROCESS | 1842 | __start_cc_report 14:20:58 INFO - PROCESS | 1842 | _x_x_mozilla_cycle_collect,948 14:20:58 INFO - PROCESS | 1842 | __end_cc_report 14:20:58 INFO - PROCESS | 1842 | __startTimestamp1452118858507__endTimestamp 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | ------- Summary: start ------- 14:20:58 INFO - PROCESS | 1842 | Number of tests: 14 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.04 (3.7%) stddev-sans-first:4.27 14:20:58 INFO - PROCESS | 1842 | Values: 109.0 110.0 104.0 110.0 110.0 111.0 98.0 110.0 109.0 110.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.50 stddev:16.55 (10.7%) stddev-sans-first:17.35 14:20:58 INFO - PROCESS | 1842 | Values: 153.0 127.0 158.0 159.0 130.0 155.0 154.0 128.0 170.0 125.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.56 (1.0%) stddev-sans-first:1.62 14:20:58 INFO - PROCESS | 1842 | Values: 160.0 161.0 160.0 160.0 160.0 161.0 165.0 162.0 160.0 161.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#3] audio-fft Cycles:10 Average:80.60 Median:81.50 stddev:11.08 (13.6%) stddev-sans-first:11.49 14:20:58 INFO - PROCESS | 1842 | Values: 74.0 71.0 89.0 94.0 72.0 72.0 72.0 97.0 93.0 72.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:21.01 (21.9%) stddev-sans-first:21.75 14:20:58 INFO - PROCESS | 1842 | Values: 96.0 96.0 140.0 95.0 96.0 96.0 139.0 96.0 96.0 139.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:20:58 INFO - PROCESS | 1842 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:20:58 INFO - PROCESS | 1842 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 144.0 145.0 146.0 145.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:20:58 INFO - PROCESS | 1842 | Values: 96.0 96.0 95.0 96.0 95.0 97.0 95.0 96.0 96.0 95.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:3.33 (5.9%) stddev-sans-first:3.54 14:20:58 INFO - PROCESS | 1842 | Values: 57.0 57.0 57.0 58.0 54.0 56.0 57.0 57.0 66.0 54.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:20:58 INFO - PROCESS | 1842 | Values: 67.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:3.36 (3.9%) stddev-sans-first:3.27 14:20:58 INFO - PROCESS | 1842 | Values: 91.0 83.0 91.0 84.0 85.0 85.0 93.0 87.0 86.0 87.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.50 stddev:4.27 (3.6%) stddev-sans-first:4.39 14:20:58 INFO - PROCESS | 1842 | Values: 116.0 121.0 118.0 116.0 113.0 119.0 127.0 117.0 125.0 118.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.00 stddev:4.89 (3.2%) stddev-sans-first:4.53 14:20:58 INFO - PROCESS | 1842 | Values: 143.0 153.0 157.0 152.0 152.0 143.0 154.0 150.0 150.0 144.0 14:20:58 INFO - PROCESS | 1842 | 14:20:58 INFO - PROCESS | 1842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:3.02 (4.3%) stddev-sans-first:2.01 14:20:58 INFO - PROCESS | 1842 | Values: 77.0 73.0 70.0 71.0 71.0 68.0 66.0 69.0 69.0 69.0 14:20:58 INFO - PROCESS | 1842 | -------- Summary: end -------- 14:20:58 INFO - PROCESS | 1842 | 14:20:59 INFO - TEST-INFO | 1842: exit 0 14:20:59 INFO - TEST-OK | kraken | took 58351ms 14:20:59 INFO - TEST-START | v8_7 14:20:59 INFO - operating with platform_type : linux_ 14:20:59 INFO - Initialising browser for v8_7 test... 14:20:59 INFO - TEST-INFO | started process 2090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprJjzMv/profile http://localhost:39172/getInfo.html) 14:21:02 INFO - PROCESS | 2090 | __metrics Screen width/height:1600/1200 14:21:02 INFO - PROCESS | 2090 | colorDepth:24 14:21:02 INFO - PROCESS | 2090 | Browser inner width/height: 1024/697 14:21:02 INFO - PROCESS | 2090 | __metrics 14:21:02 INFO - PROCESS | 2090 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:21:02 INFO - PROCESS | 2090 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:03 INFO - TEST-INFO | 2090: exit 0 14:21:03 INFO - Browser initialized. 14:21:03 INFO - Running cycle 1/1 for v8_7 test... 14:21:03 INFO - TEST-INFO | started process 2170 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprJjzMv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:15 INFO - PROCESS | 2170 | RSS: Main: 149819392 14:21:15 INFO - PROCESS | 2170 | 14:21:36 INFO - PROCESS | 2170 | Cycle 1(1): loaded http://localhost:39172/tests/v8_7/run.html (next: http://localhost:39172/tests/v8_7/run.html) 14:21:37 INFO - PROCESS | 2170 | RSS: Main: 556187648 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | __start_tp_report 14:21:37 INFO - PROCESS | 2170 | _x_x_mozilla_page_load 14:21:37 INFO - PROCESS | 2170 | _x_x_mozilla_page_load_details 14:21:37 INFO - PROCESS | 2170 | |i|pagename|runs| 14:21:37 INFO - PROCESS | 2170 | |0;Richards;166.03021749958492 14:21:37 INFO - PROCESS | 2170 | |1;DeltaBlue;191.3143294432753 14:21:37 INFO - PROCESS | 2170 | |2;Encrypt;280.97780275358247 14:21:37 INFO - PROCESS | 2170 | |3;Decrypt;5186.5284974093265 14:21:37 INFO - PROCESS | 2170 | |4;RayTrace;1109.8779134295228 14:21:37 INFO - PROCESS | 2170 | |5;Earley;781.8608287724785 14:21:37 INFO - PROCESS | 2170 | |6;Boyer;12370.37037037037 14:21:37 INFO - PROCESS | 2170 | |7;RegExp;26394.736842105263 14:21:37 INFO - PROCESS | 2170 | |8;Splay;599.4047619047619 14:21:37 INFO - PROCESS | 2170 | |9;NavierStokes;4826.923076923077 14:21:37 INFO - PROCESS | 2170 | __end_tp_report 14:21:37 INFO - PROCESS | 2170 | __startTimestamp1452118897216__endTimestamp 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | ------- Summary: start ------- 14:21:37 INFO - PROCESS | 2170 | Number of tests: 10 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 166.0 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#1] DeltaBlue Cycles:1 Average:191.31 Median:191.31 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 191.3 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 281.0 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 5186.5 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 1109.9 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 781.9 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 12370.4 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 26394.7 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#8] Splay Cycles:1 Average:599.40 Median:599.40 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 599.4 14:21:37 INFO - PROCESS | 2170 | 14:21:37 INFO - PROCESS | 2170 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:21:37 INFO - PROCESS | 2170 | Values: 4826.9 14:21:37 INFO - PROCESS | 2170 | -------- Summary: end -------- 14:21:37 INFO - PROCESS | 2170 | 14:21:38 INFO - TEST-INFO | 2170: exit 0 14:21:38 INFO - TEST-OK | v8_7 | took 38696ms 14:21:38 INFO - SUITE-END | took 1210s 14:21:38 INFO - Completed test suite (00:20:10) 14:21:38 INFO - Working with test: dromaeo_css 14:21:38 INFO - Generating results file: dromaeo_css 14:21:38 INFO - Working with test: kraken 14:21:38 INFO - Generating results file: kraken 14:21:38 INFO - javascript benchmark 14:21:38 INFO - Working with test: v8_7 14:21:38 INFO - Generating results file: v8_7 14:21:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:21:38 INFO - process_Request line: dromaeo_css 6868.87 graph.html#tests=[[72,64,35]] 14:21:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:38 INFO - process_Request line: kraken 1505.60 graph.html#tests=[[232,64,35]] 14:21:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:21:38 INFO - process_Request line: v8_7 20968.82 graph.html#tests=[[230,64,35]] 14:21:38 INFO - RETURN: dromaeo_css: 6868.87 14:21:38 INFO - RETURN: kraken: 1505.60 14:21:38 INFO - RETURN: v8_7: 20968.82 14:21:38 INFO - javascript benchmark 14:21:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3148.370325934813, 3177.809331440112, 3180.109569320591, 3194.0258221242525, 3228.1768149121976, 5134.64057515974, 5219.660722053069, 5233.502817232362, 5282.630215884889, 5292.126799078147, 5180.093483640367, 5257.921131183035, 5331.093714068608, 5335.1730481775385, 5358.410574836765, 4775.188218002931, 4807.61539076873, 4829.541193586612, 4961.454240033593, 4973.030259099477, 4652.046330502239, 4913.656044076916, 4947.406311242656, 4954.529319714639, 4996.0, 4763.2378819388905, 4784.66507344486, 4875.317455556225, 4896.853094407174, 4942.901141977176, 4830.782614782343, 4887.853364399074, 4896.069746748107, 4910.631702622318, 4918.655694101414, 4644.2801365788355, 4733.029728905601, 4833.637477189225, 4866.780994855205, 4919.926201106986, 5113.335266415379, 5152.458991805844, 5171.5862730981435, 5175.585953123741, 5185.403678576937, 5592.4407559244155, 5622.662640241599, 5624.578156638268, 5632.46491583303, 5633.352164501094, 5565.6104072714925, 5638.830835074954, 5654.85862853432, 5690.857728556778, 5716.771329146829, 5232.267482552407, 5375.059364611177, 5378.11261141915, 5379.327584051994, 5379.973100134474, 5751.942480575224, 5753.59724819267, 5756.424357564294, 5761.53907687384, 5816.040353341651, 5439.265699130646, 5526.171074338801, 5545.195946587723, 5556.194351818964, 5579.135234038649, 5729.255196824386, 5815.244018277597, 5815.854603634858, 5816.94183058164, 5866.325372582122, 5604.915926261109, 5614.045612245928, 5657.80197693087, 5659.037963546125, 5661.886762264731, 5470.0, 5571.220029195916, 5573.0, 5650.378458369576, 5673.035583950738, 4363.061941682554, 4432.711873728262, 4452.5547445255215, 4478.395416618715, 4487.080148569536, 3900.180961998012, 3913.0413048803225, 3920.196359746245, 3930.4104384342577, 3948.565657777642, 5119.667221630582, 5214.348206474191, 5216.765245563959, 5222.843314700565, 5228.032813929435, 5579.581531385163, 5593.0, 5670.518005969457, 5744.368119506851, 5792.044312688359, 5229.241759944863, 5231.372235331784, 5240.633155679142, 5246.186841039645, 5249.685018898878, 4658.510856360102, 4785.210440277385, 4786.976065119652, 4791.520847915181, 4833.081714474239, 5703.857403564861, 5715.199872017921, 5896.941030589725, 5985.341612422717, 6030.457258846637, 5685.289338832646, 5717.542596592346, 5732.398098199796, 5734.627249228787, 5752.309722833287, 5729.512991395778, 5853.678047707417, 5908.881822363614, 5961.046232602763, 5964.9105263420215, 5448.727563621882, 5449.836504904859, 5450.945490545044, 5453.291072160594, 5484.149956756709, 5577.358603760619, 5582.0, 5582.748776304995, 5585.636933599303, 5590.217369568182, 5422.539084177889, 5426.348838139291, 5431.23962645222, 5434.184872269191, 5460.972695136499, 5567.526760225426, 5620.747066382104, 5624.803131890364, 5627.774889004394, 5669.149627555899, 5489.862753431196, 5523.392426832965, 5546.805861794818, 5548.334199896039, 5550.361708403424, 5448.318960129984, 5560.749766260609, 5569.693666848362, 5617.634853734494, 5633.8309850704545, 5410.918836217538, 5502.0, 5510.338759348743, 5518.613697041169, 5555.666660000413], "unit": "score", "name": "dojo.html", "value": 5222.830024583627}, {"lowerIsBetter": false, "replicates": [534.6791924845091, 559.3399788249866, 584.6755050946723, 591.0926727473329, 602.7890238416554, 27656.446871062566, 34867.0, 35632.0, 35684.2863142737, 35777.82111089441, 38799.41800872982, 39179.21641567167, 39333.40999885004, 39381.21237575247, 39532.20935581287, 7381.9261807382045, 7444.590547519884, 8399.958000210007, 8588.957055214747, 8605.61274742635, 9943.850842237372, 10091.344062635904, 10092.697219083439, 10169.542370593304, 10170.593176272978, 9913.851292230622, 9953.950230248838, 9993.250506212027, 10009.89990100097, 10015.799684006315, 7613.16255211929, 7757.883631745528, 7764.262395072459, 9940.40357578544, 10014.298999070068, 9748.171405430547, 9860.901390986142, 9881.604735810559, 9887.060729230712, 9889.109980101754, 35187.4721879172, 35529.64470355315, 35592.110197245274, 35636.643633563595, 35645.82177089124, 3165.889193878203, 3384.76306658534, 3467.8959631211105, 3544.432890737495, 3863.8068096595057, 28119.37723981024, 28527.857360713064, 28622.570661440095, 31177.37645247105, 31229.53155702666, 3743.4384842273603, 3959.802009899522, 3966.504186976628, 3980.7412518186516, 4013.97993010036, 269892.0, 270841.0, 271478.0, 271617.6419117912, 271653.0, 60207.69896150579, 60606.0, 60824.69587652122, 60835.69582152149, 60869.34783912891, 57859.0, 58806.41193588095, 64075.679621602525, 64378.678106609164, 64423.35576644267, 14875.404983800743, 14911.552653420415, 15020.549383518512, 15052.172130532927, 15070.472533461276, 10979.1765617579, 11006.0, 11042.889571104346, 11045.33727976324, 11049.0, 19370.515737106685, 19407.805921940882, 19491.0, 19569.217231310588, 19579.902100489693, 7761.728339508203, 7857.685692572348, 7911.446198766032, 7911.920880791234, 8094.959525202336, 933.2813733425224, 1040.7554224757175, 1045.8744950605976, 1099.741560733227, 1105.8120119579692, 28498.0, 28511.85744071308, 28580.14259572216, 28624.856875715905, 28664.426711466072, 977.0571398600384, 1031.6595523477235, 1061.994690026545, 1105.0219658021554, 1135.28477059452, 14814.333354999051, 14896.97623758411, 15112.168830714416, 15155.696886062216, 15202.619934501727, 326858.0, 333137.0, 333754.0, 333816.0, 334149.0, 53101.46898531043, 53663.73168134134, 53671.73164134155, 53699.0, 53731.731341343046, 1228.269179837995, 1230.39095647655, 1261.7981123020456, 1271.211848653822, 1400.2508657868195, 27595.58606620862, 28317.558045396585, 28645.14064578066, 28924.710752892202, 28963.0, 42261.0, 43039.354409683256, 46765.76617116893, 47126.0, 48438.5156148434, 214277.0, 214924.0, 215061.0, 215492.0, 215712.0, 32419.35161296808, 32875.835620821745, 32904.34191316112, 32931.176720582174, 32955.50566741453, 32549.0, 36737.448938265414, 39421.0, 42789.78605106955, 43805.123897522506, 31516.0, 38665.80667096759, 38915.416268756555, 40230.1953960925, 41226.79386603048, 35189.82405087958, 35358.46962295619, 36015.0, 36187.276254474236, 36313.273734524635, 34321.65678343185, 35353.58585656545, 35373.115672108404, 35416.822915885255, 35438.29123417569, 29178.70821291845, 32437.0, 32714.182145445604, 32730.345393091528, 32739.181520462178, 23862.642060368762, 24139.637905431784, 24386.634200487362, 24501.754982449947, 24691.382715432257], "unit": "score", "name": "ext.html", "value": 18310.905687986247}, {"lowerIsBetter": false, "replicates": [353.4574428252633, 356.5863598226057, 359.7643543479021, 365.79149884565794, 368.80269056055016, 14143.080699754535, 14273.357698903548, 16359.509214723563, 16971.321147154114, 17880.374186903446, 15642.139682317467, 15942.282597283122, 16338.673226535491, 16578.17109144544, 16663.75004374932, 4771.785269662856, 5524.806631767889, 5525.613207075507, 5527.917081243784, 5529.225908372831, 4184.456020717303, 4311.913761724763, 5526.364468086182, 5552.194931734896, 5956.047032474805, 6048.243969503812, 6069.514438844882, 6089.1170780236835, 6091.695415229243, 6103.81688549342, 5937.2578427696535, 6053.939460605426, 6098.939010609882, 6101.0, 6115.571909966304, 5234.842954711365, 5373.274607927919, 5378.46215378463, 5401.864953376158, 5405.972970135163, 20476.590468190552, 20477.897610511853, 20562.383128506168, 20896.05967731456, 20976.895115524323, 1998.5403357227774, 2224.7504732190187, 2237.53950282429, 2287.4853158039473, 2323.5933711600574, 13191.208527488285, 13200.801987970188, 13280.0, 13286.800697989442, 13508.797368039488, 1788.1148831328576, 1816.2371803842418, 1851.7963024067342, 1925.8363039141689, 1931.2950772967765, 57147.0, 59659.0, 59807.102893456635, 60066.399336006514, 60314.0, 9612.1829644481, 9828.655997040069, 10123.797524049625, 10161.796764064677, 10240.0, 12075.154739168174, 12084.0, 12097.516099355928, 12113.515459381702, 12118.0, 7584.0, 7587.203343648947, 7588.354989825816, 7615.5430674159725, 7678.923210767821, 7278.490505664553, 7332.266773322625, 7344.081989751281, 7359.264073592705, 7407.925920740831, 5981.282246130492, 6000.699965001732, 6077.8480537986015, 6092.634441933498, 6153.107799369156, 1628.9511314660579, 1707.1549582956516, 1725.4133594577904, 1739.6346767178782, 1743.9128043597768, 799.8440304140637, 984.1487113646788, 994.2791476179856, 1010.4291075542442, 1019.9439030853374, 14848.703025939421, 16644.0, 18207.635847283243, 18330.90834545819, 18627.441176764718, 894.3784070071238, 905.7101727447285, 913.7715571107224, 926.4858003807817, 971.2666936463066, 9635.470049147223, 9993.80012399748, 10046.346987445793, 10374.22193335503, 10466.0, 552878.0, 577528.0, 590770.0, 599100.0, 600506.0, 62236.377636223966, 80378.0, 80713.59643201863, 83372.58313708514, 83373.16626833775, 1007.9899201007896, 1022.8261195596766, 1072.3137192197, 1091.6561283195767, 1094.7482079121846, 15879.603009924844, 16050.759238611197, 16142.354305828105, 16177.191140442696, 16264.593385164992, 36524.63475365212, 37047.25905481929, 38009.42985855159, 38461.80769096137, 38532.22935541329, 47472.72745452926, 49822.75088624679, 50684.49315506945, 50755.74622126866, 51901.0, 9177.311701622539, 9189.908100918905, 9286.953565232401, 9301.674441394518, 9396.201322887631, 13956.79064814049, 17767.46697599074, 18292.359767408077, 18331.266749329876, 18412.0, 13956.302184890917, 14210.360533776211, 14231.71536569242, 15010.249487525798, 15041.473548425753, 14231.928840355731, 14512.492062777752, 14573.0, 14958.0, 15068.246587670792, 11044.558217671525, 11714.297142171497, 11772.938336273972, 13641.795373069213, 14130.293485325898, 8778.385513014284, 8872.556372181494, 8883.200511953955, 8897.599608017785, 9434.103760142776, 9363.859542106738, 9474.52627368615, 9483.715488535356, 12847.743045138857, 14503.347349369515], "unit": "score", "name": "jquery.html", "value": 9008.203577704779}, {"lowerIsBetter": false, "replicates": [1318.3671837517986, 1435.3397437178899, 1438.5684294711584, 1587.436205718163, 1767.699491086515, 6681.265060843303, 6842.486813488989, 7213.567185968839, 7367.336939675428, 7371.557706537598, 7281.381082607972, 7302.123745150576, 7380.483366164371, 7382.963085184567, 7388.335049845513, 1936.6804477261235, 1963.6072785442968, 2213.7786221377855, 2252.986156229695, 2254.413852398372, 2260.547890421922, 2301.0910690277415, 2301.976980230201, 2302.5049614332916, 2302.82728795341, 2172.4677454023786, 2172.706684597575, 2260.4800895793896, 2263.3549438410055, 2265.0600000999566, 2216.9889150554304, 2217.079911836586, 2242.573910956913, 2243.719535058118, 2266.7733226677365, 2202.31728164268, 2237.865728056322, 2284.0863654538316, 2288.78256565626, 2294.1740973249616, 7457.179710231871, 7535.982642343269, 7538.3215510604305, 7544.660490277951, 7546.207648196915, 4458.910821783546, 4464.0402313502755, 4523.86428407145, 4524.049949510607, 4536.183486972343, 2899.362140329124, 2988.0886329669443, 2989.237744375192, 2992.940141197164, 3011.412774508972, 882.841088604051, 896.188949001155, 899.5996781432265, 906.4244204929851, 920.4293338130335, 10109.696709098665, 10121.797564048678, 10156.593736250541, 10162.491875406275, 10183.185345172442, 4134.49091081753, 4156.106437116035, 4205.558416366238, 4218.093109981369, 4221.050263690707, 8747.606357713918, 8750.256228220673, 8756.605952732143, 8757.124287571192, 8764.1674040966, 4532.614727748112, 4533.478649955297, 4536.4102666653125, 4538.682292239578, 4541.727496350163, 4127.4015267786, 4146.253674338588, 4159.417681524589, 4160.438340824011, 4165.66674666026, 3353.865845366207, 3398.04854640701, 3470.5314782504543, 3620.1854582719207, 3651.434027725707, 1186.400867561893, 1186.7389174381622, 1187.8455800745849, 1194.7610477904454, 1195.8505186851644, 1011.206203130539, 1011.6105299459614, 1071.2019545438543, 1141.520561364229, 1322.9140105893086, 6858.6570671466225, 6915.51591388608, 6924.61914594692, 6985.93014069863, 6998.370146686822, 1080.0711388206137, 1092.9234953553334, 1102.7298311913632, 1102.73534351755, 1119.7088756923097, 5512.944870551323, 5589.888202235932, 5624.100143976944, 5630.493255607015, 5636.04187288162, 8523.190296921783, 8618.052014278424, 8716.08481109487, 8732.214100730966, 9113.954430227806, 8594.355423343275, 8616.181462761027, 8660.090690477535, 8663.653453861902, 8677.435966662148, 6962.851129563666, 7000.719971201197, 7007.614581198083, 7079.610621415872, 7083.504154709224, 6947.930520694728, 7008.264132266038, 7011.0, 7015.333543313377, 7017.157941047107, 7999.640016199169, 8070.919290807017, 8192.344612430872, 8195.959020205099, 8214.383921206054, 8135.75592732219, 8187.836243274982, 8285.95857020711, 8325.708600198965, 8361.916380836114, 6735.158105236846, 6753.797386078229, 6817.420519255918, 6822.522423430312, 6828.863422731418, 6458.063580780855, 6573.96713016451, 6583.078369028244, 6585.6377899216, 7284.890726639211, 6454.354564543508, 6500.837479062872, 6512.05575191604, 6596.0, 6625.238097618835, 6364.904526432199, 6505.707243173973, 6512.869742605027, 6542.607443553402, 6609.1408116944485, 6410.967945160244, 6487.0, 6501.317361676955, 6501.772437964649, 6506.316836732264, 5985.191999080069, 6095.0, 6098.786542470993, 6101.694915254308, 6102.145699602148, 5992.730327135202, 6012.188354572252, 6140.969295153495, 6146.231721034871, 6156.045812899008], "unit": "score", "name": "mootools.html", "value": 4298.752023422214}, {"lowerIsBetter": false, "replicates": [324.54401565800055, 330.7932542161149, 342.44352926494446, 344.30965913343744, 350.11770338746345, 5781.537477001841, 5803.448672376123, 5825.941740582598, 5871.588988770788, 5898.705064746756, 5783.392743761908, 5785.537157027438, 5785.652860828342, 5790.7683692652345, 5792.189093526909, 4527.999999999992, 4535.047639995589, 4539.296409056601, 4541.43232095988, 4544.363789069516, 4446.888827779299, 4508.842190523333, 4521.434820647419, 4523.886902827423, 4536.092781443708, 4468.575485328888, 4475.1049790042125, 4484.304932735415, 4494.1910456117885, 4496.505384407713, 4253.51084625269, 4315.8057887394825, 4472.239719247719, 4484.910301793979, 4490.775461226942, 3848.8460461581503, 3908.237893610747, 3914.941275880864, 3940.1725637616137, 3940.625640564142, 5438.15708565173, 5446.673199607996, 5457.345118585756, 5457.372402173761, 5462.071447853875, 4934.827281045146, 5005.874853128665, 5080.339555857715, 5103.362079740033, 5152.149895267276, 6030.216071910668, 6062.242219722535, 6069.0592958091565, 6072.301685306202, 6080.452759251644, 4318.4170137031415, 4321.178975994582, 4321.6326612238, 4324.091940692459, 4331.177076355514, 6229.844253893689, 6394.168758061469, 6395.936040639627, 6400.295967443578, 6403.071554624554, 4429.848239457764, 4438.533953934791, 4446.822127114944, 4447.999200179934, 4452.866414007585, 4489.865304040884, 4490.708103973231, 4492.887677808016, 4494.348319493721, 4495.483019452739, 5149.48505149482, 5149.639525233198, 5149.871253218625, 5150.4334523202415, 5157.974210129, 5973.432523910222, 6158.969205153946, 6161.599496032743, 6162.661053642093, 6167.321594624587, 1543.1589783567983, 1548.3110016042979, 1551.7129331073788, 1552.0, 1552.2781906413345, 1011.7066050845319, 1038.050184081572, 1040.843873418978, 1040.885502594714, 1043.7547176413536, 5815.41845815415, 5824.271966004249, 5826.038703613941, 5828.125781132864, 5829.621074630136, 6305.085762564402, 6332.240131184195, 6380.393862583047, 6386.648734319564, 6389.424951754364, 5770.913436298459, 5804.245448091721, 5820.796272130455, 5824.504917082096, 5826.038703613856, 3296.489044198153, 3390.1694084949345, 3391.135260508604, 3395.3548825723033, 3400.2349471368743, 6489.318621544764, 6491.221053473613, 6506.674666266667, 6508.60948343101, 6513.316101809337, 6187.195664563578, 6415.454686351619, 6418.903716444257, 6424.871502569922, 6432.807015789534, 6337.207849018872, 6342.39747224013, 6608.074869518367, 6609.339066093352, 6619.735210591522, 6326.145970293951, 6353.4599559038, 6363.5863668861375, 6366.3633636637815, 6371.299157092809, 6047.606905551125, 6283.120363149072, 6293.905591416224, 6298.748050077946, 6302.401271879165, 6561.606303621798, 6587.571807832475, 6593.901091483727, 6594.175728033996, 6603.141591593062, 4293.184294983943, 4326.351047342924, 4331.740095594275, 4331.870043898688, 4334.068175342317, 6338.207724034496, 6362.3319551448285, 6410.775622853178, 6416.422521973045, 6418.101465794886, 6038.5169186465855, 6166.568340216142, 6174.629522228681, 6175.722092505938, 6181.381861813962, 6063.514918806573, 6140.723667434887, 6149.0, 6151.046587778901, 6158.107074474086, 5997.250343707036, 6030.396960303934, 6070.908936366046, 6092.116643086639, 6101.054336577838, 6036.63780173191, 6192.0, 6204.100405441276, 6204.348543403058, 6210.7515699373325, 5960.83763666081, 5974.581779275582, 5975.043992961279, 5977.163197152315, 5977.432143946318], "unit": "score", "name": "prototype.html", "value": 4641.711875843469}, {"lowerIsBetter": false, "replicates": [718.8680554866983, 761.2425636491691, 797.7806103321586, 807.6446363600015, 827.6606591297569, 13599.728005439898, 13866.791998120023, 13886.0, 13892.305384730747, 13906.860931390684, 12945.158564693313, 12998.54505092322, 13030.674233144153, 13065.542706005292, 13870.306484675777, 690.6926417744106, 821.6795449774608, 838.4424357802054, 838.6645341863273, 839.1859895900966, 695.8817001109799, 829.1128492513013, 847.4830353484369, 848.4315508609246, 848.5884346092171, 846.7290467050547, 875.0942774228674, 878.7495563764328, 879.0725784297564, 879.3888247667874, 717.3507975282378, 723.5188599581272, 856.1908995998783, 873.0614589316478, 874.0516539554591, 640.5068097564896, 641.4996302883758, 653.3531803514534, 654.2933631677824, 654.4077609763171, 13495.59513214605, 13582.25297608641, 13621.25083120428, 13625.25061121638, 13628.11417257885, 12060.638180854588, 12413.317267550281, 12696.80954785679, 12862.935685321607, 12884.87115128846, 9949.552270147788, 10014.898361180265, 10117.544710487971, 10494.108000819939, 10510.842337364946, 3657.085728567858, 3657.305112028706, 3664.76179048361, 3667.9816600916824, 3678.70570354371, 45553.316700249525, 46322.76838615819, 46652.06695866097, 46965.765171174266, 47086.29370559444, 9625.56684949179, 9854.7805755934, 9932.255080868963, 9936.254780891462, 9953.353032052893, 18820.43538693814, 18873.056347182584, 18897.716534252, 18930.81069189318, 18945.052747362577, 7490.138634057044, 7490.775276741598, 7643.4267429942975, 7767.53394796314, 7896.565688887166, 4147.170565886774, 4154.1068670236045, 4203.201391735561, 4248.171606536757, 4322.308430651081, 3129.937401251962, 3201.3117179806454, 3203.19920019995, 3210.5826242588314, 3212.839358032089, 534.9438308977501, 562.6230425614848, 564.2241917363625, 616.8026231605843, 629.288903538998, 603.8158361699724, 614.2830787947697, 620.5718054542351, 650.2286736925811, 666.4235436347622, 7485.176630570633, 7624.771256862303, 7640.656170472342, 8016.438849280611, 8037.35701143907, 563.0934195944526, 580.8780156167168, 583.8277708076128, 602.3464540973006, 612.4549151255297, 3648.8540458381367, 3802.4106263529197, 3823.866164684223, 3863.0728625130328, 3996.900077498086, 50317.49682503128, 50973.745131274845, 51022.74488627533, 51186.0, 51325.23012154821, 47108.293375599394, 47115.29327060097, 47221.29168062482, 47424.7628761854, 48290.27564586534, 44102.779486102365, 44483.0, 44775.32837007447, 45047.774761125984, 45129.774351128035, 7580.469367144247, 7682.500637458547, 7893.723719669784, 7922.7227047053075, 7991.92008079935, 33735.83132084324, 34271.14322141966, 35859.0, 36114.09714757152, 36251.0, 38756.6124338753, 40401.787946361655, 40501.594984049785, 42786.50247241332, 43316.35025474557, 10343.0, 10457.529411176363, 10476.68569942903, 10668.0, 10746.355218686904, 10925.508352124014, 11522.366269855238, 11650.53397864076, 11825.290482571074, 11911.523539058688, 9968.252381071303, 9983.251256155963, 10298.897011029794, 10489.213309001703, 10583.047525722723, 9825.803483930424, 10219.540120694437, 10374.792504150026, 10426.739331516772, 10458.26792124544, 9715.22278217755, 9969.700908972452, 10245.897541024793, 10290.578571570766, 10292.639757608447, 9039.136315765789, 9137.314701397288, 9145.954270228607, 9192.58633361487, 9554.61781528731, 8064.83870322602, 8522.616482258438, 8582.699605513777, 8682.956585217033, 8722.433041852513], "unit": "score", "name": "yui.html", "value": 6109.361223315487}], "name": "dromaeo_css", "value": 6868.869721505755}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 111.0, 98.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 158.0, 159.0, 130.0, 155.0, 154.0, 128.0, 170.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 165.0, 162.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 89.0, 94.0, 72.0, 72.0, 72.0, 97.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 95.0, 96.0, 96.0, 139.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 144.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 58.0, 54.0, 56.0, 57.0, 57.0, 66.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 91.0, 84.0, 85.0, 85.0, 93.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.2}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 118.0, 116.0, 113.0, 119.0, 127.0, 117.0, 125.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 157.0, 152.0, 152.0, 143.0, 154.0, 150.0, 150.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 70.0, 71.0, 71.0, 68.0, 66.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1505.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [191.3143294432753], "unit": "score", "name": "DeltaBlue", "value": 345.5987859999999}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [599.4047619047619], "unit": "score", "name": "Splay", "value": 135.95320754716985}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20968.823233681425}]} 14:21:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20968.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1505.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6868.87"}}} 14:21:38 INFO - Return code: 0 14:21:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:38 INFO - # TBPL SUCCESS # 14:21:38 INFO - Running post-action listener: _resource_record_post_action 14:21:38 INFO - Running post-run listener: _resource_record_post_run 14:21:39 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 564330496; Read time: 244; Write time: 421644 14:21:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255479808; Read time: 0; Write time: 240084 14:21:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 12288; Write bytes: 308850688; Read time: 244; Write time: 181560 14:21:39 INFO - Running post-run listener: _upload_blobber_files 14:21:39 INFO - Blob upload gear active. 14:21:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:21:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:21:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:21:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:21:40 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:41 INFO - (blobuploader) - INFO - Done attempting. 14:21:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:41 INFO - (blobuploader) - INFO - Done attempting. 14:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:41 INFO - Return code: 0 14:21:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50984899b8f330f67cfa9141281e96f0895f5c5d3d1acce87f24887e39156b6f81123be5dc8f7069ca1fc320bfc160c5c43dcb866562cf910da529c037235762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588aca8fba693aa0c936bd3845754e308371ecba1e07e2afc1083539468eaead25e2b8d80533cd88bc29f609617af4e85cf6beb1b8f6d2ba00c37c0c4df65c7f"} 14:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:21:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:21:41 INFO - Contents: 14:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50984899b8f330f67cfa9141281e96f0895f5c5d3d1acce87f24887e39156b6f81123be5dc8f7069ca1fc320bfc160c5c43dcb866562cf910da529c037235762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588aca8fba693aa0c936bd3845754e308371ecba1e07e2afc1083539468eaead25e2b8d80533cd88bc29f609617af4e85cf6beb1b8f6d2ba00c37c0c4df65c7f"} 14:21:41 INFO - Copying logs to upload dir... 14:21:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.834651 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-06 14:21:41.926330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 14:21:41.930168) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50984899b8f330f67cfa9141281e96f0895f5c5d3d1acce87f24887e39156b6f81123be5dc8f7069ca1fc320bfc160c5c43dcb866562cf910da529c037235762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588aca8fba693aa0c936bd3845754e308371ecba1e07e2afc1083539468eaead25e2b8d80533cd88bc29f609617af4e85cf6beb1b8f6d2ba00c37c0c4df65c7f"} build_url:https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/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/Fx-Team/sha512/50984899b8f330f67cfa9141281e96f0895f5c5d3d1acce87f24887e39156b6f81123be5dc8f7069ca1fc320bfc160c5c43dcb866562cf910da529c037235762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588aca8fba693aa0c936bd3845754e308371ecba1e07e2afc1083539468eaead25e2b8d80533cd88bc29f609617af4e85cf6beb1b8f6d2ba00c37c0c4df65c7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 14:21:41.959764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:21:41.960612) ========= 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=1f5564757af27664ca02d71f000001b0-1452117636.360164-1656571314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:21:42.041664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 14:21:42.042448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 14:21:42.043234) ========= ========= Total master_lag: 0.24 =========