builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1450737552.1 results: success (0) buildid: 20151221113009 builduid: 0dd6f278436e49988b821e90e4017cf9 revision: 6587e9c69c362f1674b3e158be23311139411441 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.104747) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.105238) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.105547) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006186 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.128114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.128422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.141776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.142155) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.191381) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.191691) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.192064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.192347) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 14:39:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.8M=0.001s 2015-12-21 14:39:13 (21.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.354507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.354841) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020083 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:12.403984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 14:39:12.404294) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6587e9c69c362f1674b3e158be23311139411441 --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 6587e9c69c362f1674b3e158be23311139411441 --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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 14:39:13,112 truncating revision to first 12 chars 2015-12-21 14:39:13,112 Setting DEBUG logging. 2015-12-21 14:39:13,112 attempt 1/10 2015-12-21 14:39:13,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6587e9c69c36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 14:39:14,281 unpacking tar archive at: fx-team-6587e9c69c36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.470409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 14:39:13.891807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:13.892619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:13.903893) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:13.904183) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:39:13.904619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-21 14:39:13.904954) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:14 INFO - MultiFileLogger online at 20151221 14:39:14 in /builds/slave/test-pgo 14:39:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:39:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:39:14 INFO - {'append_to_log': False, 14:39:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:39:14 INFO - 'blob_upload_branch': 'Fx-Team', 14:39:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:39:14 INFO - 'branch': 'Fx-Team', 14:39:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:14 INFO - 'config_files': ('talos/linux_config.py',), 14:39:14 INFO - 'default_actions': ('clobber', 14:39:14 INFO - 'read-buildbot-config', 14:39:14 INFO - 'download-and-extract', 14:39:14 INFO - 'populate-webroot', 14:39:14 INFO - 'create-virtualenv', 14:39:14 INFO - 'install', 14:39:14 INFO - 'run-tests'), 14:39:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:14 INFO - 'download_minidump_stackwalk': True, 14:39:14 INFO - 'download_symbols': 'ondemand', 14:39:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:14 INFO - 'installer_path': 'installer.exe', 14:39:14 INFO - 'log_level': 'info', 14:39:14 INFO - 'log_name': 'talos', 14:39:14 INFO - 'log_to_console': True, 14:39:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:14 INFO - 'opt_config_files': (), 14:39:14 INFO - 'pip_index': False, 14:39:14 INFO - 'sps_profile': False, 14:39:14 INFO - 'sps_profile_interval': 0, 14:39:14 INFO - 'suite': 'dromaeojs-e10s', 14:39:14 INFO - 'system_bits': '64', 14:39:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:14 INFO - 'title': 'talos-linux64-ix-053', 14:39:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:14 INFO - 'use_talos_json': True, 14:39:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:39:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:14 INFO - 'work_dir': 'build'} 14:39:14 INFO - ##### 14:39:14 INFO - ##### Running clobber step. 14:39:14 INFO - ##### 14:39:14 INFO - Running pre-action listener: _resource_record_pre_action 14:39:14 INFO - Running main action method: clobber 14:39:14 INFO - rmtree: /builds/slave/test-pgo/build 14:39:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:39:15 INFO - Running post-action listener: _resource_record_post_action 14:39:15 INFO - ##### 14:39:15 INFO - ##### Running read-buildbot-config step. 14:39:15 INFO - ##### 14:39:15 INFO - Running pre-action listener: _resource_record_pre_action 14:39:15 INFO - Running main action method: read_buildbot_config 14:39:15 INFO - Using buildbot properties: 14:39:15 INFO - { 14:39:15 INFO - "project": "", 14:39:15 INFO - "product": "firefox", 14:39:15 INFO - "script_repo_revision": "production", 14:39:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:39:15 INFO - "repository": "", 14:39:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:39:15 INFO - "buildid": "20151221113009", 14:39:15 INFO - "pgo_build": "True", 14:39:15 INFO - "basedir": "/builds/slave/test-pgo", 14:39:15 INFO - "buildnumber": 111, 14:39:15 INFO - "slavename": "talos-linux64-ix-053", 14:39:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:39:15 INFO - "platform": "ubuntu64_hw", 14:39:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:39:15 INFO - "branch": "fx-team", 14:39:15 INFO - "repo_path": "integration/fx-team", 14:39:15 INFO - "revision": "6587e9c69c362f1674b3e158be23311139411441", 14:39:15 INFO - "stage_platform": "linux64-pgo", 14:39:15 INFO - "builduid": "0dd6f278436e49988b821e90e4017cf9", 14:39:15 INFO - "slavebuilddir": "test" 14:39:15 INFO - } 14:39:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:39:15 INFO - Running post-action listener: _resource_record_post_action 14:39:15 INFO - ##### 14:39:15 INFO - ##### Running download-and-extract step. 14:39:15 INFO - ##### 14:39:15 INFO - Running pre-action listener: _resource_record_pre_action 14:39:15 INFO - Running main action method: download_and_extract 14:39:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:15 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:39:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json 14:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json 14:39:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:39:16 INFO - Downloaded 1302 bytes. 14:39:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:39:16 INFO - Using the following test package requirements: 14:39:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'jsshell-linux-x86_64.zip'], 14:39:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:39:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:39:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:16 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:17 INFO - Downloaded 23175551 bytes. 14:39:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:39:19 INFO - Return code: 0 14:39:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:19 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:21 INFO - Downloaded 23175551 bytes. 14:39:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:39:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:39:22 INFO - Return code: 0 14:39:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:22 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:39:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:24 INFO - Downloaded 11132277 bytes. 14:39:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:39:24 INFO - Return code: 0 14:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:24 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:39:26 INFO - Downloaded 54940903 bytes. 14:39:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:39:26 INFO - mkdir: /builds/slave/test-pgo/properties 14:39:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:39:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:39:26 INFO - Contents: 14:39:26 INFO - build_url:https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:39:26 INFO - Running post-action listener: _resource_record_post_action 14:39:26 INFO - Running post-action listener: set_extra_try_arguments 14:39:26 INFO - ##### 14:39:26 INFO - ##### Running populate-webroot step. 14:39:26 INFO - ##### 14:39:26 INFO - Running pre-action listener: _resource_record_pre_action 14:39:26 INFO - Running main action method: populate_webroot 14:39:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:26 INFO - '--tppagecycles', 14:39:26 INFO - '7'], 14:39:26 INFO - 'tests': ['tsvgm']}}, 14:39:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:39:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:39:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:39:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'tests': ['damp', 'tps']}, 14:39:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['damp', 'tps']}, 14:39:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:39:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:26 INFO - 'other': {'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'other_l64': {'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'other_nol64': {'tests': ['a11yr', 14:39:26 INFO - 'ts_paint', 14:39:26 INFO - 'tpaint', 14:39:26 INFO - 'sessionrestore', 14:39:26 INFO - 'sessionrestore_no_auto_restore']}, 14:39:26 INFO - 'svgr': {'tests': ['tsvgx', 14:39:26 INFO - 'tsvgr_opacity', 14:39:26 INFO - 'tart', 14:39:26 INFO - 'tscrollx', 14:39:26 INFO - 'cart']}, 14:39:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['tsvgx', 14:39:26 INFO - 'tsvgr_opacity', 14:39:26 INFO - 'tart', 14:39:26 INFO - 'tscrollx', 14:39:26 INFO - 'cart']}, 14:39:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'tests': ['tp5o']}, 14:39:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'talos_options': ['--e10s'], 14:39:26 INFO - 'tests': ['tp5o']}, 14:39:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'talos_options': ['--xperf_path', 14:39:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:26 INFO - 'tests': ['tp5n']}, 14:39:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:26 INFO - 'talos_options': ['--e10s', 14:39:26 INFO - '--xperf_path', 14:39:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:26 INFO - 'tests': ['tp5n']}}, 14:39:26 INFO - 'talos.zip': {'path': '', 14:39:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:26 INFO - Running post-action listener: _resource_record_post_action 14:39:26 INFO - ##### 14:39:26 INFO - ##### Running create-virtualenv step. 14:39:26 INFO - ##### 14:39:26 INFO - Running pre-action listener: _resource_record_pre_action 14:39:26 INFO - Running main action method: create_virtualenv 14:39:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:39:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:39:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:39:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:26 INFO - Using real prefix '/usr' 14:39:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:39:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:29 INFO - Installing pip.................done. 14:39:29 INFO - Return code: 0 14:39:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:29 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:29 INFO - Using env: {'DISPLAY': ':0', 14:39:29 INFO - 'HOME': '/home/cltbld', 14:39:29 INFO - 'LANG': 'en_US.UTF-8', 14:39:29 INFO - 'LANGUAGE': 'en_US:en', 14:39:29 INFO - 'LOGNAME': 'cltbld', 14:39:29 INFO - 'MAIL': '/var/mail/cltbld', 14:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:29 INFO - 'MOZ_NO_REMOTE': '1', 14:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:29 INFO - 'NO_EM_RESTART': '1', 14:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:29 INFO - 'SHELL': '/bin/bash', 14:39:29 INFO - 'SHLVL': '1', 14:39:29 INFO - 'TERM': 'linux', 14:39:29 INFO - 'TMOUT': '86400', 14:39:29 INFO - 'USER': 'cltbld', 14:39:29 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:29 INFO - '_': '/tools/buildbot/bin/python'} 14:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:39:29 INFO - Cleaning up... 14:39:29 INFO - Return code: 0 14:39:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:29 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:39:29 INFO - Using env: {'DISPLAY': ':0', 14:39:29 INFO - 'HOME': '/home/cltbld', 14:39:29 INFO - 'LANG': 'en_US.UTF-8', 14:39:29 INFO - 'LANGUAGE': 'en_US:en', 14:39:29 INFO - 'LOGNAME': 'cltbld', 14:39:29 INFO - 'MAIL': '/var/mail/cltbld', 14:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:29 INFO - 'MOZ_NO_REMOTE': '1', 14:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:29 INFO - 'NO_EM_RESTART': '1', 14:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:29 INFO - 'SHELL': '/bin/bash', 14:39:29 INFO - 'SHLVL': '1', 14:39:29 INFO - 'TERM': 'linux', 14:39:29 INFO - 'TMOUT': '86400', 14:39:29 INFO - 'USER': 'cltbld', 14:39:29 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:29 INFO - '_': '/tools/buildbot/bin/python'} 14:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:29 INFO - Downloading/unpacking psutil>=0.7.1 14:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:31 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:39:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:39:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:31 INFO - Installing collected packages: psutil 14:39:31 INFO - Running setup.py install for psutil 14:39:31 INFO - building 'psutil._psutil_linux' extension 14:39:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:39:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:39:31 INFO - building 'psutil._psutil_posix' extension 14:39:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:39:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:39:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:32 INFO - Successfully installed psutil 14:39:32 INFO - Cleaning up... 14:39:32 INFO - Return code: 0 14:39:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:32 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:39:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:39:32 INFO - Using env: {'DISPLAY': ':0', 14:39:32 INFO - 'HOME': '/home/cltbld', 14:39:32 INFO - 'LANG': 'en_US.UTF-8', 14:39:32 INFO - 'LANGUAGE': 'en_US:en', 14:39:32 INFO - 'LOGNAME': 'cltbld', 14:39:32 INFO - 'MAIL': '/var/mail/cltbld', 14:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:32 INFO - 'MOZ_NO_REMOTE': '1', 14:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:32 INFO - 'NO_EM_RESTART': '1', 14:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:32 INFO - 'SHELL': '/bin/bash', 14:39:32 INFO - 'SHLVL': '1', 14:39:32 INFO - 'TERM': 'linux', 14:39:32 INFO - 'TMOUT': '86400', 14:39:32 INFO - 'USER': 'cltbld', 14:39:32 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:32 INFO - '_': '/tools/buildbot/bin/python'} 14:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:39:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:34 INFO - Installing collected packages: mozsystemmonitor 14:39:34 INFO - Running setup.py install for mozsystemmonitor 14:39:34 INFO - Successfully installed mozsystemmonitor 14:39:34 INFO - Cleaning up... 14:39:34 INFO - Return code: 0 14:39:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:34 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:39:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:39:34 INFO - Using env: {'DISPLAY': ':0', 14:39:34 INFO - 'HOME': '/home/cltbld', 14:39:34 INFO - 'LANG': 'en_US.UTF-8', 14:39:34 INFO - 'LANGUAGE': 'en_US:en', 14:39:34 INFO - 'LOGNAME': 'cltbld', 14:39:34 INFO - 'MAIL': '/var/mail/cltbld', 14:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:34 INFO - 'MOZ_NO_REMOTE': '1', 14:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:34 INFO - 'NO_EM_RESTART': '1', 14:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:34 INFO - 'SHELL': '/bin/bash', 14:39:34 INFO - 'SHLVL': '1', 14:39:34 INFO - 'TERM': 'linux', 14:39:34 INFO - 'TMOUT': '86400', 14:39:34 INFO - 'USER': 'cltbld', 14:39:34 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:34 INFO - '_': '/tools/buildbot/bin/python'} 14:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:34 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:36 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:39:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:39:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:39:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:36 INFO - Downloading docopt-0.6.1.tar.gz 14:39:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:39:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:36 INFO - Running setup.py install for blobuploader 14:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:39:36 INFO - Running setup.py install for requests 14:39:37 INFO - Running setup.py install for docopt 14:39:37 INFO - Successfully installed blobuploader requests docopt 14:39:37 INFO - Cleaning up... 14:39:37 INFO - Return code: 0 14:39:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:37 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:39:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:37 INFO - Using env: {'DISPLAY': ':0', 14:39:37 INFO - 'HOME': '/home/cltbld', 14:39:37 INFO - 'LANG': 'en_US.UTF-8', 14:39:37 INFO - 'LANGUAGE': 'en_US:en', 14:39:37 INFO - 'LOGNAME': 'cltbld', 14:39:37 INFO - 'MAIL': '/var/mail/cltbld', 14:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:37 INFO - 'MOZ_NO_REMOTE': '1', 14:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:37 INFO - 'NO_EM_RESTART': '1', 14:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:37 INFO - 'SHELL': '/bin/bash', 14:39:37 INFO - 'SHLVL': '1', 14:39:37 INFO - 'TERM': 'linux', 14:39:37 INFO - 'TMOUT': '86400', 14:39:37 INFO - 'USER': 'cltbld', 14:39:37 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:37 INFO - '_': '/tools/buildbot/bin/python'} 14:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:37 INFO - Running setup.py (path:/tmp/pip-KX03iR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:37 INFO - Running setup.py (path:/tmp/pip-lnn2GY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:37 INFO - Running setup.py (path:/tmp/pip-NrWp0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:37 INFO - Running setup.py (path:/tmp/pip-y0LMjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:37 INFO - Running setup.py (path:/tmp/pip-f5_JDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:37 INFO - Running setup.py (path:/tmp/pip-3IxiPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:38 INFO - Running setup.py (path:/tmp/pip-idvIbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:38 INFO - Running setup.py (path:/tmp/pip-Ju9WVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:38 INFO - Running setup.py (path:/tmp/pip-RNiEFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:38 INFO - Running setup.py (path:/tmp/pip-Fk3ka1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:38 INFO - Running setup.py (path:/tmp/pip-pAn1GZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:38 INFO - Running setup.py (path:/tmp/pip-YG8Plv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:38 INFO - Running setup.py (path:/tmp/pip-sw7pPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:38 INFO - Running setup.py (path:/tmp/pip-zDGSa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:38 INFO - Running setup.py (path:/tmp/pip-rp2sxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:38 INFO - Running setup.py (path:/tmp/pip-7IM_EV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:38 INFO - Running setup.py (path:/tmp/pip-nIqONB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:38 INFO - Running setup.py install for manifestparser 14:39:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:39:38 INFO - Running setup.py install for mozcrash 14:39:39 INFO - Running setup.py install for mozdebug 14:39:39 INFO - Running setup.py install for mozdevice 14:39:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for mozfile 14:39:39 INFO - Running setup.py install for mozhttpd 14:39:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for mozinfo 14:39:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for mozInstall 14:39:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for mozleak 14:39:39 INFO - Running setup.py install for mozlog 14:39:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for moznetwork 14:39:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:39:39 INFO - Running setup.py install for mozprocess 14:39:40 INFO - Running setup.py install for mozprofile 14:39:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:39:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:39:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:39:40 INFO - Running setup.py install for mozrunner 14:39:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:39:40 INFO - Running setup.py install for mozscreenshot 14:39:40 INFO - Running setup.py install for moztest 14:39:40 INFO - Running setup.py install for mozversion 14:39:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:39:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:40 INFO - Cleaning up... 14:39:40 INFO - Return code: 0 14:39:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:40 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:39:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:40 INFO - Using env: {'DISPLAY': ':0', 14:39:40 INFO - 'HOME': '/home/cltbld', 14:39:40 INFO - 'LANG': 'en_US.UTF-8', 14:39:40 INFO - 'LANGUAGE': 'en_US:en', 14:39:40 INFO - 'LOGNAME': 'cltbld', 14:39:40 INFO - 'MAIL': '/var/mail/cltbld', 14:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:40 INFO - 'MOZ_NO_REMOTE': '1', 14:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:40 INFO - 'NO_EM_RESTART': '1', 14:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:40 INFO - 'SHELL': '/bin/bash', 14:39:40 INFO - 'SHLVL': '1', 14:39:40 INFO - 'TERM': 'linux', 14:39:40 INFO - 'TMOUT': '86400', 14:39:40 INFO - 'USER': 'cltbld', 14:39:40 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:40 INFO - '_': '/tools/buildbot/bin/python'} 14:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:40 INFO - Running setup.py (path:/tmp/pip-np7PQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:39:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:40 INFO - Running setup.py (path:/tmp/pip-ImhoMY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:40 INFO - Running setup.py (path:/tmp/pip-jRPEJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:41 INFO - Running setup.py (path:/tmp/pip-qjzzBX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:41 INFO - Running setup.py (path:/tmp/pip-v84VNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:41 INFO - Running setup.py (path:/tmp/pip-put8ub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:41 INFO - Running setup.py (path:/tmp/pip-dwt8vr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:41 INFO - Running setup.py (path:/tmp/pip-I5B24V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:41 INFO - Running setup.py (path:/tmp/pip-bZtTTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:41 INFO - Running setup.py (path:/tmp/pip-PJKyWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:41 INFO - Running setup.py (path:/tmp/pip-mBexDL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:41 INFO - Running setup.py (path:/tmp/pip-27Ct8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:41 INFO - Running setup.py (path:/tmp/pip-pE2Z80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:41 INFO - Running setup.py (path:/tmp/pip-FTnJH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:41 INFO - Running setup.py (path:/tmp/pip-r2kS7N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:39:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:41 INFO - Running setup.py (path:/tmp/pip-7cUda6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:39:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:42 INFO - Running setup.py (path:/tmp/pip-jiEZcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:43 INFO - Downloading blessings-1.5.1.tar.gz 14:39:43 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:39:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:43 INFO - Installing collected packages: blessings 14:39:43 INFO - Running setup.py install for blessings 14:39:43 INFO - Successfully installed blessings 14:39:43 INFO - Cleaning up... 14:39:44 INFO - Return code: 0 14:39:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:39:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:39:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:39:44 INFO - Reading from file tmpfile_stdout 14:39:44 INFO - Current package versions: 14:39:44 INFO - argparse == 1.2.1 14:39:44 INFO - blessings == 1.5.1 14:39:44 INFO - blobuploader == 1.2.4 14:39:44 INFO - docopt == 0.6.1 14:39:44 INFO - manifestparser == 1.1 14:39:44 INFO - mozInstall == 1.12 14:39:44 INFO - mozcrash == 0.16 14:39:44 INFO - mozdebug == 0.1 14:39:44 INFO - mozdevice == 0.47 14:39:44 INFO - mozfile == 1.2 14:39:44 INFO - mozhttpd == 0.7 14:39:44 INFO - mozinfo == 0.9 14:39:44 INFO - mozleak == 0.1 14:39:44 INFO - mozlog == 3.1 14:39:44 INFO - moznetwork == 0.27 14:39:44 INFO - mozprocess == 0.22 14:39:44 INFO - mozprofile == 0.28 14:39:44 INFO - mozrunner == 6.11 14:39:44 INFO - mozscreenshot == 0.1 14:39:44 INFO - mozsystemmonitor == 0.0 14:39:44 INFO - moztest == 0.7 14:39:44 INFO - mozversion == 1.4 14:39:44 INFO - psutil == 3.1.1 14:39:44 INFO - requests == 1.2.3 14:39:44 INFO - wsgiref == 0.1.2 14:39:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:39:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:44 INFO - Using env: {'DISPLAY': ':0', 14:39:44 INFO - 'HOME': '/home/cltbld', 14:39:44 INFO - 'LANG': 'en_US.UTF-8', 14:39:44 INFO - 'LANGUAGE': 'en_US:en', 14:39:44 INFO - 'LOGNAME': 'cltbld', 14:39:44 INFO - 'MAIL': '/var/mail/cltbld', 14:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:44 INFO - 'MOZ_NO_REMOTE': '1', 14:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:44 INFO - 'NO_EM_RESTART': '1', 14:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:44 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:44 INFO - 'SHELL': '/bin/bash', 14:39:44 INFO - 'SHLVL': '1', 14:39:44 INFO - 'TERM': 'linux', 14:39:44 INFO - 'TMOUT': '86400', 14:39:44 INFO - 'USER': 'cltbld', 14:39:44 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:44 INFO - '_': '/tools/buildbot/bin/python'} 14:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:39:44 INFO - Cleaning up... 14:39:44 INFO - Return code: 0 14:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 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 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:39:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:39:44 INFO - Using env: {'DISPLAY': ':0', 14:39:44 INFO - 'HOME': '/home/cltbld', 14:39:44 INFO - 'LANG': 'en_US.UTF-8', 14:39:44 INFO - 'LANGUAGE': 'en_US:en', 14:39:44 INFO - 'LOGNAME': 'cltbld', 14:39:44 INFO - 'MAIL': '/var/mail/cltbld', 14:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:44 INFO - 'MOZ_NO_REMOTE': '1', 14:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:44 INFO - 'NO_EM_RESTART': '1', 14:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:44 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:44 INFO - 'SHELL': '/bin/bash', 14:39:44 INFO - 'SHLVL': '1', 14:39:44 INFO - 'TERM': 'linux', 14:39:44 INFO - 'TMOUT': '86400', 14:39:44 INFO - 'USER': 'cltbld', 14:39:44 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:44 INFO - '_': '/tools/buildbot/bin/python'} 14:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:44 INFO - Downloading/unpacking jsonschema 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:39:46 INFO - Downloading/unpacking functools32 (from jsonschema) 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:39:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:46 INFO - warning: no files found matching '*.txt' 14:39:46 INFO - no previously-included directories found matching 'build' 14:39:46 INFO - no previously-included directories found matching 'dist' 14:39:46 INFO - no previously-included directories found matching '.git*' 14:39:46 INFO - Installing collected packages: jsonschema, functools32 14:39:46 INFO - Running setup.py install for functools32 14:39:46 INFO - warning: no files found matching '*.txt' 14:39:46 INFO - no previously-included directories found matching 'build' 14:39:46 INFO - no previously-included directories found matching 'dist' 14:39:46 INFO - no previously-included directories found matching '.git*' 14:39:46 INFO - Successfully installed jsonschema functools32 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4aaa896f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:39:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:39:46 INFO - Using env: {'DISPLAY': ':0', 14:39:46 INFO - 'HOME': '/home/cltbld', 14:39:46 INFO - 'LANG': 'en_US.UTF-8', 14:39:46 INFO - 'LANGUAGE': 'en_US:en', 14:39:46 INFO - 'LOGNAME': 'cltbld', 14:39:46 INFO - 'MAIL': '/var/mail/cltbld', 14:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:46 INFO - 'MOZ_NO_REMOTE': '1', 14:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:46 INFO - 'NO_EM_RESTART': '1', 14:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:46 INFO - 'SHELL': '/bin/bash', 14:39:46 INFO - 'SHLVL': '1', 14:39:46 INFO - 'TERM': 'linux', 14:39:46 INFO - 'TMOUT': '86400', 14:39:46 INFO - 'USER': 'cltbld', 14:39:46 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:46 INFO - '_': '/tools/buildbot/bin/python'} 14:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:47 INFO - Downloading/unpacking flake8 14:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:39:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:39:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:39:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:39:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:39:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:39:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:49 INFO - no previously-included directories found matching 'docs/_build' 14:39:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:39:49 INFO - Running setup.py install for pep8 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:49 INFO - no previously-included directories found matching 'docs/_build' 14:39:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:39:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:39:49 INFO - Cleaning up... 14:39:49 INFO - Return code: 0 14:39:49 INFO - Running post-action listener: _resource_record_post_action 14:39:49 INFO - Running post-action listener: _start_resource_monitoring 14:39:49 INFO - Starting resource monitoring. 14:39:49 INFO - ##### 14:39:49 INFO - ##### Running install step. 14:39:49 INFO - ##### 14:39:49 INFO - Running pre-action listener: _resource_record_pre_action 14:39:49 INFO - Running main action method: install 14:39:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:39:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:39:49 INFO - Reading from file tmpfile_stdout 14:39:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:39:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:39:50 INFO - Reading from file tmpfile_stdout 14:39:50 INFO - Output received: 14:39:50 INFO - Usage: mozinstall [options] installer 14:39:50 INFO - Options: 14:39:50 INFO - -h, --help show this help message and exit 14:39:50 INFO - -d DEST, --destination=DEST 14:39:50 INFO - Directory to install application into. [default: 14:39:50 INFO - "/builds/slave/test-pgo"] 14:39:50 INFO - --app=APP Application being installed. [default: firefox] 14:39:50 INFO - mkdir: /builds/slave/test-pgo/build/application 14:39:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:39:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:40:05 INFO - Reading from file tmpfile_stdout 14:40:05 INFO - Output received: 14:40:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:40:05 INFO - Running post-action listener: _resource_record_post_action 14:40:05 INFO - ##### 14:40:05 INFO - ##### Running run-tests step. 14:40:05 INFO - ##### 14:40:05 INFO - Running pre-action listener: _resource_record_pre_action 14:40:05 INFO - Running main action method: run_tests 14:40:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:40:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:40:05 INFO - Python 2.7.3 14:40:05 INFO - Return code: 0 14:40:05 INFO - grabbing minidump binary from tooltool 14:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:05 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 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:40:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:40:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:40:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:05 INFO - Return code: 0 14:40:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:40:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:40:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:40:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:40:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:40:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:40:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:40:06 INFO - Return code: 0 14:40:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:40:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:40:06 INFO - Using env: {'DISPLAY': ':0', 14:40:06 INFO - 'HOME': '/home/cltbld', 14:40:06 INFO - 'LANG': 'en_US.UTF-8', 14:40:06 INFO - 'LANGUAGE': 'en_US:en', 14:40:06 INFO - 'LOGNAME': 'cltbld', 14:40:06 INFO - 'MAIL': '/var/mail/cltbld', 14:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:06 INFO - 'MOZ_NO_REMOTE': '1', 14:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:06 INFO - 'NO_EM_RESTART': '1', 14:40:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:40:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:40:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:40:06 INFO - 'SHELL': '/bin/bash', 14:40:06 INFO - 'SHLVL': '1', 14:40:06 INFO - 'TERM': 'linux', 14:40:06 INFO - 'TMOUT': '86400', 14:40:06 INFO - 'USER': 'cltbld', 14:40:06 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089', 14:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:06 INFO - '_': '/tools/buildbot/bin/python'} 14:40:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:40:07 INFO - mozversion application_buildid: 20151221113009 14:40:07 INFO - mozversion application_changeset: 6587e9c69c362f1674b3e158be23311139411441 14:40:07 INFO - mozversion application_display_name: Nightly 14:40:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:07 INFO - mozversion application_name: Firefox 14:40:07 INFO - mozversion application_remotingname: firefox 14:40:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:40:07 INFO - mozversion application_vendor: Mozilla 14:40:07 INFO - mozversion application_version: 46.0a1 14:40:07 INFO - mozversion platform_buildid: 20151221113009 14:40:07 INFO - mozversion platform_changeset: 6587e9c69c362f1674b3e158be23311139411441 14:40:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:40:07 INFO - mozversion platform_version: 46.0a1 14:40:07 INFO - using testdate: 1450737607 14:40:07 INFO - actual date: 1450737607 14:40:07 INFO - starting webserver on 'localhost:54715' 14:40:07 INFO - SUITE-START | Running 3 tests 14:40:07 INFO - TEST-START | dromaeo_css 14:40:07 INFO - operating with platform_type : linux_ 14:40:07 INFO - Initialising browser for dromaeo_css test... 14:40:07 INFO - TEST-INFO | started process 30122 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCjtnrI/profile http://localhost:54715/getInfo.html) 14:40:10 INFO - PROCESS | 30122 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 14:40:11 INFO - PROCESS | 30122 | __metrics Screen width/height:1600/1200 14:40:11 INFO - PROCESS | 30122 | colorDepth:24 14:40:11 INFO - PROCESS | 30122 | Browser inner width/height: 1024/697 14:40:11 INFO - PROCESS | 30122 | __metrics 14:40:11 INFO - PROCESS | 30122 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:40:12 INFO - TEST-INFO | 30122: exit 0 14:40:12 INFO - Browser initialized. 14:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:12 INFO - TEST-INFO | started process 30256 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCjtnrI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:24 INFO - PROCESS | 30256 | RSS: Main: 151289856 14:40:24 INFO - PROCESS | 30256 | 14:41:14 INFO - PROCESS | 30256 | 1450737674049 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:43:22 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54715/tests/dromaeo/cssquery-ext.html) 14:43:24 INFO - PROCESS | 30256 | RSS: Main: 158265344 14:43:24 INFO - PROCESS | 30256 | 14:46:26 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-ext.html (next: http://localhost:54715/tests/dromaeo/cssquery-jquery.html) 14:46:26 INFO - PROCESS | 30256 | RSS: Main: 156106752 14:46:26 INFO - PROCESS | 30256 | 14:49:28 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54715/tests/dromaeo/cssquery-mootools.html) 14:49:28 INFO - PROCESS | 30256 | RSS: Main: 155226112 14:49:28 INFO - PROCESS | 30256 | 14:52:30 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54715/tests/dromaeo/cssquery-prototype.html) 14:52:31 INFO - PROCESS | 30256 | RSS: Main: 153427968 14:52:31 INFO - PROCESS | 30256 | 14:55:33 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54715/tests/dromaeo/cssquery-yui.html) 14:55:34 INFO - PROCESS | 30256 | RSS: Main: 153284608 14:55:34 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | Cycle 1(1): loaded http://localhost:54715/tests/dromaeo/cssquery-yui.html (next: http://localhost:54715/tests/dromaeo/cssquery-dojo.html) 14:58:36 INFO - PROCESS | 30256 | RSS: Main: 154816512 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | __start_tp_report 14:58:36 INFO - PROCESS | 30256 | _x_x_mozilla_page_load 14:58:36 INFO - PROCESS | 30256 | _x_x_mozilla_page_load_details 14:58:36 INFO - PROCESS | 30256 | |i|pagename|runs| 14:58:36 INFO - PROCESS | 30256 | |0;dojo.html;3205.3268813549153;3223.5003574445955;3244;3282.7209687176587;3292.7981286830313;5236.7119808410525;5374.973125134369;5403.135498320269;5426.593005524586;5428.267183930173;5315.309009828727;5329.227262047001;5332.546733527654;5336.226247194155;5460.918086228699;4831.347768051321;4915.877103072416;4970.2296144097545;4995.0509403213455;5000.449950505442;4967.503249675022;5003.774830132635;5019.021290848286;5036.6222533309965;5086.567641750437;4807.206810876201;4849.248366503198;4895.8776030599165;4930.827421040264;4943.1102401567705;4969.353983982095;4970.378702662168;4978.427480839714;4995.875103122415;5000.74996250186;4924.507549245082;4956.2565615157655;4957.405111386656;4972.8508144755715;4987.47631498691;5122.948770512285;5123.385193776733;5233.476652334774;5275.340582427197;5336.359636843565;5685.118806584986;5824.242848429677;5829.358770535237;5830.941690583125;5832.912506312408;5862.443067908542;5870.735816888207;5874.206982057411;5876.11858221266;5882.029465138247;5329.120695085307;5356.91964620531;5425.403205647375;5487.64330318528;5538.778448862041;5957.165996760457;5964.940350596438;5980.641161530322;5981.282246130492;5991.3409524953095;5710.086386178192;5757.395473475309;5772.6536407815665;5778.451047150514;5780.21967034445;5791.478766910914;5803.912941305884;5814.5348372130975;5837.066069428956;5885.205497257901;5714.457126572969;5734.340550836707;5786.71066446676;5811.82564523065;5823.184754134425;5583.330000399978;5644.604877658525;5746.367899531048;5799.159121927297;5799.681017543991;4421.9336709949375;4471.396361491222;4488.685791994594;4497.257952437876;4507.684462087688;3997.620226078518;4000.2199571083943;4003.7197396181987;4025.1949610077518;4037.8384864605673;5362;5509.862253443615;5530.5299049580435;5538.335399752055;5553.694546799965;5681.687507187062;5697.202391665171;5736.4550367715;5738.1679656450415;5794.130880367894;5478.890422191534;5491.066518691832;5504.889902201933;5505.394406615269;5510.724463776795;5013.924791128136;5168.043911876315;5172.405173405032;5174.09453345663;5220.477952204825;5866.149408335853;5899.321578018497;5930.199423077829;5944.138099975566;5970.611910225822;5885.61743486672;5888.4700376966275;5895.764169433174;5899.852503687443;5901.29184497863;5854.648721076749;5890.6760128191645;5957.255343082114;5959.970200148971;5960.493358064613;5671.092625179951;5715;5716.28546431696;5717.685527296038;5800.535957123504;5787.102999035156;5889.58772885911;5906.734196961061;5908.793192238251;5931.584789064724;5516.062269414129;5520.1443776214755;5529.087700529368;5736.082226843685;5751.654900705971;5650.915236271541;5655.717214139194;5740.971295143498;5808.883822323614;5822.272215973004;5562.415946325577;5565.888682226414;5566.749496272759;5569.749361278671;5569.972150139223;5605.607607467438;5630.662160270397;5657.15142728594;5693.658380497183;5706.087026075808;5604.411536788579;5645.802396916089;5655.575831812713;5726.141078838207;5791.276090488689 14:58:36 INFO - PROCESS | 30256 | |1;ext.html;548.5780280063519;591.1192323438075;594.6313285762826;594.6669864875668;601.858563237639;37940.620593794054;38424.61575384245;38492.42261366078;38552.99999999996;38659.61340386595;42276;42278.154436911245;42637.78681106598;42650.14699706004;42762.35856462156;8710.956445217766;8941.821163576724;8993.10068993102;9002.279817614575;9007;8800.779980500474;8863.157999990022;8863.335249856254;8873.95563022184;8882.955585222066;8835.249003834682;8861.645534178657;8872.512011839346;8885.511296878669;8890.977537583163;8718;8810.955945220298;8833.425827321204;8846;8863.601137948808;8756.693515726982;8833.514156721378;8883.378163528556;8888.555572221363;8891.19979201875;39892.60107398918;40408.59591404078;40414.79792601048;40467;40507;3320.186554294189;3346.2303670156;3505.386557352453;3551.6448355164534;3641.3445579795625;29039.854800726072;29226.123216303546;29518.26204344887;30210.395792084255;30211.546826797614;3553.7690050146657;3588.22853086585;3594.6944509716704;3597.8201089945396;3615.1865830188262;264548;266303;267300;269135;269143;42223.57776422196;42676.78661606672;42976;60580;60809;40435.59564404377;40575.797121014795;40758.388624170664;40832.59167408347;41140.794296028325;13685.452581896812;13727.245001525012;13799.2410417426;13837.86162138386;13860.4455821766;10528.684139475828;10553.31403458788;10593.947030264953;10608.628697995688;10615.363078215332;13951.441942322397;14137;14304.57086287413;14329.211893345757;14397.712045759026;5674.744636491285;5679.545636349165;5688.23208866806;5740.368559458456;5791.652500849962;868.5613765048736;923.3951761596165;931.9580618872031;944.7213072143734;973.6981535723806;28696;29044;32579;32675.67324326726;32974.17564560905;965.180634503965;1010.3432768700256;1056.894310568937;1059.0891833023593;1108.2962318927378;14711.926440367944;14740.11559306445;14786.704265914621;14951;15053.623659408602;379233;384154;384340;387009;388128;52683.473165268624;53309;53342;53395.73302133542;53406.46593534093;1298.9610311690665;1300.5318085489216;1322.6098301001227;1329.2091205732575;1331.2079312808862;27580.448391031667;28325.71674283231;28618;28782.424351513273;28832.567511486926;46202.53797462117;46415;46615.53384466112;46717.76641116773;46837.2974405391;307073;309308;309852;310930;311037;32462.35075298528;32503.349933000736;32916.177095571846;33035.504467433486;33049.669503305624;43015;43597.12805743931;43977.56022439735;44332;44720;36978.44532331963;37045;37296.44055339226;37892.62107378891;38254.61745382511;36845.63154368422;37234.6276537242;37520.62479375171;37608.623913760515;40794;35048.64951350556;35542.64457355393;35626.643733562334;35711.28577428489;36143.63856361508;32008.35983280368;32661.836690816395;32867.34265314633;33394;33458.16354591155;25817.612735809354;25843.61234581445;25916.48167036611;25950;25964 14:58:36 INFO - PROCESS | 30256 | |2;jquery.html;363.37136753416587;364.2060308527409;364.21148214116437;364.93613617616927;368.2487725040917;14438.639034024129;14803;16749.078800665957;17059.914700426496;17583.73624395635;11039.503222354993;11397.259178153414;11424.885751142487;14986.475473358434;15382.23088845556;4759.904801903968;4876.4148302203785;4877.756112194376;4910;4997.600191984632;5315.867103322428;5326.360836699601;5347.224652425396;5363.9463605363835;5374.758135883894;5203;5302.814401495929;5318.335208098988;5330.973345133289;5331.600129990247;5266.868328291805;5272.947270527322;5322.680639161663;5340.91988620171;5349.117395629716;4740.312654665088;4774.092922344744;4789.928151077736;4796.496367881392;4800.879978000543;19719.704204436945;19884.90057549703;20199.38404927617;20241.190352386035;20414.79585204144;2075.833933285349;2139.5506943541873;2149.849510534263;2155.23489161347;2668.5997100434897;9945.701628951143;10051.849222261671;10584.100351470135;10860.837087443695;13658.590242292747;1732.9653406931916;1741.1468380493593;1754.0966402302824;1761.9911900440416;1785.2501949181376;59597;62513;62842.68578657123;63511.682441587494;65074;10242.6415075472;10373.325733827278;10390.168786497063;10468.581256749798;10500.73748156287;13508.459661613622;13678.384472698752;13711.520096796763;13730.51943181984;13748.106373085917;7089.645517724093;7271.3455788979245;7314.232005639437;7318.926810731931;7336;6710.429613482811;6722.29415911332;6763.458923286125;6909.861802763917;7003.509754317149;4447.2439685253585;4483.529229430928;4498.6626003049905;4510.797014134372;4520.9095818084115;1833.0193346559527;1848.2606957216951;1851.1484717030048;1857.3127942661301;1860.2930886263134;768.5696010234286;862.7239283429368;885.5085427587621;911.5123408976166;1022.0341777020644;16435.91782041106;16629.16854157287;16700.498985030226;16844.831551684572;16878.409255675993;838.0990435282096;855.1277696749405;878.7495563764296;892.455602082729;892.9776755581032;8684.60919258635;9585.520723963913;9607.711768646952;9618.470984095802;9753.122219000325;482909;493002;495035;495155;495808;76040;78663.60668196737;78820.60589697016;79157.20842791499;79419;1060.8726952765717;1075.473018221066;1116.6370929447962;1124.7300647844622;1126.4592995362273;14806.185659788815;14866;14912.478063268167;14920;15174.24128793578;35059.824700876336;35332.470012949314;35443;35620.643793561736;36168.638313616524;45357.54642453665;45722.08555828931;46700;47732.52267477281;47794.52205477901;9496.572654230438;9694.85457718149;9697.175740062174;9732.172765315028;9773.511324433608;15584.454544090902;16503.504894853173;17583.384581539583;17664.470065898044;17944;13983.440662373798;14685.632859178606;14847.480338188112;15046.097234165985;15294.923525382303;14002.929985350416;14084.647883802987;14363.281835907954;14609.269536523343;14798.778018329518;14836;14918.552443426715;15110.848891510945;15196.544103676908;15294;9542.188913942393;9689.70930872075;9745.561449734638;9784.461854597781;9787.755306117404;14225.64435889111;14251.073680210753;14624.488142915372;14668.633284167981;14712.926435367755 14:58:36 INFO - PROCESS | 30256 | |3;mootools.html;1453.832809226939;1518.5064853922474;1610.7181243282423;1636;1744.1453687693026;7474.7757567273;7513.549187048781;7809.492382995101;7936.484128531649;7936.722214722486;7821.960890195541;7890.7632771016815;7967.282944534991;8006.679732810695;8020.278174964252;2286.0512887151854;2307.653851922208;2312.595295823224;2318.304508647399;2326.732425771041;2276.590213761522;2300.1604414388794;2303.665968434576;2307.238611258289;2321.7562155973633;2263.321003698892;2316.073570571776;2323.512062466884;2335.6730057791924;2340.508493216427;2242.2264318809985;2249.325202439262;2276.044061494168;2285.897134628929;2296.0930432479245;2289.7366802817724;2300.1259521381935;2310.7689231076924;2322.744498105207;2324.0239099578216;7728.845423091563;7899.565523896184;7950.761477155695;7954.403419743485;7971.561564113971;4523.615492683126;4630.8147674093;4667.393238878924;4672.719636821802;4685.086408150412;2999.145243605562;3006.969930300713;3095.520194369854;3116.3144108296137;3123.593932788746;937.4234845569994;970.1026550440814;991.2367477042709;992.4839083676447;1019.5921631347446;10358;10387.480625968747;10388;10400.583976640924;10410.271281010257;4134.64855487281;4212.494500659879;4228.725132866354;4244.766537840386;4255.148970205909;8638.654453821777;8663.870041949376;8666.913330866611;8668.60991255395;8677.39258251929;4567.703099298535;4601.5168407317415;4605.194091034055;4608.170529304691;4654.37165982588;4274.700770946004;4280.272353699878;4281.357796330575;4294.3558466230315;4310.224159651293;3403.6426175251736;3404.3191361727754;3413.9829300853335;3421.674940880612;3425.3149370126075;1008.9596416143419;1014.7108074198818;1018.0379541333369;1018.2159737002466;1023.9129673977646;1016.7204018894863;1019.7807471393686;1037.9273450858368;1140.7718456308605;1298.2210673595955;7076.752313668997;7288.08898887639;7340.522866013692;7346.118465784033;7397.889031664529;1095.6001059613184;1097.8463015177722;1113.4098927568402;1118.3625333559792;1124.578283143821;5823;5828.446297601721;5843.853903652443;5875.089361149029;5876.206712093898;9053.59258833354;9133.81732365349;9381.108794664497;9481.431114133175;9484.715458536117;9244.029376915461;9265.351425400157;9289.953550232205;9309.069093090637;9330.486823224788;7214.2785721427435;7247.855042899112;7310.597917114504;7327.047483827068;7333.303336183054;7060.682269297997;7078.787636370917;7086.858262834818;7106.218315985341;7119.288071192839;7900.723474678589;8165.38759593021;8177.386695997943;8188.2630563249595;8207.302379297827;8318.83362332762;8477.109903460048;8495.702650407206;8529.189726975927;8597.699080532151;6517.120188774645;6628.602283862983;6792.3547263011915;6800.251972282946;6808.251092379934;7509.66206520697;7543.321101100927;7562.395008399205;7566.810829729301;7624.961875190588;6608.933910661024;6657.7669781557415;6756.155480564929;6886.655667216719;6886.965565172142;6666.400023997863;6830.180378354629;6856.142982127234;6875.5530890491955;6908.205556361083;6419.2938776735455;6471.352864713491;6477.77327793525;6481.708323125376;6553.541252112497;6384.808455746335;6454.806355809334;6469.611823290617;6483.448906842971;6490.707918143789;6446.742130314735;6487.091807147098;6515.869682606416;6545.050967609574;6583.111279977142 14:58:36 INFO - PROCESS | 30256 | |4;prototype.html;342.998285008575;346.6810534308436;356.41369946438124;356.657608695652;356.69042946918705;6271.059341098838;6292.150559674443;6332.176817013782;6377.107204991299;6380.29816720161;6021.2473440819895;6269.780557680482;6280.057991301307;6286.52851036173;6321.589096708711;4842.7723247306285;4851.611871050308;4854.199057155565;4864.489228630996;4867.075255701423;4844;4848.103100926322;4853.660243782937;4867.561919427251;4868.391451068616;4712.552307530779;4800.4719480857075;4814.711117332971;4829.082474329884;4831.710097394168;4779.474257831635;4794.760261986904;4800.495947925452;4811.326414301965;4812.831550895702;4223.408722778813;4236.364545318196;4236.809343579546;4256.212600668886;4258;5920.141579470953;5924.229850119457;5931.110333449974;5956.880862382772;5966.731497082642;5459.481349271813;5577.581681373873;5581.190727344553;5587.944120558783;5588.133839254922;6646.8005959821285;6677.565958212749;6704.463642908556;6710.7315707371645;6714.731410743564;4631.096936097462;4640.767961601907;4642.326862604938;4643.605293550052;4649.628029757611;6891.620960847152;6891.793246202622;6925.896111558331;6943.652817359111;7016.894746578805;4702.905941881211;4729.148753224384;4743.1225223333795;4745.905081898342;4755.476897541268;4797.736124513185;4804.759762011886;4811.591014763784;4815.470298267188;4821.156297647968;5539.7784088636;5577.693226872561;5584.63699859516;5590.944090559043;5593.133064375028;6536.444402225864;6701.698423570951;6726.831829204211;6805.625690586966;6807.795766127024;1653.768472413863;1682.9747553786704;1686.2917574618689;1689.4678176374402;1691.2981112838033;1098.2477003252798;1118.4407796101948;1123.971900702489;1128.1031579894004;1139.3101670294095;6297.748090076346;6349.015902535114;6354.555181137369;6361.632249066381;6364.586301890362;6866.382025617719;6878.243393226741;6887.5178737488895;6899.689513971884;6933.5493192942295;6293.433590976834;6348.206474190726;6350.333215012357;6352.523560732963;6364.586301890362;3790.6209379061875;3824.961750382516;3826.9617303826603;3831.6934645228316;3839.1361943562474;7142.285771422816;7153.177384600734;7187.281271872876;7204.495685302083;7242.746503872339;7021.087258656342;7176.569405835667;7186.676599553032;7194.172670142896;7209.134903811576;7129.9305104233745;7149.0348802911985;7162.391196748335;7162.928370716226;7165.570065796069;6971.686274117778;7008.7897363077145;7014.719411223494;7015.824604384931;7033.753818616324;6777.966110169417;6859.794206173823;6890.2420733720255;6915.51591388598;6947.305269473012;7123.501354905314;7124.465665075037;7127.679254433459;7129.21578626361;7165.140183178052;4694.131585656664;4702.576768090751;4712.717236965793;4726.314684370678;4758.8096476141955;6907.102076729993;7003.894941575983;7018.192907815666;7026.437884969088;7050.224475307815;6778.93221067783;6813.591184528944;6813.965930170318;6823.590584564942;6827.522073455009;6807.659617019228;6812.625305608239;6818.897716534355;6820.556663816836;6823.965880170766;6524.836879077871;6610.07458955737;6681.064650948774;6685.76599819004;6686.498512611476;6802.93197068023;6824.692888819915;6849.075374824534;6852.862942741217;6856.5200435971;6516.348365163446;6621.6689165540565;6648.767293144911;6664.133662624022;6685 14:58:36 INFO - PROCESS | 30256 | |5;yui.html;811.9309858662014;859.9484030958143;863.9827203455931;867.0722327109991;890.3989806880354;13182.472701091956;13481.39333729982;13496.865031349696;13585.116967397113;13662.726745465085;12271.141020128594;12802.80795788064;12852.228866268031;12919.74160516789;13003;835.0605568735173;841.2344766262718;851.8637018077109;861.8750281209252;867.1501928110456;839.689314953465;839.7270886961732;844.9915500845005;848.4018766769412;848.4951453884929;886.6276164011099;892.7232557907037;894.5929602031093;895.9462432254086;897.6364572348177;884.9026607073217;888.7822483491553;889.3596610440472;890.132121181849;890.9287257019455;643.3020173112179;651.1307404614797;653.7090994507446;653.7744478155076;654.564714464885;13825.101368411122;13832.23922684252;13919.956003299692;13963.58109256724;13993.790093148611;11306.364390599814;11497.827532587018;11678.007369373528;11822.645320640395;12438.689032774162;9593.184579310768;9624.230061595055;9887.802243955153;10351.482425878752;10642.467876606217;3593.3531964246426;3613.6747692707518;3623.673869351771;3629.546306711661;3760.172761992357;48007;48458.51541484575;48461.27308090346;48629;49066.75466622644;8969.730908072768;9263.490508021989;9301.255899528021;9316.673916413029;9656.855147172799;16048.518544443685;16093;16141.59646008859;16164.75752863708;16268.186590670419;6037.016522203423;6209.9379006210265;6340.270868850049;6370.904436433457;6584.374484423972;3973.1457736586194;3991.9201615967518;4042;4090.3250963591267;4125.154343359604;2893.956590651142;2906.636670416198;2921.985390073036;2922.517784565523;2939.3239554902493;540.5567434703505;554.2794367322465;564.5201578658108;566.2101368590793;568.4457653787524;545.6807767456082;611.6849822341497;612.1980205930246;631.7094136697079;640.4652115483624;7358.595277259802;7917.920820791834;8864.556772161366;8958.10418958112;9622.422654640744;525.716113298822;628.6919409489409;642.1299139665779;642.392938672959;688.3288793426369;3940.6453419191835;4012.9598704012587;4018.276710192135;4038.7778672173313;4091.4067460218102;52511;53304.20043699347;54247.45752542503;57578.4242157573;57827.71086144543;48736.75631621819;49182.262266066034;49980.750096249285;50086;50125.49874501281;44587.554124458344;44626.77686611611;44983.55016449859;45213;45247;7912.802179945547;8137.145599711945;8226.917730822615;8351.415400921876;8363.916360836314;33213.50179747257;33988.660113398546;34501.827490862386;34548;35145.82427087848;39707;40997.1800563993;43198.352024719024;43226.567734322256;43944;10672.733181670521;10983.780324393627;10988.835167472655;11072.224944253825;11087.501062452371;12109.939450303045;12135.939320303341;12244.755104897675;12728.554500592434;12759.48962041508;10636.946815265874;10999.835002474809;11154.107671386431;11258.549658013915;11288.096952243637;10975.725606859893;11124.443777810915;11194.720131996764;11394.601188958346;11400.543978240778;10770.838437423601;10958.397288149228;10999.175061870552;11179.105671546095;11340.829887551858;8955.59699813497;9501.239900808057;9503.19222866064;9517.762055948657;9740.269479788902;8297.792555185928;8350.206730360605;8462.661493540189;8726.817217022246;9073.546322683707 14:58:36 INFO - PROCESS | 30256 | __end_tp_report 14:58:36 INFO - PROCESS | 30256 | __start_cc_report 14:58:36 INFO - PROCESS | 30256 | _x_x_mozilla_cycle_collect,311 14:58:36 INFO - PROCESS | 30256 | __end_cc_report 14:58:36 INFO - PROCESS | 30256 | __startTimestamp1450738716767__endTimestamp 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | ------- Summary: start ------- 14:58:36 INFO - PROCESS | 30256 | Number of tests: 6 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#0] dojo.html Cycles:165 Average:5397.40 Median:5569.97 stddev:590.30 (10.6%) stddev-sans-first:566.51 14:58:36 INFO - PROCESS | 30256 | Values: 3205.3 3223.5 3244.0 3282.7 3292.8 5236.7 5375.0 5403.1 5426.6 5428.3 5315.3 5329.2 5332.5 5336.2 5460.9 4831.3 4915.9 4970.2 4995.1 5000.4 4967.5 5003.8 5019.0 5036.6 5086.6 4807.2 4849.2 4895.9 4930.8 4943.1 4969.4 4970.4 4978.4 4995.9 5000.7 4924.5 4956.3 4957.4 4972.9 4987.5 5122.9 5123.4 5233.5 5275.3 5336.4 5685.1 5824.2 5829.4 5830.9 5832.9 5862.4 5870.7 5874.2 5876.1 5882.0 5329.1 5356.9 5425.4 5487.6 5538.8 5957.2 5964.9 5980.6 5981.3 5991.3 5710.1 5757.4 5772.7 5778.5 5780.2 5791.5 5803.9 5814.5 5837.1 5885.2 5714.5 5734.3 5786.7 5811.8 5823.2 5583.3 5644.6 5746.4 5799.2 5799.7 4421.9 4471.4 4488.7 4497.3 4507.7 3997.6 4000.2 4003.7 4025.2 4037.8 5362.0 5509.9 5530.5 5538.3 5553.7 5681.7 5697.2 5736.5 5738.2 5794.1 5478.9 5491.1 5504.9 5505.4 5510.7 5013.9 5168.0 5172.4 5174.1 5220.5 5866.1 5899.3 5930.2 5944.1 5970.6 5885.6 5888.5 5895.8 5899.9 5901.3 5854.6 5890.7 5957.3 5960.0 5960.5 5671.1 5715.0 5716.3 5717.7 5800.5 5787.1 5889.6 5906.7 5908.8 5931.6 5516.1 5520.1 5529.1 5736.1 5751.7 5650.9 5655.7 5741.0 5808.9 5822.3 5562.4 5565.9 5566.7 5569.7 5570.0 5605.6 5630.7 5657.2 5693.7 5706.1 5604.4 5645.8 5655.6 5726.1 5791.3 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#1] ext.html Cycles:180 Average:47873.15 Median:37750.62 stddev:85151.96 (225.6%) stddev-sans-first:85316.70 14:58:36 INFO - PROCESS | 30256 | Values: 548.6 591.1 594.6 594.7 601.9 37940.6 38424.6 38492.4 38553.0 38659.6 42276.0 42278.2 42637.8 42650.1 42762.4 8711.0 8941.8 8993.1 9002.3 9007.0 8800.8 8863.2 8863.3 8874.0 8883.0 8835.2 8861.6 8872.5 8885.5 8891.0 8718.0 8811.0 8833.4 8846.0 8863.6 8756.7 8833.5 8883.4 8888.6 8891.2 39892.6 40408.6 40414.8 40467.0 40507.0 3320.2 3346.2 3505.4 3551.6 3641.3 29039.9 29226.1 29518.3 30210.4 30211.5 3553.8 3588.2 3594.7 3597.8 3615.2 264548.0 266303.0 267300.0 269135.0 269143.0 42223.6 42676.8 42976.0 60580.0 60809.0 40435.6 40575.8 40758.4 40832.6 41140.8 13685.5 13727.2 13799.2 13837.9 13860.4 10528.7 10553.3 10593.9 10608.6 10615.4 13951.4 14137.0 14304.6 14329.2 14397.7 5674.7 5679.5 5688.2 5740.4 5791.7 868.6 923.4 932.0 944.7 973.7 28696.0 29044.0 32579.0 32675.7 32974.2 965.2 1010.3 1056.9 1059.1 1108.3 14711.9 14740.1 14786.7 14951.0 15053.6 379233.0 384154.0 384340.0 387009.0 388128.0 52683.5 53309.0 53342.0 53395.7 53406.5 1299.0 1300.5 1322.6 1329.2 1331.2 27580.4 28325.7 28618.0 28782.4 28832.6 46202.5 46415.0 46615.5 46717.8 46837.3 307073.0 309308.0 309852.0 310930.0 311037.0 32462.4 32503.3 32916.2 33035.5 33049.7 43015.0 43597.1 43977.6 44332.0 44720.0 36978.4 37045.0 37296.4 37892.6 38254.6 36845.6 37234.6 37520.6 37608.6 40794.0 35048.6 35542.6 35626.6 35711.3 36143.6 32008.4 32661.8 32867.3 33394.0 33458.2 25817.6 25843.6 25916.5 25950.0 25964.0 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#2] jquery.html Cycles:180 Average:27482.20 Median:363.79 stddev:80544.93 (22140.6%) stddev-sans-first:80745.14 14:58:36 INFO - PROCESS | 30256 | Values: 363.4 364.2 364.2 364.9 368.2 14438.6 14803.0 16749.1 17059.9 17583.7 11039.5 11397.3 11424.9 14986.5 15382.2 4759.9 4876.4 4877.8 4910.0 4997.6 5315.9 5326.4 5347.2 5363.9 5374.8 5203.0 5302.8 5318.3 5331.0 5331.6 5266.9 5272.9 5322.7 5340.9 5349.1 4740.3 4774.1 4789.9 4796.5 4800.9 19719.7 19884.9 20199.4 20241.2 20414.8 2075.8 2139.6 2149.8 2155.2 2668.6 9945.7 10051.8 10584.1 10860.8 13658.6 1733.0 1741.1 1754.1 1762.0 1785.3 59597.0 62513.0 62842.7 63511.7 65074.0 10242.6 10373.3 10390.2 10468.6 10500.7 13508.5 13678.4 13711.5 13730.5 13748.1 7089.6 7271.3 7314.2 7318.9 7336.0 6710.4 6722.3 6763.5 6909.9 7003.5 4447.2 4483.5 4498.7 4510.8 4520.9 1833.0 1848.3 1851.1 1857.3 1860.3 768.6 862.7 885.5 911.5 1022.0 16435.9 16629.2 16700.5 16844.8 16878.4 838.1 855.1 878.7 892.5 893.0 8684.6 9585.5 9607.7 9618.5 9753.1 482909.0 493002.0 495035.0 495155.0 495808.0 76040.0 78663.6 78820.6 79157.2 79419.0 1060.9 1075.5 1116.6 1124.7 1126.5 14806.2 14866.0 14912.5 14920.0 15174.2 35059.8 35332.5 35443.0 35620.6 36168.6 45357.5 45722.1 46700.0 47732.5 47794.5 9496.6 9694.9 9697.2 9732.2 9773.5 15584.5 16503.5 17583.4 17664.5 17944.0 13983.4 14685.6 14847.5 15046.1 15294.9 14002.9 14084.6 14363.3 14609.3 14798.8 14836.0 14918.6 15110.8 15196.5 15294.0 9542.2 9689.7 9745.6 9784.5 9787.8 14225.6 14251.1 14624.5 14668.6 14712.9 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#3] mootools.html Cycles:180 Average:5394.49 Median:6470.48 stddev:2779.38 (43.0%) stddev-sans-first:2771.40 14:58:36 INFO - PROCESS | 30256 | Values: 1453.8 1518.5 1610.7 1636.0 1744.1 7474.8 7513.5 7809.5 7936.5 7936.7 7822.0 7890.8 7967.3 8006.7 8020.3 2286.1 2307.7 2312.6 2318.3 2326.7 2276.6 2300.2 2303.7 2307.2 2321.8 2263.3 2316.1 2323.5 2335.7 2340.5 2242.2 2249.3 2276.0 2285.9 2296.1 2289.7 2300.1 2310.8 2322.7 2324.0 7728.8 7899.6 7950.8 7954.4 7971.6 4523.6 4630.8 4667.4 4672.7 4685.1 2999.1 3007.0 3095.5 3116.3 3123.6 937.4 970.1 991.2 992.5 1019.6 10358.0 10387.5 10388.0 10400.6 10410.3 4134.6 4212.5 4228.7 4244.8 4255.1 8638.7 8663.9 8666.9 8668.6 8677.4 4567.7 4601.5 4605.2 4608.2 4654.4 4274.7 4280.3 4281.4 4294.4 4310.2 3403.6 3404.3 3414.0 3421.7 3425.3 1009.0 1014.7 1018.0 1018.2 1023.9 1016.7 1019.8 1037.9 1140.8 1298.2 7076.8 7288.1 7340.5 7346.1 7397.9 1095.6 1097.8 1113.4 1118.4 1124.6 5823.0 5828.4 5843.9 5875.1 5876.2 9053.6 9133.8 9381.1 9481.4 9484.7 9244.0 9265.4 9290.0 9309.1 9330.5 7214.3 7247.9 7310.6 7327.0 7333.3 7060.7 7078.8 7086.9 7106.2 7119.3 7900.7 8165.4 8177.4 8188.3 8207.3 8318.8 8477.1 8495.7 8529.2 8597.7 6517.1 6628.6 6792.4 6800.3 6808.3 7509.7 7543.3 7562.4 7566.8 7625.0 6608.9 6657.8 6756.2 6886.7 6887.0 6666.4 6830.2 6856.1 6875.6 6908.2 6419.3 6471.4 6477.8 6481.7 6553.5 6384.8 6454.8 6469.6 6483.4 6490.7 6446.7 6487.1 6515.9 6545.1 6583.1 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#4] prototype.html Cycles:180 Average:5618.00 Median:6348.61 stddev:1699.60 (26.8%) stddev-sans-first:1657.61 14:58:36 INFO - PROCESS | 30256 | Values: 343.0 346.7 356.4 356.7 356.7 6271.1 6292.2 6332.2 6377.1 6380.3 6021.2 6269.8 6280.1 6286.5 6321.6 4842.8 4851.6 4854.2 4864.5 4867.1 4844.0 4848.1 4853.7 4867.6 4868.4 4712.6 4800.5 4814.7 4829.1 4831.7 4779.5 4794.8 4800.5 4811.3 4812.8 4223.4 4236.4 4236.8 4256.2 4258.0 5920.1 5924.2 5931.1 5956.9 5966.7 5459.5 5577.6 5581.2 5587.9 5588.1 6646.8 6677.6 6704.5 6710.7 6714.7 4631.1 4640.8 4642.3 4643.6 4649.6 6891.6 6891.8 6925.9 6943.7 7016.9 4702.9 4729.1 4743.1 4745.9 4755.5 4797.7 4804.8 4811.6 4815.5 4821.2 5539.8 5577.7 5584.6 5590.9 5593.1 6536.4 6701.7 6726.8 6805.6 6807.8 1653.8 1683.0 1686.3 1689.5 1691.3 1098.2 1118.4 1124.0 1128.1 1139.3 6297.7 6349.0 6354.6 6361.6 6364.6 6866.4 6878.2 6887.5 6899.7 6933.5 6293.4 6348.2 6350.3 6352.5 6364.6 3790.6 3825.0 3827.0 3831.7 3839.1 7142.3 7153.2 7187.3 7204.5 7242.7 7021.1 7176.6 7186.7 7194.2 7209.1 7129.9 7149.0 7162.4 7162.9 7165.6 6971.7 7008.8 7014.7 7015.8 7033.8 6778.0 6859.8 6890.2 6915.5 6947.3 7123.5 7124.5 7127.7 7129.2 7165.1 4694.1 4702.6 4712.7 4726.3 4758.8 6907.1 7003.9 7018.2 7026.4 7050.2 6778.9 6813.6 6814.0 6823.6 6827.5 6807.7 6812.6 6818.9 6820.6 6824.0 6524.8 6610.1 6681.1 6685.8 6686.5 6802.9 6824.7 6849.1 6852.9 6856.5 6516.3 6621.7 6648.8 6664.1 6685.0 14:58:36 INFO - PROCESS | 30256 | 14:58:36 INFO - PROCESS | 30256 | [#5] yui.html Cycles:180 Average:13367.04 Median:48682.88 stddev:15477.73 (31.8%) stddev-sans-first:15492.43 14:58:36 INFO - PROCESS | 30256 | Values: 811.9 859.9 864.0 867.1 890.4 13182.5 13481.4 13496.9 13585.1 13662.7 12271.1 12802.8 12852.2 12919.7 13003.0 835.1 841.2 851.9 861.9 867.2 839.7 839.7 845.0 848.4 848.5 886.6 892.7 894.6 895.9 897.6 884.9 888.8 889.4 890.1 890.9 643.3 651.1 653.7 653.8 654.6 13825.1 13832.2 13920.0 13963.6 13993.8 11306.4 11497.8 11678.0 11822.6 12438.7 9593.2 9624.2 9887.8 10351.5 10642.5 3593.4 3613.7 3623.7 3629.5 3760.2 48007.0 48458.5 48461.3 48629.0 49066.8 8969.7 9263.5 9301.3 9316.7 9656.9 16048.5 16093.0 16141.6 16164.8 16268.2 6037.0 6209.9 6340.3 6370.9 6584.4 3973.1 3991.9 4042.0 4090.3 4125.2 2894.0 2906.6 2922.0 2922.5 2939.3 540.6 554.3 564.5 566.2 568.4 545.7 611.7 612.2 631.7 640.5 7358.6 7917.9 8864.6 8958.1 9622.4 525.7 628.7 642.1 642.4 688.3 3940.6 4013.0 4018.3 4038.8 4091.4 52511.0 53304.2 54247.5 57578.4 57827.7 48736.8 49182.3 49980.8 50086.0 50125.5 44587.6 44626.8 44983.6 45213.0 45247.0 7912.8 8137.1 8226.9 8351.4 8363.9 33213.5 33988.7 34501.8 34548.0 35145.8 39707.0 40997.2 43198.4 43226.6 43944.0 10672.7 10983.8 10988.8 11072.2 11087.5 12109.9 12135.9 12244.8 12728.6 12759.5 10636.9 10999.8 11154.1 11258.5 11288.1 10975.7 11124.4 11194.7 11394.6 11400.5 10770.8 10958.4 10999.2 11179.1 11340.8 8955.6 9501.2 9503.2 9517.8 9740.3 8297.8 8350.2 8462.7 8726.8 9073.5 14:58:36 INFO - PROCESS | 30256 | -------- Summary: end -------- 14:58:36 INFO - PROCESS | 30256 | 14:58:37 INFO - TEST-INFO | 30256: exit 0 14:58:37 INFO - TEST-OK | dromaeo_css | took 1110013ms 14:58:37 INFO - TEST-START | kraken 14:58:37 INFO - operating with platform_type : linux_ 14:58:37 INFO - Initialising browser for kraken test... 14:58:37 INFO - TEST-INFO | started process 30498 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7NEW1h/profile http://localhost:54715/getInfo.html) 14:58:40 INFO - PROCESS | 30498 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 14:58:41 INFO - PROCESS | 30498 | __metrics Screen width/height:1600/1200 14:58:41 INFO - PROCESS | 30498 | colorDepth:24 14:58:41 INFO - PROCESS | 30498 | Browser inner width/height: 1024/697 14:58:41 INFO - PROCESS | 30498 | __metrics 14:58:41 INFO - PROCESS | 30498 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:58:42 INFO - TEST-INFO | 30498: exit 0 14:58:42 INFO - Browser initialized. 14:58:42 INFO - Running cycle 1/1 for kraken test... 14:58:42 INFO - TEST-INFO | started process 30618 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7NEW1h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:54 INFO - PROCESS | 30618 | RSS: Main: 151044096 14:58:54 INFO - PROCESS | 30618 | 14:58:56 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54715/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:57 INFO - PROCESS | 30618 | RSS: Main: 151351296 14:58:57 INFO - PROCESS | 30618 | 14:59:00 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54715/tests/kraken/driver.html?testName=audio-dft) 14:59:00 INFO - PROCESS | 30618 | RSS: Main: 151678976 14:59:00 INFO - PROCESS | 30618 | 14:59:03 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54715/tests/kraken/driver.html?testName=audio-fft) 14:59:04 INFO - PROCESS | 30618 | RSS: Main: 146341888 14:59:04 INFO - PROCESS | 30618 | 14:59:06 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54715/tests/kraken/driver.html?testName=audio-oscillator) 14:59:06 INFO - PROCESS | 30618 | RSS: Main: 146759680 14:59:06 INFO - PROCESS | 30618 | 14:59:09 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:09 INFO - PROCESS | 30618 | RSS: Main: 146849792 14:59:09 INFO - PROCESS | 30618 | 14:59:12 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54715/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:13 INFO - PROCESS | 30618 | RSS: Main: 147025920 14:59:13 INFO - PROCESS | 30618 | 14:59:16 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54715/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:17 INFO - PROCESS | 30618 | RSS: Main: 148344832 14:59:17 INFO - PROCESS | 30618 | 14:59:19 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54715/tests/kraken/driver.html?testName=json-parse-financial) 14:59:20 INFO - PROCESS | 30618 | RSS: Main: 148910080 14:59:20 INFO - PROCESS | 30618 | 14:59:22 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:22 INFO - PROCESS | 30618 | RSS: Main: 149553152 14:59:22 INFO - PROCESS | 30618 | 14:59:24 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:25 INFO - PROCESS | 30618 | RSS: Main: 148606976 14:59:25 INFO - PROCESS | 30618 | 14:59:27 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:27 INFO - PROCESS | 30618 | RSS: Main: 148271104 14:59:27 INFO - PROCESS | 30618 | 14:59:30 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:30 INFO - PROCESS | 30618 | RSS: Main: 149307392 14:59:30 INFO - PROCESS | 30618 | 14:59:33 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:33 INFO - PROCESS | 30618 | RSS: Main: 149782528 14:59:33 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | Cycle 1(1): loaded http://localhost:54715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54715/tests/kraken/driver.html?testName=ai-astar) 14:59:35 INFO - PROCESS | 30618 | RSS: Main: 149614592 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | __start_tp_report 14:59:35 INFO - PROCESS | 30618 | _x_x_mozilla_page_load 14:59:35 INFO - PROCESS | 30618 | _x_x_mozilla_page_load_details 14:59:35 INFO - PROCESS | 30618 | |i|pagename|runs| 14:59:35 INFO - PROCESS | 30618 | |0;ai-astar;111;105;110;110;110;121;111;112;110;111 14:59:35 INFO - PROCESS | 30618 | |1;audio-beat-detection;151;123;148;168;131;151;146;131;161;126 14:59:35 INFO - PROCESS | 30618 | |2;audio-dft;161;161;163;161;162;162;163;163;173;162 14:59:35 INFO - PROCESS | 30618 | |3;audio-fft;74;74;71;72;73;73;73;139;71;73 14:59:35 INFO - PROCESS | 30618 | |4;audio-oscillator;93;94;135;91;92;93;136;93;93;144 14:59:35 INFO - PROCESS | 30618 | |5;imaging-gaussian-blur;110;110;110;110;110;111;110;111;110;110 14:59:35 INFO - PROCESS | 30618 | |6;imaging-darkroom;145;148;146;147;147;147;146;146;147;146 14:59:35 INFO - PROCESS | 30618 | |7;imaging-desaturate;97;95;97;97;96;98;97;96;97;95 14:59:35 INFO - PROCESS | 30618 | |8;json-parse-financial;61;61;63;61;60;60;59;64;75;60 14:59:35 INFO - PROCESS | 30618 | |9;json-stringify-tinderbox;67;68;67;66;68;67;66;67;67;67 14:59:35 INFO - PROCESS | 30618 | |10;stanford-crypto-aes;83;92;85;85;93;86;87;85;85;86 14:59:35 INFO - PROCESS | 30618 | |11;stanford-crypto-ccm;119;116;120;125;114;131;126;121;122;123 14:59:35 INFO - PROCESS | 30618 | |12;stanford-crypto-pbkdf2;142;150;154;154;150;153;163;154;154;150 14:59:35 INFO - PROCESS | 30618 | |13;stanford-crypto-sha256-iterative;68;67;70;67;72;70;72;69;67;69 14:59:35 INFO - PROCESS | 30618 | __end_tp_report 14:59:35 INFO - PROCESS | 30618 | __start_cc_report 14:59:35 INFO - PROCESS | 30618 | _x_x_mozilla_cycle_collect,728 14:59:35 INFO - PROCESS | 30618 | __end_cc_report 14:59:35 INFO - PROCESS | 30618 | __startTimestamp1450738775946__endTimestamp 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | ------- Summary: start ------- 14:59:35 INFO - PROCESS | 30618 | Number of tests: 14 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:3.96 (3.6%) stddev-sans-first:4.20 14:59:35 INFO - PROCESS | 30618 | Values: 111.0 105.0 110.0 110.0 110.0 121.0 111.0 112.0 110.0 111.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.50 stddev:15.22 (10.2%) stddev-sans-first:15.90 14:59:35 INFO - PROCESS | 30618 | Values: 151.0 123.0 148.0 168.0 131.0 151.0 146.0 131.0 161.0 126.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:3.57 (2.2%) stddev-sans-first:3.71 14:59:35 INFO - PROCESS | 30618 | Values: 161.0 161.0 163.0 161.0 162.0 162.0 163.0 163.0 173.0 162.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#3] audio-fft Cycles:10 Average:79.30 Median:73.00 stddev:21.00 (28.8%) stddev-sans-first:22.19 14:59:35 INFO - PROCESS | 30618 | Values: 74.0 74.0 71.0 72.0 73.0 73.0 73.0 139.0 71.0 73.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:22.17 (23.8%) stddev-sans-first:22.98 14:59:35 INFO - PROCESS | 30618 | Values: 93.0 94.0 135.0 91.0 92.0 93.0 136.0 93.0 93.0 144.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:59:35 INFO - PROCESS | 30618 | Values: 110.0 110.0 110.0 110.0 110.0 111.0 110.0 111.0 110.0 110.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 14:59:35 INFO - PROCESS | 30618 | Values: 145.0 148.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 14:59:35 INFO - PROCESS | 30618 | Values: 97.0 95.0 97.0 97.0 96.0 98.0 97.0 96.0 97.0 95.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:61.00 stddev:4.67 (7.7%) stddev-sans-first:4.93 14:59:35 INFO - PROCESS | 30618 | Values: 61.0 61.0 63.0 61.0 60.0 60.0 59.0 64.0 75.0 60.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:59:35 INFO - PROCESS | 30618 | Values: 67.0 68.0 67.0 66.0 68.0 67.0 66.0 67.0 67.0 67.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:3.23 (3.8%) stddev-sans-first:3.14 14:59:35 INFO - PROCESS | 30618 | Values: 83.0 92.0 85.0 85.0 93.0 86.0 87.0 85.0 85.0 86.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:122.50 stddev:4.95 (4.0%) stddev-sans-first:5.15 14:59:35 INFO - PROCESS | 30618 | Values: 119.0 116.0 120.0 125.0 114.0 131.0 126.0 121.0 122.0 123.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:154.00 stddev:5.25 (3.4%) stddev-sans-first:4.00 14:59:35 INFO - PROCESS | 30618 | Values: 142.0 150.0 154.0 154.0 150.0 153.0 163.0 154.0 154.0 150.0 14:59:35 INFO - PROCESS | 30618 | 14:59:35 INFO - PROCESS | 30618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.91 (2.8%) stddev-sans-first:1.99 14:59:35 INFO - PROCESS | 30618 | Values: 68.0 67.0 70.0 67.0 72.0 70.0 72.0 69.0 67.0 69.0 14:59:35 INFO - PROCESS | 30618 | -------- Summary: end -------- 14:59:35 INFO - PROCESS | 30618 | 14:59:36 INFO - TEST-INFO | 30618: exit 0 14:59:36 INFO - TEST-OK | kraken | took 59347ms 14:59:36 INFO - TEST-START | v8_7 14:59:36 INFO - operating with platform_type : linux_ 14:59:36 INFO - Initialising browser for v8_7 test... 14:59:36 INFO - TEST-INFO | started process 30905 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6RaC1g/profile http://localhost:54715/getInfo.html) 14:59:40 INFO - PROCESS | 30905 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 14:59:40 INFO - PROCESS | 30905 | __metrics Screen width/height:1600/1200 14:59:40 INFO - PROCESS | 30905 | colorDepth:24 14:59:40 INFO - PROCESS | 30905 | Browser inner width/height: 1024/697 14:59:40 INFO - PROCESS | 30905 | __metrics 14:59:40 INFO - PROCESS | 30905 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:59:41 INFO - TEST-INFO | 30905: exit 0 14:59:41 INFO - Browser initialized. 14:59:41 INFO - Running cycle 1/1 for v8_7 test... 14:59:41 INFO - TEST-INFO | started process 31024 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6RaC1g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:53 INFO - PROCESS | 31024 | RSS: Main: 150929408 14:59:53 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | Cycle 1(1): loaded http://localhost:54715/tests/v8_7/run.html (next: http://localhost:54715/tests/v8_7/run.html) 15:00:15 INFO - PROCESS | 31024 | RSS: Main: 147496960 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | __start_tp_report 15:00:15 INFO - PROCESS | 31024 | _x_x_mozilla_page_load 15:00:15 INFO - PROCESS | 31024 | _x_x_mozilla_page_load_details 15:00:15 INFO - PROCESS | 31024 | |i|pagename|runs| 15:00:15 INFO - PROCESS | 31024 | |0;Richards;165.80998176090202 15:00:15 INFO - PROCESS | 31024 | |1;DeltaBlue;187.9699248120301 15:00:15 INFO - PROCESS | 31024 | |2;Encrypt;279.01785714285717 15:00:15 INFO - PROCESS | 31024 | |3;Decrypt;5213.541666666667 15:00:15 INFO - PROCESS | 31024 | |4;RayTrace;1075.268817204301 15:00:15 INFO - PROCESS | 31024 | |5;Earley;707.7140835102618 15:00:15 INFO - PROCESS | 31024 | |6;Boyer;12192.77108433735 15:00:15 INFO - PROCESS | 31024 | |7;RegExp;25550 15:00:15 INFO - PROCESS | 31024 | |8;Splay;655.307994757536 15:00:15 INFO - PROCESS | 31024 | |9;NavierStokes;4835.748792270531 15:00:15 INFO - PROCESS | 31024 | __end_tp_report 15:00:15 INFO - PROCESS | 31024 | __startTimestamp1450738815302__endTimestamp 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | ------- Summary: start ------- 15:00:15 INFO - PROCESS | 31024 | Number of tests: 10 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 165.8 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#1] DeltaBlue Cycles:1 Average:187.97 Median:187.97 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 188.0 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 279.0 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 5213.5 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 1075.3 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#5] Earley Cycles:1 Average:707.71 Median:707.71 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 707.7 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 12192.8 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 25550.0 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#8] Splay Cycles:1 Average:655.31 Median:655.31 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 655.3 15:00:15 INFO - PROCESS | 31024 | 15:00:15 INFO - PROCESS | 31024 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:00:15 INFO - PROCESS | 31024 | Values: 4835.7 15:00:15 INFO - PROCESS | 31024 | -------- Summary: end -------- 15:00:15 INFO - PROCESS | 31024 | 15:00:16 INFO - TEST-INFO | 31024: exit 0 15:00:16 INFO - TEST-OK | v8_7 | took 39357ms 15:00:16 INFO - SUITE-END | took 1208s 15:00:16 INFO - Completed test suite (00:20:08) 15:00:16 INFO - Working with test: dromaeo_css 15:00:16 INFO - Generating results file: dromaeo_css 15:00:16 INFO - Working with test: kraken 15:00:16 INFO - Generating results file: kraken 15:00:16 INFO - javascript benchmark 15:00:16 INFO - Working with test: v8_7 15:00:16 INFO - Generating results file: v8_7 15:00:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 15:00:16 INFO - process_Request line: dromaeo_css 6992.51 graph.html#tests=[[72,64,43]] 15:00:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:16 INFO - process_Request line: kraken 1516.00 graph.html#tests=[[232,64,43]] 15:00:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:16 INFO - process_Request line: v8_7 21196.49 graph.html#tests=[[230,64,43]] 15:00:16 INFO - RETURN: dromaeo_css: 6992.51 15:00:16 INFO - RETURN: kraken: 1516.00 15:00:16 INFO - RETURN: v8_7: 21196.49 15:00:16 INFO - javascript benchmark 15:00:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3205.3268813549153, 3223.5003574445955, 3244.0, 3282.7209687176587, 3292.7981286830313, 5236.7119808410525, 5374.973125134369, 5403.135498320269, 5426.593005524586, 5428.267183930173, 5315.309009828727, 5329.227262047001, 5332.546733527654, 5336.226247194155, 5460.918086228699, 4831.347768051321, 4915.877103072416, 4970.2296144097545, 4995.0509403213455, 5000.449950505442, 4967.503249675022, 5003.774830132635, 5019.021290848286, 5036.6222533309965, 5086.567641750437, 4807.206810876201, 4849.248366503198, 4895.8776030599165, 4930.827421040264, 4943.1102401567705, 4969.353983982095, 4970.378702662168, 4978.427480839714, 4995.875103122415, 5000.74996250186, 4924.507549245082, 4956.2565615157655, 4957.405111386656, 4972.8508144755715, 4987.47631498691, 5122.948770512285, 5123.385193776733, 5233.476652334774, 5275.340582427197, 5336.359636843565, 5685.118806584986, 5824.242848429677, 5829.358770535237, 5830.941690583125, 5832.912506312408, 5862.443067908542, 5870.735816888207, 5874.206982057411, 5876.11858221266, 5882.029465138247, 5329.120695085307, 5356.91964620531, 5425.403205647375, 5487.64330318528, 5538.778448862041, 5957.165996760457, 5964.940350596438, 5980.641161530322, 5981.282246130492, 5991.3409524953095, 5710.086386178192, 5757.395473475309, 5772.6536407815665, 5778.451047150514, 5780.21967034445, 5791.478766910914, 5803.912941305884, 5814.5348372130975, 5837.066069428956, 5885.205497257901, 5714.457126572969, 5734.340550836707, 5786.71066446676, 5811.82564523065, 5823.184754134425, 5583.330000399978, 5644.604877658525, 5746.367899531048, 5799.159121927297, 5799.681017543991, 4421.9336709949375, 4471.396361491222, 4488.685791994594, 4497.257952437876, 4507.684462087688, 3997.620226078518, 4000.2199571083943, 4003.7197396181987, 4025.1949610077518, 4037.8384864605673, 5362.0, 5509.862253443615, 5530.5299049580435, 5538.335399752055, 5553.694546799965, 5681.687507187062, 5697.202391665171, 5736.4550367715, 5738.1679656450415, 5794.130880367894, 5478.890422191534, 5491.066518691832, 5504.889902201933, 5505.394406615269, 5510.724463776795, 5013.924791128136, 5168.043911876315, 5172.405173405032, 5174.09453345663, 5220.477952204825, 5866.149408335853, 5899.321578018497, 5930.199423077829, 5944.138099975566, 5970.611910225822, 5885.61743486672, 5888.4700376966275, 5895.764169433174, 5899.852503687443, 5901.29184497863, 5854.648721076749, 5890.6760128191645, 5957.255343082114, 5959.970200148971, 5960.493358064613, 5671.092625179951, 5715.0, 5716.28546431696, 5717.685527296038, 5800.535957123504, 5787.102999035156, 5889.58772885911, 5906.734196961061, 5908.793192238251, 5931.584789064724, 5516.062269414129, 5520.1443776214755, 5529.087700529368, 5736.082226843685, 5751.654900705971, 5650.915236271541, 5655.717214139194, 5740.971295143498, 5808.883822323614, 5822.272215973004, 5562.415946325577, 5565.888682226414, 5566.749496272759, 5569.749361278671, 5569.972150139223, 5605.607607467438, 5630.662160270397, 5657.15142728594, 5693.658380497183, 5706.087026075808, 5604.411536788579, 5645.802396916089, 5655.575831812713, 5726.141078838207, 5791.276090488689], "unit": "score", "name": "dojo.html", "value": 5359.549467270029}, {"lowerIsBetter": false, "replicates": [548.5780280063519, 591.1192323438075, 594.6313285762826, 594.6669864875668, 601.858563237639, 37940.620593794054, 38424.61575384245, 38492.42261366078, 38552.99999999996, 38659.61340386595, 42276.0, 42278.154436911245, 42637.78681106598, 42650.14699706004, 42762.35856462156, 8710.956445217766, 8941.821163576724, 8993.10068993102, 9002.279817614575, 9007.0, 8800.779980500474, 8863.157999990022, 8863.335249856254, 8873.95563022184, 8882.955585222066, 8835.249003834682, 8861.645534178657, 8872.512011839346, 8885.511296878669, 8890.977537583163, 8718.0, 8810.955945220298, 8833.425827321204, 8846.0, 8863.601137948808, 8756.693515726982, 8833.514156721378, 8883.378163528556, 8888.555572221363, 8891.19979201875, 39892.60107398918, 40408.59591404078, 40414.79792601048, 40467.0, 40507.0, 3320.186554294189, 3346.2303670156, 3505.386557352453, 3551.6448355164534, 3641.3445579795625, 29039.854800726072, 29226.123216303546, 29518.26204344887, 30210.395792084255, 30211.546826797614, 3553.7690050146657, 3588.22853086585, 3594.6944509716704, 3597.8201089945396, 3615.1865830188262, 264548.0, 266303.0, 267300.0, 269135.0, 269143.0, 42223.57776422196, 42676.78661606672, 42976.0, 60580.0, 60809.0, 40435.59564404377, 40575.797121014795, 40758.388624170664, 40832.59167408347, 41140.794296028325, 13685.452581896812, 13727.245001525012, 13799.2410417426, 13837.86162138386, 13860.4455821766, 10528.684139475828, 10553.31403458788, 10593.947030264953, 10608.628697995688, 10615.363078215332, 13951.441942322397, 14137.0, 14304.57086287413, 14329.211893345757, 14397.712045759026, 5674.744636491285, 5679.545636349165, 5688.23208866806, 5740.368559458456, 5791.652500849962, 868.5613765048736, 923.3951761596165, 931.9580618872031, 944.7213072143734, 973.6981535723806, 28696.0, 29044.0, 32579.0, 32675.67324326726, 32974.17564560905, 965.180634503965, 1010.3432768700256, 1056.894310568937, 1059.0891833023593, 1108.2962318927378, 14711.926440367944, 14740.11559306445, 14786.704265914621, 14951.0, 15053.623659408602, 379233.0, 384154.0, 384340.0, 387009.0, 388128.0, 52683.473165268624, 53309.0, 53342.0, 53395.73302133542, 53406.46593534093, 1298.9610311690665, 1300.5318085489216, 1322.6098301001227, 1329.2091205732575, 1331.2079312808862, 27580.448391031667, 28325.71674283231, 28618.0, 28782.424351513273, 28832.567511486926, 46202.53797462117, 46415.0, 46615.53384466112, 46717.76641116773, 46837.2974405391, 307073.0, 309308.0, 309852.0, 310930.0, 311037.0, 32462.35075298528, 32503.349933000736, 32916.177095571846, 33035.504467433486, 33049.669503305624, 43015.0, 43597.12805743931, 43977.56022439735, 44332.0, 44720.0, 36978.44532331963, 37045.0, 37296.44055339226, 37892.62107378891, 38254.61745382511, 36845.63154368422, 37234.6276537242, 37520.62479375171, 37608.623913760515, 40794.0, 35048.64951350556, 35542.64457355393, 35626.643733562334, 35711.28577428489, 36143.63856361508, 32008.35983280368, 32661.836690816395, 32867.34265314633, 33394.0, 33458.16354591155, 25817.612735809354, 25843.61234581445, 25916.48167036611, 25950.0, 25964.0], "unit": "score", "name": "ext.html", "value": 18001.480884711982}, {"lowerIsBetter": false, "replicates": [363.37136753416587, 364.2060308527409, 364.21148214116437, 364.93613617616927, 368.2487725040917, 14438.639034024129, 14803.0, 16749.078800665957, 17059.914700426496, 17583.73624395635, 11039.503222354993, 11397.259178153414, 11424.885751142487, 14986.475473358434, 15382.23088845556, 4759.904801903968, 4876.4148302203785, 4877.756112194376, 4910.0, 4997.600191984632, 5315.867103322428, 5326.360836699601, 5347.224652425396, 5363.9463605363835, 5374.758135883894, 5203.0, 5302.814401495929, 5318.335208098988, 5330.973345133289, 5331.600129990247, 5266.868328291805, 5272.947270527322, 5322.680639161663, 5340.91988620171, 5349.117395629716, 4740.312654665088, 4774.092922344744, 4789.928151077736, 4796.496367881392, 4800.879978000543, 19719.704204436945, 19884.90057549703, 20199.38404927617, 20241.190352386035, 20414.79585204144, 2075.833933285349, 2139.5506943541873, 2149.849510534263, 2155.23489161347, 2668.5997100434897, 9945.701628951143, 10051.849222261671, 10584.100351470135, 10860.837087443695, 13658.590242292747, 1732.9653406931916, 1741.1468380493593, 1754.0966402302824, 1761.9911900440416, 1785.2501949181376, 59597.0, 62513.0, 62842.68578657123, 63511.682441587494, 65074.0, 10242.6415075472, 10373.325733827278, 10390.168786497063, 10468.581256749798, 10500.73748156287, 13508.459661613622, 13678.384472698752, 13711.520096796763, 13730.51943181984, 13748.106373085917, 7089.645517724093, 7271.3455788979245, 7314.232005639437, 7318.926810731931, 7336.0, 6710.429613482811, 6722.29415911332, 6763.458923286125, 6909.861802763917, 7003.509754317149, 4447.2439685253585, 4483.529229430928, 4498.6626003049905, 4510.797014134372, 4520.9095818084115, 1833.0193346559527, 1848.2606957216951, 1851.1484717030048, 1857.3127942661301, 1860.2930886263134, 768.5696010234286, 862.7239283429368, 885.5085427587621, 911.5123408976166, 1022.0341777020644, 16435.91782041106, 16629.16854157287, 16700.498985030226, 16844.831551684572, 16878.409255675993, 838.0990435282096, 855.1277696749405, 878.7495563764296, 892.455602082729, 892.9776755581032, 8684.60919258635, 9585.520723963913, 9607.711768646952, 9618.470984095802, 9753.122219000325, 482909.0, 493002.0, 495035.0, 495155.0, 495808.0, 76040.0, 78663.60668196737, 78820.60589697016, 79157.20842791499, 79419.0, 1060.8726952765717, 1075.473018221066, 1116.6370929447962, 1124.7300647844622, 1126.4592995362273, 14806.185659788815, 14866.0, 14912.478063268167, 14920.0, 15174.24128793578, 35059.824700876336, 35332.470012949314, 35443.0, 35620.643793561736, 36168.638313616524, 45357.54642453665, 45722.08555828931, 46700.0, 47732.52267477281, 47794.52205477901, 9496.572654230438, 9694.85457718149, 9697.175740062174, 9732.172765315028, 9773.511324433608, 15584.454544090902, 16503.504894853173, 17583.384581539583, 17664.470065898044, 17944.0, 13983.440662373798, 14685.632859178606, 14847.480338188112, 15046.097234165985, 15294.923525382303, 14002.929985350416, 14084.647883802987, 14363.281835907954, 14609.269536523343, 14798.778018329518, 14836.0, 14918.552443426715, 15110.848891510945, 15196.544103676908, 15294.0, 9542.188913942393, 9689.70930872075, 9745.561449734638, 9784.461854597781, 9787.755306117404, 14225.64435889111, 14251.073680210753, 14624.488142915372, 14668.633284167981, 14712.926435367755], "unit": "score", "name": "jquery.html", "value": 8749.94809631298}, {"lowerIsBetter": false, "replicates": [1453.832809226939, 1518.5064853922474, 1610.7181243282423, 1636.0, 1744.1453687693026, 7474.7757567273, 7513.549187048781, 7809.492382995101, 7936.484128531649, 7936.722214722486, 7821.960890195541, 7890.7632771016815, 7967.282944534991, 8006.679732810695, 8020.278174964252, 2286.0512887151854, 2307.653851922208, 2312.595295823224, 2318.304508647399, 2326.732425771041, 2276.590213761522, 2300.1604414388794, 2303.665968434576, 2307.238611258289, 2321.7562155973633, 2263.321003698892, 2316.073570571776, 2323.512062466884, 2335.6730057791924, 2340.508493216427, 2242.2264318809985, 2249.325202439262, 2276.044061494168, 2285.897134628929, 2296.0930432479245, 2289.7366802817724, 2300.1259521381935, 2310.7689231076924, 2322.744498105207, 2324.0239099578216, 7728.845423091563, 7899.565523896184, 7950.761477155695, 7954.403419743485, 7971.561564113971, 4523.615492683126, 4630.8147674093, 4667.393238878924, 4672.719636821802, 4685.086408150412, 2999.145243605562, 3006.969930300713, 3095.520194369854, 3116.3144108296137, 3123.593932788746, 937.4234845569994, 970.1026550440814, 991.2367477042709, 992.4839083676447, 1019.5921631347446, 10358.0, 10387.480625968747, 10388.0, 10400.583976640924, 10410.271281010257, 4134.64855487281, 4212.494500659879, 4228.725132866354, 4244.766537840386, 4255.148970205909, 8638.654453821777, 8663.870041949376, 8666.913330866611, 8668.60991255395, 8677.39258251929, 4567.703099298535, 4601.5168407317415, 4605.194091034055, 4608.170529304691, 4654.37165982588, 4274.700770946004, 4280.272353699878, 4281.357796330575, 4294.3558466230315, 4310.224159651293, 3403.6426175251736, 3404.3191361727754, 3413.9829300853335, 3421.674940880612, 3425.3149370126075, 1008.9596416143419, 1014.7108074198818, 1018.0379541333369, 1018.2159737002466, 1023.9129673977646, 1016.7204018894863, 1019.7807471393686, 1037.9273450858368, 1140.7718456308605, 1298.2210673595955, 7076.752313668997, 7288.08898887639, 7340.522866013692, 7346.118465784033, 7397.889031664529, 1095.6001059613184, 1097.8463015177722, 1113.4098927568402, 1118.3625333559792, 1124.578283143821, 5823.0, 5828.446297601721, 5843.853903652443, 5875.089361149029, 5876.206712093898, 9053.59258833354, 9133.81732365349, 9381.108794664497, 9481.431114133175, 9484.715458536117, 9244.029376915461, 9265.351425400157, 9289.953550232205, 9309.069093090637, 9330.486823224788, 7214.2785721427435, 7247.855042899112, 7310.597917114504, 7327.047483827068, 7333.303336183054, 7060.682269297997, 7078.787636370917, 7086.858262834818, 7106.218315985341, 7119.288071192839, 7900.723474678589, 8165.38759593021, 8177.386695997943, 8188.2630563249595, 8207.302379297827, 8318.83362332762, 8477.109903460048, 8495.702650407206, 8529.189726975927, 8597.699080532151, 6517.120188774645, 6628.602283862983, 6792.3547263011915, 6800.251972282946, 6808.251092379934, 7509.66206520697, 7543.321101100927, 7562.395008399205, 7566.810829729301, 7624.961875190588, 6608.933910661024, 6657.7669781557415, 6756.155480564929, 6886.655667216719, 6886.965565172142, 6666.400023997863, 6830.180378354629, 6856.142982127234, 6875.5530890491955, 6908.205556361083, 6419.2938776735455, 6471.352864713491, 6477.77327793525, 6481.708323125376, 6553.541252112497, 6384.808455746335, 6454.806355809334, 6469.611823290617, 6483.448906842971, 6490.707918143789, 6446.742130314735, 6487.091807147098, 6515.869682606416, 6545.050967609574, 6583.111279977142], "unit": "score", "name": "mootools.html", "value": 4430.071719276323}, {"lowerIsBetter": false, "replicates": [342.998285008575, 346.6810534308436, 356.41369946438124, 356.657608695652, 356.69042946918705, 6271.059341098838, 6292.150559674443, 6332.176817013782, 6377.107204991299, 6380.29816720161, 6021.2473440819895, 6269.780557680482, 6280.057991301307, 6286.52851036173, 6321.589096708711, 4842.7723247306285, 4851.611871050308, 4854.199057155565, 4864.489228630996, 4867.075255701423, 4844.0, 4848.103100926322, 4853.660243782937, 4867.561919427251, 4868.391451068616, 4712.552307530779, 4800.4719480857075, 4814.711117332971, 4829.082474329884, 4831.710097394168, 4779.474257831635, 4794.760261986904, 4800.495947925452, 4811.326414301965, 4812.831550895702, 4223.408722778813, 4236.364545318196, 4236.809343579546, 4256.212600668886, 4258.0, 5920.141579470953, 5924.229850119457, 5931.110333449974, 5956.880862382772, 5966.731497082642, 5459.481349271813, 5577.581681373873, 5581.190727344553, 5587.944120558783, 5588.133839254922, 6646.8005959821285, 6677.565958212749, 6704.463642908556, 6710.7315707371645, 6714.731410743564, 4631.096936097462, 4640.767961601907, 4642.326862604938, 4643.605293550052, 4649.628029757611, 6891.620960847152, 6891.793246202622, 6925.896111558331, 6943.652817359111, 7016.894746578805, 4702.905941881211, 4729.148753224384, 4743.1225223333795, 4745.905081898342, 4755.476897541268, 4797.736124513185, 4804.759762011886, 4811.591014763784, 4815.470298267188, 4821.156297647968, 5539.7784088636, 5577.693226872561, 5584.63699859516, 5590.944090559043, 5593.133064375028, 6536.444402225864, 6701.698423570951, 6726.831829204211, 6805.625690586966, 6807.795766127024, 1653.768472413863, 1682.9747553786704, 1686.2917574618689, 1689.4678176374402, 1691.2981112838033, 1098.2477003252798, 1118.4407796101948, 1123.971900702489, 1128.1031579894004, 1139.3101670294095, 6297.748090076346, 6349.015902535114, 6354.555181137369, 6361.632249066381, 6364.586301890362, 6866.382025617719, 6878.243393226741, 6887.5178737488895, 6899.689513971884, 6933.5493192942295, 6293.433590976834, 6348.206474190726, 6350.333215012357, 6352.523560732963, 6364.586301890362, 3790.6209379061875, 3824.961750382516, 3826.9617303826603, 3831.6934645228316, 3839.1361943562474, 7142.285771422816, 7153.177384600734, 7187.281271872876, 7204.495685302083, 7242.746503872339, 7021.087258656342, 7176.569405835667, 7186.676599553032, 7194.172670142896, 7209.134903811576, 7129.9305104233745, 7149.0348802911985, 7162.391196748335, 7162.928370716226, 7165.570065796069, 6971.686274117778, 7008.7897363077145, 7014.719411223494, 7015.824604384931, 7033.753818616324, 6777.966110169417, 6859.794206173823, 6890.2420733720255, 6915.51591388598, 6947.305269473012, 7123.501354905314, 7124.465665075037, 7127.679254433459, 7129.21578626361, 7165.140183178052, 4694.131585656664, 4702.576768090751, 4712.717236965793, 4726.314684370678, 4758.8096476141955, 6907.102076729993, 7003.894941575983, 7018.192907815666, 7026.437884969088, 7050.224475307815, 6778.93221067783, 6813.591184528944, 6813.965930170318, 6823.590584564942, 6827.522073455009, 6807.659617019228, 6812.625305608239, 6818.897716534355, 6820.556663816836, 6823.965880170766, 6524.836879077871, 6610.07458955737, 6681.064650948774, 6685.76599819004, 6686.498512611476, 6802.93197068023, 6824.692888819915, 6849.075374824534, 6852.862942741217, 6856.5200435971, 6516.348365163446, 6621.6689165540565, 6648.767293144911, 6664.133662624022, 6685.0], "unit": "score", "name": "prototype.html", "value": 5062.2716731636265}, {"lowerIsBetter": false, "replicates": [811.9309858662014, 859.9484030958143, 863.9827203455931, 867.0722327109991, 890.3989806880354, 13182.472701091956, 13481.39333729982, 13496.865031349696, 13585.116967397113, 13662.726745465085, 12271.141020128594, 12802.80795788064, 12852.228866268031, 12919.74160516789, 13003.0, 835.0605568735173, 841.2344766262718, 851.8637018077109, 861.8750281209252, 867.1501928110456, 839.689314953465, 839.7270886961732, 844.9915500845005, 848.4018766769412, 848.4951453884929, 886.6276164011099, 892.7232557907037, 894.5929602031093, 895.9462432254086, 897.6364572348177, 884.9026607073217, 888.7822483491553, 889.3596610440472, 890.132121181849, 890.9287257019455, 643.3020173112179, 651.1307404614797, 653.7090994507446, 653.7744478155076, 654.564714464885, 13825.101368411122, 13832.23922684252, 13919.956003299692, 13963.58109256724, 13993.790093148611, 11306.364390599814, 11497.827532587018, 11678.007369373528, 11822.645320640395, 12438.689032774162, 9593.184579310768, 9624.230061595055, 9887.802243955153, 10351.482425878752, 10642.467876606217, 3593.3531964246426, 3613.6747692707518, 3623.673869351771, 3629.546306711661, 3760.172761992357, 48007.0, 48458.51541484575, 48461.27308090346, 48629.0, 49066.75466622644, 8969.730908072768, 9263.490508021989, 9301.255899528021, 9316.673916413029, 9656.855147172799, 16048.518544443685, 16093.0, 16141.59646008859, 16164.75752863708, 16268.186590670419, 6037.016522203423, 6209.9379006210265, 6340.270868850049, 6370.904436433457, 6584.374484423972, 3973.1457736586194, 3991.9201615967518, 4042.0, 4090.3250963591267, 4125.154343359604, 2893.956590651142, 2906.636670416198, 2921.985390073036, 2922.517784565523, 2939.3239554902493, 540.5567434703505, 554.2794367322465, 564.5201578658108, 566.2101368590793, 568.4457653787524, 545.6807767456082, 611.6849822341497, 612.1980205930246, 631.7094136697079, 640.4652115483624, 7358.595277259802, 7917.920820791834, 8864.556772161366, 8958.10418958112, 9622.422654640744, 525.716113298822, 628.6919409489409, 642.1299139665779, 642.392938672959, 688.3288793426369, 3940.6453419191835, 4012.9598704012587, 4018.276710192135, 4038.7778672173313, 4091.4067460218102, 52511.0, 53304.20043699347, 54247.45752542503, 57578.4242157573, 57827.71086144543, 48736.75631621819, 49182.262266066034, 49980.750096249285, 50086.0, 50125.49874501281, 44587.554124458344, 44626.77686611611, 44983.55016449859, 45213.0, 45247.0, 7912.802179945547, 8137.145599711945, 8226.917730822615, 8351.415400921876, 8363.916360836314, 33213.50179747257, 33988.660113398546, 34501.827490862386, 34548.0, 35145.82427087848, 39707.0, 40997.1800563993, 43198.352024719024, 43226.567734322256, 43944.0, 10672.733181670521, 10983.780324393627, 10988.835167472655, 11072.224944253825, 11087.501062452371, 12109.939450303045, 12135.939320303341, 12244.755104897675, 12728.554500592434, 12759.48962041508, 10636.946815265874, 10999.835002474809, 11154.107671386431, 11258.549658013915, 11288.096952243637, 10975.725606859893, 11124.443777810915, 11194.720131996764, 11394.601188958346, 11400.543978240778, 10770.838437423601, 10958.397288149228, 10999.175061870552, 11179.105671546095, 11340.829887551858, 8955.59699813497, 9501.239900808057, 9503.19222866064, 9517.762055948657, 9740.269479788902, 8297.792555185928, 8350.206730360605, 8462.661493540189, 8726.817217022246, 9073.546322683707], "unit": "score", "name": "yui.html", "value": 6173.971056270081}], "name": "dromaeo_css", "value": 6992.511366632638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 110.0, 110.0, 121.0, 111.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 148.0, 168.0, 131.0, 151.0, 146.0, 131.0, 161.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 163.0, 163.0, 173.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 71.0, 72.0, 73.0, 73.0, 73.0, 139.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 91.0, 92.0, 93.0, 136.0, 93.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [145.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 97.0, 97.0, 96.0, 98.0, 97.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 63.0, 61.0, 60.0, 60.0, 59.0, 64.0, 75.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [83.0, 92.0, 85.0, 85.0, 93.0, 86.0, 87.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 120.0, 125.0, 114.0, 131.0, 126.0, 121.0, 122.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 154.0, 154.0, 150.0, 153.0, 163.0, 154.0, 154.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 70.0, 67.0, 72.0, 70.0, 72.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1516.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [187.9699248120301], "unit": "score", "name": "DeltaBlue", "value": 351.74775999999986}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [707.7140835102618], "unit": "score", "name": "Earley", "value": 941.7122190000003}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [655.307994757536], "unit": "score", "name": "Splay", "value": 124.35526599999999}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21196.489042259756}]} 15:00:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21196.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6992.51"}}} 15:00:16 INFO - Return code: 0 15:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:00:16 INFO - # TBPL SUCCESS # 15:00:16 INFO - Running post-action listener: _resource_record_post_action 15:00:16 INFO - Running post-run listener: _resource_record_post_run 15:00:17 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 557932544; Read time: 0; Write time: 449212 15:00:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234573824; Read time: 0; Write time: 244260 15:00:17 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 322375680; Read time: 0; Write time: 204944 15:00:17 INFO - Running post-run listener: _upload_blobber_files 15:00:17 INFO - Blob upload gear active. 15:00:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:00:17 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 15:00:17 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'] 15:00:17 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 15:00:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:19 INFO - (blobuploader) - INFO - Done attempting. 15:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:20 INFO - (blobuploader) - INFO - Done attempting. 15:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:20 INFO - Return code: 0 15:00:20 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d64643836ef2b5536d41b60f3d66a194e59532a3a5fdc35a1e0555d5107d50dfa5dd5e47301031d61d460471963c0d4c0c668219c5b3fc8237bf25dfaf0e2f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3081dd144b21dbf5117503672561d166a3c1319c72d3ae2344bd4e5e41d7406985c6e1aa2a55a992feb5b542f23b6bca3f4e1d16d9d524cc0cded8262b9ddd"} 15:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:00:20 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:00:20 INFO - Contents: 15:00:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d64643836ef2b5536d41b60f3d66a194e59532a3a5fdc35a1e0555d5107d50dfa5dd5e47301031d61d460471963c0d4c0c668219c5b3fc8237bf25dfaf0e2f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3081dd144b21dbf5117503672561d166a3c1319c72d3ae2344bd4e5e41d7406985c6e1aa2a55a992feb5b542f23b6bca3f4e1d16d9d524cc0cded8262b9ddd"} 15:00:20 INFO - Copying logs to upload dir... 15:00:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.930641 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-21 15:00:19.858118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:00:19.866937) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d64643836ef2b5536d41b60f3d66a194e59532a3a5fdc35a1e0555d5107d50dfa5dd5e47301031d61d460471963c0d4c0c668219c5b3fc8237bf25dfaf0e2f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3081dd144b21dbf5117503672561d166a3c1319c72d3ae2344bd4e5e41d7406985c6e1aa2a55a992feb5b542f23b6bca3f4e1d16d9d524cc0cded8262b9ddd"} build_url:https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d64643836ef2b5536d41b60f3d66a194e59532a3a5fdc35a1e0555d5107d50dfa5dd5e47301031d61d460471963c0d4c0c668219c5b3fc8237bf25dfaf0e2f7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd3081dd144b21dbf5117503672561d166a3c1319c72d3ae2344bd4e5e41d7406985c6e1aa2a55a992feb5b542f23b6bca3f4e1d16d9d524cc0cded8262b9ddd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:00:19.891399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:00:19.891748) ========= 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=919420d7ee4ef147bef0346300000385-1450737551.996812-1838749089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:00:19.978384) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:00:19.978788) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:00:19.979266) ========= ========= Total master_lag: 0.24 =========