builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1452611664.7 results: success (0) buildid: 20160112043006 builduid: 739b166c82744fa5a2d5914d758d20a1 revision: e790bba372f14241addda469a4bdb7ab00786ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.702249) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.702772) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.703089) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.726173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.726478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.739338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.739625) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.824516) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.824809) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.825239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.825517) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 07:14:24-- 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% 38.7M=0s 2016-01-12 07:14:25 (38.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.986308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:24.986585) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017925 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:25.036756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 07:14:25.037124) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e790bba372f14241addda469a4bdb7ab00786ab3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e790bba372f14241addda469a4bdb7ab00786ab3 --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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 07:14:25,187 truncating revision to first 12 chars 2016-01-12 07:14:25,187 Setting DEBUG logging. 2016-01-12 07:14:25,187 attempt 1/10 2016-01-12 07:14:25,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e790bba372f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 07:14:26,250 unpacking tar archive at: mozilla-central-e790bba372f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 07:14:26.423913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:26.424441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:26.434726) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:26.435096) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 07:14:26.435555) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-01-12 07:14:26.435882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:26 INFO - MultiFileLogger online at 20160112 07:14:26 in /builds/slave/test-pgo 07:14:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:14:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:14:26 INFO - {'append_to_log': False, 07:14:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:14:26 INFO - 'blob_upload_branch': 'Firefox', 07:14:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:14:26 INFO - 'branch': 'Firefox', 07:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:26 INFO - 'config_files': ('talos/linux_config.py',), 07:14:26 INFO - 'default_actions': ('clobber', 07:14:26 INFO - 'read-buildbot-config', 07:14:26 INFO - 'download-and-extract', 07:14:26 INFO - 'populate-webroot', 07:14:26 INFO - 'create-virtualenv', 07:14:26 INFO - 'install', 07:14:26 INFO - 'run-tests'), 07:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:26 INFO - 'download_minidump_stackwalk': True, 07:14:26 INFO - 'download_symbols': 'ondemand', 07:14:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:26 INFO - 'installer_path': 'installer.exe', 07:14:26 INFO - 'log_level': 'info', 07:14:26 INFO - 'log_name': 'talos', 07:14:26 INFO - 'log_to_console': True, 07:14:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:26 INFO - 'opt_config_files': (), 07:14:26 INFO - 'pip_index': False, 07:14:26 INFO - 'sps_profile': False, 07:14:26 INFO - 'sps_profile_interval': 0, 07:14:26 INFO - 'suite': 'dromaeojs', 07:14:26 INFO - 'system_bits': '32', 07:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:26 INFO - 'title': 'talos-linux64-ix-062', 07:14:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:26 INFO - 'use_talos_json': True, 07:14:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:26 INFO - 'work_dir': 'build'} 07:14:26 INFO - ##### 07:14:26 INFO - ##### Running clobber step. 07:14:26 INFO - ##### 07:14:26 INFO - Running pre-action listener: _resource_record_pre_action 07:14:26 INFO - Running main action method: clobber 07:14:26 INFO - rmtree: /builds/slave/test-pgo/build 07:14:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:14:27 INFO - Running post-action listener: _resource_record_post_action 07:14:27 INFO - ##### 07:14:27 INFO - ##### Running read-buildbot-config step. 07:14:27 INFO - ##### 07:14:27 INFO - Running pre-action listener: _resource_record_pre_action 07:14:27 INFO - Running main action method: read_buildbot_config 07:14:27 INFO - Using buildbot properties: 07:14:27 INFO - { 07:14:27 INFO - "project": "", 07:14:27 INFO - "product": "firefox", 07:14:27 INFO - "script_repo_revision": "production", 07:14:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:14:27 INFO - "repository": "", 07:14:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:14:27 INFO - "buildid": "20160112043006", 07:14:27 INFO - "pgo_build": "True", 07:14:27 INFO - "basedir": "/builds/slave/test-pgo", 07:14:27 INFO - "buildnumber": 642, 07:14:27 INFO - "slavename": "talos-linux64-ix-062", 07:14:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:14:27 INFO - "platform": "ubuntu64_hw", 07:14:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:14:27 INFO - "branch": "mozilla-central", 07:14:27 INFO - "repo_path": "mozilla-central", 07:14:27 INFO - "revision": "e790bba372f14241addda469a4bdb7ab00786ab3", 07:14:27 INFO - "stage_platform": "linux64-pgo", 07:14:27 INFO - "builduid": "739b166c82744fa5a2d5914d758d20a1", 07:14:27 INFO - "slavebuilddir": "test" 07:14:27 INFO - } 07:14:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:14:27 INFO - Running post-action listener: _resource_record_post_action 07:14:27 INFO - ##### 07:14:27 INFO - ##### Running download-and-extract step. 07:14:27 INFO - ##### 07:14:27 INFO - Running pre-action listener: _resource_record_pre_action 07:14:27 INFO - Running main action method: download_and_extract 07:14:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:27 INFO - https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/test_packages.json 07:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/test_packages.json 07:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:14:27 INFO - Downloaded 1302 bytes. 07:14:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:14:27 INFO - Using the following test package requirements: 07:14:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:14:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'jsshell-linux-x86_64.zip'], 07:14:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:14:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:14:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:14:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:14:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:14:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:27 INFO - https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:30 INFO - Downloaded 24026957 bytes. 07:14:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:14:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:14:31 INFO - Return code: 0 07:14:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:31 INFO - https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:34 INFO - Downloaded 24026957 bytes. 07:14:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:14:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:14:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:14:35 INFO - Return code: 0 07:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:35 INFO - https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:14:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:14:37 INFO - Downloaded 11132285 bytes. 07:14:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:14:38 INFO - Return code: 0 07:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:38 INFO - https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:14:40 INFO - Downloaded 55740991 bytes. 07:14:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:14:40 INFO - mkdir: /builds/slave/test-pgo/properties 07:14:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:14:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:14:40 INFO - Contents: 07:14:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:14:40 INFO - Running post-action listener: _resource_record_post_action 07:14:40 INFO - Running post-action listener: set_extra_try_arguments 07:14:40 INFO - ##### 07:14:40 INFO - ##### Running populate-webroot step. 07:14:40 INFO - ##### 07:14:40 INFO - Running pre-action listener: _resource_record_pre_action 07:14:40 INFO - Running main action method: populate_webroot 07:14:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:41 INFO - '--tppagecycles', 07:14:41 INFO - '7'], 07:14:41 INFO - 'tests': ['tsvgm']}}, 07:14:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:14:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:14:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:14:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'tests': ['damp', 'tps']}, 07:14:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['damp', 'tps']}, 07:14:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:14:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:41 INFO - 'other': {'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'other_l64': {'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'other_nol64': {'tests': ['a11yr', 07:14:41 INFO - 'ts_paint', 07:14:41 INFO - 'tpaint', 07:14:41 INFO - 'sessionrestore', 07:14:41 INFO - 'sessionrestore_no_auto_restore']}, 07:14:41 INFO - 'svgr': {'tests': ['tsvgx', 07:14:41 INFO - 'tsvgr_opacity', 07:14:41 INFO - 'tart', 07:14:41 INFO - 'tscrollx', 07:14:41 INFO - 'cart']}, 07:14:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['tsvgx', 07:14:41 INFO - 'tsvgr_opacity', 07:14:41 INFO - 'tart', 07:14:41 INFO - 'tscrollx', 07:14:41 INFO - 'cart']}, 07:14:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'tests': ['tp5o']}, 07:14:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'talos_options': ['--e10s'], 07:14:41 INFO - 'tests': ['tp5o']}, 07:14:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'talos_options': ['--xperf_path', 07:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:41 INFO - 'tests': ['tp5n']}, 07:14:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:41 INFO - 'talos_options': ['--e10s', 07:14:41 INFO - '--xperf_path', 07:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:41 INFO - 'tests': ['tp5n']}}, 07:14:41 INFO - 'talos.zip': {'path': '', 07:14:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:41 INFO - Running post-action listener: _resource_record_post_action 07:14:41 INFO - ##### 07:14:41 INFO - ##### Running create-virtualenv step. 07:14:41 INFO - ##### 07:14:41 INFO - Running pre-action listener: _resource_record_pre_action 07:14:41 INFO - Running main action method: create_virtualenv 07:14:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:14:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:14:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:14:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:41 INFO - Using real prefix '/usr' 07:14:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:43 INFO - Installing pip.................done. 07:14:43 INFO - Return code: 0 07:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:14:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:14:43 INFO - Using env: {'DISPLAY': ':0', 07:14:43 INFO - 'HOME': '/home/cltbld', 07:14:43 INFO - 'LANG': 'en_US.UTF-8', 07:14:43 INFO - 'LANGUAGE': 'en_US:en', 07:14:43 INFO - 'LOGNAME': 'cltbld', 07:14:43 INFO - 'MAIL': '/var/mail/cltbld', 07:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:43 INFO - 'MOZ_NO_REMOTE': '1', 07:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:43 INFO - 'NO_EM_RESTART': '1', 07:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:43 INFO - 'SHELL': '/bin/bash', 07:14:43 INFO - 'SHLVL': '1', 07:14:43 INFO - 'TERM': 'linux', 07:14:43 INFO - 'TMOUT': '86400', 07:14:43 INFO - 'USER': 'cltbld', 07:14:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:43 INFO - '_': '/tools/buildbot/bin/python'} 07:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:14:43 INFO - Cleaning up... 07:14:43 INFO - Return code: 0 07:14:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:43 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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:14:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:14:43 INFO - Using env: {'DISPLAY': ':0', 07:14:43 INFO - 'HOME': '/home/cltbld', 07:14:43 INFO - 'LANG': 'en_US.UTF-8', 07:14:43 INFO - 'LANGUAGE': 'en_US:en', 07:14:43 INFO - 'LOGNAME': 'cltbld', 07:14:43 INFO - 'MAIL': '/var/mail/cltbld', 07:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:43 INFO - 'MOZ_NO_REMOTE': '1', 07:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:43 INFO - 'NO_EM_RESTART': '1', 07:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:43 INFO - 'SHELL': '/bin/bash', 07:14:43 INFO - 'SHLVL': '1', 07:14:43 INFO - 'TERM': 'linux', 07:14:43 INFO - 'TMOUT': '86400', 07:14:43 INFO - 'USER': 'cltbld', 07:14:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:43 INFO - '_': '/tools/buildbot/bin/python'} 07:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:43 INFO - Downloading/unpacking psutil>=0.7.1 07:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:14:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:14:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:45 INFO - Installing collected packages: psutil 07:14:45 INFO - Running setup.py install for psutil 07:14:45 INFO - building 'psutil._psutil_linux' extension 07:14:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:14:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:14:46 INFO - building 'psutil._psutil_posix' extension 07:14:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:14:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:46 INFO - Successfully installed psutil 07:14:46 INFO - Cleaning up... 07:14:46 INFO - Return code: 0 07:14:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:14:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:14:46 INFO - Using env: {'DISPLAY': ':0', 07:14:46 INFO - 'HOME': '/home/cltbld', 07:14:46 INFO - 'LANG': 'en_US.UTF-8', 07:14:46 INFO - 'LANGUAGE': 'en_US:en', 07:14:46 INFO - 'LOGNAME': 'cltbld', 07:14:46 INFO - 'MAIL': '/var/mail/cltbld', 07:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:46 INFO - 'MOZ_NO_REMOTE': '1', 07:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:46 INFO - 'NO_EM_RESTART': '1', 07:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:46 INFO - 'SHELL': '/bin/bash', 07:14:46 INFO - 'SHLVL': '1', 07:14:46 INFO - 'TERM': 'linux', 07:14:46 INFO - 'TMOUT': '86400', 07:14:46 INFO - 'USER': 'cltbld', 07:14:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:46 INFO - '_': '/tools/buildbot/bin/python'} 07:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:14:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:48 INFO - Installing collected packages: mozsystemmonitor 07:14:48 INFO - Running setup.py install for mozsystemmonitor 07:14:48 INFO - Successfully installed mozsystemmonitor 07:14:48 INFO - Cleaning up... 07:14:48 INFO - Return code: 0 07:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:48 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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:14:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:14:48 INFO - Using env: {'DISPLAY': ':0', 07:14:48 INFO - 'HOME': '/home/cltbld', 07:14:48 INFO - 'LANG': 'en_US.UTF-8', 07:14:48 INFO - 'LANGUAGE': 'en_US:en', 07:14:48 INFO - 'LOGNAME': 'cltbld', 07:14:48 INFO - 'MAIL': '/var/mail/cltbld', 07:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:48 INFO - 'MOZ_NO_REMOTE': '1', 07:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:48 INFO - 'NO_EM_RESTART': '1', 07:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:48 INFO - 'SHELL': '/bin/bash', 07:14:48 INFO - 'SHLVL': '1', 07:14:48 INFO - 'TERM': 'linux', 07:14:48 INFO - 'TMOUT': '86400', 07:14:48 INFO - 'USER': 'cltbld', 07:14:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:48 INFO - '_': '/tools/buildbot/bin/python'} 07:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:14:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:14:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:14:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:51 INFO - Downloading docopt-0.6.1.tar.gz 07:14:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:14:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:51 INFO - Running setup.py install for blobuploader 07:14:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:14:51 INFO - Running setup.py install for requests 07:14:51 INFO - Running setup.py install for docopt 07:14:51 INFO - Successfully installed blobuploader requests docopt 07:14:51 INFO - Cleaning up... 07:14:51 INFO - Return code: 0 07:14:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:51 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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:14:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:14:51 INFO - Using env: {'DISPLAY': ':0', 07:14:51 INFO - 'HOME': '/home/cltbld', 07:14:51 INFO - 'LANG': 'en_US.UTF-8', 07:14:51 INFO - 'LANGUAGE': 'en_US:en', 07:14:51 INFO - 'LOGNAME': 'cltbld', 07:14:51 INFO - 'MAIL': '/var/mail/cltbld', 07:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:51 INFO - 'MOZ_NO_REMOTE': '1', 07:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:51 INFO - 'NO_EM_RESTART': '1', 07:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:51 INFO - 'SHELL': '/bin/bash', 07:14:51 INFO - 'SHLVL': '1', 07:14:51 INFO - 'TERM': 'linux', 07:14:51 INFO - 'TMOUT': '86400', 07:14:51 INFO - 'USER': 'cltbld', 07:14:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:51 INFO - '_': '/tools/buildbot/bin/python'} 07:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:14:51 INFO - Running setup.py (path:/tmp/pip-BNjJEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:14:52 INFO - Running setup.py (path:/tmp/pip-KmiyCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:14:52 INFO - Running setup.py (path:/tmp/pip-atkYVB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:14:52 INFO - Running setup.py (path:/tmp/pip-UUf4AC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:14:52 INFO - Running setup.py (path:/tmp/pip-s_CSFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:14:52 INFO - Running setup.py (path:/tmp/pip-LBRLCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:14:52 INFO - Running setup.py (path:/tmp/pip-NxosjI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:14:52 INFO - Running setup.py (path:/tmp/pip-_LrhkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:14:52 INFO - Running setup.py (path:/tmp/pip-Qf9z18-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:14:52 INFO - Running setup.py (path:/tmp/pip-cPN9zB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:14:52 INFO - Running setup.py (path:/tmp/pip-qjv6hg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:14:52 INFO - Running setup.py (path:/tmp/pip-BaN9qy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:14:52 INFO - Running setup.py (path:/tmp/pip-p1xKaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:14:52 INFO - Running setup.py (path:/tmp/pip-mV7d_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:14:52 INFO - Running setup.py (path:/tmp/pip-Z7gQX2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:14:53 INFO - Running setup.py (path:/tmp/pip-B44Mxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:14:53 INFO - Running setup.py (path:/tmp/pip-DzrKgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:53 INFO - Running setup.py install for manifestparser 07:14:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Running setup.py install for mozcrash 07:14:53 INFO - Running setup.py install for mozdebug 07:14:53 INFO - Running setup.py install for mozdevice 07:14:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Running setup.py install for mozfile 07:14:53 INFO - Running setup.py install for mozhttpd 07:14:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Running setup.py install for mozinfo 07:14:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Running setup.py install for mozInstall 07:14:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:14:53 INFO - Running setup.py install for mozleak 07:14:54 INFO - Running setup.py install for mozlog 07:14:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Running setup.py install for moznetwork 07:14:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Running setup.py install for mozprocess 07:14:54 INFO - Running setup.py install for mozprofile 07:14:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Running setup.py install for mozrunner 07:14:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Running setup.py install for mozscreenshot 07:14:54 INFO - Running setup.py install for moztest 07:14:54 INFO - Running setup.py install for mozversion 07:14:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:14:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:54 INFO - Cleaning up... 07:14:54 INFO - Return code: 0 07:14:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:14: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')]} 07:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', '-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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:14:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:14:54 INFO - Using env: {'DISPLAY': ':0', 07:14:54 INFO - 'HOME': '/home/cltbld', 07:14:54 INFO - 'LANG': 'en_US.UTF-8', 07:14:54 INFO - 'LANGUAGE': 'en_US:en', 07:14:54 INFO - 'LOGNAME': 'cltbld', 07:14:54 INFO - 'MAIL': '/var/mail/cltbld', 07:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:54 INFO - 'MOZ_NO_REMOTE': '1', 07:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:54 INFO - 'NO_EM_RESTART': '1', 07:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:54 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:54 INFO - 'SHELL': '/bin/bash', 07:14:54 INFO - 'SHLVL': '1', 07:14:54 INFO - 'TERM': 'linux', 07:14:54 INFO - 'TMOUT': '86400', 07:14:54 INFO - 'USER': 'cltbld', 07:14:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:54 INFO - '_': '/tools/buildbot/bin/python'} 07:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:14:55 INFO - Running setup.py (path:/tmp/pip-cwqSIV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:14:55 INFO - Running setup.py (path:/tmp/pip-WWHNQD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:14:55 INFO - Running setup.py (path:/tmp/pip-jyx_no-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:14:55 INFO - Running setup.py (path:/tmp/pip-p77glL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:14:55 INFO - Running setup.py (path:/tmp/pip-KDYFSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:14:55 INFO - Running setup.py (path:/tmp/pip-aTKFgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:14:55 INFO - Running setup.py (path:/tmp/pip-AowZgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:14:55 INFO - Running setup.py (path:/tmp/pip-bwk9AK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:14:55 INFO - Running setup.py (path:/tmp/pip-IaJWJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:14:55 INFO - Running setup.py (path:/tmp/pip-0a1rT_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:14:55 INFO - Running setup.py (path:/tmp/pip-L826fP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:14:55 INFO - Running setup.py (path:/tmp/pip-OUJeYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:14:56 INFO - Running setup.py (path:/tmp/pip-fFiKPg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:14:56 INFO - Running setup.py (path:/tmp/pip-1SZHug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:14:56 INFO - Running setup.py (path:/tmp/pip-His66_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:14:56 INFO - Running setup.py (path:/tmp/pip-zXJHmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:14:56 INFO - Running setup.py (path:/tmp/pip-nuE7hM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:58 INFO - Downloading blessings-1.5.1.tar.gz 07:14:58 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:14:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:58 INFO - Installing collected packages: blessings 07:14:58 INFO - Running setup.py install for blessings 07:14:58 INFO - Successfully installed blessings 07:14:58 INFO - Cleaning up... 07:14:58 INFO - Return code: 0 07:14:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:14:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:14:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:14:58 INFO - Reading from file tmpfile_stdout 07:14:58 INFO - Current package versions: 07:14:58 INFO - argparse == 1.2.1 07:14:58 INFO - blessings == 1.5.1 07:14:58 INFO - blobuploader == 1.2.4 07:14:58 INFO - docopt == 0.6.1 07:14:58 INFO - manifestparser == 1.1 07:14:58 INFO - mozInstall == 1.12 07:14:58 INFO - mozcrash == 0.16 07:14:58 INFO - mozdebug == 0.1 07:14:58 INFO - mozdevice == 0.47 07:14:58 INFO - mozfile == 1.2 07:14:58 INFO - mozhttpd == 0.7 07:14:58 INFO - mozinfo == 0.9 07:14:58 INFO - mozleak == 0.1 07:14:58 INFO - mozlog == 3.1 07:14:58 INFO - moznetwork == 0.27 07:14:58 INFO - mozprocess == 0.22 07:14:58 INFO - mozprofile == 0.28 07:14:58 INFO - mozrunner == 6.11 07:14:58 INFO - mozscreenshot == 0.1 07:14:58 INFO - mozsystemmonitor == 0.0 07:14:58 INFO - moztest == 0.7 07:14:58 INFO - mozversion == 1.4 07:14:58 INFO - psutil == 3.1.1 07:14:58 INFO - requests == 1.2.3 07:14:58 INFO - wsgiref == 0.1.2 07:14:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:14: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')]} 07:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:14:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:14:58 INFO - Using env: {'DISPLAY': ':0', 07:14:58 INFO - 'HOME': '/home/cltbld', 07:14:58 INFO - 'LANG': 'en_US.UTF-8', 07:14:58 INFO - 'LANGUAGE': 'en_US:en', 07:14:58 INFO - 'LOGNAME': 'cltbld', 07:14:58 INFO - 'MAIL': '/var/mail/cltbld', 07:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:58 INFO - 'MOZ_NO_REMOTE': '1', 07:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:58 INFO - 'NO_EM_RESTART': '1', 07:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:58 INFO - 'SHELL': '/bin/bash', 07:14:58 INFO - 'SHLVL': '1', 07:14:58 INFO - 'TERM': 'linux', 07:14:58 INFO - 'TMOUT': '86400', 07:14:58 INFO - 'USER': 'cltbld', 07:14:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:58 INFO - '_': '/tools/buildbot/bin/python'} 07:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:14:58 INFO - Cleaning up... 07:14:58 INFO - Return code: 0 07:14:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:14: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')]} 07:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:14:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:14:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:14:58 INFO - Using env: {'DISPLAY': ':0', 07:14:58 INFO - 'HOME': '/home/cltbld', 07:14:58 INFO - 'LANG': 'en_US.UTF-8', 07:14:58 INFO - 'LANGUAGE': 'en_US:en', 07:14:58 INFO - 'LOGNAME': 'cltbld', 07:14:58 INFO - 'MAIL': '/var/mail/cltbld', 07:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:58 INFO - 'MOZ_NO_REMOTE': '1', 07:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:58 INFO - 'NO_EM_RESTART': '1', 07:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:14:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:14:58 INFO - 'SHELL': '/bin/bash', 07:14:58 INFO - 'SHLVL': '1', 07:14:58 INFO - 'TERM': 'linux', 07:14:58 INFO - 'TMOUT': '86400', 07:14:58 INFO - 'USER': 'cltbld', 07:14:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:58 INFO - '_': '/tools/buildbot/bin/python'} 07:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:59 INFO - Downloading/unpacking jsonschema 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:15:00 INFO - Downloading/unpacking functools32 (from jsonschema) 07:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:00 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:01 INFO - warning: no files found matching '*.txt' 07:15:01 INFO - no previously-included directories found matching 'build' 07:15:01 INFO - no previously-included directories found matching 'dist' 07:15:01 INFO - no previously-included directories found matching '.git*' 07:15:01 INFO - Installing collected packages: jsonschema, functools32 07:15:01 INFO - Running setup.py install for functools32 07:15:01 INFO - warning: no files found matching '*.txt' 07:15:01 INFO - no previously-included directories found matching 'build' 07:15:01 INFO - no previously-included directories found matching 'dist' 07:15:01 INFO - no previously-included directories found matching '.git*' 07:15:01 INFO - Successfully installed jsonschema functools32 07:15:01 INFO - Cleaning up... 07:15:01 INFO - Return code: 0 07:15:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:15: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')]} 07:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', '--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 0x7f516ae68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:15:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:15:01 INFO - Using env: {'DISPLAY': ':0', 07:15:01 INFO - 'HOME': '/home/cltbld', 07:15:01 INFO - 'LANG': 'en_US.UTF-8', 07:15:01 INFO - 'LANGUAGE': 'en_US:en', 07:15:01 INFO - 'LOGNAME': 'cltbld', 07:15:01 INFO - 'MAIL': '/var/mail/cltbld', 07:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:01 INFO - 'MOZ_NO_REMOTE': '1', 07:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:01 INFO - 'NO_EM_RESTART': '1', 07:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:15:01 INFO - 'SHELL': '/bin/bash', 07:15:01 INFO - 'SHLVL': '1', 07:15:01 INFO - 'TERM': 'linux', 07:15:01 INFO - 'TMOUT': '86400', 07:15:01 INFO - 'USER': 'cltbld', 07:15:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:01 INFO - '_': '/tools/buildbot/bin/python'} 07:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:01 INFO - Downloading/unpacking flake8 07:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:15:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:15:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:15:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:03 INFO - no previously-included directories found matching 'docs/_build' 07:15:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:03 INFO - Running setup.py install for pep8 07:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:03 INFO - no previously-included directories found matching 'docs/_build' 07:15:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:15:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:04 INFO - Cleaning up... 07:15:04 INFO - Return code: 0 07:15:04 INFO - Running post-action listener: _resource_record_post_action 07:15:04 INFO - Running post-action listener: _start_resource_monitoring 07:15:04 INFO - Starting resource monitoring. 07:15:04 INFO - ##### 07:15:04 INFO - ##### Running install step. 07:15:04 INFO - ##### 07:15:04 INFO - Running pre-action listener: _resource_record_pre_action 07:15:04 INFO - Running main action method: install 07:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:15:04 INFO - Reading from file tmpfile_stdout 07:15:04 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:15:04 INFO - Reading from file tmpfile_stdout 07:15:04 INFO - Output received: 07:15:04 INFO - Usage: mozinstall [options] installer 07:15:04 INFO - Options: 07:15:04 INFO - -h, --help show this help message and exit 07:15:04 INFO - -d DEST, --destination=DEST 07:15:04 INFO - Directory to install application into. [default: 07:15:04 INFO - "/builds/slave/test-pgo"] 07:15:04 INFO - --app=APP Application being installed. [default: firefox] 07:15:04 INFO - mkdir: /builds/slave/test-pgo/build/application 07:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:15:20 INFO - Reading from file tmpfile_stdout 07:15:20 INFO - Output received: 07:15:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:15:20 INFO - Running post-action listener: _resource_record_post_action 07:15:20 INFO - ##### 07:15:20 INFO - ##### Running run-tests step. 07:15:20 INFO - ##### 07:15:20 INFO - Running pre-action listener: _resource_record_pre_action 07:15:20 INFO - Running main action method: run_tests 07:15:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:15:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:15:20 INFO - Python 2.7.3 07:15:20 INFO - Return code: 0 07:15:20 INFO - grabbing minidump binary from tooltool 07:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:20 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 0x1276840>, '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 0x11e36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:15:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:15:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:15:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:20 INFO - Return code: 0 07:15:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:15:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:15:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:15:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:15:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:15:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:15:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:15:21 INFO - Return code: 0 07:15:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:15:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:15:21 INFO - Using env: {'DISPLAY': ':0', 07:15:21 INFO - 'HOME': '/home/cltbld', 07:15:21 INFO - 'LANG': 'en_US.UTF-8', 07:15:21 INFO - 'LANGUAGE': 'en_US:en', 07:15:21 INFO - 'LOGNAME': 'cltbld', 07:15:21 INFO - 'MAIL': '/var/mail/cltbld', 07:15:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:15:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:21 INFO - 'MOZ_NO_REMOTE': '1', 07:15:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:21 INFO - 'NO_EM_RESTART': '1', 07:15:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:15:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:15:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:15:21 INFO - 'SHELL': '/bin/bash', 07:15:21 INFO - 'SHLVL': '1', 07:15:21 INFO - 'TERM': 'linux', 07:15:21 INFO - 'TMOUT': '86400', 07:15:21 INFO - 'USER': 'cltbld', 07:15:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841', 07:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:21 INFO - '_': '/tools/buildbot/bin/python'} 07:15:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:15:21 INFO - mozversion application_buildid: 20160112043006 07:15:21 INFO - mozversion application_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 07:15:21 INFO - mozversion application_display_name: Nightly 07:15:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:21 INFO - mozversion application_name: Firefox 07:15:21 INFO - mozversion application_remotingname: firefox 07:15:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:21 INFO - mozversion application_vendor: Mozilla 07:15:21 INFO - mozversion application_version: 46.0a1 07:15:21 INFO - mozversion platform_buildid: 20160112043006 07:15:21 INFO - mozversion platform_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 07:15:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:21 INFO - mozversion platform_version: 46.0a1 07:15:21 INFO - using testdate: 1452611721 07:15:21 INFO - actual date: 1452611721 07:15:21 INFO - starting webserver on 'localhost:58043' 07:15:21 INFO - SUITE-START | Running 3 tests 07:15:21 INFO - TEST-START | dromaeo_css 07:15:21 INFO - operating with platform_type : linux_ 07:15:21 INFO - Initialising browser for dromaeo_css test... 07:15:21 INFO - TEST-INFO | started process 9869 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA1UVGr/profile http://localhost:58043/getInfo.html) 07:15:25 INFO - PROCESS | 9869 | __metrics Screen width/height:1600/1200 07:15:25 INFO - PROCESS | 9869 | colorDepth:24 07:15:25 INFO - PROCESS | 9869 | Browser inner width/height: 1024/697 07:15:25 INFO - PROCESS | 9869 | __metrics 07:15:25 INFO - PROCESS | 9869 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:15:25 INFO - PROCESS | 9869 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:15:26 INFO - TEST-INFO | 9869: exit 0 07:15:26 INFO - Browser initialized. 07:15:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:26 INFO - TEST-INFO | started process 9969 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA1UVGr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:38 INFO - PROCESS | 9969 | RSS: Main: 148156416 07:15:38 INFO - PROCESS | 9969 | 07:16:29 INFO - PROCESS | 9969 | 1452611789539 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:18:37 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58043/tests/dromaeo/cssquery-ext.html) 07:18:38 INFO - PROCESS | 9969 | RSS: Main: 243453952 07:18:38 INFO - PROCESS | 9969 | 07:21:40 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-ext.html (next: http://localhost:58043/tests/dromaeo/cssquery-jquery.html) 07:21:41 INFO - PROCESS | 9969 | RSS: Main: 231948288 07:21:41 INFO - PROCESS | 9969 | 07:24:43 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58043/tests/dromaeo/cssquery-mootools.html) 07:24:44 INFO - PROCESS | 9969 | RSS: Main: 229924864 07:24:44 INFO - PROCESS | 9969 | 07:27:46 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58043/tests/dromaeo/cssquery-prototype.html) 07:27:46 INFO - PROCESS | 9969 | RSS: Main: 206450688 07:27:46 INFO - PROCESS | 9969 | 07:30:49 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58043/tests/dromaeo/cssquery-yui.html) 07:30:49 INFO - PROCESS | 9969 | RSS: Main: 215269376 07:30:49 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:58043/tests/dromaeo/cssquery-yui.html (next: http://localhost:58043/tests/dromaeo/cssquery-dojo.html) 07:33:52 INFO - PROCESS | 9969 | RSS: Main: 280870912 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | __start_tp_report 07:33:52 INFO - PROCESS | 9969 | _x_x_mozilla_page_load 07:33:52 INFO - PROCESS | 9969 | _x_x_mozilla_page_load_details 07:33:52 INFO - PROCESS | 9969 | |i|pagename|runs| 07:33:52 INFO - PROCESS | 9969 | |0;dojo.html;3055.70970757778;3065.3869226154775;3103.3793241351723;3106.875724971001;3125.640551336596;4873.098476781798;4945.455999840015;5007.273945277932;5010.849674509766;5021.271915572244;4998.625103117262;5043.798248070082;5064.366954130734;5119.411267704215;5134.204198349253;4398.428204333432;4505.684602077856;4580.358749775034;4633.884152896171;4698.718076915379;4535.229011068126;4624.953750462503;4641.210994130989;4690.9296360554445;4766.046790641885;4624.606908412789;4627.444706635209;4632.3514707941085;4636;4675.83104223944;4626.028534007863;4627.282771170474;4640.744759038252;4640.907181856378;4676.134915040694;4527.61515271199;4572.428446444194;4593.379893714339;4625.930611040837;4639.605633521155;4953.6037117030555;4969.925451118236;4974.204127339608;4985.401751789808;4990.82532111378;5434.538064264542;5457.672539647634;5458.754356053987;5465.890682186334;5492.533134683516;5254.947450525484;5379.112446446371;5455.8363249102595;5492.615516913817;5499.175123731432;5117.2068329409;5124.769385377593;5127.871803204913;5141;5152.6650767699975;5549.833504994856;5567.888642227133;5577;5581.246531718166;5589.189567512769;5222.112240919053;5309.522143007071;5309.7079660618265;5311.681299122065;5371.489708477767;5421.430749771296;5441.238226648273;5442.700651464207;5446.400895901447;5460.5085542300585;5382.842688821922;5405.8107966221;5425.647332923348;5432.185172224119;5475.753591088411;5197.532222100029;5251;5301.946980530222;5350.411454739976;5447.863803404946;4227.915441691149;4244.214820258262;4256.425382573375;4262.254105531581;4301.978490107529;3808.9428658570146;3825.1202223488754;3825.445310430028;3831.693464522887;3867.1298957734284;4939.728314942641;5014.974925125424;5020.422651395136;5027.145385284511;5075.543201111917;5374;5381.865453363619;5393.406725260218;5396.62223644349;5420.07858664028;4952.925706114411;5050.974745126251;5051.494850514992;5061.569766569883;5075.746212689351;4611.262198048296;4613.284940834176;4617.238155704338;4635.930461043087;4668;5625.71871406428;5648.293963254593;5650.915236271459;5653.23681303027;5695.231143795618;5248.448912864094;5315.521603055744;5365.275687782256;5424.213489044146;5430.02259593277;5576.804811831566;5599.356074051373;5617.578681598815;5640.294963129609;5670.886582268414;5321.467853214647;5323.281357016908;5326.547243484192;5331.173668081454;5335.839924802262;5336.2529245904825;5357.357117145967;5409.053415652166;5412.242286079873;5475.342958844964;5263.789448422173;5265.4997775211295;5268.025415298182;5275.630705850554;5294.7352632369;5256.947430525645;5261.710605916712;5268.631195816256;5269.314989051399;5304.363476382859;5160.200168973815;5191.8182863599595;5197.558207552401;5210.036143313499;5287.550558202596;5277.129273669955;5299.41706412302;5312.362516498045;5314.016906872241;5347.1979203119845;5203.609729270244;5226.137687281556;5247.16045432729;5248.553872920845;5249.816256431007 07:33:52 INFO - PROCESS | 9969 | |1;ext.html;513.8792383789809;515.9613029022825;528.9312389389379;531.8565085067105;536.5224949794683;27368.58947115795;27813.582796258048;35514.46728299077;35532.46701299483;35672;37117.07207319811;37456;37519.437208441894;37529;37625.247495050084;8353.705175697745;8462.957685211566;8554.828903421927;8562.657493700244;8570.700025499109;8304.128066553016;8339.874901876477;8446.83106337873;8470.110638382974;8473;8420.49477031377;8510.148985101472;8684.653878648787;8691.782705432352;8706.0858609846;8599.312055035582;8687.956560217222;8688.695895643654;8688.695895643685;8691.087435819274;8458.915410845875;8501.914980850173;8599.355048371397;8609.440386374865;8631.827363452758;38179.236415271815;38457.42313865294;38789.41815872764;38809.417858732144;38860.611393885985;2955.349823038928;3292.2098696312714;3389.8983030508875;3416.641252668459;3607.062163837395;26053.348666283306;26290.07984720545;26668.866655666596;28271;29127.70872291271;3884.184321292532;3930.4693866327966;3959.425883246942;3966.6628336591134;4079.469668943048;267272;270815;270982;271496;271878;52322.476775231764;52997;57997;59650.70174649186;60508.69745651243;52434.737826311386;52571.737141314814;52622.736886315324;52693;52753.736231318595;14601.78097328541;14646.414143434356;14669.92665036668;14868.479603214051;14884.776728349083;10680.732981675521;10721.410322432184;10747.247692661595;10748;10779.353238805697;19143.4691635979;19473.673721551324;19560.413187604394;19576.510587235432;19630.607387852164;7757.456978011485;7879.606019698992;7893.368530517545;7996.760097197093;8038.598070096472;970.4419958523877;981.5975450065439;993.2897977945803;998.121652945418;1087.1628845788698;27308.180754577395;27641.723582764316;27648.447031059266;27686;27780.58329125065;1028.7890982348601;1063.7340664833791;1075.44077079918;1107.0755918807886;1107.5182295701395;14319.284035798168;14358.138511689333;14480.565583032527;14600.707985840223;14623.415063397344;294634;299063;299718;299747;300630;48221.517784821706;48956.26565601519;48990.26514602284;49029.754851225516;49046.60487346389;1276.897848172144;1291.7868551688866;1297.9935100324437;1307.9149855259377;1311;26382.868085659447;27292.454150916474;27450;27473.725262747117;27540;43961.78019110012;44524.55475445204;44564.77717611391;44568.10863782771;44650.77674611606;263589;266998;267892;267894;268817;27460.862695687192;30497.23756906095;30674;31040.22399440032;31066.68933310638;35399.82300088483;35851;36430.8178459106;36757.816210918776;36781.816090919376;29853.253668658457;31889;38212.42681359837;38914.80542597269;39662;30382.848085760314;32641.673583263862;33158.66841331556;34130.317393651494;40274.59725402708;32950.67049329476;34187.65812341845;34708.82645586756;34904.47643285302;35169.64830351664;30889.536656949713;32160.678393215767;34531.65468345284;35720.464193037646;35766;23751.762482374954;24397.512049758552;24501.509969800147;24510.264692059267;24633 07:33:52 INFO - PROCESS | 9969 | |2;jquery.html;351.337728382;356.0493482401988;365.6087985855135;367.6158414456893;367.89882782234866;13397.129186602864;13660.180389176656;15970.920145399272;16348.100854453016;17401.390951316705;14388.712225755506;14617.780733288982;14767.409303627868;15506.689866202698;15582.844171558281;5136.974315128428;5338.679679219259;5345.4120046795015;5347.7058761768085;5414.729263536827;3475.0617333319988;3506.544149260605;5286.7885284588765;5341.65279256849;5652.463016013472;5760.4815566599;5807.274090738658;5821.738021789009;5824.708764561776;5826.067829147337;4991.650584459089;5139.254808052811;5145.922811157836;5170.353705786777;5172.663776854492;4790.209615413452;4939.259111133323;4956.479569645171;4962.578180854632;4968.527989840995;18169;18345.26618935241;18496.352627658103;19210.711839322423;19243.23027078915;1994.58113796103;2031.339814560274;2035.735354403933;2040.6122836660986;2088.9164433422643;9477.90522094777;10645.57417703291;11666.008389286835;12184.81722774159;12775.23348599087;1808.1772793378982;1813.7460755494242;1878.158449723453;1923.144200830631;1971.871828331154;53351.733241333546;53444.19833702497;53911.19133212966;54418.72790636061;54887.72556137234;9584.089511496397;9753.658621948198;9945.104940555384;9986.97826065338;10102.292839501164;12848.293343866177;13050.282234477196;13072;13075.934620326838;13087.803682944763;7298.635068246566;7356.080489938758;7361.190269070398;7394.149672787591;7471.51435156724;7005.859882802315;7024.5082844200415;7080.893786593205;7090.290970902868;7185.6766445510075;4328.610425061696;4340.175366680383;4385.868423947287;4391.3193455014525;4435.223835828717;1682.125294846673;1691.7969843618844;1701.4555342290348;1745.3106023120797;1757.841794238499;847.3517758914436;858.1590041759112;871.9493010921824;897.2373482539789;912.4388501071793;13209.669758256121;14855.182964937032;14932.402703891723;15465.149416782186;15839.841601584067;869.5347988825948;875.444093000949;894.6913314906477;906.4528674424887;919.1451949686856;9199.402038867453;9311.115444032806;9359.298052645943;9460.95269523648;9538.904610953801;519515;539256;547196;550058;550675;67007.66496167488;67422.32577674258;67692.661536692;69319;71035.64482177555;1048.3919326790597;1057.7567159553346;1070.9143268538498;1072.0780129088978;1076.9676909692564;14149.43402263898;14326.57020289393;14420.927895360875;14707.705845882809;14741.11553306805;31772.364552708354;32341.51487727639;32590.34819303648;32630;32672.83663581762;41315.215869778855;41416.1716765657;41787.7910610445;41897.162056759305;42233.788831055645;7106.147262328554;7319.4144468443465;7417.777466676009;7431.516951398142;7448.5158464699625;9329.626814927598;10958.178136639624;11321.320720756781;11323.943380283046;11498.597549085742;9420.434773913586;9530.904690953003;9575.712728618153;9689.079537444213;9692.41845489273;9148.63405463774;9602.231821454126;9687.17658998993;9984;10182.338148020652;7599.848003040019;9494.098060684224;9553.18797902186;10038.799224015625;10080.395176289447;7411.444141689287;7536.171021187774;7586.24137586237;7621.618919054136;7634.8091297718;8421.536815475207;9014.729558113268;9057.909420905706;9061.728148155566;9116.772080698036 07:33:52 INFO - PROCESS | 9969 | |3;mootools.html;1308.5877948446246;1437.6837095838914;1448.7102579484103;1573.7009968106058;1744.1889521372552;6812.965935170323;7428.739994100208;7578.052743407081;7587.84824303515;7589.544627322364;7282.526635768671;7450.888236676454;7451.813704657387;7454.888176677354;7465.738699145531;1990.4625751047208;2023.7773844877051;2219.4340443186966;2236.317923033474;2260.9434764130865;2284.23478134825;2287.897044632987;2288.9198878039274;2290.7823756743082;2292.060255295329;2124.968125478119;2194.7476040255415;2196.1105752170397;2197.703310053146;2201.6477363621825;1982.9008549572536;2042.9693554596693;2240.327901629513;2304.2511183865313;2305.216226482987;2276.5105502317083;2287.3023727763025;2335.4161459635093;2366.7633236676365;2371.7983971362455;7369.299916507923;7433.145188303361;7491.213422590604;7491.925080749232;7502.2122677119205;4622.6070783983405;4722.220833562458;4765.523447655207;4768.904621907577;4770.713757174581;2901.840398778066;3020.2902317955263;3035.4080954213937;3065;3082.2756652186717;1001.944893030883;1011.3072545306488;1043.248860820216;1054.931429457083;1065.8134826405349;10212.693619191436;10392.116670083127;10401.323913945569;10420.84368734462;10432.739181520523;4127.174565086994;4360.7819609019425;4369.148016136823;4383.802728877208;4434.246178149658;8973.641054357882;8984.550772461482;9043.909560904438;9130.589123489326;9143.817123657489;4812.422509298906;4862.051899879561;4874.4150701916;4877.3903262092235;4891.779869905863;4391.341298805205;4412.867613971522;4419.602235798793;4424.446944131983;4431.711938723973;3475.6176820549717;3484.3553942520716;3492.161881148506;3512.2624248908014;3589.9102522436624;1154.6593754842343;1173.6244401791516;1178.4284621958343;1188.708766352232;1199.736058067224;888.3093198943105;965.3821554205314;992.6029588164791;1004.8542961270575;1056.2922841696081;6787.6266805325195;6868.656567171622;6934.098567186335;6960.825979350557;6969.05917701114;591.8254115036075;603.6709993053796;608.592243197059;610.9776639323852;753.0511555440185;5186.092433824066;5205.7397130143345;5213.661112027706;5219.686818790885;5264.0261551613075;8503.23470887623;8677;8689.522076285739;8817.867731984026;8956.104389560991;8556.614952327036;8696.695615653549;8700.52147131901;8701.086385929513;8712.651493940299;6878;6888.242293347727;6965.432777624994;6984.371406573433;7000.544964577286;6777.966110169417;6825.69284382194;6858.622775747382;6872.312768723088;6883.965580172067;7882.330001949669;7986;8078.919210807817;8117.188281171835;8264.917350826414;8142.389320800845;8352.33181345503;8455.32357411418;8489.533075680896;8531.957340213508;6788.93211067883;6818.897716534157;6859.108315918898;6889.758858439931;6894.620795856075;7205.495615306878;7221.963890180516;7235.457340699574;7240.312170343809;7257.745978890714;6710;6937.583744975318;7035.648217589202;7051.858962820817;7115.359617634438;6844.5208835381045;6864.519483636098;6877.071595334566;6888.793336199922;6934.8613027740175;6294.937050629435;6489.415952564292;6655.434288085373;6915.619640919596;7004;6066.696665166635;6102.359252278625;6123.938760612336;6148.231471066117;6152.846178845564;6126.448619624255;6163.845903852261;6177;6177.351378105414;6203.8138855834395 07:33:52 INFO - PROCESS | 9969 | |4;prototype.html;323.6375259709126;328.58762253372015;330.3607519449865;332.4398388715017;334.80581262867537;5934.139549765281;5934.5845790794665;5965.671888046156;5986.940130598693;6042.184305118808;5611.438856114387;5741.224934633834;5855.590108692393;5901.911471327933;5972.25346831646;4523.864284071483;4550.635949124062;4551.998560316725;4552.339910712944;4570.702904311226;4353.956460435403;4530.048689775152;4541.296099104644;4555.04344087742;4555.817767289321;4367.978160109195;4403.832984259174;4445.466544014723;4467.888302792424;4482.215612267856;4467.553244675522;4483.7758112094425;4509.616682581985;4519.07358991406;4534.251848445003;3971.8808435746973;3982.780947047911;3983.203359328146;3987.521497420328;3994.820233089518;5608.663480191201;5699;5710.2862142232225;5713.914291285634;5724.284464441945;5293.7353132343615;5296.25852380667;5296.973515132399;5299.364076310867;5309.070912590281;6277.372262773732;6281.340459251758;6285.025820997707;6288.245410550763;6297.244330680302;4413.337999300131;4423.867283981485;4424.093060922503;4427.00392411708;4431.069475410168;6427.132337134473;6577.934220657828;6581.605103693842;6595.274519802818;6613.437857782094;4484.663650226246;4497.370368148462;4510.436195475566;4514.435695538058;4534.59188673021;4567.657425693086;4584.564466375689;4586;4586.908261834745;4591.219492686251;5274.657147285414;5275.841724748264;5276.973615131899;5279;5295.947040529622;6107.083937409424;6221.968890155611;6277.717502712298;6293.527985401113;6359.841003974938;1553.122485795522;1554.0364973716369;1557.727397705397;1558.828528861847;1558.9922050389675;1020.1787561013307;1036.18659352408;1037.4657051618422;1053.7049626104704;1055.8046761349176;5990.281166260077;5996.700164991733;6002.579819412686;6003.789867354709;6057.182280392179;6522.119513865662;6531.379518945692;6543.901841472381;6545.312742162099;6566.770163044366;5854.356020837705;5935.910961335583;6039.245094363205;6062.939370606237;6066.090086486974;3501.142220156078;3539.8584056637446;3552.3605750965075;3560.359135355661;3560.768550044239;6855.520113592101;6864.759733409307;6879.2432832388395;6883.518153729191;6885.380315771505;6556.213254409501;6703.430208432241;6712.160979877418;6714.959181326903;6715.731370745213;6853.348931851466;6861.656917154122;6862.107925969592;6863.656817159222;6870.381665650116;6508.219013718384;6545.050967609765;6562.179727534059;6565.507586930904;6570.080188773671;6321.49428045746;6490.480761538971;6497.155369801895;6497.837554061186;6507.544471886922;6814.1482314710665;6859.039734437282;6867.965660171667;6871.969204619347;6888.621125837926;4476.768888555674;4485.237509623437;4486.573775491323;4486.932696009628;4492.124035812985;6423.807285781434;6569.770058047945;6585.078089067439;6590.472762178918;6590.5716128451495;6416.877046516935;6422.779671862331;6426.582272152295;6429.32492088324;6440.710168042543;6325.652089134957;6399.232092148972;6400.679966001589;6411.871762564816;6416.582922110048;6162.845928851635;6276.874462510633;6279.434850863444;6288.27684816252;6289.9371006291185;6422.100905873088;6425.45383642377;6441.742330306735;6444.226692796894;6445.1943507061615;6276.560640755103;6279.183706118175;6282.057691346335;6289.150964619717;6305.873882522415 07:33:52 INFO - PROCESS | 9969 | |5;yui.html;745.8843879198724;833.4415941319315;833.7128938352773;845.8688903220003;865.0311650950936;12275.693107672301;12409.813852792204;12421.068419868501;12439.564615238469;12443;12574.245545267291;12578.371081445937;12601.747965040693;12606.68483287916;12631.621051368451;645.3288579876922;651.7067319706127;751.9924800751991;755.7090520149754;770.8882212079245;776.2276534847806;779.380392587894;782.5226611766818;783.5181363461459;783.7374479549358;809.0493669937829;809.3039985612398;809.7530253272749;809.8501777171242;809.8704207326829;663.5222639699409;672.707372293054;799.9840003199903;814.5235037503068;815.8490679224303;596.4989408896504;597.6175247841385;597.8116893178635;600.1747597054051;606.6451126091198;12861.099723019392;12898.419571119322;12902.032347573875;13021.56762756096;13027.934860325733;11907.28556286617;12317.076219283499;12356.135070545066;12370.876291237153;12484.81272780909;9893.258005649604;10009.69970900874;10019.8497022544;10122.848157277647;10329.535170917326;3589.9820500897326;3617.8914632561064;3621.4386770050683;3623.6738693517445;3753.230587729509;44592;44875;45020.09959800786;45199;45261.77369113133;9901.15840153595;9920.282552953655;10013.949930250448;10016.64941727036;10132.189424845994;17958.371456998942;18050.548736281697;18105.275788968294;18162.545936351697;18224.726629100573;7319.085114360705;7323.597202153826;7400.888986665204;7568.5837278950185;7658.65536050879;4280.250956082673;4320.740755554677;4354.346847972829;4359.084592235666;4407.933880991788;2998.160515055788;3071.6928307169105;3072.969270307313;3076.64618568863;3078.815271083742;541.8564080518665;548.235211879426;548.7942021741846;549.3846891481567;560.1122221279237;653.2194028136331;677.8745932002595;684.1174884399169;687.8280429892527;699.4194818300798;7853.960730196312;8303.543305118277;8399.244068033906;8447.915520844714;8466.238038576557;507.96444248902964;650.890232154176;676.4385559985201;681.4684546054086;685.4550632247276;4009.258287216874;4095.5494895561465;4212.347086201644;4284.8500302489265;4325.697201195886;51721.7413912928;52969;53246.467535324926;53252;53474;48064.519354806005;48093.8357773901;48633;48893;49134.26298605524;41448.792756036026;41535.7923210382;41939.951501212105;42196;42227.57772422236;8085.636146373545;8272.420930534805;8280;8307.169283071644;8431.873521897054;31835.68164318327;32778.83610581932;32977.34045319032;33173.50239746358;33192.33615327728;38748.41877371898;40518.59481405148;41442.37836432396;42163.78918105512;42252.57747422486;10254.384736915808;10648.414337211529;10672.62645807424;10896.782064358827;11086.501107450023;12298.938505307417;12794.424250908545;12858.228506289652;13018.544350947672;13375.26436045988;11238.50133436702;11665.183437159318;11820.23168494045;11939.701507462383;12073.57742479009;11573.537058517564;11737.941310293736;11786.823197651871;12415.255084694947;12445.066620003356;10970.670879873616;11100.944495277472;11587.88412115868;11767.941160294144;12046;9408.623655053721;9932.659091022619;9989.700308990741;10158;10202.591896324064;8700;9022;9029;9655.613775449185;10016.699499015042 07:33:52 INFO - PROCESS | 9969 | __end_tp_report 07:33:52 INFO - PROCESS | 9969 | __start_cc_report 07:33:52 INFO - PROCESS | 9969 | _x_x_mozilla_cycle_collect,795 07:33:52 INFO - PROCESS | 9969 | __end_cc_report 07:33:52 INFO - PROCESS | 9969 | __startTimestamp1452612832538__endTimestamp 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | ------- Summary: start ------- 07:33:52 INFO - PROCESS | 9969 | Number of tests: 6 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#0] dojo.html Cycles:165 Average:5032.99 Median:5226.14 stddev:537.33 (10.3%) stddev-sans-first:516.10 07:33:52 INFO - PROCESS | 9969 | Values: 3055.7 3065.4 3103.4 3106.9 3125.6 4873.1 4945.5 5007.3 5010.8 5021.3 4998.6 5043.8 5064.4 5119.4 5134.2 4398.4 4505.7 4580.4 4633.9 4698.7 4535.2 4625.0 4641.2 4690.9 4766.0 4624.6 4627.4 4632.4 4636.0 4675.8 4626.0 4627.3 4640.7 4640.9 4676.1 4527.6 4572.4 4593.4 4625.9 4639.6 4953.6 4969.9 4974.2 4985.4 4990.8 5434.5 5457.7 5458.8 5465.9 5492.5 5254.9 5379.1 5455.8 5492.6 5499.2 5117.2 5124.8 5127.9 5141.0 5152.7 5549.8 5567.9 5577.0 5581.2 5589.2 5222.1 5309.5 5309.7 5311.7 5371.5 5421.4 5441.2 5442.7 5446.4 5460.5 5382.8 5405.8 5425.6 5432.2 5475.8 5197.5 5251.0 5301.9 5350.4 5447.9 4227.9 4244.2 4256.4 4262.3 4302.0 3808.9 3825.1 3825.4 3831.7 3867.1 4939.7 5015.0 5020.4 5027.1 5075.5 5374.0 5381.9 5393.4 5396.6 5420.1 4952.9 5051.0 5051.5 5061.6 5075.7 4611.3 4613.3 4617.2 4635.9 4668.0 5625.7 5648.3 5650.9 5653.2 5695.2 5248.4 5315.5 5365.3 5424.2 5430.0 5576.8 5599.4 5617.6 5640.3 5670.9 5321.5 5323.3 5326.5 5331.2 5335.8 5336.3 5357.4 5409.1 5412.2 5475.3 5263.8 5265.5 5268.0 5275.6 5294.7 5256.9 5261.7 5268.6 5269.3 5304.4 5160.2 5191.8 5197.6 5210.0 5287.6 5277.1 5299.4 5312.4 5314.0 5347.2 5203.6 5226.1 5247.2 5248.6 5249.8 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#1] ext.html Cycles:180 Average:43875.62 Median:35284.74 stddev:72850.42 (206.5%) stddev-sans-first:72982.03 07:33:52 INFO - PROCESS | 9969 | Values: 513.9 516.0 528.9 531.9 536.5 27368.6 27813.6 35514.5 35532.5 35672.0 37117.1 37456.0 37519.4 37529.0 37625.2 8353.7 8463.0 8554.8 8562.7 8570.7 8304.1 8339.9 8446.8 8470.1 8473.0 8420.5 8510.1 8684.7 8691.8 8706.1 8599.3 8688.0 8688.7 8688.7 8691.1 8458.9 8501.9 8599.4 8609.4 8631.8 38179.2 38457.4 38789.4 38809.4 38860.6 2955.3 3292.2 3389.9 3416.6 3607.1 26053.3 26290.1 26668.9 28271.0 29127.7 3884.2 3930.5 3959.4 3966.7 4079.5 267272.0 270815.0 270982.0 271496.0 271878.0 52322.5 52997.0 57997.0 59650.7 60508.7 52434.7 52571.7 52622.7 52693.0 52753.7 14601.8 14646.4 14669.9 14868.5 14884.8 10680.7 10721.4 10747.2 10748.0 10779.4 19143.5 19473.7 19560.4 19576.5 19630.6 7757.5 7879.6 7893.4 7996.8 8038.6 970.4 981.6 993.3 998.1 1087.2 27308.2 27641.7 27648.4 27686.0 27780.6 1028.8 1063.7 1075.4 1107.1 1107.5 14319.3 14358.1 14480.6 14600.7 14623.4 294634.0 299063.0 299718.0 299747.0 300630.0 48221.5 48956.3 48990.3 49029.8 49046.6 1276.9 1291.8 1298.0 1307.9 1311.0 26382.9 27292.5 27450.0 27473.7 27540.0 43961.8 44524.6 44564.8 44568.1 44650.8 263589.0 266998.0 267892.0 267894.0 268817.0 27460.9 30497.2 30674.0 31040.2 31066.7 35399.8 35851.0 36430.8 36757.8 36781.8 29853.3 31889.0 38212.4 38914.8 39662.0 30382.8 32641.7 33158.7 34130.3 40274.6 32950.7 34187.7 34708.8 34904.5 35169.6 30889.5 32160.7 34531.7 35720.5 35766.0 23751.8 24397.5 24501.5 24510.3 24633.0 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#2] jquery.html Cycles:180 Average:27133.61 Median:5138.11 stddev:88385.26 (1720.2%) stddev-sans-first:88610.32 07:33:52 INFO - PROCESS | 9969 | Values: 351.3 356.0 365.6 367.6 367.9 13397.1 13660.2 15970.9 16348.1 17401.4 14388.7 14617.8 14767.4 15506.7 15582.8 5137.0 5338.7 5345.4 5347.7 5414.7 3475.1 3506.5 5286.8 5341.7 5652.5 5760.5 5807.3 5821.7 5824.7 5826.1 4991.7 5139.3 5145.9 5170.4 5172.7 4790.2 4939.3 4956.5 4962.6 4968.5 18169.0 18345.3 18496.4 19210.7 19243.2 1994.6 2031.3 2035.7 2040.6 2088.9 9477.9 10645.6 11666.0 12184.8 12775.2 1808.2 1813.7 1878.2 1923.1 1971.9 53351.7 53444.2 53911.2 54418.7 54887.7 9584.1 9753.7 9945.1 9987.0 10102.3 12848.3 13050.3 13072.0 13075.9 13087.8 7298.6 7356.1 7361.2 7394.1 7471.5 7005.9 7024.5 7080.9 7090.3 7185.7 4328.6 4340.2 4385.9 4391.3 4435.2 1682.1 1691.8 1701.5 1745.3 1757.8 847.4 858.2 871.9 897.2 912.4 13209.7 14855.2 14932.4 15465.1 15839.8 869.5 875.4 894.7 906.5 919.1 9199.4 9311.1 9359.3 9461.0 9538.9 519515.0 539256.0 547196.0 550058.0 550675.0 67007.7 67422.3 67692.7 69319.0 71035.6 1048.4 1057.8 1070.9 1072.1 1077.0 14149.4 14326.6 14420.9 14707.7 14741.1 31772.4 32341.5 32590.3 32630.0 32672.8 41315.2 41416.2 41787.8 41897.2 42233.8 7106.1 7319.4 7417.8 7431.5 7448.5 9329.6 10958.2 11321.3 11323.9 11498.6 9420.4 9530.9 9575.7 9689.1 9692.4 9148.6 9602.2 9687.2 9984.0 10182.3 7599.8 9494.1 9553.2 10038.8 10080.4 7411.4 7536.2 7586.2 7621.6 7634.8 8421.5 9014.7 9057.9 9061.7 9116.8 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#3] mootools.html Cycles:180 Average:5269.47 Median:6150.54 stddev:2717.84 (44.2%) stddev-sans-first:2709.16 07:33:52 INFO - PROCESS | 9969 | Values: 1308.6 1437.7 1448.7 1573.7 1744.2 6813.0 7428.7 7578.1 7587.8 7589.5 7282.5 7450.9 7451.8 7454.9 7465.7 1990.5 2023.8 2219.4 2236.3 2260.9 2284.2 2287.9 2288.9 2290.8 2292.1 2125.0 2194.7 2196.1 2197.7 2201.6 1982.9 2043.0 2240.3 2304.3 2305.2 2276.5 2287.3 2335.4 2366.8 2371.8 7369.3 7433.1 7491.2 7491.9 7502.2 4622.6 4722.2 4765.5 4768.9 4770.7 2901.8 3020.3 3035.4 3065.0 3082.3 1001.9 1011.3 1043.2 1054.9 1065.8 10212.7 10392.1 10401.3 10420.8 10432.7 4127.2 4360.8 4369.1 4383.8 4434.2 8973.6 8984.6 9043.9 9130.6 9143.8 4812.4 4862.1 4874.4 4877.4 4891.8 4391.3 4412.9 4419.6 4424.4 4431.7 3475.6 3484.4 3492.2 3512.3 3589.9 1154.7 1173.6 1178.4 1188.7 1199.7 888.3 965.4 992.6 1004.9 1056.3 6787.6 6868.7 6934.1 6960.8 6969.1 591.8 603.7 608.6 611.0 753.1 5186.1 5205.7 5213.7 5219.7 5264.0 8503.2 8677.0 8689.5 8817.9 8956.1 8556.6 8696.7 8700.5 8701.1 8712.7 6878.0 6888.2 6965.4 6984.4 7000.5 6778.0 6825.7 6858.6 6872.3 6884.0 7882.3 7986.0 8078.9 8117.2 8264.9 8142.4 8352.3 8455.3 8489.5 8532.0 6788.9 6818.9 6859.1 6889.8 6894.6 7205.5 7222.0 7235.5 7240.3 7257.7 6710.0 6937.6 7035.6 7051.9 7115.4 6844.5 6864.5 6877.1 6888.8 6934.9 6294.9 6489.4 6655.4 6915.6 7004.0 6066.7 6102.4 6123.9 6148.2 6152.8 6126.4 6163.8 6177.0 6177.4 6203.8 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#4] prototype.html Cycles:180 Average:5299.75 Median:5988.61 stddev:1612.95 (26.9%) stddev-sans-first:1573.64 07:33:52 INFO - PROCESS | 9969 | Values: 323.6 328.6 330.4 332.4 334.8 5934.1 5934.6 5965.7 5986.9 6042.2 5611.4 5741.2 5855.6 5901.9 5972.3 4523.9 4550.6 4552.0 4552.3 4570.7 4354.0 4530.0 4541.3 4555.0 4555.8 4368.0 4403.8 4445.5 4467.9 4482.2 4467.6 4483.8 4509.6 4519.1 4534.3 3971.9 3982.8 3983.2 3987.5 3994.8 5608.7 5699.0 5710.3 5713.9 5724.3 5293.7 5296.3 5297.0 5299.4 5309.1 6277.4 6281.3 6285.0 6288.2 6297.2 4413.3 4423.9 4424.1 4427.0 4431.1 6427.1 6577.9 6581.6 6595.3 6613.4 4484.7 4497.4 4510.4 4514.4 4534.6 4567.7 4584.6 4586.0 4586.9 4591.2 5274.7 5275.8 5277.0 5279.0 5295.9 6107.1 6222.0 6277.7 6293.5 6359.8 1553.1 1554.0 1557.7 1558.8 1559.0 1020.2 1036.2 1037.5 1053.7 1055.8 5990.3 5996.7 6002.6 6003.8 6057.2 6522.1 6531.4 6543.9 6545.3 6566.8 5854.4 5935.9 6039.2 6062.9 6066.1 3501.1 3539.9 3552.4 3560.4 3560.8 6855.5 6864.8 6879.2 6883.5 6885.4 6556.2 6703.4 6712.2 6715.0 6715.7 6853.3 6861.7 6862.1 6863.7 6870.4 6508.2 6545.1 6562.2 6565.5 6570.1 6321.5 6490.5 6497.2 6497.8 6507.5 6814.1 6859.0 6868.0 6872.0 6888.6 4476.8 4485.2 4486.6 4486.9 4492.1 6423.8 6569.8 6585.1 6590.5 6590.6 6416.9 6422.8 6426.6 6429.3 6440.7 6325.7 6399.2 6400.7 6411.9 6416.6 6162.8 6276.9 6279.4 6288.3 6289.9 6422.1 6425.5 6441.7 6444.2 6445.2 6276.6 6279.2 6282.1 6289.2 6305.9 07:33:52 INFO - PROCESS | 9969 | 07:33:52 INFO - PROCESS | 9969 | [#5] yui.html Cycles:180 Average:13172.69 Median:4323.22 stddev:14711.83 (340.3%) stddev-sans-first:14723.50 07:33:52 INFO - PROCESS | 9969 | Values: 745.9 833.4 833.7 845.9 865.0 12275.7 12409.8 12421.1 12439.6 12443.0 12574.2 12578.4 12601.7 12606.7 12631.6 645.3 651.7 752.0 755.7 770.9 776.2 779.4 782.5 783.5 783.7 809.0 809.3 809.8 809.9 809.9 663.5 672.7 800.0 814.5 815.8 596.5 597.6 597.8 600.2 606.6 12861.1 12898.4 12902.0 13021.6 13027.9 11907.3 12317.1 12356.1 12370.9 12484.8 9893.3 10009.7 10019.8 10122.8 10329.5 3590.0 3617.9 3621.4 3623.7 3753.2 44592.0 44875.0 45020.1 45199.0 45261.8 9901.2 9920.3 10013.9 10016.6 10132.2 17958.4 18050.5 18105.3 18162.5 18224.7 7319.1 7323.6 7400.9 7568.6 7658.7 4280.3 4320.7 4354.3 4359.1 4407.9 2998.2 3071.7 3073.0 3076.6 3078.8 541.9 548.2 548.8 549.4 560.1 653.2 677.9 684.1 687.8 699.4 7854.0 8303.5 8399.2 8447.9 8466.2 508.0 650.9 676.4 681.5 685.5 4009.3 4095.5 4212.3 4284.9 4325.7 51721.7 52969.0 53246.5 53252.0 53474.0 48064.5 48093.8 48633.0 48893.0 49134.3 41448.8 41535.8 41940.0 42196.0 42227.6 8085.6 8272.4 8280.0 8307.2 8431.9 31835.7 32778.8 32977.3 33173.5 33192.3 38748.4 40518.6 41442.4 42163.8 42252.6 10254.4 10648.4 10672.6 10896.8 11086.5 12298.9 12794.4 12858.2 13018.5 13375.3 11238.5 11665.2 11820.2 11939.7 12073.6 11573.5 11737.9 11786.8 12415.3 12445.1 10970.7 11100.9 11587.9 11767.9 12046.0 9408.6 9932.7 9989.7 10158.0 10202.6 8700.0 9022.0 9029.0 9655.6 10016.7 07:33:52 INFO - PROCESS | 9969 | -------- Summary: end -------- 07:33:52 INFO - PROCESS | 9969 | 07:33:53 INFO - TEST-INFO | 9969: exit 0 07:33:53 INFO - TEST-OK | dromaeo_css | took 1111488ms 07:33:53 INFO - TEST-START | kraken 07:33:53 INFO - operating with platform_type : linux_ 07:33:53 INFO - Initialising browser for kraken test... 07:33:53 INFO - TEST-INFO | started process 10171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYjiHBc/profile http://localhost:58043/getInfo.html) 07:33:57 INFO - PROCESS | 10171 | __metrics Screen width/height:1600/1200 07:33:57 INFO - PROCESS | 10171 | colorDepth:24 07:33:57 INFO - PROCESS | 10171 | Browser inner width/height: 1024/697 07:33:57 INFO - PROCESS | 10171 | __metrics 07:33:57 INFO - PROCESS | 10171 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:33:57 INFO - PROCESS | 10171 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:57 INFO - PROCESS | 10171 | 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. 07:33:58 INFO - TEST-INFO | 10171: exit 0 07:33:58 INFO - Browser initialized. 07:33:58 INFO - Running cycle 1/1 for kraken test... 07:33:58 INFO - TEST-INFO | started process 10257 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYjiHBc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:09 INFO - PROCESS | 10257 | RSS: Main: 146747392 07:34:09 INFO - PROCESS | 10257 | 07:34:12 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58043/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:13 INFO - PROCESS | 10257 | RSS: Main: 185393152 07:34:13 INFO - PROCESS | 10257 | 07:34:15 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58043/tests/kraken/driver.html?testName=audio-dft) 07:34:16 INFO - PROCESS | 10257 | RSS: Main: 174960640 07:34:16 INFO - PROCESS | 10257 | 07:34:19 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58043/tests/kraken/driver.html?testName=audio-fft) 07:34:19 INFO - PROCESS | 10257 | RSS: Main: 158343168 07:34:19 INFO - PROCESS | 10257 | 07:34:21 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58043/tests/kraken/driver.html?testName=audio-oscillator) 07:34:22 INFO - PROCESS | 10257 | RSS: Main: 161857536 07:34:22 INFO - PROCESS | 10257 | 07:34:24 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58043/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:25 INFO - PROCESS | 10257 | RSS: Main: 162758656 07:34:25 INFO - PROCESS | 10257 | 07:34:28 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58043/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:28 INFO - PROCESS | 10257 | RSS: Main: 162586624 07:34:28 INFO - PROCESS | 10257 | 07:34:31 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58043/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:32 INFO - PROCESS | 10257 | RSS: Main: 163741696 07:34:32 INFO - PROCESS | 10257 | 07:34:35 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58043/tests/kraken/driver.html?testName=json-parse-financial) 07:34:35 INFO - PROCESS | 10257 | RSS: Main: 164696064 07:34:35 INFO - PROCESS | 10257 | 07:34:37 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58043/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:37 INFO - PROCESS | 10257 | RSS: Main: 174665728 07:34:37 INFO - PROCESS | 10257 | 07:34:39 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:40 INFO - PROCESS | 10257 | RSS: Main: 171503616 07:34:40 INFO - PROCESS | 10257 | 07:34:42 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:43 INFO - PROCESS | 10257 | RSS: Main: 184532992 07:34:43 INFO - PROCESS | 10257 | 07:34:45 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:46 INFO - PROCESS | 10257 | RSS: Main: 191545344 07:34:46 INFO - PROCESS | 10257 | 07:34:48 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:49 INFO - PROCESS | 10257 | RSS: Main: 191561728 07:34:49 INFO - PROCESS | 10257 | 07:34:50 INFO - PROCESS | 10257 | Cycle 1(1): loaded http://localhost:58043/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58043/tests/kraken/driver.html?testName=ai-astar) 07:34:51 INFO - PROCESS | 10257 | RSS: Main: 249122816 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | __start_tp_report 07:34:51 INFO - PROCESS | 10257 | _x_x_mozilla_page_load 07:34:51 INFO - PROCESS | 10257 | _x_x_mozilla_page_load_details 07:34:51 INFO - PROCESS | 10257 | |i|pagename|runs| 07:34:51 INFO - PROCESS | 10257 | |0;ai-astar;110;119;104;111;111;113;100;111;112;112 07:34:51 INFO - PROCESS | 10257 | |1;audio-beat-detection;148;127;151;166;127;156;151;124;170;142 07:34:51 INFO - PROCESS | 10257 | |2;audio-dft;164;162;162;162;163;164;160;162;162;164 07:34:51 INFO - PROCESS | 10257 | |3;audio-fft;74;72;88;93;72;74;74;111;93;74 07:34:51 INFO - PROCESS | 10257 | |4;audio-oscillator;96;96;137;96;96;97;142;97;95;145 07:34:51 INFO - PROCESS | 10257 | |5;imaging-gaussian-blur;110;109;109;110;109;111;110;109;110;109 07:34:51 INFO - PROCESS | 10257 | |6;imaging-darkroom;146;159;145;145;146;145;147;146;146;145 07:34:51 INFO - PROCESS | 10257 | |7;imaging-desaturate;95;96;97;97;97;97;97;97;97;96 07:34:51 INFO - PROCESS | 10257 | |8;json-parse-financial;59;55;56;54;56;56;56;63;53;54 07:34:51 INFO - PROCESS | 10257 | |9;json-stringify-tinderbox;68;69;68;69;68;69;69;68;68;69 07:34:51 INFO - PROCESS | 10257 | |10;stanford-crypto-aes;86;88;85;86;87;86;86;87;90;87 07:34:51 INFO - PROCESS | 10257 | |11;stanford-crypto-ccm;120;119;119;118;114;124;119;123;126;117 07:34:51 INFO - PROCESS | 10257 | |12;stanford-crypto-pbkdf2;149;146;152;155;152;142;152;152;152;141 07:34:51 INFO - PROCESS | 10257 | |13;stanford-crypto-sha256-iterative;67;69;69;68;68;67;69;68;69;68 07:34:51 INFO - PROCESS | 10257 | __end_tp_report 07:34:51 INFO - PROCESS | 10257 | __start_cc_report 07:34:51 INFO - PROCESS | 10257 | _x_x_mozilla_cycle_collect,940 07:34:51 INFO - PROCESS | 10257 | __end_cc_report 07:34:51 INFO - PROCESS | 10257 | __startTimestamp1452612891195__endTimestamp 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | ------- Summary: start ------- 07:34:51 INFO - PROCESS | 10257 | Number of tests: 14 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:5.12 (4.6%) stddev-sans-first:5.43 07:34:51 INFO - PROCESS | 10257 | Values: 110.0 119.0 104.0 111.0 111.0 113.0 100.0 111.0 112.0 112.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.00 stddev:16.16 (10.7%) stddev-sans-first:17.13 07:34:51 INFO - PROCESS | 10257 | Values: 148.0 127.0 151.0 166.0 127.0 156.0 151.0 124.0 170.0 142.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 07:34:51 INFO - PROCESS | 10257 | Values: 164.0 162.0 162.0 162.0 163.0 164.0 160.0 162.0 162.0 164.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:13.22 (17.9%) stddev-sans-first:13.66 07:34:51 INFO - PROCESS | 10257 | Values: 74.0 72.0 88.0 93.0 72.0 74.0 74.0 111.0 93.0 74.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:21.92 (22.8%) stddev-sans-first:22.68 07:34:51 INFO - PROCESS | 10257 | Values: 96.0 96.0 137.0 96.0 96.0 97.0 142.0 97.0 95.0 145.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:34:51 INFO - PROCESS | 10257 | Values: 110.0 109.0 109.0 110.0 109.0 111.0 110.0 109.0 110.0 109.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:146.00 stddev:4.27 (2.9%) stddev-sans-first:4.51 07:34:51 INFO - PROCESS | 10257 | Values: 146.0 159.0 145.0 145.0 146.0 145.0 147.0 146.0 146.0 145.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 07:34:51 INFO - PROCESS | 10257 | Values: 95.0 96.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 96.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.90 (5.2%) stddev-sans-first:2.89 07:34:51 INFO - PROCESS | 10257 | Values: 59.0 55.0 56.0 54.0 56.0 56.0 56.0 63.0 53.0 54.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:34:51 INFO - PROCESS | 10257 | Values: 68.0 69.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 69.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:1.40 (1.6%) stddev-sans-first:1.45 07:34:51 INFO - PROCESS | 10257 | Values: 86.0 88.0 85.0 86.0 87.0 86.0 86.0 87.0 90.0 87.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:119.50 stddev:3.54 (3.0%) stddev-sans-first:3.76 07:34:51 INFO - PROCESS | 10257 | Values: 120.0 119.0 119.0 118.0 114.0 124.0 119.0 123.0 126.0 117.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:152.00 stddev:4.74 (3.1%) stddev-sans-first:5.02 07:34:51 INFO - PROCESS | 10257 | Values: 149.0 146.0 152.0 155.0 152.0 142.0 152.0 152.0 152.0 141.0 07:34:51 INFO - PROCESS | 10257 | 07:34:51 INFO - PROCESS | 10257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 07:34:51 INFO - PROCESS | 10257 | Values: 67.0 69.0 69.0 68.0 68.0 67.0 69.0 68.0 69.0 68.0 07:34:51 INFO - PROCESS | 10257 | -------- Summary: end -------- 07:34:51 INFO - PROCESS | 10257 | 07:34:52 INFO - TEST-INFO | 10257: exit 0 07:34:52 INFO - TEST-OK | kraken | took 58869ms 07:34:52 INFO - TEST-START | v8_7 07:34:52 INFO - operating with platform_type : linux_ 07:34:52 INFO - Initialising browser for v8_7 test... 07:34:52 INFO - TEST-INFO | started process 10508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5nDZP9/profile http://localhost:58043/getInfo.html) 07:34:55 INFO - PROCESS | 10508 | __metrics Screen width/height:1600/1200 07:34:55 INFO - PROCESS | 10508 | colorDepth:24 07:34:55 INFO - PROCESS | 10508 | Browser inner width/height: 1024/697 07:34:55 INFO - PROCESS | 10508 | __metrics 07:34:56 INFO - PROCESS | 10508 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:34:56 INFO - PROCESS | 10508 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:56 INFO - TEST-INFO | 10508: exit 0 07:34:56 INFO - Browser initialized. 07:34:56 INFO - Running cycle 1/1 for v8_7 test... 07:34:56 INFO - TEST-INFO | started process 10594 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5nDZP9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:08 INFO - PROCESS | 10594 | RSS: Main: 148086784 07:35:08 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | Cycle 1(1): loaded http://localhost:58043/tests/v8_7/run.html (next: http://localhost:58043/tests/v8_7/run.html) 07:35:31 INFO - PROCESS | 10594 | RSS: Main: 554823680 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | __start_tp_report 07:35:31 INFO - PROCESS | 10594 | _x_x_mozilla_page_load 07:35:31 INFO - PROCESS | 10594 | _x_x_mozilla_page_load_details 07:35:31 INFO - PROCESS | 10594 | |i|pagename|runs| 07:35:31 INFO - PROCESS | 10594 | |0;Richards;166.9727834362999 07:35:31 INFO - PROCESS | 10594 | |1;DeltaBlue;192.56691700365877 07:35:31 INFO - PROCESS | 10594 | |2;Encrypt;281.135788585887 07:35:31 INFO - PROCESS | 10594 | |3;Decrypt;5170.103092783505 07:35:31 INFO - PROCESS | 10594 | |4;RayTrace;1960.7843137254902 07:35:31 INFO - PROCESS | 10594 | |5;Earley;792.3930269413629 07:35:31 INFO - PROCESS | 10594 | |6;Boyer;12395.061728395061 07:35:31 INFO - PROCESS | 10594 | |7;RegExp;42723.40425531915 07:35:31 INFO - PROCESS | 10594 | |8;Splay;612.369871402327 07:35:31 INFO - PROCESS | 10594 | |9;NavierStokes;4840.579710144928 07:35:31 INFO - PROCESS | 10594 | __end_tp_report 07:35:31 INFO - PROCESS | 10594 | __startTimestamp1452612931352__endTimestamp 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | ------- Summary: start ------- 07:35:31 INFO - PROCESS | 10594 | Number of tests: 10 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 167.0 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#1] DeltaBlue Cycles:1 Average:192.57 Median:192.57 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 192.6 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 281.1 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 5170.1 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 1960.8 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 792.4 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 12395.1 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#7] RegExp Cycles:1 Average:42723.40 Median:42723.40 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 42723.4 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#8] Splay Cycles:1 Average:612.37 Median:612.37 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 612.4 07:35:31 INFO - PROCESS | 10594 | 07:35:31 INFO - PROCESS | 10594 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:35:31 INFO - PROCESS | 10594 | Values: 4840.6 07:35:31 INFO - PROCESS | 10594 | -------- Summary: end -------- 07:35:31 INFO - PROCESS | 10594 | 07:35:32 INFO - TEST-INFO | 10594: exit 0 07:35:32 INFO - TEST-OK | v8_7 | took 40163ms 07:35:32 INFO - SUITE-END | took 1210s 07:35:32 INFO - Completed test suite (00:20:10) 07:35:32 INFO - Working with test: dromaeo_css 07:35:32 INFO - Generating results file: dromaeo_css 07:35:32 INFO - Working with test: kraken 07:35:32 INFO - Generating results file: kraken 07:35:32 INFO - javascript benchmark 07:35:32 INFO - Working with test: v8_7 07:35:32 INFO - Generating results file: v8_7 07:35:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:35:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:35:32 INFO - process_Request line: dromaeo_css 6675.89 graph.html#tests=[[72,1,35]] 07:35:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:35:32 INFO - process_Request line: kraken 1513.30 graph.html#tests=[[232,1,35]] 07:35:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:35:32 INFO - process_Request line: v8_7 18809.63 graph.html#tests=[[230,1,35]] 07:35:32 INFO - RETURN: dromaeo_css: 6675.89 07:35:32 INFO - RETURN: kraken: 1513.30 07:35:32 INFO - RETURN: v8_7: 18809.63 07:35:32 INFO - javascript benchmark 07:35:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3055.70970757778, 3065.3869226154775, 3103.3793241351723, 3106.875724971001, 3125.640551336596, 4873.098476781798, 4945.455999840015, 5007.273945277932, 5010.849674509766, 5021.271915572244, 4998.625103117262, 5043.798248070082, 5064.366954130734, 5119.411267704215, 5134.204198349253, 4398.428204333432, 4505.684602077856, 4580.358749775034, 4633.884152896171, 4698.718076915379, 4535.229011068126, 4624.953750462503, 4641.210994130989, 4690.9296360554445, 4766.046790641885, 4624.606908412789, 4627.444706635209, 4632.3514707941085, 4636.0, 4675.83104223944, 4626.028534007863, 4627.282771170474, 4640.744759038252, 4640.907181856378, 4676.134915040694, 4527.61515271199, 4572.428446444194, 4593.379893714339, 4625.930611040837, 4639.605633521155, 4953.6037117030555, 4969.925451118236, 4974.204127339608, 4985.401751789808, 4990.82532111378, 5434.538064264542, 5457.672539647634, 5458.754356053987, 5465.890682186334, 5492.533134683516, 5254.947450525484, 5379.112446446371, 5455.8363249102595, 5492.615516913817, 5499.175123731432, 5117.2068329409, 5124.769385377593, 5127.871803204913, 5141.0, 5152.6650767699975, 5549.833504994856, 5567.888642227133, 5577.0, 5581.246531718166, 5589.189567512769, 5222.112240919053, 5309.522143007071, 5309.7079660618265, 5311.681299122065, 5371.489708477767, 5421.430749771296, 5441.238226648273, 5442.700651464207, 5446.400895901447, 5460.5085542300585, 5382.842688821922, 5405.8107966221, 5425.647332923348, 5432.185172224119, 5475.753591088411, 5197.532222100029, 5251.0, 5301.946980530222, 5350.411454739976, 5447.863803404946, 4227.915441691149, 4244.214820258262, 4256.425382573375, 4262.254105531581, 4301.978490107529, 3808.9428658570146, 3825.1202223488754, 3825.445310430028, 3831.693464522887, 3867.1298957734284, 4939.728314942641, 5014.974925125424, 5020.422651395136, 5027.145385284511, 5075.543201111917, 5374.0, 5381.865453363619, 5393.406725260218, 5396.62223644349, 5420.07858664028, 4952.925706114411, 5050.974745126251, 5051.494850514992, 5061.569766569883, 5075.746212689351, 4611.262198048296, 4613.284940834176, 4617.238155704338, 4635.930461043087, 4668.0, 5625.71871406428, 5648.293963254593, 5650.915236271459, 5653.23681303027, 5695.231143795618, 5248.448912864094, 5315.521603055744, 5365.275687782256, 5424.213489044146, 5430.02259593277, 5576.804811831566, 5599.356074051373, 5617.578681598815, 5640.294963129609, 5670.886582268414, 5321.467853214647, 5323.281357016908, 5326.547243484192, 5331.173668081454, 5335.839924802262, 5336.2529245904825, 5357.357117145967, 5409.053415652166, 5412.242286079873, 5475.342958844964, 5263.789448422173, 5265.4997775211295, 5268.025415298182, 5275.630705850554, 5294.7352632369, 5256.947430525645, 5261.710605916712, 5268.631195816256, 5269.314989051399, 5304.363476382859, 5160.200168973815, 5191.8182863599595, 5197.558207552401, 5210.036143313499, 5287.550558202596, 5277.129273669955, 5299.41706412302, 5312.362516498045, 5314.016906872241, 5347.1979203119845, 5203.609729270244, 5226.137687281556, 5247.16045432729, 5248.553872920845, 5249.816256431007], "unit": "score", "name": "dojo.html", "value": 4999.81854820733}, {"lowerIsBetter": false, "replicates": [513.8792383789809, 515.9613029022825, 528.9312389389379, 531.8565085067105, 536.5224949794683, 27368.58947115795, 27813.582796258048, 35514.46728299077, 35532.46701299483, 35672.0, 37117.07207319811, 37456.0, 37519.437208441894, 37529.0, 37625.247495050084, 8353.705175697745, 8462.957685211566, 8554.828903421927, 8562.657493700244, 8570.700025499109, 8304.128066553016, 8339.874901876477, 8446.83106337873, 8470.110638382974, 8473.0, 8420.49477031377, 8510.148985101472, 8684.653878648787, 8691.782705432352, 8706.0858609846, 8599.312055035582, 8687.956560217222, 8688.695895643654, 8688.695895643685, 8691.087435819274, 8458.915410845875, 8501.914980850173, 8599.355048371397, 8609.440386374865, 8631.827363452758, 38179.236415271815, 38457.42313865294, 38789.41815872764, 38809.417858732144, 38860.611393885985, 2955.349823038928, 3292.2098696312714, 3389.8983030508875, 3416.641252668459, 3607.062163837395, 26053.348666283306, 26290.07984720545, 26668.866655666596, 28271.0, 29127.70872291271, 3884.184321292532, 3930.4693866327966, 3959.425883246942, 3966.6628336591134, 4079.469668943048, 267272.0, 270815.0, 270982.0, 271496.0, 271878.0, 52322.476775231764, 52997.0, 57997.0, 59650.70174649186, 60508.69745651243, 52434.737826311386, 52571.737141314814, 52622.736886315324, 52693.0, 52753.736231318595, 14601.78097328541, 14646.414143434356, 14669.92665036668, 14868.479603214051, 14884.776728349083, 10680.732981675521, 10721.410322432184, 10747.247692661595, 10748.0, 10779.353238805697, 19143.4691635979, 19473.673721551324, 19560.413187604394, 19576.510587235432, 19630.607387852164, 7757.456978011485, 7879.606019698992, 7893.368530517545, 7996.760097197093, 8038.598070096472, 970.4419958523877, 981.5975450065439, 993.2897977945803, 998.121652945418, 1087.1628845788698, 27308.180754577395, 27641.723582764316, 27648.447031059266, 27686.0, 27780.58329125065, 1028.7890982348601, 1063.7340664833791, 1075.44077079918, 1107.0755918807886, 1107.5182295701395, 14319.284035798168, 14358.138511689333, 14480.565583032527, 14600.707985840223, 14623.415063397344, 294634.0, 299063.0, 299718.0, 299747.0, 300630.0, 48221.517784821706, 48956.26565601519, 48990.26514602284, 49029.754851225516, 49046.60487346389, 1276.897848172144, 1291.7868551688866, 1297.9935100324437, 1307.9149855259377, 1311.0, 26382.868085659447, 27292.454150916474, 27450.0, 27473.725262747117, 27540.0, 43961.78019110012, 44524.55475445204, 44564.77717611391, 44568.10863782771, 44650.77674611606, 263589.0, 266998.0, 267892.0, 267894.0, 268817.0, 27460.862695687192, 30497.23756906095, 30674.0, 31040.22399440032, 31066.68933310638, 35399.82300088483, 35851.0, 36430.8178459106, 36757.816210918776, 36781.816090919376, 29853.253668658457, 31889.0, 38212.42681359837, 38914.80542597269, 39662.0, 30382.848085760314, 32641.673583263862, 33158.66841331556, 34130.317393651494, 40274.59725402708, 32950.67049329476, 34187.65812341845, 34708.82645586756, 34904.47643285302, 35169.64830351664, 30889.536656949713, 32160.678393215767, 34531.65468345284, 35720.464193037646, 35766.0, 23751.762482374954, 24397.512049758552, 24501.509969800147, 24510.264692059267, 24633.0], "unit": "score", "name": "ext.html", "value": 17672.05420090806}, {"lowerIsBetter": false, "replicates": [351.337728382, 356.0493482401988, 365.6087985855135, 367.6158414456893, 367.89882782234866, 13397.129186602864, 13660.180389176656, 15970.920145399272, 16348.100854453016, 17401.390951316705, 14388.712225755506, 14617.780733288982, 14767.409303627868, 15506.689866202698, 15582.844171558281, 5136.974315128428, 5338.679679219259, 5345.4120046795015, 5347.7058761768085, 5414.729263536827, 3475.0617333319988, 3506.544149260605, 5286.7885284588765, 5341.65279256849, 5652.463016013472, 5760.4815566599, 5807.274090738658, 5821.738021789009, 5824.708764561776, 5826.067829147337, 4991.650584459089, 5139.254808052811, 5145.922811157836, 5170.353705786777, 5172.663776854492, 4790.209615413452, 4939.259111133323, 4956.479569645171, 4962.578180854632, 4968.527989840995, 18169.0, 18345.26618935241, 18496.352627658103, 19210.711839322423, 19243.23027078915, 1994.58113796103, 2031.339814560274, 2035.735354403933, 2040.6122836660986, 2088.9164433422643, 9477.90522094777, 10645.57417703291, 11666.008389286835, 12184.81722774159, 12775.23348599087, 1808.1772793378982, 1813.7460755494242, 1878.158449723453, 1923.144200830631, 1971.871828331154, 53351.733241333546, 53444.19833702497, 53911.19133212966, 54418.72790636061, 54887.72556137234, 9584.089511496397, 9753.658621948198, 9945.104940555384, 9986.97826065338, 10102.292839501164, 12848.293343866177, 13050.282234477196, 13072.0, 13075.934620326838, 13087.803682944763, 7298.635068246566, 7356.080489938758, 7361.190269070398, 7394.149672787591, 7471.51435156724, 7005.859882802315, 7024.5082844200415, 7080.893786593205, 7090.290970902868, 7185.6766445510075, 4328.610425061696, 4340.175366680383, 4385.868423947287, 4391.3193455014525, 4435.223835828717, 1682.125294846673, 1691.7969843618844, 1701.4555342290348, 1745.3106023120797, 1757.841794238499, 847.3517758914436, 858.1590041759112, 871.9493010921824, 897.2373482539789, 912.4388501071793, 13209.669758256121, 14855.182964937032, 14932.402703891723, 15465.149416782186, 15839.841601584067, 869.5347988825948, 875.444093000949, 894.6913314906477, 906.4528674424887, 919.1451949686856, 9199.402038867453, 9311.115444032806, 9359.298052645943, 9460.95269523648, 9538.904610953801, 519515.0, 539256.0, 547196.0, 550058.0, 550675.0, 67007.66496167488, 67422.32577674258, 67692.661536692, 69319.0, 71035.64482177555, 1048.3919326790597, 1057.7567159553346, 1070.9143268538498, 1072.0780129088978, 1076.9676909692564, 14149.43402263898, 14326.57020289393, 14420.927895360875, 14707.705845882809, 14741.11553306805, 31772.364552708354, 32341.51487727639, 32590.34819303648, 32630.0, 32672.83663581762, 41315.215869778855, 41416.1716765657, 41787.7910610445, 41897.162056759305, 42233.788831055645, 7106.147262328554, 7319.4144468443465, 7417.777466676009, 7431.516951398142, 7448.5158464699625, 9329.626814927598, 10958.178136639624, 11321.320720756781, 11323.943380283046, 11498.597549085742, 9420.434773913586, 9530.904690953003, 9575.712728618153, 9689.079537444213, 9692.41845489273, 9148.63405463774, 9602.231821454126, 9687.17658998993, 9984.0, 10182.338148020652, 7599.848003040019, 9494.098060684224, 9553.18797902186, 10038.799224015625, 10080.395176289447, 7411.444141689287, 7536.171021187774, 7586.24137586237, 7621.618919054136, 7634.8091297718, 8421.536815475207, 9014.729558113268, 9057.909420905706, 9061.728148155566, 9116.772080698036], "unit": "score", "name": "jquery.html", "value": 7956.091814379344}, {"lowerIsBetter": false, "replicates": [1308.5877948446246, 1437.6837095838914, 1448.7102579484103, 1573.7009968106058, 1744.1889521372552, 6812.965935170323, 7428.739994100208, 7578.052743407081, 7587.84824303515, 7589.544627322364, 7282.526635768671, 7450.888236676454, 7451.813704657387, 7454.888176677354, 7465.738699145531, 1990.4625751047208, 2023.7773844877051, 2219.4340443186966, 2236.317923033474, 2260.9434764130865, 2284.23478134825, 2287.897044632987, 2288.9198878039274, 2290.7823756743082, 2292.060255295329, 2124.968125478119, 2194.7476040255415, 2196.1105752170397, 2197.703310053146, 2201.6477363621825, 1982.9008549572536, 2042.9693554596693, 2240.327901629513, 2304.2511183865313, 2305.216226482987, 2276.5105502317083, 2287.3023727763025, 2335.4161459635093, 2366.7633236676365, 2371.7983971362455, 7369.299916507923, 7433.145188303361, 7491.213422590604, 7491.925080749232, 7502.2122677119205, 4622.6070783983405, 4722.220833562458, 4765.523447655207, 4768.904621907577, 4770.713757174581, 2901.840398778066, 3020.2902317955263, 3035.4080954213937, 3065.0, 3082.2756652186717, 1001.944893030883, 1011.3072545306488, 1043.248860820216, 1054.931429457083, 1065.8134826405349, 10212.693619191436, 10392.116670083127, 10401.323913945569, 10420.84368734462, 10432.739181520523, 4127.174565086994, 4360.7819609019425, 4369.148016136823, 4383.802728877208, 4434.246178149658, 8973.641054357882, 8984.550772461482, 9043.909560904438, 9130.589123489326, 9143.817123657489, 4812.422509298906, 4862.051899879561, 4874.4150701916, 4877.3903262092235, 4891.779869905863, 4391.341298805205, 4412.867613971522, 4419.602235798793, 4424.446944131983, 4431.711938723973, 3475.6176820549717, 3484.3553942520716, 3492.161881148506, 3512.2624248908014, 3589.9102522436624, 1154.6593754842343, 1173.6244401791516, 1178.4284621958343, 1188.708766352232, 1199.736058067224, 888.3093198943105, 965.3821554205314, 992.6029588164791, 1004.8542961270575, 1056.2922841696081, 6787.6266805325195, 6868.656567171622, 6934.098567186335, 6960.825979350557, 6969.05917701114, 591.8254115036075, 603.6709993053796, 608.592243197059, 610.9776639323852, 753.0511555440185, 5186.092433824066, 5205.7397130143345, 5213.661112027706, 5219.686818790885, 5264.0261551613075, 8503.23470887623, 8677.0, 8689.522076285739, 8817.867731984026, 8956.104389560991, 8556.614952327036, 8696.695615653549, 8700.52147131901, 8701.086385929513, 8712.651493940299, 6878.0, 6888.242293347727, 6965.432777624994, 6984.371406573433, 7000.544964577286, 6777.966110169417, 6825.69284382194, 6858.622775747382, 6872.312768723088, 6883.965580172067, 7882.330001949669, 7986.0, 8078.919210807817, 8117.188281171835, 8264.917350826414, 8142.389320800845, 8352.33181345503, 8455.32357411418, 8489.533075680896, 8531.957340213508, 6788.93211067883, 6818.897716534157, 6859.108315918898, 6889.758858439931, 6894.620795856075, 7205.495615306878, 7221.963890180516, 7235.457340699574, 7240.312170343809, 7257.745978890714, 6710.0, 6937.583744975318, 7035.648217589202, 7051.858962820817, 7115.359617634438, 6844.5208835381045, 6864.519483636098, 6877.071595334566, 6888.793336199922, 6934.8613027740175, 6294.937050629435, 6489.415952564292, 6655.434288085373, 6915.619640919596, 7004.0, 6066.696665166635, 6102.359252278625, 6123.938760612336, 6148.231471066117, 6152.846178845564, 6126.448619624255, 6163.845903852261, 6177.0, 6177.351378105414, 6203.8138855834395], "unit": "score", "name": "mootools.html", "value": 4289.894993977649}, {"lowerIsBetter": false, "replicates": [323.6375259709126, 328.58762253372015, 330.3607519449865, 332.4398388715017, 334.80581262867537, 5934.139549765281, 5934.5845790794665, 5965.671888046156, 5986.940130598693, 6042.184305118808, 5611.438856114387, 5741.224934633834, 5855.590108692393, 5901.911471327933, 5972.25346831646, 4523.864284071483, 4550.635949124062, 4551.998560316725, 4552.339910712944, 4570.702904311226, 4353.956460435403, 4530.048689775152, 4541.296099104644, 4555.04344087742, 4555.817767289321, 4367.978160109195, 4403.832984259174, 4445.466544014723, 4467.888302792424, 4482.215612267856, 4467.553244675522, 4483.7758112094425, 4509.616682581985, 4519.07358991406, 4534.251848445003, 3971.8808435746973, 3982.780947047911, 3983.203359328146, 3987.521497420328, 3994.820233089518, 5608.663480191201, 5699.0, 5710.2862142232225, 5713.914291285634, 5724.284464441945, 5293.7353132343615, 5296.25852380667, 5296.973515132399, 5299.364076310867, 5309.070912590281, 6277.372262773732, 6281.340459251758, 6285.025820997707, 6288.245410550763, 6297.244330680302, 4413.337999300131, 4423.867283981485, 4424.093060922503, 4427.00392411708, 4431.069475410168, 6427.132337134473, 6577.934220657828, 6581.605103693842, 6595.274519802818, 6613.437857782094, 4484.663650226246, 4497.370368148462, 4510.436195475566, 4514.435695538058, 4534.59188673021, 4567.657425693086, 4584.564466375689, 4586.0, 4586.908261834745, 4591.219492686251, 5274.657147285414, 5275.841724748264, 5276.973615131899, 5279.0, 5295.947040529622, 6107.083937409424, 6221.968890155611, 6277.717502712298, 6293.527985401113, 6359.841003974938, 1553.122485795522, 1554.0364973716369, 1557.727397705397, 1558.828528861847, 1558.9922050389675, 1020.1787561013307, 1036.18659352408, 1037.4657051618422, 1053.7049626104704, 1055.8046761349176, 5990.281166260077, 5996.700164991733, 6002.579819412686, 6003.789867354709, 6057.182280392179, 6522.119513865662, 6531.379518945692, 6543.901841472381, 6545.312742162099, 6566.770163044366, 5854.356020837705, 5935.910961335583, 6039.245094363205, 6062.939370606237, 6066.090086486974, 3501.142220156078, 3539.8584056637446, 3552.3605750965075, 3560.359135355661, 3560.768550044239, 6855.520113592101, 6864.759733409307, 6879.2432832388395, 6883.518153729191, 6885.380315771505, 6556.213254409501, 6703.430208432241, 6712.160979877418, 6714.959181326903, 6715.731370745213, 6853.348931851466, 6861.656917154122, 6862.107925969592, 6863.656817159222, 6870.381665650116, 6508.219013718384, 6545.050967609765, 6562.179727534059, 6565.507586930904, 6570.080188773671, 6321.49428045746, 6490.480761538971, 6497.155369801895, 6497.837554061186, 6507.544471886922, 6814.1482314710665, 6859.039734437282, 6867.965660171667, 6871.969204619347, 6888.621125837926, 4476.768888555674, 4485.237509623437, 4486.573775491323, 4486.932696009628, 4492.124035812985, 6423.807285781434, 6569.770058047945, 6585.078089067439, 6590.472762178918, 6590.5716128451495, 6416.877046516935, 6422.779671862331, 6426.582272152295, 6429.32492088324, 6440.710168042543, 6325.652089134957, 6399.232092148972, 6400.679966001589, 6411.871762564816, 6416.582922110048, 6162.845928851635, 6276.874462510633, 6279.434850863444, 6288.27684816252, 6289.9371006291185, 6422.100905873088, 6425.45383642377, 6441.742330306735, 6444.226692796894, 6445.1943507061615, 6276.560640755103, 6279.183706118175, 6282.057691346335, 6289.150964619717, 6305.873882522415], "unit": "score", "name": "prototype.html", "value": 4769.547895423792}, {"lowerIsBetter": false, "replicates": [745.8843879198724, 833.4415941319315, 833.7128938352773, 845.8688903220003, 865.0311650950936, 12275.693107672301, 12409.813852792204, 12421.068419868501, 12439.564615238469, 12443.0, 12574.245545267291, 12578.371081445937, 12601.747965040693, 12606.68483287916, 12631.621051368451, 645.3288579876922, 651.7067319706127, 751.9924800751991, 755.7090520149754, 770.8882212079245, 776.2276534847806, 779.380392587894, 782.5226611766818, 783.5181363461459, 783.7374479549358, 809.0493669937829, 809.3039985612398, 809.7530253272749, 809.8501777171242, 809.8704207326829, 663.5222639699409, 672.707372293054, 799.9840003199903, 814.5235037503068, 815.8490679224303, 596.4989408896504, 597.6175247841385, 597.8116893178635, 600.1747597054051, 606.6451126091198, 12861.099723019392, 12898.419571119322, 12902.032347573875, 13021.56762756096, 13027.934860325733, 11907.28556286617, 12317.076219283499, 12356.135070545066, 12370.876291237153, 12484.81272780909, 9893.258005649604, 10009.69970900874, 10019.8497022544, 10122.848157277647, 10329.535170917326, 3589.9820500897326, 3617.8914632561064, 3621.4386770050683, 3623.6738693517445, 3753.230587729509, 44592.0, 44875.0, 45020.09959800786, 45199.0, 45261.77369113133, 9901.15840153595, 9920.282552953655, 10013.949930250448, 10016.64941727036, 10132.189424845994, 17958.371456998942, 18050.548736281697, 18105.275788968294, 18162.545936351697, 18224.726629100573, 7319.085114360705, 7323.597202153826, 7400.888986665204, 7568.5837278950185, 7658.65536050879, 4280.250956082673, 4320.740755554677, 4354.346847972829, 4359.084592235666, 4407.933880991788, 2998.160515055788, 3071.6928307169105, 3072.969270307313, 3076.64618568863, 3078.815271083742, 541.8564080518665, 548.235211879426, 548.7942021741846, 549.3846891481567, 560.1122221279237, 653.2194028136331, 677.8745932002595, 684.1174884399169, 687.8280429892527, 699.4194818300798, 7853.960730196312, 8303.543305118277, 8399.244068033906, 8447.915520844714, 8466.238038576557, 507.96444248902964, 650.890232154176, 676.4385559985201, 681.4684546054086, 685.4550632247276, 4009.258287216874, 4095.5494895561465, 4212.347086201644, 4284.8500302489265, 4325.697201195886, 51721.7413912928, 52969.0, 53246.467535324926, 53252.0, 53474.0, 48064.519354806005, 48093.8357773901, 48633.0, 48893.0, 49134.26298605524, 41448.792756036026, 41535.7923210382, 41939.951501212105, 42196.0, 42227.57772422236, 8085.636146373545, 8272.420930534805, 8280.0, 8307.169283071644, 8431.873521897054, 31835.68164318327, 32778.83610581932, 32977.34045319032, 33173.50239746358, 33192.33615327728, 38748.41877371898, 40518.59481405148, 41442.37836432396, 42163.78918105512, 42252.57747422486, 10254.384736915808, 10648.414337211529, 10672.62645807424, 10896.782064358827, 11086.501107450023, 12298.938505307417, 12794.424250908545, 12858.228506289652, 13018.544350947672, 13375.26436045988, 11238.50133436702, 11665.183437159318, 11820.23168494045, 11939.701507462383, 12073.57742479009, 11573.537058517564, 11737.941310293736, 11786.823197651871, 12415.255084694947, 12445.066620003356, 10970.670879873616, 11100.944495277472, 11587.88412115868, 11767.941160294144, 12046.0, 9408.623655053721, 9932.659091022619, 9989.700308990741, 10158.0, 10202.591896324064, 8700.0, 9022.0, 9029.0, 9655.613775449185, 10016.699499015042], "unit": "score", "name": "yui.html", "value": 6153.931334966105}], "name": "dromaeo_css", "value": 6675.892834797674}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 119.0, 104.0, 111.0, 111.0, 113.0, 100.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 151.0, 166.0, 127.0, 156.0, 151.0, 124.0, 170.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 162.0, 163.0, 164.0, 160.0, 162.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 88.0, 93.0, 72.0, 74.0, 74.0, 111.0, 93.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 96.0, 96.0, 97.0, 142.0, 97.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 159.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 56.0, 54.0, 56.0, 56.0, 56.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 85.0, 86.0, 87.0, 86.0, 86.0, 87.0, 90.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 119.0, 118.0, 114.0, 124.0, 119.0, 123.0, 126.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 152.0, 155.0, 152.0, 142.0, 152.0, 152.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1513.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [192.56691700365877], "unit": "score", "name": "DeltaBlue", "value": 343.35077400000006}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [42723.40425531915], "unit": "score", "name": "RegExp", "value": 21.32285607569722}, {"lowerIsBetter": false, "replicates": [612.369871402327], "unit": "score", "name": "Splay", "value": 133.07480300000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18809.628276577354}]} 07:35:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18809.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1513.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6675.89"}}} 07:35:32 INFO - Return code: 0 07:35:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:35:32 INFO - # TBPL SUCCESS # 07:35:32 INFO - Running post-action listener: _resource_record_post_action 07:35:32 INFO - Running post-run listener: _resource_record_post_run 07:35:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 552771584; Read time: 0; Write time: 483000 07:35:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 210006016; Read time: 0; Write time: 257672 07:35:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 302329856; Read time: 0; Write time: 201672 07:35:33 INFO - Running post-run listener: _upload_blobber_files 07:35:33 INFO - Blob upload gear active. 07:35:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:35:33 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 07:35:33 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:35:33 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:35:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:35 INFO - (blobuploader) - INFO - Done attempting. 07:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:36 INFO - (blobuploader) - INFO - Done attempting. 07:35:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:36 INFO - Return code: 0 07:35:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:35:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c6010905e736645046236e8b4ec2b5fa9e100fb2e99151ce59d299125129ca1573af285866e8c99bb1e7e9aa81f2b8496d6e30e7f53ea567d0246046a6de7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218fb3a90a27f00e3745dfe041386343f7cee46e7157c0ae82dc898ffa8babea9699072c18a27eeb61235bac641501bb736bfdaa781b6d28799d8ac88a9acad0"} 07:35:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:35:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:35:36 INFO - Contents: 07:35:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c6010905e736645046236e8b4ec2b5fa9e100fb2e99151ce59d299125129ca1573af285866e8c99bb1e7e9aa81f2b8496d6e30e7f53ea567d0246046a6de7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218fb3a90a27f00e3745dfe041386343f7cee46e7157c0ae82dc898ffa8babea9699072c18a27eeb61235bac641501bb736bfdaa781b6d28799d8ac88a9acad0"} 07:35:36 INFO - Copying logs to upload dir... 07:35:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.723786 ========= master_lag: 41.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-01-12 07:36:17.531610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 07:36:17.536679) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/760c6010905e736645046236e8b4ec2b5fa9e100fb2e99151ce59d299125129ca1573af285866e8c99bb1e7e9aa81f2b8496d6e30e7f53ea567d0246046a6de7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218fb3a90a27f00e3745dfe041386343f7cee46e7157c0ae82dc898ffa8babea9699072c18a27eeb61235bac641501bb736bfdaa781b6d28799d8ac88a9acad0"} build_url:https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/Of2ynpwFSAin8nQ7s94jjg/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/Firefox/sha512/760c6010905e736645046236e8b4ec2b5fa9e100fb2e99151ce59d299125129ca1573af285866e8c99bb1e7e9aa81f2b8496d6e30e7f53ea567d0246046a6de7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218fb3a90a27f00e3745dfe041386343f7cee46e7157c0ae82dc898ffa8babea9699072c18a27eeb61235bac641501bb736bfdaa781b6d28799d8ac88a9acad0"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 07:36:17.767636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-01-12 07:36:17.767986) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452609179.921900-1478744841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 4.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-01-12 07:36:21.883436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 07:36:21.883740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 07:36:21.886786) ========= ========= Total master_lag: 45.86 =========