builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1451112864.82 results: success (0) buildid: 20151225203208 builduid: 53aaf277d0fc479991fc62dad5cc3426 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.819874) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.820296) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.820588) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006327 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.876554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.876822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.898694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.898948) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.949393) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.949650) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.950040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:24.950312) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 22:54:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-25 22:54:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.143117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.143395) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017736 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.192259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.192552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 22:54:25,818 truncating revision to first 12 chars 2015-12-25 22:54:25,818 Setting DEBUG logging. 2015-12-25 22:54:25,818 attempt 1/10 2015-12-25 22:54:25,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 22:54:26,310 unpacking tar archive at: fx-team-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.763248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.967920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.968223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.979074) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.979313) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 22:54:25.979685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-25 22:54:25.979961) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:26 INFO - MultiFileLogger online at 20151225 22:54:26 in /builds/slave/test-pgo 22:54:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:54:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:54:26 INFO - {'append_to_log': False, 22:54:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:54:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:54:26 INFO - 'branch': 'Fx-Team', 22:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:26 INFO - 'config_files': ('talos/linux_config.py',), 22:54:26 INFO - 'default_actions': ('clobber', 22:54:26 INFO - 'read-buildbot-config', 22:54:26 INFO - 'download-and-extract', 22:54:26 INFO - 'populate-webroot', 22:54:26 INFO - 'create-virtualenv', 22:54:26 INFO - 'install', 22:54:26 INFO - 'run-tests'), 22:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:26 INFO - 'download_minidump_stackwalk': True, 22:54:26 INFO - 'download_symbols': 'ondemand', 22:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:26 INFO - 'installer_path': 'installer.exe', 22:54:26 INFO - 'log_level': 'info', 22:54:26 INFO - 'log_name': 'talos', 22:54:26 INFO - 'log_to_console': True, 22:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:26 INFO - 'opt_config_files': (), 22:54:26 INFO - 'pip_index': False, 22:54:26 INFO - 'sps_profile': False, 22:54:26 INFO - 'sps_profile_interval': 0, 22:54:26 INFO - 'suite': 'dromaeojs', 22:54:26 INFO - 'system_bits': '64', 22:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:26 INFO - 'title': 'talos-linux64-ix-062', 22:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:26 INFO - 'use_talos_json': True, 22:54:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:26 INFO - 'work_dir': 'build'} 22:54:26 INFO - ##### 22:54:26 INFO - ##### Running clobber step. 22:54:26 INFO - ##### 22:54:26 INFO - Running pre-action listener: _resource_record_pre_action 22:54:26 INFO - Running main action method: clobber 22:54:26 INFO - rmtree: /builds/slave/test-pgo/build 22:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:54:27 INFO - Running post-action listener: _resource_record_post_action 22:54:27 INFO - ##### 22:54:27 INFO - ##### Running read-buildbot-config step. 22:54:27 INFO - ##### 22:54:27 INFO - Running pre-action listener: _resource_record_pre_action 22:54:27 INFO - Running main action method: read_buildbot_config 22:54:27 INFO - Using buildbot properties: 22:54:27 INFO - { 22:54:27 INFO - "project": "", 22:54:27 INFO - "product": "firefox", 22:54:27 INFO - "script_repo_revision": "production", 22:54:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:54:27 INFO - "repository": "", 22:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:54:27 INFO - "buildid": "20151225203208", 22:54:27 INFO - "pgo_build": "True", 22:54:27 INFO - "basedir": "/builds/slave/test-pgo", 22:54:27 INFO - "buildnumber": 854, 22:54:27 INFO - "slavename": "talos-linux64-ix-062", 22:54:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:54:27 INFO - "platform": "ubuntu64_hw", 22:54:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:54:27 INFO - "branch": "fx-team", 22:54:27 INFO - "repo_path": "integration/fx-team", 22:54:27 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 22:54:27 INFO - "stage_platform": "linux64-pgo", 22:54:27 INFO - "builduid": "53aaf277d0fc479991fc62dad5cc3426", 22:54:27 INFO - "slavebuilddir": "test" 22:54:27 INFO - } 22:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:54:27 INFO - Running post-action listener: _resource_record_post_action 22:54:27 INFO - ##### 22:54:27 INFO - ##### Running download-and-extract step. 22:54:27 INFO - ##### 22:54:27 INFO - Running pre-action listener: _resource_record_pre_action 22:54:27 INFO - Running main action method: download_and_extract 22:54:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:54: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')]} 22:54:27 INFO - https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/test_packages.json 22:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/test_packages.json 22:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:54:33 INFO - Downloaded 1302 bytes. 22:54:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:54:33 INFO - Using the following test package requirements: 22:54:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'jsshell-linux-x86_64.zip'], 22:54:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:54:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:54:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54:33 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')]} 22:54:33 INFO - https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:34 INFO - Downloaded 23191406 bytes. 22:54: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 22:54:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54: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 22:54:35 INFO - Return code: 0 22:54:35 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 22:54: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')]} 22:54:35 INFO - https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:38 INFO - Downloaded 23191406 bytes. 22:54:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:54:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:54:39 INFO - Return code: 0 22:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:39 INFO - https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:41 INFO - Downloaded 11132270 bytes. 22:54:41 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 22:54:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:41 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 22:54:41 INFO - Return code: 0 22:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:41 INFO - https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:54:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:54:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:54:42 INFO - Downloaded 54908670 bytes. 22:54:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:54:42 INFO - mkdir: /builds/slave/test-pgo/properties 22:54:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:54:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:54:42 INFO - Contents: 22:54:42 INFO - build_url:https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:54:42 INFO - Running post-action listener: _resource_record_post_action 22:54:42 INFO - Running post-action listener: set_extra_try_arguments 22:54:42 INFO - ##### 22:54:42 INFO - ##### Running populate-webroot step. 22:54:42 INFO - ##### 22:54:42 INFO - Running pre-action listener: _resource_record_pre_action 22:54:42 INFO - Running main action method: populate_webroot 22:54:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:42 INFO - '--tppagecycles', 22:54:42 INFO - '7'], 22:54:42 INFO - 'tests': ['tsvgm']}}, 22:54:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:54:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:54:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'tests': ['damp', 'tps']}, 22:54:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['damp', 'tps']}, 22:54:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:42 INFO - 'other': {'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'other_l64': {'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:42 INFO - 'ts_paint', 22:54:42 INFO - 'tpaint', 22:54:42 INFO - 'sessionrestore', 22:54:42 INFO - 'sessionrestore_no_auto_restore']}, 22:54:42 INFO - 'svgr': {'tests': ['tsvgx', 22:54:42 INFO - 'tsvgr_opacity', 22:54:42 INFO - 'tart', 22:54:42 INFO - 'tscrollx', 22:54:42 INFO - 'cart']}, 22:54:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['tsvgx', 22:54:42 INFO - 'tsvgr_opacity', 22:54:42 INFO - 'tart', 22:54:42 INFO - 'tscrollx', 22:54:42 INFO - 'cart']}, 22:54:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'tests': ['tp5o']}, 22:54:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'talos_options': ['--e10s'], 22:54:42 INFO - 'tests': ['tp5o']}, 22:54:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'talos_options': ['--xperf_path', 22:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:42 INFO - 'tests': ['tp5n']}, 22:54:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:42 INFO - 'talos_options': ['--e10s', 22:54:42 INFO - '--xperf_path', 22:54:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:42 INFO - 'tests': ['tp5n']}}, 22:54:42 INFO - 'talos.zip': {'path': '', 22:54:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:42 INFO - Running post-action listener: _resource_record_post_action 22:54:42 INFO - ##### 22:54:42 INFO - ##### Running create-virtualenv step. 22:54:42 INFO - ##### 22:54:42 INFO - Running pre-action listener: _resource_record_pre_action 22:54:42 INFO - Running main action method: create_virtualenv 22:54:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:54:42 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 22:54:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:54:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:42 INFO - Using real prefix '/usr' 22:54:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:54:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:45 INFO - Installing pip.................done. 22:54:45 INFO - Return code: 0 22:54:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:45 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54:45 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 22:54:45 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 22:54:45 INFO - Using env: {'DISPLAY': ':0', 22:54:45 INFO - 'HOME': '/home/cltbld', 22:54:45 INFO - 'LANG': 'en_US.UTF-8', 22:54:45 INFO - 'LANGUAGE': 'en_US:en', 22:54:45 INFO - 'LOGNAME': 'cltbld', 22:54:45 INFO - 'MAIL': '/var/mail/cltbld', 22:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:45 INFO - 'MOZ_NO_REMOTE': '1', 22:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:45 INFO - 'NO_EM_RESTART': '1', 22:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:45 INFO - 'SHELL': '/bin/bash', 22:54:45 INFO - 'SHLVL': '1', 22:54:45 INFO - 'TERM': 'linux', 22:54:45 INFO - 'TMOUT': '86400', 22:54:45 INFO - 'USER': 'cltbld', 22:54:45 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:45 INFO - '_': '/tools/buildbot/bin/python'} 22:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:45 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 22:54:45 INFO - Cleaning up... 22:54:45 INFO - Return code: 0 22:54:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:45 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54:45 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 22:54:45 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 22:54:45 INFO - Using env: {'DISPLAY': ':0', 22:54:45 INFO - 'HOME': '/home/cltbld', 22:54:45 INFO - 'LANG': 'en_US.UTF-8', 22:54:45 INFO - 'LANGUAGE': 'en_US:en', 22:54:45 INFO - 'LOGNAME': 'cltbld', 22:54:45 INFO - 'MAIL': '/var/mail/cltbld', 22:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:45 INFO - 'MOZ_NO_REMOTE': '1', 22:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:45 INFO - 'NO_EM_RESTART': '1', 22:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:45 INFO - 'SHELL': '/bin/bash', 22:54:45 INFO - 'SHLVL': '1', 22:54:45 INFO - 'TERM': 'linux', 22:54:45 INFO - 'TMOUT': '86400', 22:54:45 INFO - 'USER': 'cltbld', 22:54:45 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:45 INFO - '_': '/tools/buildbot/bin/python'} 22:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:45 INFO - Downloading/unpacking psutil>=0.7.1 22:54:45 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 22:54:45 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 22:54:45 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 22:54:45 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 22:54:45 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 22:54:45 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 22:54:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:54:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:54:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:47 INFO - Installing collected packages: psutil 22:54:47 INFO - Running setup.py install for psutil 22:54:47 INFO - building 'psutil._psutil_linux' extension 22:54:47 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 22:54:47 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 22:54:47 INFO - building 'psutil._psutil_posix' extension 22:54:47 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 22:54:47 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 22:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:48 INFO - Successfully installed psutil 22:54:48 INFO - Cleaning up... 22:54:48 INFO - Return code: 0 22:54:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:54: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')]} 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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', '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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:54: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 mozsystemmonitor==0.0.0 22:54:48 INFO - Using env: {'DISPLAY': ':0', 22:54:48 INFO - 'HOME': '/home/cltbld', 22:54:48 INFO - 'LANG': 'en_US.UTF-8', 22:54:48 INFO - 'LANGUAGE': 'en_US:en', 22:54:48 INFO - 'LOGNAME': 'cltbld', 22:54:48 INFO - 'MAIL': '/var/mail/cltbld', 22:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:48 INFO - 'MOZ_NO_REMOTE': '1', 22:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:48 INFO - 'NO_EM_RESTART': '1', 22:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:48 INFO - 'SHELL': '/bin/bash', 22:54:48 INFO - 'SHLVL': '1', 22:54:48 INFO - 'TERM': 'linux', 22:54:48 INFO - 'TMOUT': '86400', 22:54:48 INFO - 'USER': 'cltbld', 22:54:48 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:48 INFO - '_': '/tools/buildbot/bin/python'} 22:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:50 INFO - Installing collected packages: mozsystemmonitor 22:54:50 INFO - Running setup.py install for mozsystemmonitor 22:54:50 INFO - Successfully installed mozsystemmonitor 22:54:50 INFO - Cleaning up... 22:54:50 INFO - Return code: 0 22:54:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:54:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:54:50 INFO - Using env: {'DISPLAY': ':0', 22:54:50 INFO - 'HOME': '/home/cltbld', 22:54:50 INFO - 'LANG': 'en_US.UTF-8', 22:54:50 INFO - 'LANGUAGE': 'en_US:en', 22:54:50 INFO - 'LOGNAME': 'cltbld', 22:54:50 INFO - 'MAIL': '/var/mail/cltbld', 22:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:50 INFO - 'MOZ_NO_REMOTE': '1', 22:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:50 INFO - 'NO_EM_RESTART': '1', 22:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:50 INFO - 'SHELL': '/bin/bash', 22:54:50 INFO - 'SHLVL': '1', 22:54:50 INFO - 'TERM': 'linux', 22:54:50 INFO - 'TMOUT': '86400', 22:54:50 INFO - 'USER': 'cltbld', 22:54:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:50 INFO - '_': '/tools/buildbot/bin/python'} 22:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:52 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:54:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:54:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:54:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:52 INFO - Downloading docopt-0.6.1.tar.gz 22:54:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:54:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:52 INFO - Running setup.py install for blobuploader 22:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:54:52 INFO - Running setup.py install for requests 22:54:53 INFO - Running setup.py install for docopt 22:54:53 INFO - Successfully installed blobuploader requests docopt 22:54:53 INFO - Cleaning up... 22:54:53 INFO - Return code: 0 22:54:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:53 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')]} 22:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:53 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')]} 22:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:53 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54:53 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 22:54:53 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 22:54:53 INFO - Using env: {'DISPLAY': ':0', 22:54:53 INFO - 'HOME': '/home/cltbld', 22:54:53 INFO - 'LANG': 'en_US.UTF-8', 22:54:53 INFO - 'LANGUAGE': 'en_US:en', 22:54:53 INFO - 'LOGNAME': 'cltbld', 22:54:53 INFO - 'MAIL': '/var/mail/cltbld', 22:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:53 INFO - 'MOZ_NO_REMOTE': '1', 22:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:53 INFO - 'NO_EM_RESTART': '1', 22:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:53 INFO - 'SHELL': '/bin/bash', 22:54:53 INFO - 'SHLVL': '1', 22:54:53 INFO - 'TERM': 'linux', 22:54:53 INFO - 'TMOUT': '86400', 22:54:53 INFO - 'USER': 'cltbld', 22:54:53 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:53 INFO - '_': '/tools/buildbot/bin/python'} 22:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:53 INFO - Running setup.py (path:/tmp/pip-Irnn6n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:53 INFO - Running setup.py (path:/tmp/pip-uTgt4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:53 INFO - Running setup.py (path:/tmp/pip-QnkcR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:53 INFO - Running setup.py (path:/tmp/pip-6Yr5kh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:53 INFO - Running setup.py (path:/tmp/pip-s_9oz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:53 INFO - Running setup.py (path:/tmp/pip-nH7MW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:53 INFO - Running setup.py (path:/tmp/pip-SXbjS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:54 INFO - Running setup.py (path:/tmp/pip-sXxiOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:54 INFO - Running setup.py (path:/tmp/pip-yRrWY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:54 INFO - Running setup.py (path:/tmp/pip-dykbp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:54 INFO - Running setup.py (path:/tmp/pip-9zJCnl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:54 INFO - Running setup.py (path:/tmp/pip-fAHDIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:54 INFO - Running setup.py (path:/tmp/pip-h4PinT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:54 INFO - Running setup.py (path:/tmp/pip-n0Z0xz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:54 INFO - Running setup.py (path:/tmp/pip-kt_5lY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:54 INFO - Running setup.py (path:/tmp/pip-j5AgOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:54 INFO - Running setup.py (path:/tmp/pip-AS9VdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:54 INFO - Running setup.py install for manifestparser 22:54:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:54:54 INFO - Running setup.py install for mozcrash 22:54:54 INFO - Running setup.py install for mozdebug 22:54:55 INFO - Running setup.py install for mozdevice 22:54:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozfile 22:54:55 INFO - Running setup.py install for mozhttpd 22:54:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozinfo 22:54:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozInstall 22:54:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozleak 22:54:55 INFO - Running setup.py install for mozlog 22:54:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for moznetwork 22:54:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:54:55 INFO - Running setup.py install for mozprocess 22:54:55 INFO - Running setup.py install for mozprofile 22:54:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Running setup.py install for mozrunner 22:54:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Running setup.py install for mozscreenshot 22:54:56 INFO - Running setup.py install for moztest 22:54:56 INFO - Running setup.py install for mozversion 22:54:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:54:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:56 INFO - Cleaning up... 22:54:56 INFO - Return code: 0 22:54:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:56 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:54:56 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 22:54:56 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 22:54:56 INFO - Using env: {'DISPLAY': ':0', 22:54:56 INFO - 'HOME': '/home/cltbld', 22:54:56 INFO - 'LANG': 'en_US.UTF-8', 22:54:56 INFO - 'LANGUAGE': 'en_US:en', 22:54:56 INFO - 'LOGNAME': 'cltbld', 22:54:56 INFO - 'MAIL': '/var/mail/cltbld', 22:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:56 INFO - 'MOZ_NO_REMOTE': '1', 22:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:56 INFO - 'NO_EM_RESTART': '1', 22:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:56 INFO - 'SHELL': '/bin/bash', 22:54:56 INFO - 'SHLVL': '1', 22:54:56 INFO - 'TERM': 'linux', 22:54:56 INFO - 'TMOUT': '86400', 22:54:56 INFO - 'USER': 'cltbld', 22:54:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:56 INFO - '_': '/tools/buildbot/bin/python'} 22:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:56 INFO - Running setup.py (path:/tmp/pip-BfXeB0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:56 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)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:56 INFO - Running setup.py (path:/tmp/pip-5EVwWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:56 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)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:56 INFO - Running setup.py (path:/tmp/pip-SGtVUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:56 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)) 22:54:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:57 INFO - Running setup.py (path:/tmp/pip-0Hey6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:57 INFO - Running setup.py (path:/tmp/pip-xojFm0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:57 INFO - Running setup.py (path:/tmp/pip-hlMEHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:57 INFO - Running setup.py (path:/tmp/pip-fZPyPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:57 INFO - Running setup.py (path:/tmp/pip-2KdUi6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:57 INFO - Running setup.py (path:/tmp/pip-v3xFz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:57 INFO - Running setup.py (path:/tmp/pip-k7yeI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:57 INFO - Running setup.py (path:/tmp/pip-gxiy4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:57 INFO - Running setup.py (path:/tmp/pip-RhlSEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:57 INFO - Running setup.py (path:/tmp/pip-Yogn4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:57 INFO - Running setup.py (path:/tmp/pip-qP9FNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:57 INFO - Running setup.py (path:/tmp/pip-FFjj3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:57 INFO - Running setup.py (path:/tmp/pip-rDlrLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:57 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)) 22:54:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:57 INFO - Running setup.py (path:/tmp/pip-EfJu1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:58 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)) 22:54:58 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)) 22:54:58 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)) 22:54:58 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)) 22:54: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:58 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)) 22:54:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:58 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 22:54:58 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 22:54:58 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 22:54:58 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 22:54:58 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 22:54:58 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 22:54:59 INFO - Downloading blessings-1.5.1.tar.gz 22:54:59 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 22:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:59 INFO - Installing collected packages: blessings 22:54:59 INFO - Running setup.py install for blessings 22:54:59 INFO - Successfully installed blessings 22:54:59 INFO - Cleaning up... 22:54:59 INFO - Return code: 0 22:54:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:00 INFO - Reading from file tmpfile_stdout 22:55:00 INFO - Current package versions: 22:55:00 INFO - argparse == 1.2.1 22:55:00 INFO - blessings == 1.5.1 22:55:00 INFO - blobuploader == 1.2.4 22:55:00 INFO - docopt == 0.6.1 22:55:00 INFO - manifestparser == 1.1 22:55:00 INFO - mozInstall == 1.12 22:55:00 INFO - mozcrash == 0.16 22:55:00 INFO - mozdebug == 0.1 22:55:00 INFO - mozdevice == 0.47 22:55:00 INFO - mozfile == 1.2 22:55:00 INFO - mozhttpd == 0.7 22:55:00 INFO - mozinfo == 0.9 22:55:00 INFO - mozleak == 0.1 22:55:00 INFO - mozlog == 3.1 22:55:00 INFO - moznetwork == 0.27 22:55:00 INFO - mozprocess == 0.22 22:55:00 INFO - mozprofile == 0.28 22:55:00 INFO - mozrunner == 6.11 22:55:00 INFO - mozscreenshot == 0.1 22:55:00 INFO - mozsystemmonitor == 0.0 22:55:00 INFO - moztest == 0.7 22:55:00 INFO - mozversion == 1.4 22:55:00 INFO - psutil == 3.1.1 22:55:00 INFO - requests == 1.2.3 22:55:00 INFO - wsgiref == 0.1.2 22:55:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:00 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')]} 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 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')]} 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:55:00 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 22:55:00 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 22:55:00 INFO - Using env: {'DISPLAY': ':0', 22:55:00 INFO - 'HOME': '/home/cltbld', 22:55:00 INFO - 'LANG': 'en_US.UTF-8', 22:55:00 INFO - 'LANGUAGE': 'en_US:en', 22:55:00 INFO - 'LOGNAME': 'cltbld', 22:55:00 INFO - 'MAIL': '/var/mail/cltbld', 22:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:00 INFO - 'MOZ_NO_REMOTE': '1', 22:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:00 INFO - 'NO_EM_RESTART': '1', 22:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:00 INFO - 'SHELL': '/bin/bash', 22:55:00 INFO - 'SHLVL': '1', 22:55:00 INFO - 'TERM': 'linux', 22:55:00 INFO - 'TMOUT': '86400', 22:55:00 INFO - 'USER': 'cltbld', 22:55:00 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:00 INFO - '_': '/tools/buildbot/bin/python'} 22:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 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)) 22:55:00 INFO - Cleaning up... 22:55:00 INFO - Return code: 0 22:55:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:55:00 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')]} 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 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')]} 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 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 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:55:00 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 22:55:00 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 22:55:00 INFO - Using env: {'DISPLAY': ':0', 22:55:00 INFO - 'HOME': '/home/cltbld', 22:55:00 INFO - 'LANG': 'en_US.UTF-8', 22:55:00 INFO - 'LANGUAGE': 'en_US:en', 22:55:00 INFO - 'LOGNAME': 'cltbld', 22:55:00 INFO - 'MAIL': '/var/mail/cltbld', 22:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:00 INFO - 'MOZ_NO_REMOTE': '1', 22:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:00 INFO - 'NO_EM_RESTART': '1', 22:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:00 INFO - 'SHELL': '/bin/bash', 22:55:00 INFO - 'SHLVL': '1', 22:55:00 INFO - 'TERM': 'linux', 22:55:00 INFO - 'TMOUT': '86400', 22:55:00 INFO - 'USER': 'cltbld', 22:55:00 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:00 INFO - '_': '/tools/buildbot/bin/python'} 22:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:00 INFO - Downloading/unpacking jsonschema 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55: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 22:55:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:02 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 22:55:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:02 INFO - warning: no files found matching '*.txt' 22:55:02 INFO - no previously-included directories found matching 'build' 22:55:02 INFO - no previously-included directories found matching 'dist' 22:55:02 INFO - no previously-included directories found matching '.git*' 22:55:02 INFO - Installing collected packages: jsonschema, functools32 22:55:02 INFO - Running setup.py install for functools32 22:55:02 INFO - warning: no files found matching '*.txt' 22:55:02 INFO - no previously-included directories found matching 'build' 22:55:02 INFO - no previously-included directories found matching 'dist' 22:55:02 INFO - no previously-included directories found matching '.git*' 22:55:02 INFO - Successfully installed jsonschema functools32 22:55:02 INFO - Cleaning up... 22:55:02 INFO - Return code: 0 22:55:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff669ea3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', '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 22:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:55:02 INFO - Using env: {'DISPLAY': ':0', 22:55:02 INFO - 'HOME': '/home/cltbld', 22:55:02 INFO - 'LANG': 'en_US.UTF-8', 22:55:02 INFO - 'LANGUAGE': 'en_US:en', 22:55:02 INFO - 'LOGNAME': 'cltbld', 22:55:02 INFO - 'MAIL': '/var/mail/cltbld', 22:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:02 INFO - 'MOZ_NO_REMOTE': '1', 22:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:02 INFO - 'NO_EM_RESTART': '1', 22:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:02 INFO - 'SHELL': '/bin/bash', 22:55:02 INFO - 'SHLVL': '1', 22:55:02 INFO - 'TERM': 'linux', 22:55:02 INFO - 'TMOUT': '86400', 22:55:02 INFO - 'USER': 'cltbld', 22:55:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:02 INFO - '_': '/tools/buildbot/bin/python'} 22:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:02 INFO - Downloading/unpacking flake8 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:04 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 22:55:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:04 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 22:55:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 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 22:55:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:05 INFO - no previously-included directories found matching 'docs/_build' 22:55:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:05 INFO - Running setup.py install for pep8 22:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:05 INFO - no previously-included directories found matching 'docs/_build' 22:55:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:55:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:05 INFO - Cleaning up... 22:55:05 INFO - Return code: 0 22:55:05 INFO - Running post-action listener: _resource_record_post_action 22:55:05 INFO - Running post-action listener: _start_resource_monitoring 22:55:05 INFO - Starting resource monitoring. 22:55:05 INFO - ##### 22:55:05 INFO - ##### Running install step. 22:55:05 INFO - ##### 22:55:05 INFO - Running pre-action listener: _resource_record_pre_action 22:55:05 INFO - Running main action method: install 22:55:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:05 INFO - Reading from file tmpfile_stdout 22:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:55:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:55:05 INFO - Reading from file tmpfile_stdout 22:55:05 INFO - Output received: 22:55:05 INFO - Usage: mozinstall [options] installer 22:55:05 INFO - Options: 22:55:05 INFO - -h, --help show this help message and exit 22:55:05 INFO - -d DEST, --destination=DEST 22:55:05 INFO - Directory to install application into. [default: 22:55:05 INFO - "/builds/slave/test-pgo"] 22:55:05 INFO - --app=APP Application being installed. [default: firefox] 22:55:05 INFO - mkdir: /builds/slave/test-pgo/build/application 22:55:05 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'] 22:55:05 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 22:55:21 INFO - Reading from file tmpfile_stdout 22:55:21 INFO - Output received: 22:55:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:55:21 INFO - Running post-action listener: _resource_record_post_action 22:55:21 INFO - ##### 22:55:21 INFO - ##### Running run-tests step. 22:55:21 INFO - ##### 22:55:21 INFO - Running pre-action listener: _resource_record_pre_action 22:55:21 INFO - Running main action method: run_tests 22:55:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:55:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:55:21 INFO - Python 2.7.3 22:55:21 INFO - Return code: 0 22:55:21 INFO - grabbing minidump binary from tooltool 22:55:21 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')]} 22:55:21 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 0x264a840>, '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 0x25b76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:55:21 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 22:55:21 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 22:55:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:21 INFO - Return code: 0 22:55:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:55:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:55:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:55:22 INFO - Return code: 0 22:55:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:55:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:55:22 INFO - Using env: {'DISPLAY': ':0', 22:55:22 INFO - 'HOME': '/home/cltbld', 22:55:22 INFO - 'LANG': 'en_US.UTF-8', 22:55:22 INFO - 'LANGUAGE': 'en_US:en', 22:55:22 INFO - 'LOGNAME': 'cltbld', 22:55:22 INFO - 'MAIL': '/var/mail/cltbld', 22:55:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:22 INFO - 'MOZ_NO_REMOTE': '1', 22:55:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:22 INFO - 'NO_EM_RESTART': '1', 22:55:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:55:22 INFO - 'SHELL': '/bin/bash', 22:55:22 INFO - 'SHLVL': '1', 22:55:22 INFO - 'TERM': 'linux', 22:55:22 INFO - 'TMOUT': '86400', 22:55:22 INFO - 'USER': 'cltbld', 22:55:22 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758', 22:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:22 INFO - '_': '/tools/buildbot/bin/python'} 22:55:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/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 22:55:23 INFO - mozversion application_buildid: 20151225203208 22:55:23 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 22:55:23 INFO - mozversion application_display_name: Nightly 22:55:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:23 INFO - mozversion application_name: Firefox 22:55:23 INFO - mozversion application_remotingname: firefox 22:55:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:23 INFO - mozversion application_vendor: Mozilla 22:55:23 INFO - mozversion application_version: 46.0a1 22:55:23 INFO - mozversion platform_buildid: 20151225203208 22:55:23 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 22:55:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:23 INFO - mozversion platform_version: 46.0a1 22:55:23 INFO - using testdate: 1451112923 22:55:23 INFO - actual date: 1451112923 22:55:23 INFO - starting webserver on 'localhost:40136' 22:55:23 INFO - SUITE-START | Running 3 tests 22:55:23 INFO - TEST-START | dromaeo_css 22:55:23 INFO - operating with platform_type : linux_ 22:55:23 INFO - Initialising browser for dromaeo_css test... 22:55:23 INFO - TEST-INFO | started process 18101 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJr7TQ/profile http://localhost:40136/getInfo.html) 22:55:27 INFO - PROCESS | 18101 | __metrics Screen width/height:1600/1200 22:55:27 INFO - PROCESS | 18101 | colorDepth:24 22:55:27 INFO - PROCESS | 18101 | Browser inner width/height: 1024/697 22:55:27 INFO - PROCESS | 18101 | __metrics 22:55:27 INFO - PROCESS | 18101 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:55:27 INFO - PROCESS | 18101 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:55:28 INFO - TEST-INFO | 18101: exit 0 22:55:28 INFO - Browser initialized. 22:55:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:28 INFO - TEST-INFO | started process 18197 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJr7TQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:40 INFO - PROCESS | 18197 | RSS: Main: 147992576 22:55:40 INFO - PROCESS | 18197 | 22:56:32 INFO - PROCESS | 18197 | 1451112991997 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] 22:58:40 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40136/tests/dromaeo/cssquery-ext.html) 22:58:41 INFO - PROCESS | 18197 | RSS: Main: 268161024 22:58:41 INFO - PROCESS | 18197 | 23:01:43 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-ext.html (next: http://localhost:40136/tests/dromaeo/cssquery-jquery.html) 23:01:44 INFO - PROCESS | 18197 | RSS: Main: 234205184 23:01:44 INFO - PROCESS | 18197 | 23:04:46 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40136/tests/dromaeo/cssquery-mootools.html) 23:04:47 INFO - PROCESS | 18197 | RSS: Main: 225513472 23:04:47 INFO - PROCESS | 18197 | 23:07:48 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40136/tests/dromaeo/cssquery-prototype.html) 23:07:49 INFO - PROCESS | 18197 | RSS: Main: 212389888 23:07:49 INFO - PROCESS | 18197 | 23:10:51 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40136/tests/dromaeo/cssquery-yui.html) 23:10:52 INFO - PROCESS | 18197 | RSS: Main: 215826432 23:10:52 INFO - PROCESS | 18197 | 23:13:54 INFO - PROCESS | 18197 | Cycle 1(1): loaded http://localhost:40136/tests/dromaeo/cssquery-yui.html (next: http://localhost:40136/tests/dromaeo/cssquery-dojo.html) 23:13:55 INFO - PROCESS | 18197 | RSS: Main: 298500096 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | __start_tp_report 23:13:55 INFO - PROCESS | 18197 | _x_x_mozilla_page_load 23:13:55 INFO - PROCESS | 18197 | _x_x_mozilla_page_load_details 23:13:55 INFO - PROCESS | 18197 | |i|pagename|runs| 23:13:55 INFO - PROCESS | 18197 | |0;dojo.html;3063.2035670725613;3120.60992375953;3166.5250212468127;3166.746660267179;3198.504231844064;4980.804606894347;5086.949130508694;5105.412877519091;5117.948820511794;5131.153359695651;5080.745962701869;5091.389033315998;5096.439391666913;5210.55710264627;5220.373555173375;4680.859574212779;4694.131585656647;4709.317149013391;4727.220008698578;4818.3495228144275;4689.296605509184;4733.5739783419485;4741.786619602109;4749.263864101053;4779.139754844126;4581.65637577183;4612.331211974245;4664.836730714443;4693.71837689738;4727.149113159613;4692.460367057798;4695.835645752416;4716.622670186377;4718.174319494075;4743;4669.042846216517;4686.507916668769;4714.198586240347;4715.08055929094;4716.858494245178;4848.054629347279;4848.903021939542;4920.581750551208;4949.604031677457;4950.985048065138;5477.534409575191;5510.366307874606;5516.641418307797;5519.917201241985;5544.362398324204;5613.354464236624;5615.66306021636;5621.269234999465;5622.634528755618;5637.49262566371;5106.872328191787;5150.253213284052;5200.193969934666;5228.4510126436935;5264.868378290574;5595;5612.298462692163;5620.606557540933;5624.353199382042;5651;5465.234867118606;5528.281323427928;5533.22534845122;5546.306711661043;5552.91670624941;5424.186372044225;5488.1767734839295;5510;5522.475364840334;5560.805371812048;5476.096444086761;5477.315335583052;5477.698726570077;5483.2049352844415;5491.368492623399;5341.839744807662;5487.286652735119;5492.258545096441;5510.834674959758;5545.972270138624;4209.494860616745;4248.91502169961;4259.936100958488;4292.441982542249;4297.097609501977;3849.4610754494392;3863.0535518798074;3867.690584753213;3893.6690381317903;3923.74495657787;5126.461721519261;5137.460566640524;5141.357330333708;5155;5189.844304670866;5404.432534583812;5430.456954304538;5516.420775818561;5522.116461366162;5523.171524271392;5006.374203224597;5028.974855125701;5036.345275114211;5063.746812659352;5064.468230835783;4623.42207224097;4649.604783593432;4652.209124448852;4663.556962088596;4681.906361872743;5595.019116979946;5622.240997465372;5629;5723.742431590588;5729.799457018984;5379.892402152013;5417.214503896992;5419.620626556103;5435.157550579666;5469.726513674221;5608.663480191201;5633;5634.887302254014;5648.293963254593;5655.547556195576;5309;5349.411564727799;5392.002479541297;5443.265159203457;5460.672359658433;5473.261109750133;5492.862678433071;5494.5054945055135;5503.477169668875;5548.361938377138;5341.839744807662;5346.1713434417725;5364;5376.274202982548;5384.165454354425;5224.947750522446;5319.707416092152;5352.464753524617;5357.383900851452;5410.8647283816645;5263.473652634706;5267.947320526746;5269.631125821155;5271.077561426811;5271.815486457956;5339.626226164131;5354.9464505354445;5365.2220428036935;5378.623496355374;5392.083345831296;5195.9740201300265;5249.527542521191;5288.312519372457;5298.284731561344;5299.761510731949 23:13:55 INFO - PROCESS | 18197 | |1;ext.html;561.1386521689208;604.9243844519435;608.8447445901295;610.0544156557335;615.1940957345877;28673.42653146936;28744.856275718645;28754.706038228276;28786;28821;30434.391312173797;36626.71806486774;37181.62818371815;37296.81351593238;37384.81307593465;8522.062573116953;8631.360041592108;8641.351898607598;8641.870371944426;8658.307335413152;8402.075771665111;8505.787355316104;8517.787055323635;8547.615357308905;8558.828823423528;8393.286570641503;8407.159284071575;8492.405531612789;8496.235338819504;8667.69663061793;8479.745607631781;8514.957425212866;8575.056743758181;8575.399722019461;8601.39790214682;8476.406651534395;8567.186117318844;8669.913300866974;8676.34927380449;8683;38879;39415.80292098521;39497;39498.21003579941;39511.80244098761;3330.167458135466;3341.799492030486;3699.500567423417;4089.3865920111925;4132.752034877917;29192.562111568343;29410.852945735347;29635.703642963508;29642.40715185684;30534.389312213632;3903.759009535567;4008.178323443687;4016.4176194451643;4082.6529744971713;4128.504579450455;258173;258715;258845;258987;259120;51418.74290628598;52635.736821316415;57323.42676573264;58409;59805.10292345619;52895.20657190145;53007;53202.201966970526;53234.20148697773;53286.200706989424;11810.940945295219;13526.188428694113;13611.727765444635;13708.86291137076;13717.725645487035;9283.48940808262;10103.242256830767;10357.067863892134;10371.481425928674;10390.116840068527;18586;18698.532536686693;18743.90628046851;18751;18797.90601046986;6813.863722725617;7040.2607726189035;7077.84125841613;7144.3212894774915;7240.312170343809;893.4192774696369;938.7136923238342;1004.8351473426593;1142.5943789954613;1155.9479823407967;24760.25719228426;25536.106236282012;25558;25619.74380256211;25677;988.1551273661061;1053.8629978102952;1057.5505410200633;1060.8620879285797;1132.869719982196;12587.30769807651;14140.646483837987;14284.142951422948;15475.767863482057;15619.3752249911;308536;313600;314542;314567;314944;51096.744516277184;51222.48777512177;51272.23091653628;51302.230466543035;51429.74285128625;1322.781741012722;1324.6158614001831;1325.1585243370337;1326.396489597231;1339.370495866941;28726;29439;29450.410991779616;29863;29887;46305.305420418044;46405;46617;46635;46938.76530617325;288576;292867;295882;304462;304793;30304;30316;30494.542581861733;30504.542431863985;30510.542341864446;42285;42361.57638423699;42630;43414.56585434105;43525.78237108794;34904;35183;35414.468782967764;35519.11202219965;39443.40834887422;34908.301833963684;35318.29363412769;35774.642253577134;36054;36186.638133618326;34978.30043399067;35065.123371915906;35428.46857297194;35824;35913.1021724459;27545;28016.719832801413;31694.36611267808;32271.35457290794;33370.666293336755;23528.29415117549;23714.762852371947;25630;25755;25861.353466162745 23:13:55 INFO - PROCESS | 18197 | |2;jquery.html;347.4787818272591;351.3938456163118;353.9876104336347;354.5001547817578;358.54464829666335;13955.581332560014;14502.782458263107;16317.265723042461;16794.916025419872;17719.11404429778;14127.505537306197;14272.286385680727;15115.470958516455;15216.391344346213;15245;5208.661437006583;5227.660202086861;5312.203169524583;5322.2548843161985;5344.118220493614;3909.882703518899;3976.5029371328583;5335;5679.8580035499235;5924.911126333109;5802.071668533035;5818.41815818419;5822.475977162055;5847.444492773201;5857.76568937242;5678.48893599576;5844.386339434341;5847.26909136358;5850.9414905851245;5861.17943487912;5125.846224613268;5135.563477104451;5138.665986710852;5162.767675454576;5166.715830629314;20247.696284555743;20402.5919481611;20432.897835510877;20531.589368212703;21033.26383576583;2122.8089471947446;2200.9559808803733;2236.9552608947893;2250.17868478006;2296.3799774061076;13063.085584009123;13166.605001849959;13251.072424930258;13446.260455674934;13476.932615336958;1731.419974308608;1747.474898771276;1764.3383731100837;1798.7661603991528;1810.6197698483334;57670.42329576692;59178.70410647919;60423.39576604222;60654.09018864765;60794.088088678705;9269;9500.097490738368;9535;9566.521673916277;9675.806483870283;12134.817977730341;12218.144729869002;12261.283420321162;12269.93865030669;12274.754504909852;6805.557638753465;6856.520043597;6999.09011828459;7117.750878719324;7244.855102897913;6417.550771445954;6459.644719540471;6614.371634694697;6636.203655561267;6652.933470665328;5684.8863022739315;5829.4170582942215;5840.2115714378015;5851.736671849777;5872.207252020922;1596.0822527046994;1698.1678977301033;1702.7786387769759;1723.5001849463765;1724.9482515524555;909.2453263791037;952.2334520710895;962.2206013129388;995.1392045880406;1020.9234307426973;14826.62933426673;16187.595310117105;17108.144592770313;17145.399911003056;17691.734623980392;938.9108034736689;953.4088864903665;956.5026186383042;971.8056388722284;979.3585201692903;9596.95201523988;9864.704058878246;9883.901160988442;10003.149732272694;10062.49687515636;495788;495826;505295.62930594507;506259;522327;66268.33731662718;66650.66674666693;68367.65816170987;68387.65806170937;68687.65656171687;978.7602037500858;996.940183588987;1077.617445806743;1123.2923258347353;1140.5152810055692;14881.255937203314;14958.850411496182;15024.699506010038;15129.47046853355;15429.305681244596;31078.22304442407;31603.683963160995;31744.20639483939;31822;32387.51418728674;38862.4170637435;40537.391939121524;43342.34986475269;43350.78324608357;43780.56219437765;9361.157495825408;9427.62289508412;9709.223262139154;9793.804123917624;9806.117449429586;11446.42767861587;11527.365994870363;11750.58872939443;16635.334586616398;16720.749188761936;13905.37425815861;14127.011109222256;14493.855061449673;14518.274086295432;14812.7778083331;14189.858101418853;14485.85514144845;14585.781213281596;14635.121892686473;14708;14767.04014239071;14909.627259318604;14984.625384365041;15369.769453458432;15443;9154.313426493172;9604.279679024241;9697.9030209697;9897.703068907944;9936.453495057842;9845.852312215466;13788.103773254707;13858.792118118437;14072.437102515785;14572.125672459686 23:13:55 INFO - PROCESS | 18197 | |3;mootools.html;1335.272276609249;1441.6467965348488;1442.5023366938406;1592.6973874963755;1757.4973397744927;6527.249366322874;6983.301669833014;7118.1458225013;7123.931410288459;7216.927830721691;6959.443244540437;7097.183823860258;7126;7128.322809333118;7142.821429464266;1868.4488076017608;1878.3331917169412;2132.7867213278705;2166.8591541549827;2200.1639377036786;2057.5473395852887;2058.1561559760503;2059.34101087652;2060.248009476538;2062.236972320236;2112.049577690038;2128.5317230209407;2172.9239476618322;2173.0330003148606;2177.281497105951;2020.929267475646;2046.1917542570675;2061.7628972668035;2063.0509965416004;2064.886431246281;2113.3765539165984;2138.0592539282666;2140.4327853118934;2148.194427089841;2149.3659370485743;7297.343239108506;7382.741604043887;7392.371648409891;7395.519291246052;7404.333609975074;4397.538258482845;4433.866983990485;4455.688101832873;4456.55434456555;4466.620337271336;2782.6382570265937;2845.1037923054378;2853.9001134960176;2863.9713602863912;2907.0406765767248;916.5005072235648;918.2929144558719;931.4783721116197;937.4328531238639;943.528235882059;9778.706638800848;9783.90216097837;9791.167750741195;9817.90182098177;9835.21318294542;3875.7286989910435;3918.7648741075627;3958.9208215835524;3961.485006949136;3965.6827453803626;8446.366522510836;8478.872816907751;8487.066422693499;8487.405881588353;8500.27747641445;4329.761863097497;4350.499692535335;4353.434053573015;4356.128774245164;4360.825566977349;3939.763614183158;3941.4087886817206;3944.8422063117155;3946.8223929923224;3946.9210615788097;3170.873165073371;3171.238902663344;3403.7106845918374;3438.0889064397957;3473.7047350974944;1057.2652006855162;1084.4306738962107;1095.1622009162998;1100.3672888089382;1103.4979084516526;1038.3717850700218;1066.5467176449977;1069.4385447640052;1211.5335595795682;1345.5828693105168;6623.867522649616;6741.528093033538;6773.62745049027;6777.796666100025;6817.659117044128;1094.578587243917;1097.1716354152722;1098.9395583242838;1111.2721167635211;1116.1740312168936;5392.514673679388;5407.70257635826;5425.891482170335;5462.918056229159;5464.316960379952;8387.748367548984;8390.119037501097;8487.321014318839;8567.614457349435;8657;8565.14348565151;8575;8631.482111073356;8645.265152461985;8645.913540864636;6675.6662166891465;6793.252742198453;6837.555558888656;6878.8624227515165;6888.758893438806;6512.153420055552;6513.73945042193;6526.24948130952;6527.5757075789925;6554.737810487527;7512.286332798375;7570.129435114812;7623.390128789794;7728.8454230916195;7748.806279843049;7666.769996900102;7872.134065252703;7901.723439679584;8010.239027292398;8049.235322644339;6477.319881412383;6507.186601674791;6559.770408035887;6566.474682025331;6568.441682457044;6254.2807577129215;6328.367163283819;6723.193216814014;6782.762603308861;6855.245922948571;6449.548531602931;6554.541182117397;6598.703058362481;6644.501662375438;6721.663916804238;6533.67331633407;6538.509611779041;6618.271990080991;6671.933280667326;6678.365555272241;6551.475881929529;6589.24223714279;6590.143281373391;6599.340065993362;6612.272650008399;6093.177421048279;6102.0541816018585;6102.603330783485;6105.236845394325;6134.2332208473945;6134.018557030854;6141.416565426277;6161.353057928853;6165.84585385351;6212.347703491068 23:13:55 INFO - PROCESS | 18197 | |4;prototype.html;333.96138010786456;338.050079277231;338.34192495596074;342.18901204146175;347.730508855637;5851.6196447230905;5974.372690867462;5980.551458640598;5983.670898100603;5993.041113421853;5832.533397328214;5893.145493903381;5898.88202235955;5907.350191478945;5920.763169473216;4582.725036497813;4586.220342541759;4586.3579098926175;4590.632749380042;4611.7232966021975;4466.352378905057;4578.244589642705;4579.67942244043;4581.404417425747;4581.518940511249;4508.549145085498;4530.411046563942;4530.818767249306;4539.0694907543875;4540.046590216059;4371.672124590653;4422.137683151786;4476.239039363316;4537.2740361542155;4549.499555048958;3988.7008474364247;3993.1813978134414;4016.477857878457;4025.255327764373;4036.777977211252;5645.887082258332;5645.887082258373;5654.547636189095;5654.943450565483;5655.547556195535;5029.974850125763;5156.742162891878;5170.095233334189;5172.043172013189;5174.120399532051;6203.906941395882;6281.7173227204885;6285.59143655661;6287.056941458772;6301.495880329563;4436.290193569013;4440.7335559866515;4446.666500012512;4447.799849006802;4448.266036104039;6337.968310158466;6440.645764482952;6489.70796314167;6498.577592456475;6518.1200537927725;4565.817367305271;4568.954310456853;4571.9085618287445;4574.153781550423;4580.175568397721;4600.815967361335;4633.513481084505;4636.165490211794;4638.443386793607;4651.511591282934;5287.814926477555;5288.81489147878;5291.3385826771655;5291.444398338119;5295.311609490742;6147.84630384244;6306.905396419057;6311.895418301779;6312.368763123743;6323.399277068671;1630.4945466905297;1649.9422520211735;1653.6279337149044;1654.1811803157273;1657.1796960504387;1111.8943700348455;1116.4640972333325;1121.1647322744445;1123.2193625430248;1146.7649131927935;5942.435468630473;5957.1362152487645;5966.105084237399;5976.910346344808;5980;6491.837704057436;6495.7076931538195;6497.545171837926;6508.056331831858;6508.739650414025;5974.61165024272;5975;5975.910361344583;5976.8804623908145;5980.671063091571;3460.86156553735;3532.682058614737;3540.990817616967;3541.3094446583186;3544.0608238816735;6837.897431538531;6845.760398386033;6858.759943401957;6861.313868613099;6866.931330686729;6339.619622822645;6590.176227971504;6692.732290708414;6705.698243578953;6711.395974362234;6635.677512870457;6873.1064961554675;6891.552049116792;6903.9989201565495;6910.032595436643;6514.869702606016;6548.607083575001;6556.508261880474;6558.147440832661;6572.934270657232;6365.8726825464155;6449.226092868886;6475.902861457176;6483.319251478527;6483.935160648333;6786.830329241809;6788.185417749902;6791.7283308669075;6798.048273241849;6803.081583986296;4439.4228750262255;4499.1451624191295;4509.932351014671;4510.797014134438;4512.9097418052115;6407.231132264158;6555.246146693191;6561.639109849004;6571.704273307617;6583.868322633616;6357.713902874474;6358.586691865014;6363.61818290904;6366.6180029198395;6376.489880809431;6361.77733779334;6370.17187765606;6373.904391434225;6375.203099612549;6382.744690212339;6026.126211699191;6194.4115309045565;6250.937490625036;6253.499720022478;6254.843628909313;6397.552171347961;6405.615663060231;6409.9038514423255;6420.775272865428;6429.935700642934;6241.843953901189;6244.687765611792;6249.375062493714;6256.217972753406;6261.436470717657 23:13:55 INFO - PROCESS | 18197 | |5;yui.html;800.9279164875162;800.9359251259892;826.1449399871135;840.5671079394114;849.7450764770567;13161.539346122887;13207.07550471465;13248.337583120854;13327.400266987985;13372.866271337283;12242.693932651666;12303.692407689812;12328.260304381722;12917.483300667962;12975.480980760758;677.156939610186;806.8587997100514;827.1976183102381;827.6730691376903;829.0134739659785;682.0791930893304;818.3003531980161;835.5738573327616;836.8995720513547;837.1210229259284;849.2781136034383;855.6620135046653;861.961211745473;863.0851297624538;864.2135656552539;694.0768777525878;711.9288071192891;838.8028813228887;847.8346722389136;850.4769566716486;629.5341447328989;631.3528633151057;631.6462780842743;632.3865850125371;632.5666918161074;13126.86873131266;13346.13250138738;13372.264525451097;13385.397657105454;13411.329433528284;10822.404767737771;11352.545898164064;11451.656450306504;11566.248193867455;11924.582639607659;9537.14165725088;10223.897761022443;10340.741481462948;10375.377477351307;10677.466126693713;3546.521219635342;3593.1915319053264;3623.9275214495824;3625.800580968046;3634.7637403568947;47523.76238118787;47549.76225118887;47756.76121619404;47990;48154.759226204;9486.383385079947;9488.857667134998;9571.165299806746;9595.376300540442;9744.805103897883;18861.24555017784;18865.52836179079;18881;18903.716444253347;18920.05399730008;7524.360429363456;7531.924680753232;7632.412676657832;7965.960170199228;8188.14024527428;4315.741055536678;4368.301071828492;4453.977730111329;4479.472395623813;4563.771811409416;3028.6668466468673;3043.904194489982;3046.664866864643;3053.8473076346095;3056.5109582467144;525.2987262005189;539.8824433422856;542.7638977044919;543.5461389739612;550.0676353580642;613.1660941120073;669.9698513566901;670.9798706038827;674.8312921769558;678.2064983968768;7721.884171737428;8016.879746803803;8223.17768223173;8263.545504997282;8446.915530844613;554.3984776517443;670.2526682748797;678.6335378895341;679.1917618034523;685.1127789512593;3911.5501717302304;3934.9016274593364;4037.1320166164414;4073.5926407359025;4196.454460920061;52799.73600132052;53150.46849531533;53521.73239133857;54205.45794542004;58993;51526.48473515217;52406.475935240924;52458.737706311986;53195;53267.20099198515;46583;46782.53217467782;47168.29247561289;47844;48355.27467087997;8127.878081828659;8166.877496837671;8349.248567628943;8371.916280837113;8485.40602157843;34871.30257394889;35634.82182589071;35966.460503092996;36162;36271.27457450889;42421.15157696891;42615;45206.54793452023;45330.77334613306;46211.537884620724;9630.759231019281;10317.329373590692;10401.27191096616;10421.635242766466;10455.84316235242;11288.661340159808;11445.828312575484;11502.194846360675;11608.361540115375;11821.038604586558;10598.682039538826;10626.096781773636;10804.729881752704;10918;11275.32348059119;10588.682339529827;10966.177536684621;11075.667729968114;11078.279911805706;11083.889161108285;10413;10704.30422022566;10839.241253112521;11134.777304454028;11344.602938897098;9072.954635227046;9161.954190229006;9534.809303814023;9552.188064014637;9851;8012.439129260896;8468.49189048659;8619.91380086191;8681.392302538761;9018.278537717099 23:13:55 INFO - PROCESS | 18197 | __end_tp_report 23:13:55 INFO - PROCESS | 18197 | __start_cc_report 23:13:55 INFO - PROCESS | 18197 | _x_x_mozilla_cycle_collect,905 23:13:55 INFO - PROCESS | 18197 | __end_cc_report 23:13:55 INFO - PROCESS | 18197 | __startTimestamp1451114035208__endTimestamp 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | ------- Summary: start ------- 23:13:55 INFO - PROCESS | 18197 | Number of tests: 6 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#0] dojo.html Cycles:165 Average:5103.33 Median:5271.82 stddev:546.36 (10.4%) stddev-sans-first:524.07 23:13:55 INFO - PROCESS | 18197 | Values: 3063.2 3120.6 3166.5 3166.7 3198.5 4980.8 5086.9 5105.4 5117.9 5131.2 5080.7 5091.4 5096.4 5210.6 5220.4 4680.9 4694.1 4709.3 4727.2 4818.3 4689.3 4733.6 4741.8 4749.3 4779.1 4581.7 4612.3 4664.8 4693.7 4727.1 4692.5 4695.8 4716.6 4718.2 4743.0 4669.0 4686.5 4714.2 4715.1 4716.9 4848.1 4848.9 4920.6 4949.6 4951.0 5477.5 5510.4 5516.6 5519.9 5544.4 5613.4 5615.7 5621.3 5622.6 5637.5 5106.9 5150.3 5200.2 5228.5 5264.9 5595.0 5612.3 5620.6 5624.4 5651.0 5465.2 5528.3 5533.2 5546.3 5552.9 5424.2 5488.2 5510.0 5522.5 5560.8 5476.1 5477.3 5477.7 5483.2 5491.4 5341.8 5487.3 5492.3 5510.8 5546.0 4209.5 4248.9 4259.9 4292.4 4297.1 3849.5 3863.1 3867.7 3893.7 3923.7 5126.5 5137.5 5141.4 5155.0 5189.8 5404.4 5430.5 5516.4 5522.1 5523.2 5006.4 5029.0 5036.3 5063.7 5064.5 4623.4 4649.6 4652.2 4663.6 4681.9 5595.0 5622.2 5629.0 5723.7 5729.8 5379.9 5417.2 5419.6 5435.2 5469.7 5608.7 5633.0 5634.9 5648.3 5655.5 5309.0 5349.4 5392.0 5443.3 5460.7 5473.3 5492.9 5494.5 5503.5 5548.4 5341.8 5346.2 5364.0 5376.3 5384.2 5224.9 5319.7 5352.5 5357.4 5410.9 5263.5 5267.9 5269.6 5271.1 5271.8 5339.6 5354.9 5365.2 5378.6 5392.1 5196.0 5249.5 5288.3 5298.3 5299.8 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#1] ext.html Cycles:180 Average:44965.13 Median:35421.47 stddev:76040.12 (214.7%) stddev-sans-first:76180.34 23:13:55 INFO - PROCESS | 18197 | Values: 561.1 604.9 608.8 610.1 615.2 28673.4 28744.9 28754.7 28786.0 28821.0 30434.4 36626.7 37181.6 37296.8 37384.8 8522.1 8631.4 8641.4 8641.9 8658.3 8402.1 8505.8 8517.8 8547.6 8558.8 8393.3 8407.2 8492.4 8496.2 8667.7 8479.7 8515.0 8575.1 8575.4 8601.4 8476.4 8567.2 8669.9 8676.3 8683.0 38879.0 39415.8 39497.0 39498.2 39511.8 3330.2 3341.8 3699.5 4089.4 4132.8 29192.6 29410.9 29635.7 29642.4 30534.4 3903.8 4008.2 4016.4 4082.7 4128.5 258173.0 258715.0 258845.0 258987.0 259120.0 51418.7 52635.7 57323.4 58409.0 59805.1 52895.2 53007.0 53202.2 53234.2 53286.2 11810.9 13526.2 13611.7 13708.9 13717.7 9283.5 10103.2 10357.1 10371.5 10390.1 18586.0 18698.5 18743.9 18751.0 18797.9 6813.9 7040.3 7077.8 7144.3 7240.3 893.4 938.7 1004.8 1142.6 1155.9 24760.3 25536.1 25558.0 25619.7 25677.0 988.2 1053.9 1057.6 1060.9 1132.9 12587.3 14140.6 14284.1 15475.8 15619.4 308536.0 313600.0 314542.0 314567.0 314944.0 51096.7 51222.5 51272.2 51302.2 51429.7 1322.8 1324.6 1325.2 1326.4 1339.4 28726.0 29439.0 29450.4 29863.0 29887.0 46305.3 46405.0 46617.0 46635.0 46938.8 288576.0 292867.0 295882.0 304462.0 304793.0 30304.0 30316.0 30494.5 30504.5 30510.5 42285.0 42361.6 42630.0 43414.6 43525.8 34904.0 35183.0 35414.5 35519.1 39443.4 34908.3 35318.3 35774.6 36054.0 36186.6 34978.3 35065.1 35428.5 35824.0 35913.1 27545.0 28016.7 31694.4 32271.4 33370.7 23528.3 23714.8 25630.0 25755.0 25861.4 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#2] jquery.html Cycles:180 Average:27209.22 Median:21386.15 stddev:82369.15 (385.2%) stddev-sans-first:82575.52 23:13:55 INFO - PROCESS | 18197 | Values: 347.5 351.4 354.0 354.5 358.5 13955.6 14502.8 16317.3 16794.9 17719.1 14127.5 14272.3 15115.5 15216.4 15245.0 5208.7 5227.7 5312.2 5322.3 5344.1 3909.9 3976.5 5335.0 5679.9 5924.9 5802.1 5818.4 5822.5 5847.4 5857.8 5678.5 5844.4 5847.3 5850.9 5861.2 5125.8 5135.6 5138.7 5162.8 5166.7 20247.7 20402.6 20432.9 20531.6 21033.3 2122.8 2201.0 2237.0 2250.2 2296.4 13063.1 13166.6 13251.1 13446.3 13476.9 1731.4 1747.5 1764.3 1798.8 1810.6 57670.4 59178.7 60423.4 60654.1 60794.1 9269.0 9500.1 9535.0 9566.5 9675.8 12134.8 12218.1 12261.3 12269.9 12274.8 6805.6 6856.5 6999.1 7117.8 7244.9 6417.6 6459.6 6614.4 6636.2 6652.9 5684.9 5829.4 5840.2 5851.7 5872.2 1596.1 1698.2 1702.8 1723.5 1724.9 909.2 952.2 962.2 995.1 1020.9 14826.6 16187.6 17108.1 17145.4 17691.7 938.9 953.4 956.5 971.8 979.4 9597.0 9864.7 9883.9 10003.1 10062.5 495788.0 495826.0 505295.6 506259.0 522327.0 66268.3 66650.7 68367.7 68387.7 68687.7 978.8 996.9 1077.6 1123.3 1140.5 14881.3 14958.9 15024.7 15129.5 15429.3 31078.2 31603.7 31744.2 31822.0 32387.5 38862.4 40537.4 43342.3 43350.8 43780.6 9361.2 9427.6 9709.2 9793.8 9806.1 11446.4 11527.4 11750.6 16635.3 16720.7 13905.4 14127.0 14493.9 14518.3 14812.8 14189.9 14485.9 14585.8 14635.1 14708.0 14767.0 14909.6 14984.6 15369.8 15443.0 9154.3 9604.3 9697.9 9897.7 9936.5 9845.9 13788.1 13858.8 14072.4 14572.1 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#3] mootools.html Cycles:180 Average:5060.53 Median:6291.32 stddev:2592.96 (41.2%) stddev-sans-first:2585.11 23:13:55 INFO - PROCESS | 18197 | Values: 1335.3 1441.6 1442.5 1592.7 1757.5 6527.2 6983.3 7118.1 7123.9 7216.9 6959.4 7097.2 7126.0 7128.3 7142.8 1868.4 1878.3 2132.8 2166.9 2200.2 2057.5 2058.2 2059.3 2060.2 2062.2 2112.0 2128.5 2172.9 2173.0 2177.3 2020.9 2046.2 2061.8 2063.1 2064.9 2113.4 2138.1 2140.4 2148.2 2149.4 7297.3 7382.7 7392.4 7395.5 7404.3 4397.5 4433.9 4455.7 4456.6 4466.6 2782.6 2845.1 2853.9 2864.0 2907.0 916.5 918.3 931.5 937.4 943.5 9778.7 9783.9 9791.2 9817.9 9835.2 3875.7 3918.8 3958.9 3961.5 3965.7 8446.4 8478.9 8487.1 8487.4 8500.3 4329.8 4350.5 4353.4 4356.1 4360.8 3939.8 3941.4 3944.8 3946.8 3946.9 3170.9 3171.2 3403.7 3438.1 3473.7 1057.3 1084.4 1095.2 1100.4 1103.5 1038.4 1066.5 1069.4 1211.5 1345.6 6623.9 6741.5 6773.6 6777.8 6817.7 1094.6 1097.2 1098.9 1111.3 1116.2 5392.5 5407.7 5425.9 5462.9 5464.3 8387.7 8390.1 8487.3 8567.6 8657.0 8565.1 8575.0 8631.5 8645.3 8645.9 6675.7 6793.3 6837.6 6878.9 6888.8 6512.2 6513.7 6526.2 6527.6 6554.7 7512.3 7570.1 7623.4 7728.8 7748.8 7666.8 7872.1 7901.7 8010.2 8049.2 6477.3 6507.2 6559.8 6566.5 6568.4 6254.3 6328.4 6723.2 6782.8 6855.2 6449.5 6554.5 6598.7 6644.5 6721.7 6533.7 6538.5 6618.3 6671.9 6678.4 6551.5 6589.2 6590.1 6599.3 6612.3 6093.2 6102.1 6102.6 6105.2 6134.2 6134.0 6141.4 6161.4 6165.8 6212.3 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#4] prototype.html Cycles:180 Average:5293.22 Median:5974.81 stddev:1584.15 (26.5%) stddev-sans-first:1544.24 23:13:55 INFO - PROCESS | 18197 | Values: 334.0 338.1 338.3 342.2 347.7 5851.6 5974.4 5980.6 5983.7 5993.0 5832.5 5893.1 5898.9 5907.4 5920.8 4582.7 4586.2 4586.4 4590.6 4611.7 4466.4 4578.2 4579.7 4581.4 4581.5 4508.5 4530.4 4530.8 4539.1 4540.0 4371.7 4422.1 4476.2 4537.3 4549.5 3988.7 3993.2 4016.5 4025.3 4036.8 5645.9 5645.9 5654.5 5654.9 5655.5 5030.0 5156.7 5170.1 5172.0 5174.1 6203.9 6281.7 6285.6 6287.1 6301.5 4436.3 4440.7 4446.7 4447.8 4448.3 6338.0 6440.6 6489.7 6498.6 6518.1 4565.8 4569.0 4571.9 4574.2 4580.2 4600.8 4633.5 4636.2 4638.4 4651.5 5287.8 5288.8 5291.3 5291.4 5295.3 6147.8 6306.9 6311.9 6312.4 6323.4 1630.5 1649.9 1653.6 1654.2 1657.2 1111.9 1116.5 1121.2 1123.2 1146.8 5942.4 5957.1 5966.1 5976.9 5980.0 6491.8 6495.7 6497.5 6508.1 6508.7 5974.6 5975.0 5975.9 5976.9 5980.7 3460.9 3532.7 3541.0 3541.3 3544.1 6837.9 6845.8 6858.8 6861.3 6866.9 6339.6 6590.2 6692.7 6705.7 6711.4 6635.7 6873.1 6891.6 6904.0 6910.0 6514.9 6548.6 6556.5 6558.1 6572.9 6365.9 6449.2 6475.9 6483.3 6483.9 6786.8 6788.2 6791.7 6798.0 6803.1 4439.4 4499.1 4509.9 4510.8 4512.9 6407.2 6555.2 6561.6 6571.7 6583.9 6357.7 6358.6 6363.6 6366.6 6376.5 6361.8 6370.2 6373.9 6375.2 6382.7 6026.1 6194.4 6250.9 6253.5 6254.8 6397.6 6405.6 6409.9 6420.8 6429.9 6241.8 6244.7 6249.4 6256.2 6261.4 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - PROCESS | 18197 | [#5] yui.html Cycles:180 Average:13610.73 Median:48072.38 stddev:15910.04 (33.1%) stddev-sans-first:15925.59 23:13:55 INFO - PROCESS | 18197 | Values: 800.9 800.9 826.1 840.6 849.7 13161.5 13207.1 13248.3 13327.4 13372.9 12242.7 12303.7 12328.3 12917.5 12975.5 677.2 806.9 827.2 827.7 829.0 682.1 818.3 835.6 836.9 837.1 849.3 855.7 862.0 863.1 864.2 694.1 711.9 838.8 847.8 850.5 629.5 631.4 631.6 632.4 632.6 13126.9 13346.1 13372.3 13385.4 13411.3 10822.4 11352.5 11451.7 11566.2 11924.6 9537.1 10223.9 10340.7 10375.4 10677.5 3546.5 3593.2 3623.9 3625.8 3634.8 47523.8 47549.8 47756.8 47990.0 48154.8 9486.4 9488.9 9571.2 9595.4 9744.8 18861.2 18865.5 18881.0 18903.7 18920.1 7524.4 7531.9 7632.4 7966.0 8188.1 4315.7 4368.3 4454.0 4479.5 4563.8 3028.7 3043.9 3046.7 3053.8 3056.5 525.3 539.9 542.8 543.5 550.1 613.2 670.0 671.0 674.8 678.2 7721.9 8016.9 8223.2 8263.5 8446.9 554.4 670.3 678.6 679.2 685.1 3911.6 3934.9 4037.1 4073.6 4196.5 52799.7 53150.5 53521.7 54205.5 58993.0 51526.5 52406.5 52458.7 53195.0 53267.2 46583.0 46782.5 47168.3 47844.0 48355.3 8127.9 8166.9 8349.2 8371.9 8485.4 34871.3 35634.8 35966.5 36162.0 36271.3 42421.2 42615.0 45206.5 45330.8 46211.5 9630.8 10317.3 10401.3 10421.6 10455.8 11288.7 11445.8 11502.2 11608.4 11821.0 10598.7 10626.1 10804.7 10918.0 11275.3 10588.7 10966.2 11075.7 11078.3 11083.9 10413.0 10704.3 10839.2 11134.8 11344.6 9073.0 9162.0 9534.8 9552.2 9851.0 8012.4 8468.5 8619.9 8681.4 9018.3 23:13:55 INFO - PROCESS | 18197 | -------- Summary: end -------- 23:13:55 INFO - PROCESS | 18197 | 23:13:55 INFO - TEST-INFO | 18197: exit 0 23:13:55 INFO - TEST-OK | dromaeo_css | took 1112854ms 23:13:55 INFO - TEST-START | kraken 23:13:55 INFO - operating with platform_type : linux_ 23:13:55 INFO - Initialising browser for kraken test... 23:13:55 INFO - TEST-INFO | started process 18390 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmBmwCP/profile http://localhost:40136/getInfo.html) 23:13:59 INFO - PROCESS | 18390 | __metrics Screen width/height:1600/1200 23:13:59 INFO - PROCESS | 18390 | colorDepth:24 23:13:59 INFO - PROCESS | 18390 | Browser inner width/height: 1024/697 23:13:59 INFO - PROCESS | 18390 | __metrics 23:13:59 INFO - PROCESS | 18390 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:00 INFO - PROCESS | 18390 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:14:01 INFO - TEST-INFO | 18390: exit 0 23:14:01 INFO - Browser initialized. 23:14:01 INFO - Running cycle 1/1 for kraken test... 23:14:01 INFO - TEST-INFO | started process 18474 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmBmwCP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:13 INFO - PROCESS | 18474 | RSS: Main: 150728704 23:14:13 INFO - PROCESS | 18474 | 23:14:15 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:16 INFO - PROCESS | 18474 | RSS: Main: 185057280 23:14:16 INFO - PROCESS | 18474 | 23:14:18 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-dft) 23:14:19 INFO - PROCESS | 18474 | RSS: Main: 175091712 23:14:19 INFO - PROCESS | 18474 | 23:14:22 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-fft) 23:14:22 INFO - PROCESS | 18474 | RSS: Main: 160956416 23:14:22 INFO - PROCESS | 18474 | 23:14:24 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator) 23:14:25 INFO - PROCESS | 18474 | RSS: Main: 162316288 23:14:25 INFO - PROCESS | 18474 | 23:14:27 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:28 INFO - PROCESS | 18474 | RSS: Main: 162930688 23:14:28 INFO - PROCESS | 18474 | 23:14:31 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:31 INFO - PROCESS | 18474 | RSS: Main: 163389440 23:14:31 INFO - PROCESS | 18474 | 23:14:35 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:35 INFO - PROCESS | 18474 | RSS: Main: 165765120 23:14:35 INFO - PROCESS | 18474 | 23:14:38 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial) 23:14:38 INFO - PROCESS | 18474 | RSS: Main: 164925440 23:14:38 INFO - PROCESS | 18474 | 23:14:40 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:41 INFO - PROCESS | 18474 | RSS: Main: 177963008 23:14:41 INFO - PROCESS | 18474 | 23:14:42 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:43 INFO - PROCESS | 18474 | RSS: Main: 177713152 23:14:43 INFO - PROCESS | 18474 | 23:14:45 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:46 INFO - PROCESS | 18474 | RSS: Main: 189919232 23:14:46 INFO - PROCESS | 18474 | 23:14:48 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:14:49 INFO - PROCESS | 18474 | RSS: Main: 194088960 23:14:49 INFO - PROCESS | 18474 | 23:14:51 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:14:52 INFO - PROCESS | 18474 | RSS: Main: 193671168 23:14:52 INFO - PROCESS | 18474 | 23:14:53 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:40136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40136/tests/kraken/driver.html?testName=ai-astar) 23:14:54 INFO - PROCESS | 18474 | RSS: Main: 250925056 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | __start_tp_report 23:14:54 INFO - PROCESS | 18474 | _x_x_mozilla_page_load 23:14:54 INFO - PROCESS | 18474 | _x_x_mozilla_page_load_details 23:14:54 INFO - PROCESS | 18474 | |i|pagename|runs| 23:14:54 INFO - PROCESS | 18474 | |0;ai-astar;110;112;105;112;113;112;102;115;111;103 23:14:54 INFO - PROCESS | 18474 | |1;audio-beat-detection;155;125;150;164;125;148;148;128;166;124 23:14:54 INFO - PROCESS | 18474 | |2;audio-dft;162;162;161;160;162;162;160;164;163;164 23:14:54 INFO - PROCESS | 18474 | |3;audio-fft;71;71;81;98;70;73;73;130;97;74 23:14:54 INFO - PROCESS | 18474 | |4;audio-oscillator;96;96;142;96;97;97;144;97;97;141 23:14:54 INFO - PROCESS | 18474 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;111 23:14:54 INFO - PROCESS | 18474 | |6;imaging-darkroom;148;146;147;147;147;146;147;147;147;146 23:14:54 INFO - PROCESS | 18474 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;96;96 23:14:54 INFO - PROCESS | 18474 | |8;json-parse-financial;57;57;57;58;57;58;58;65;55;55 23:14:54 INFO - PROCESS | 18474 | |9;json-stringify-tinderbox;68;69;67;68;69;69;69;69;68;69 23:14:54 INFO - PROCESS | 18474 | |10;stanford-crypto-aes;87;87;86;90;88;87;87;87;88;86 23:14:54 INFO - PROCESS | 18474 | |11;stanford-crypto-ccm;117;123;122;122;124;117;116;120;125;117 23:14:54 INFO - PROCESS | 18474 | |12;stanford-crypto-pbkdf2;142;146;156;151;153;142;155;152;145;140 23:14:54 INFO - PROCESS | 18474 | |13;stanford-crypto-sha256-iterative;66;69;71;69;70;68;68;67;69;70 23:14:54 INFO - PROCESS | 18474 | __end_tp_report 23:14:54 INFO - PROCESS | 18474 | __start_cc_report 23:14:54 INFO - PROCESS | 18474 | _x_x_mozilla_cycle_collect,961 23:14:54 INFO - PROCESS | 18474 | __end_cc_report 23:14:54 INFO - PROCESS | 18474 | __startTimestamp1451114094187__endTimestamp 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | ------- Summary: start ------- 23:14:54 INFO - PROCESS | 18474 | Number of tests: 14 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 23:14:54 INFO - PROCESS | 18474 | Values: 110.0 112.0 105.0 112.0 113.0 112.0 102.0 115.0 111.0 103.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:16.49 (11.1%) stddev-sans-first:16.93 23:14:54 INFO - PROCESS | 18474 | Values: 155.0 125.0 150.0 164.0 125.0 148.0 148.0 128.0 166.0 124.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 23:14:54 INFO - PROCESS | 18474 | Values: 162.0 162.0 161.0 160.0 162.0 162.0 160.0 164.0 163.0 164.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#3] audio-fft Cycles:10 Average:83.80 Median:73.50 stddev:19.34 (26.3%) stddev-sans-first:19.95 23:14:54 INFO - PROCESS | 18474 | Values: 71.0 71.0 81.0 98.0 70.0 73.0 73.0 130.0 97.0 74.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.50 stddev:22.12 (22.9%) stddev-sans-first:22.85 23:14:54 INFO - PROCESS | 18474 | Values: 96.0 96.0 142.0 96.0 97.0 97.0 144.0 97.0 97.0 141.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:14:54 INFO - PROCESS | 18474 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 23:14:54 INFO - PROCESS | 18474 | Values: 148.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:14:54 INFO - PROCESS | 18474 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.79 (4.9%) stddev-sans-first:2.95 23:14:54 INFO - PROCESS | 18474 | Values: 57.0 57.0 57.0 58.0 57.0 58.0 58.0 65.0 55.0 55.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 23:14:54 INFO - PROCESS | 18474 | Values: 68.0 69.0 67.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.16 (1.3%) stddev-sans-first:1.22 23:14:54 INFO - PROCESS | 18474 | Values: 87.0 87.0 86.0 90.0 88.0 87.0 87.0 87.0 88.0 86.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:122.00 stddev:3.33 (2.7%) stddev-sans-first:3.32 23:14:54 INFO - PROCESS | 18474 | Values: 117.0 123.0 122.0 122.0 124.0 117.0 116.0 120.0 125.0 117.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:151.50 stddev:5.88 (3.9%) stddev-sans-first:5.80 23:14:54 INFO - PROCESS | 18474 | Values: 142.0 146.0 156.0 151.0 153.0 142.0 155.0 152.0 145.0 140.0 23:14:54 INFO - PROCESS | 18474 | 23:14:54 INFO - PROCESS | 18474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.22 23:14:54 INFO - PROCESS | 18474 | Values: 66.0 69.0 71.0 69.0 70.0 68.0 68.0 67.0 69.0 70.0 23:14:54 INFO - PROCESS | 18474 | -------- Summary: end -------- 23:14:54 INFO - PROCESS | 18474 | 23:14:55 INFO - TEST-INFO | 18474: exit 0 23:14:55 INFO - TEST-OK | kraken | took 59142ms 23:14:55 INFO - TEST-START | v8_7 23:14:55 INFO - operating with platform_type : linux_ 23:14:55 INFO - Initialising browser for v8_7 test... 23:14:55 INFO - TEST-INFO | started process 18722 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gkRuK/profile http://localhost:40136/getInfo.html) 23:14:59 INFO - PROCESS | 18722 | __metrics Screen width/height:1600/1200 23:14:59 INFO - PROCESS | 18722 | colorDepth:24 23:14:59 INFO - PROCESS | 18722 | Browser inner width/height: 1024/697 23:14:59 INFO - PROCESS | 18722 | __metrics 23:14:59 INFO - PROCESS | 18722 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:59 INFO - PROCESS | 18722 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:15:00 INFO - TEST-INFO | 18722: exit 0 23:15:00 INFO - Browser initialized. 23:15:00 INFO - Running cycle 1/1 for v8_7 test... 23:15:00 INFO - TEST-INFO | started process 18807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gkRuK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:12 INFO - PROCESS | 18807 | RSS: Main: 149049344 23:15:12 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | Cycle 1(1): loaded http://localhost:40136/tests/v8_7/run.html (next: http://localhost:40136/tests/v8_7/run.html) 23:15:33 INFO - PROCESS | 18807 | RSS: Main: 617336832 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | __start_tp_report 23:15:33 INFO - PROCESS | 18807 | _x_x_mozilla_page_load 23:15:33 INFO - PROCESS | 18807 | _x_x_mozilla_page_load_details 23:15:33 INFO - PROCESS | 18807 | |i|pagename|runs| 23:15:33 INFO - PROCESS | 18807 | |0;Richards;168.69095816464238 23:15:33 INFO - PROCESS | 18807 | |1;DeltaBlue;191.8281220026856 23:15:33 INFO - PROCESS | 18807 | |2;Encrypt;282.4060999717594 23:15:33 INFO - PROCESS | 18807 | |3;Decrypt;5240.837696335078 23:15:33 INFO - PROCESS | 18807 | |4;RayTrace;1990.0596421471173 23:15:33 INFO - PROCESS | 18807 | |5;Earley;821.8390804597701 23:15:33 INFO - PROCESS | 18807 | |6;Boyer;11940.47619047619 23:15:33 INFO - PROCESS | 18807 | |7;RegExp;26051.28205128205 23:15:33 INFO - PROCESS | 18807 | |8;Splay;629.3266205160478 23:15:33 INFO - PROCESS | 18807 | |9;NavierStokes;4854.368932038835 23:15:33 INFO - PROCESS | 18807 | __end_tp_report 23:15:33 INFO - PROCESS | 18807 | __startTimestamp1451114133682__endTimestamp 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | ------- Summary: start ------- 23:15:33 INFO - PROCESS | 18807 | Number of tests: 10 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#0] Richards Cycles:1 Average:168.69 Median:168.69 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 168.7 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#1] DeltaBlue Cycles:1 Average:191.83 Median:191.83 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 191.8 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#2] Encrypt Cycles:1 Average:282.41 Median:282.41 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 282.4 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 5240.8 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 1990.1 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#5] Earley Cycles:1 Average:821.84 Median:821.84 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 821.8 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#6] Boyer Cycles:1 Average:11940.48 Median:11940.48 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 11940.5 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 26051.3 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#8] Splay Cycles:1 Average:629.33 Median:629.33 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 629.3 23:15:33 INFO - PROCESS | 18807 | 23:15:33 INFO - PROCESS | 18807 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 23:15:33 INFO - PROCESS | 18807 | Values: 4854.4 23:15:33 INFO - PROCESS | 18807 | -------- Summary: end -------- 23:15:33 INFO - PROCESS | 18807 | 23:15:34 INFO - TEST-INFO | 18807: exit 0 23:15:34 INFO - TEST-OK | v8_7 | took 39432ms 23:15:34 INFO - SUITE-END | took 1211s 23:15:34 INFO - Completed test suite (00:20:11) 23:15:34 INFO - Working with test: dromaeo_css 23:15:34 INFO - Generating results file: dromaeo_css 23:15:34 INFO - Working with test: kraken 23:15:34 INFO - Generating results file: kraken 23:15:34 INFO - javascript benchmark 23:15:34 INFO - Working with test: v8_7 23:15:34 INFO - Generating results file: v8_7 23:15:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:15:34 INFO - process_Request line: dromaeo_css 6785.47 graph.html#tests=[[72,64,35]] 23:15:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:34 INFO - process_Request line: kraken 1512.70 graph.html#tests=[[232,64,35]] 23:15:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:34 INFO - process_Request line: v8_7 19597.85 graph.html#tests=[[230,64,35]] 23:15:34 INFO - RETURN: dromaeo_css: 6785.47 23:15:34 INFO - RETURN: kraken: 1512.70 23:15:34 INFO - RETURN: v8_7: 19597.85 23:15:34 INFO - javascript benchmark 23:15:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3063.2035670725613, 3120.60992375953, 3166.5250212468127, 3166.746660267179, 3198.504231844064, 4980.804606894347, 5086.949130508694, 5105.412877519091, 5117.948820511794, 5131.153359695651, 5080.745962701869, 5091.389033315998, 5096.439391666913, 5210.55710264627, 5220.373555173375, 4680.859574212779, 4694.131585656647, 4709.317149013391, 4727.220008698578, 4818.3495228144275, 4689.296605509184, 4733.5739783419485, 4741.786619602109, 4749.263864101053, 4779.139754844126, 4581.65637577183, 4612.331211974245, 4664.836730714443, 4693.71837689738, 4727.149113159613, 4692.460367057798, 4695.835645752416, 4716.622670186377, 4718.174319494075, 4743.0, 4669.042846216517, 4686.507916668769, 4714.198586240347, 4715.08055929094, 4716.858494245178, 4848.054629347279, 4848.903021939542, 4920.581750551208, 4949.604031677457, 4950.985048065138, 5477.534409575191, 5510.366307874606, 5516.641418307797, 5519.917201241985, 5544.362398324204, 5613.354464236624, 5615.66306021636, 5621.269234999465, 5622.634528755618, 5637.49262566371, 5106.872328191787, 5150.253213284052, 5200.193969934666, 5228.4510126436935, 5264.868378290574, 5595.0, 5612.298462692163, 5620.606557540933, 5624.353199382042, 5651.0, 5465.234867118606, 5528.281323427928, 5533.22534845122, 5546.306711661043, 5552.91670624941, 5424.186372044225, 5488.1767734839295, 5510.0, 5522.475364840334, 5560.805371812048, 5476.096444086761, 5477.315335583052, 5477.698726570077, 5483.2049352844415, 5491.368492623399, 5341.839744807662, 5487.286652735119, 5492.258545096441, 5510.834674959758, 5545.972270138624, 4209.494860616745, 4248.91502169961, 4259.936100958488, 4292.441982542249, 4297.097609501977, 3849.4610754494392, 3863.0535518798074, 3867.690584753213, 3893.6690381317903, 3923.74495657787, 5126.461721519261, 5137.460566640524, 5141.357330333708, 5155.0, 5189.844304670866, 5404.432534583812, 5430.456954304538, 5516.420775818561, 5522.116461366162, 5523.171524271392, 5006.374203224597, 5028.974855125701, 5036.345275114211, 5063.746812659352, 5064.468230835783, 4623.42207224097, 4649.604783593432, 4652.209124448852, 4663.556962088596, 4681.906361872743, 5595.019116979946, 5622.240997465372, 5629.0, 5723.742431590588, 5729.799457018984, 5379.892402152013, 5417.214503896992, 5419.620626556103, 5435.157550579666, 5469.726513674221, 5608.663480191201, 5633.0, 5634.887302254014, 5648.293963254593, 5655.547556195576, 5309.0, 5349.411564727799, 5392.002479541297, 5443.265159203457, 5460.672359658433, 5473.261109750133, 5492.862678433071, 5494.5054945055135, 5503.477169668875, 5548.361938377138, 5341.839744807662, 5346.1713434417725, 5364.0, 5376.274202982548, 5384.165454354425, 5224.947750522446, 5319.707416092152, 5352.464753524617, 5357.383900851452, 5410.8647283816645, 5263.473652634706, 5267.947320526746, 5269.631125821155, 5271.077561426811, 5271.815486457956, 5339.626226164131, 5354.9464505354445, 5365.2220428036935, 5378.623496355374, 5392.083345831296, 5195.9740201300265, 5249.527542521191, 5288.312519372457, 5298.284731561344, 5299.761510731949], "unit": "score", "name": "dojo.html", "value": 5069.498016849246}, {"lowerIsBetter": false, "replicates": [561.1386521689208, 604.9243844519435, 608.8447445901295, 610.0544156557335, 615.1940957345877, 28673.42653146936, 28744.856275718645, 28754.706038228276, 28786.0, 28821.0, 30434.391312173797, 36626.71806486774, 37181.62818371815, 37296.81351593238, 37384.81307593465, 8522.062573116953, 8631.360041592108, 8641.351898607598, 8641.870371944426, 8658.307335413152, 8402.075771665111, 8505.787355316104, 8517.787055323635, 8547.615357308905, 8558.828823423528, 8393.286570641503, 8407.159284071575, 8492.405531612789, 8496.235338819504, 8667.69663061793, 8479.745607631781, 8514.957425212866, 8575.056743758181, 8575.399722019461, 8601.39790214682, 8476.406651534395, 8567.186117318844, 8669.913300866974, 8676.34927380449, 8683.0, 38879.0, 39415.80292098521, 39497.0, 39498.21003579941, 39511.80244098761, 3330.167458135466, 3341.799492030486, 3699.500567423417, 4089.3865920111925, 4132.752034877917, 29192.562111568343, 29410.852945735347, 29635.703642963508, 29642.40715185684, 30534.389312213632, 3903.759009535567, 4008.178323443687, 4016.4176194451643, 4082.6529744971713, 4128.504579450455, 258173.0, 258715.0, 258845.0, 258987.0, 259120.0, 51418.74290628598, 52635.736821316415, 57323.42676573264, 58409.0, 59805.10292345619, 52895.20657190145, 53007.0, 53202.201966970526, 53234.20148697773, 53286.200706989424, 11810.940945295219, 13526.188428694113, 13611.727765444635, 13708.86291137076, 13717.725645487035, 9283.48940808262, 10103.242256830767, 10357.067863892134, 10371.481425928674, 10390.116840068527, 18586.0, 18698.532536686693, 18743.90628046851, 18751.0, 18797.90601046986, 6813.863722725617, 7040.2607726189035, 7077.84125841613, 7144.3212894774915, 7240.312170343809, 893.4192774696369, 938.7136923238342, 1004.8351473426593, 1142.5943789954613, 1155.9479823407967, 24760.25719228426, 25536.106236282012, 25558.0, 25619.74380256211, 25677.0, 988.1551273661061, 1053.8629978102952, 1057.5505410200633, 1060.8620879285797, 1132.869719982196, 12587.30769807651, 14140.646483837987, 14284.142951422948, 15475.767863482057, 15619.3752249911, 308536.0, 313600.0, 314542.0, 314567.0, 314944.0, 51096.744516277184, 51222.48777512177, 51272.23091653628, 51302.230466543035, 51429.74285128625, 1322.781741012722, 1324.6158614001831, 1325.1585243370337, 1326.396489597231, 1339.370495866941, 28726.0, 29439.0, 29450.410991779616, 29863.0, 29887.0, 46305.305420418044, 46405.0, 46617.0, 46635.0, 46938.76530617325, 288576.0, 292867.0, 295882.0, 304462.0, 304793.0, 30304.0, 30316.0, 30494.542581861733, 30504.542431863985, 30510.542341864446, 42285.0, 42361.57638423699, 42630.0, 43414.56585434105, 43525.78237108794, 34904.0, 35183.0, 35414.468782967764, 35519.11202219965, 39443.40834887422, 34908.301833963684, 35318.29363412769, 35774.642253577134, 36054.0, 36186.638133618326, 34978.30043399067, 35065.123371915906, 35428.46857297194, 35824.0, 35913.1021724459, 27545.0, 28016.719832801413, 31694.36611267808, 32271.35457290794, 33370.666293336755, 23528.29415117549, 23714.762852371947, 25630.0, 25755.0, 25861.353466162745], "unit": "score", "name": "ext.html", "value": 17813.88455331009}, {"lowerIsBetter": false, "replicates": [347.4787818272591, 351.3938456163118, 353.9876104336347, 354.5001547817578, 358.54464829666335, 13955.581332560014, 14502.782458263107, 16317.265723042461, 16794.916025419872, 17719.11404429778, 14127.505537306197, 14272.286385680727, 15115.470958516455, 15216.391344346213, 15245.0, 5208.661437006583, 5227.660202086861, 5312.203169524583, 5322.2548843161985, 5344.118220493614, 3909.882703518899, 3976.5029371328583, 5335.0, 5679.8580035499235, 5924.911126333109, 5802.071668533035, 5818.41815818419, 5822.475977162055, 5847.444492773201, 5857.76568937242, 5678.48893599576, 5844.386339434341, 5847.26909136358, 5850.9414905851245, 5861.17943487912, 5125.846224613268, 5135.563477104451, 5138.665986710852, 5162.767675454576, 5166.715830629314, 20247.696284555743, 20402.5919481611, 20432.897835510877, 20531.589368212703, 21033.26383576583, 2122.8089471947446, 2200.9559808803733, 2236.9552608947893, 2250.17868478006, 2296.3799774061076, 13063.085584009123, 13166.605001849959, 13251.072424930258, 13446.260455674934, 13476.932615336958, 1731.419974308608, 1747.474898771276, 1764.3383731100837, 1798.7661603991528, 1810.6197698483334, 57670.42329576692, 59178.70410647919, 60423.39576604222, 60654.09018864765, 60794.088088678705, 9269.0, 9500.097490738368, 9535.0, 9566.521673916277, 9675.806483870283, 12134.817977730341, 12218.144729869002, 12261.283420321162, 12269.93865030669, 12274.754504909852, 6805.557638753465, 6856.520043597, 6999.09011828459, 7117.750878719324, 7244.855102897913, 6417.550771445954, 6459.644719540471, 6614.371634694697, 6636.203655561267, 6652.933470665328, 5684.8863022739315, 5829.4170582942215, 5840.2115714378015, 5851.736671849777, 5872.207252020922, 1596.0822527046994, 1698.1678977301033, 1702.7786387769759, 1723.5001849463765, 1724.9482515524555, 909.2453263791037, 952.2334520710895, 962.2206013129388, 995.1392045880406, 1020.9234307426973, 14826.62933426673, 16187.595310117105, 17108.144592770313, 17145.399911003056, 17691.734623980392, 938.9108034736689, 953.4088864903665, 956.5026186383042, 971.8056388722284, 979.3585201692903, 9596.95201523988, 9864.704058878246, 9883.901160988442, 10003.149732272694, 10062.49687515636, 495788.0, 495826.0, 505295.62930594507, 506259.0, 522327.0, 66268.33731662718, 66650.66674666693, 68367.65816170987, 68387.65806170937, 68687.65656171687, 978.7602037500858, 996.940183588987, 1077.617445806743, 1123.2923258347353, 1140.5152810055692, 14881.255937203314, 14958.850411496182, 15024.699506010038, 15129.47046853355, 15429.305681244596, 31078.22304442407, 31603.683963160995, 31744.20639483939, 31822.0, 32387.51418728674, 38862.4170637435, 40537.391939121524, 43342.34986475269, 43350.78324608357, 43780.56219437765, 9361.157495825408, 9427.62289508412, 9709.223262139154, 9793.804123917624, 9806.117449429586, 11446.42767861587, 11527.365994870363, 11750.58872939443, 16635.334586616398, 16720.749188761936, 13905.37425815861, 14127.011109222256, 14493.855061449673, 14518.274086295432, 14812.7778083331, 14189.858101418853, 14485.85514144845, 14585.781213281596, 14635.121892686473, 14708.0, 14767.04014239071, 14909.627259318604, 14984.625384365041, 15369.769453458432, 15443.0, 9154.313426493172, 9604.279679024241, 9697.9030209697, 9897.703068907944, 9936.453495057842, 9845.852312215466, 13788.103773254707, 13858.792118118437, 14072.437102515785, 14572.125672459686], "unit": "score", "name": "jquery.html", "value": 8729.921933413678}, {"lowerIsBetter": false, "replicates": [1335.272276609249, 1441.6467965348488, 1442.5023366938406, 1592.6973874963755, 1757.4973397744927, 6527.249366322874, 6983.301669833014, 7118.1458225013, 7123.931410288459, 7216.927830721691, 6959.443244540437, 7097.183823860258, 7126.0, 7128.322809333118, 7142.821429464266, 1868.4488076017608, 1878.3331917169412, 2132.7867213278705, 2166.8591541549827, 2200.1639377036786, 2057.5473395852887, 2058.1561559760503, 2059.34101087652, 2060.248009476538, 2062.236972320236, 2112.049577690038, 2128.5317230209407, 2172.9239476618322, 2173.0330003148606, 2177.281497105951, 2020.929267475646, 2046.1917542570675, 2061.7628972668035, 2063.0509965416004, 2064.886431246281, 2113.3765539165984, 2138.0592539282666, 2140.4327853118934, 2148.194427089841, 2149.3659370485743, 7297.343239108506, 7382.741604043887, 7392.371648409891, 7395.519291246052, 7404.333609975074, 4397.538258482845, 4433.866983990485, 4455.688101832873, 4456.55434456555, 4466.620337271336, 2782.6382570265937, 2845.1037923054378, 2853.9001134960176, 2863.9713602863912, 2907.0406765767248, 916.5005072235648, 918.2929144558719, 931.4783721116197, 937.4328531238639, 943.528235882059, 9778.706638800848, 9783.90216097837, 9791.167750741195, 9817.90182098177, 9835.21318294542, 3875.7286989910435, 3918.7648741075627, 3958.9208215835524, 3961.485006949136, 3965.6827453803626, 8446.366522510836, 8478.872816907751, 8487.066422693499, 8487.405881588353, 8500.27747641445, 4329.761863097497, 4350.499692535335, 4353.434053573015, 4356.128774245164, 4360.825566977349, 3939.763614183158, 3941.4087886817206, 3944.8422063117155, 3946.8223929923224, 3946.9210615788097, 3170.873165073371, 3171.238902663344, 3403.7106845918374, 3438.0889064397957, 3473.7047350974944, 1057.2652006855162, 1084.4306738962107, 1095.1622009162998, 1100.3672888089382, 1103.4979084516526, 1038.3717850700218, 1066.5467176449977, 1069.4385447640052, 1211.5335595795682, 1345.5828693105168, 6623.867522649616, 6741.528093033538, 6773.62745049027, 6777.796666100025, 6817.659117044128, 1094.578587243917, 1097.1716354152722, 1098.9395583242838, 1111.2721167635211, 1116.1740312168936, 5392.514673679388, 5407.70257635826, 5425.891482170335, 5462.918056229159, 5464.316960379952, 8387.748367548984, 8390.119037501097, 8487.321014318839, 8567.614457349435, 8657.0, 8565.14348565151, 8575.0, 8631.482111073356, 8645.265152461985, 8645.913540864636, 6675.6662166891465, 6793.252742198453, 6837.555558888656, 6878.8624227515165, 6888.758893438806, 6512.153420055552, 6513.73945042193, 6526.24948130952, 6527.5757075789925, 6554.737810487527, 7512.286332798375, 7570.129435114812, 7623.390128789794, 7728.8454230916195, 7748.806279843049, 7666.769996900102, 7872.134065252703, 7901.723439679584, 8010.239027292398, 8049.235322644339, 6477.319881412383, 6507.186601674791, 6559.770408035887, 6566.474682025331, 6568.441682457044, 6254.2807577129215, 6328.367163283819, 6723.193216814014, 6782.762603308861, 6855.245922948571, 6449.548531602931, 6554.541182117397, 6598.703058362481, 6644.501662375438, 6721.663916804238, 6533.67331633407, 6538.509611779041, 6618.271990080991, 6671.933280667326, 6678.365555272241, 6551.475881929529, 6589.24223714279, 6590.143281373391, 6599.340065993362, 6612.272650008399, 6093.177421048279, 6102.0541816018585, 6102.603330783485, 6105.236845394325, 6134.2332208473945, 6134.018557030854, 6141.416565426277, 6161.353057928853, 6165.84585385351, 6212.347703491068], "unit": "score", "name": "mootools.html", "value": 4176.974827483998}, {"lowerIsBetter": false, "replicates": [333.96138010786456, 338.050079277231, 338.34192495596074, 342.18901204146175, 347.730508855637, 5851.6196447230905, 5974.372690867462, 5980.551458640598, 5983.670898100603, 5993.041113421853, 5832.533397328214, 5893.145493903381, 5898.88202235955, 5907.350191478945, 5920.763169473216, 4582.725036497813, 4586.220342541759, 4586.3579098926175, 4590.632749380042, 4611.7232966021975, 4466.352378905057, 4578.244589642705, 4579.67942244043, 4581.404417425747, 4581.518940511249, 4508.549145085498, 4530.411046563942, 4530.818767249306, 4539.0694907543875, 4540.046590216059, 4371.672124590653, 4422.137683151786, 4476.239039363316, 4537.2740361542155, 4549.499555048958, 3988.7008474364247, 3993.1813978134414, 4016.477857878457, 4025.255327764373, 4036.777977211252, 5645.887082258332, 5645.887082258373, 5654.547636189095, 5654.943450565483, 5655.547556195535, 5029.974850125763, 5156.742162891878, 5170.095233334189, 5172.043172013189, 5174.120399532051, 6203.906941395882, 6281.7173227204885, 6285.59143655661, 6287.056941458772, 6301.495880329563, 4436.290193569013, 4440.7335559866515, 4446.666500012512, 4447.799849006802, 4448.266036104039, 6337.968310158466, 6440.645764482952, 6489.70796314167, 6498.577592456475, 6518.1200537927725, 4565.817367305271, 4568.954310456853, 4571.9085618287445, 4574.153781550423, 4580.175568397721, 4600.815967361335, 4633.513481084505, 4636.165490211794, 4638.443386793607, 4651.511591282934, 5287.814926477555, 5288.81489147878, 5291.3385826771655, 5291.444398338119, 5295.311609490742, 6147.84630384244, 6306.905396419057, 6311.895418301779, 6312.368763123743, 6323.399277068671, 1630.4945466905297, 1649.9422520211735, 1653.6279337149044, 1654.1811803157273, 1657.1796960504387, 1111.8943700348455, 1116.4640972333325, 1121.1647322744445, 1123.2193625430248, 1146.7649131927935, 5942.435468630473, 5957.1362152487645, 5966.105084237399, 5976.910346344808, 5980.0, 6491.837704057436, 6495.7076931538195, 6497.545171837926, 6508.056331831858, 6508.739650414025, 5974.61165024272, 5975.0, 5975.910361344583, 5976.8804623908145, 5980.671063091571, 3460.86156553735, 3532.682058614737, 3540.990817616967, 3541.3094446583186, 3544.0608238816735, 6837.897431538531, 6845.760398386033, 6858.759943401957, 6861.313868613099, 6866.931330686729, 6339.619622822645, 6590.176227971504, 6692.732290708414, 6705.698243578953, 6711.395974362234, 6635.677512870457, 6873.1064961554675, 6891.552049116792, 6903.9989201565495, 6910.032595436643, 6514.869702606016, 6548.607083575001, 6556.508261880474, 6558.147440832661, 6572.934270657232, 6365.8726825464155, 6449.226092868886, 6475.902861457176, 6483.319251478527, 6483.935160648333, 6786.830329241809, 6788.185417749902, 6791.7283308669075, 6798.048273241849, 6803.081583986296, 4439.4228750262255, 4499.1451624191295, 4509.932351014671, 4510.797014134438, 4512.9097418052115, 6407.231132264158, 6555.246146693191, 6561.639109849004, 6571.704273307617, 6583.868322633616, 6357.713902874474, 6358.586691865014, 6363.61818290904, 6366.6180029198395, 6376.489880809431, 6361.77733779334, 6370.17187765606, 6373.904391434225, 6375.203099612549, 6382.744690212339, 6026.126211699191, 6194.4115309045565, 6250.937490625036, 6253.499720022478, 6254.843628909313, 6397.552171347961, 6405.615663060231, 6409.9038514423255, 6420.775272865428, 6429.935700642934, 6241.843953901189, 6244.687765611792, 6249.375062493714, 6256.217972753406, 6261.436470717657], "unit": "score", "name": "prototype.html", "value": 4784.694771219954}, {"lowerIsBetter": false, "replicates": [800.9279164875162, 800.9359251259892, 826.1449399871135, 840.5671079394114, 849.7450764770567, 13161.539346122887, 13207.07550471465, 13248.337583120854, 13327.400266987985, 13372.866271337283, 12242.693932651666, 12303.692407689812, 12328.260304381722, 12917.483300667962, 12975.480980760758, 677.156939610186, 806.8587997100514, 827.1976183102381, 827.6730691376903, 829.0134739659785, 682.0791930893304, 818.3003531980161, 835.5738573327616, 836.8995720513547, 837.1210229259284, 849.2781136034383, 855.6620135046653, 861.961211745473, 863.0851297624538, 864.2135656552539, 694.0768777525878, 711.9288071192891, 838.8028813228887, 847.8346722389136, 850.4769566716486, 629.5341447328989, 631.3528633151057, 631.6462780842743, 632.3865850125371, 632.5666918161074, 13126.86873131266, 13346.13250138738, 13372.264525451097, 13385.397657105454, 13411.329433528284, 10822.404767737771, 11352.545898164064, 11451.656450306504, 11566.248193867455, 11924.582639607659, 9537.14165725088, 10223.897761022443, 10340.741481462948, 10375.377477351307, 10677.466126693713, 3546.521219635342, 3593.1915319053264, 3623.9275214495824, 3625.800580968046, 3634.7637403568947, 47523.76238118787, 47549.76225118887, 47756.76121619404, 47990.0, 48154.759226204, 9486.383385079947, 9488.857667134998, 9571.165299806746, 9595.376300540442, 9744.805103897883, 18861.24555017784, 18865.52836179079, 18881.0, 18903.716444253347, 18920.05399730008, 7524.360429363456, 7531.924680753232, 7632.412676657832, 7965.960170199228, 8188.14024527428, 4315.741055536678, 4368.301071828492, 4453.977730111329, 4479.472395623813, 4563.771811409416, 3028.6668466468673, 3043.904194489982, 3046.664866864643, 3053.8473076346095, 3056.5109582467144, 525.2987262005189, 539.8824433422856, 542.7638977044919, 543.5461389739612, 550.0676353580642, 613.1660941120073, 669.9698513566901, 670.9798706038827, 674.8312921769558, 678.2064983968768, 7721.884171737428, 8016.879746803803, 8223.17768223173, 8263.545504997282, 8446.915530844613, 554.3984776517443, 670.2526682748797, 678.6335378895341, 679.1917618034523, 685.1127789512593, 3911.5501717302304, 3934.9016274593364, 4037.1320166164414, 4073.5926407359025, 4196.454460920061, 52799.73600132052, 53150.46849531533, 53521.73239133857, 54205.45794542004, 58993.0, 51526.48473515217, 52406.475935240924, 52458.737706311986, 53195.0, 53267.20099198515, 46583.0, 46782.53217467782, 47168.29247561289, 47844.0, 48355.27467087997, 8127.878081828659, 8166.877496837671, 8349.248567628943, 8371.916280837113, 8485.40602157843, 34871.30257394889, 35634.82182589071, 35966.460503092996, 36162.0, 36271.27457450889, 42421.15157696891, 42615.0, 45206.54793452023, 45330.77334613306, 46211.537884620724, 9630.759231019281, 10317.329373590692, 10401.27191096616, 10421.635242766466, 10455.84316235242, 11288.661340159808, 11445.828312575484, 11502.194846360675, 11608.361540115375, 11821.038604586558, 10598.682039538826, 10626.096781773636, 10804.729881752704, 10918.0, 11275.32348059119, 10588.682339529827, 10966.177536684621, 11075.667729968114, 11078.279911805706, 11083.889161108285, 10413.0, 10704.30422022566, 10839.241253112521, 11134.777304454028, 11344.602938897098, 9072.954635227046, 9161.954190229006, 9534.809303814023, 9552.188064014637, 9851.0, 8012.439129260896, 8468.49189048659, 8619.91380086191, 8681.392302538761, 9018.278537717099], "unit": "score", "name": "yui.html", "value": 6194.241599699768}], "name": "dromaeo_css", "value": 6785.467904797757}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 112.0, 113.0, 112.0, 102.0, 115.0, 111.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 150.0, 164.0, 125.0, 148.0, 148.0, 128.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 162.0, 160.0, 164.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 98.0, 70.0, 73.0, 73.0, 130.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 96.0, 97.0, 97.0, 144.0, 97.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 58.0, 57.0, 58.0, 58.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 90.0, 88.0, 87.0, 87.0, 87.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 122.0, 122.0, 124.0, 117.0, 116.0, 120.0, 125.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [142.0, 146.0, 156.0, 151.0, 153.0, 142.0, 155.0, 152.0, 145.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 71.0, 69.0, 70.0, 68.0, 68.0, 67.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1512.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.69095816464238], "unit": "score", "name": "Richards", "value": 209.27025600000007}, {"lowerIsBetter": false, "replicates": [191.8281220026856], "unit": "score", "name": "DeltaBlue", "value": 344.6731340000001}, {"lowerIsBetter": false, "replicates": [282.4060999717594], "unit": "score", "name": "Encrypt", "value": 942.5469209999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [821.8390804597701], "unit": "score", "name": "Earley", "value": 810.9409930069932}, {"lowerIsBetter": false, "replicates": [11940.47619047619], "unit": "score", "name": "Boyer", "value": 55.815445663010976}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [629.3266205160478], "unit": "score", "name": "Splay", "value": 129.48919900000004}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19597.85246294773}]} 23:15:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19597.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1512.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6785.47"}}} 23:15:34 INFO - Return code: 0 23:15:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:35 INFO - # TBPL SUCCESS # 23:15:35 INFO - Running post-action listener: _resource_record_post_action 23:15:35 INFO - Running post-run listener: _resource_record_post_run 23:15:36 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 554835968; Read time: 104; Write time: 441988 23:15:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235323392; Read time: 0; Write time: 267680 23:15:36 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 319512576; Read time: 104; Write time: 174308 23:15:36 INFO - Running post-run listener: _upload_blobber_files 23:15:36 INFO - Blob upload gear active. 23:15:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:15:36 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 23:15:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:15:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:15:36 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:37 INFO - (blobuploader) - INFO - Done attempting. 23:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:38 INFO - (blobuploader) - INFO - Done attempting. 23:15:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:38 INFO - Return code: 0 23:15:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:15:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6735c5ad6e12b765f0eb27d804776eb7b58099a69651eced0aeebfdf49ee7b59bf3f0f87e2cb2499d9455dde42ef8afaa572d92e0719e47bc03097e28319fe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f8985fa31ddb1be6b430a247eea795e38bc7810c64a1395fad44c30e16dfb53b82dd61c0d8517b533f7a71d9e576f0a194465de5019ef015ec0d8e8fbad4e1b"} 23:15:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:15:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:15:38 INFO - Contents: 23:15:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6735c5ad6e12b765f0eb27d804776eb7b58099a69651eced0aeebfdf49ee7b59bf3f0f87e2cb2499d9455dde42ef8afaa572d92e0719e47bc03097e28319fe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f8985fa31ddb1be6b430a247eea795e38bc7810c64a1395fad44c30e16dfb53b82dd61c0d8517b533f7a71d9e576f0a194465de5019ef015ec0d8e8fbad4e1b"} 23:15:38 INFO - Copying logs to upload dir... 23:15:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.006314 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-25 23:15:37.997658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 23:15:38.001371) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6735c5ad6e12b765f0eb27d804776eb7b58099a69651eced0aeebfdf49ee7b59bf3f0f87e2cb2499d9455dde42ef8afaa572d92e0719e47bc03097e28319fe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f8985fa31ddb1be6b430a247eea795e38bc7810c64a1395fad44c30e16dfb53b82dd61c0d8517b533f7a71d9e576f0a194465de5019ef015ec0d8e8fbad4e1b"} build_url:https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/-LzdEAAwSOm79KsPns_9hQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e6735c5ad6e12b765f0eb27d804776eb7b58099a69651eced0aeebfdf49ee7b59bf3f0f87e2cb2499d9455dde42ef8afaa572d92e0719e47bc03097e28319fe6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f8985fa31ddb1be6b430a247eea795e38bc7810c64a1395fad44c30e16dfb53b82dd61c0d8517b533f7a71d9e576f0a194465de5019ef015ec0d8e8fbad4e1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 23:15:38.025247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 23:15:38.025553) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451110329.473579-369899758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 23:15:38.110160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 23:15:38.110496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 23:15:38.110845) ========= ========= Total master_lag: 0.26 =========