builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1450737732.11 results: success (0) buildid: 20151221113009 builduid: 0dd6f278436e49988b821e90e4017cf9 revision: 6587e9c69c362f1674b3e158be23311139411441 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.108398) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.108965) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.109300) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.126777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.127101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.139130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.139464) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004670 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.189636) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.189990) ========= 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:42:12.190415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.190728) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 14:42: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% 43.4M=0s 2015-12-21 14:42:12 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.366245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.366646) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017433 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:12.416275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 14:42:12.416678) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 14:42:12,738 truncating revision to first 12 chars 2015-12-21 14:42:12,738 Setting DEBUG logging. 2015-12-21 14:42:12,738 attempt 1/10 2015-12-21 14:42:12,738 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:42:13,529 unpacking tar archive at: fx-team-6587e9c69c36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.079224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 14:42:13.512003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:13.512750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:13.523238) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 14:42:13.523543) ========= 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:42:13.523980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-21 14:42:13.524325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:42:13 INFO - MultiFileLogger online at 20151221 14:42:13 in /builds/slave/test-pgo 14:42:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:42:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:42:13 INFO - {'append_to_log': False, 14:42:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:42:13 INFO - 'blob_upload_branch': 'Fx-Team', 14:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:42:13 INFO - 'branch': 'Fx-Team', 14:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:42:13 INFO - 'config_files': ('talos/linux_config.py',), 14:42:13 INFO - 'default_actions': ('clobber', 14:42:13 INFO - 'read-buildbot-config', 14:42:13 INFO - 'download-and-extract', 14:42:13 INFO - 'populate-webroot', 14:42:13 INFO - 'create-virtualenv', 14:42:13 INFO - 'install', 14:42:13 INFO - 'run-tests'), 14:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:42:13 INFO - 'download_minidump_stackwalk': True, 14:42:13 INFO - 'download_symbols': 'ondemand', 14:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:42:13 INFO - 'installer_path': 'installer.exe', 14:42:13 INFO - 'log_level': 'info', 14:42:13 INFO - 'log_name': 'talos', 14:42:13 INFO - 'log_to_console': True, 14:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:42:13 INFO - 'opt_config_files': (), 14:42:13 INFO - 'pip_index': False, 14:42:13 INFO - 'sps_profile': False, 14:42:13 INFO - 'sps_profile_interval': 0, 14:42:13 INFO - 'suite': 'dromaeojs', 14:42:13 INFO - 'system_bits': '64', 14:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:42:13 INFO - 'title': 'talos-linux64-ix-046', 14:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:42:13 INFO - 'use_talos_json': True, 14:42:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:42:13 INFO - 'work_dir': 'build'} 14:42:13 INFO - ##### 14:42:13 INFO - ##### Running clobber step. 14:42:13 INFO - ##### 14:42:13 INFO - Running pre-action listener: _resource_record_pre_action 14:42:13 INFO - Running main action method: clobber 14:42:13 INFO - rmtree: /builds/slave/test-pgo/build 14:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:42:14 INFO - Running post-action listener: _resource_record_post_action 14:42:14 INFO - ##### 14:42:14 INFO - ##### Running read-buildbot-config step. 14:42:14 INFO - ##### 14:42:14 INFO - Running pre-action listener: _resource_record_pre_action 14:42:14 INFO - Running main action method: read_buildbot_config 14:42:14 INFO - Using buildbot properties: 14:42:14 INFO - { 14:42:14 INFO - "project": "", 14:42:14 INFO - "product": "firefox", 14:42:14 INFO - "script_repo_revision": "production", 14:42:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:42:14 INFO - "repository": "", 14:42:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:42:14 INFO - "buildid": "20151221113009", 14:42:14 INFO - "pgo_build": "True", 14:42:14 INFO - "basedir": "/builds/slave/test-pgo", 14:42:14 INFO - "buildnumber": 380, 14:42:14 INFO - "slavename": "talos-linux64-ix-046", 14:42:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:42:14 INFO - "platform": "ubuntu64_hw", 14:42:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:42:14 INFO - "branch": "fx-team", 14:42:14 INFO - "repo_path": "integration/fx-team", 14:42:14 INFO - "revision": "6587e9c69c362f1674b3e158be23311139411441", 14:42:14 INFO - "stage_platform": "linux64-pgo", 14:42:14 INFO - "builduid": "0dd6f278436e49988b821e90e4017cf9", 14:42:14 INFO - "slavebuilddir": "test" 14:42:14 INFO - } 14:42:14 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:42:14 INFO - Running post-action listener: _resource_record_post_action 14:42:14 INFO - ##### 14:42:14 INFO - ##### Running download-and-extract step. 14:42:14 INFO - ##### 14:42:14 INFO - Running pre-action listener: _resource_record_pre_action 14:42:14 INFO - Running main action method: download_and_extract 14:42:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:14 INFO - https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json 14:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/test_packages.json 14:42:14 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:42:14 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:42:15 INFO - Downloaded 1302 bytes. 14:42:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:42:15 INFO - Using the following test package requirements: 14:42:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:42:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:42:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'jsshell-linux-x86_64.zip'], 14:42:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:42:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:42:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:42:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:42:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:42:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:42:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:42:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:42:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:42: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:42:15 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:42:15 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:42:15 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:42:15 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:42:15 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:42:16 INFO - Downloaded 23175551 bytes. 14:42:16 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:42:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:42:16 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:42:17 INFO - Return code: 0 14:42:17 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:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:17 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:42:17 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:42:17 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:42:17 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:42:17 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:42:18 INFO - Downloaded 23175551 bytes. 14:42:18 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:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:42:18 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:42:20 INFO - Return code: 0 14:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:20 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:42:20 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:42:20 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:42:20 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:42:20 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:42:21 INFO - Downloaded 11132277 bytes. 14:42:21 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:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:42:21 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:42:21 INFO - Return code: 0 14:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:21 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:42:21 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:42:21 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:42:21 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:42:21 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:42:23 INFO - Downloaded 54940903 bytes. 14:42:23 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:42:23 INFO - mkdir: /builds/slave/test-pgo/properties 14:42:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:42:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:42:23 INFO - Contents: 14:42:23 INFO - build_url:https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:42:23 INFO - Running post-action listener: _resource_record_post_action 14:42:23 INFO - Running post-action listener: set_extra_try_arguments 14:42:23 INFO - ##### 14:42:23 INFO - ##### Running populate-webroot step. 14:42:23 INFO - ##### 14:42:23 INFO - Running pre-action listener: _resource_record_pre_action 14:42:23 INFO - Running main action method: populate_webroot 14:42:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:42:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:42:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:42:23 INFO - '--tppagecycles', 14:42:23 INFO - '7'], 14:42:23 INFO - 'tests': ['tsvgm']}}, 14:42:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:42:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:42:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:42:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:42:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:42:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'tests': ['damp', 'tps']}, 14:42:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['damp', 'tps']}, 14:42:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:42:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:42:23 INFO - 'other': {'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'other_l64': {'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'other_nol64': {'tests': ['a11yr', 14:42:23 INFO - 'ts_paint', 14:42:23 INFO - 'tpaint', 14:42:23 INFO - 'sessionrestore', 14:42:23 INFO - 'sessionrestore_no_auto_restore']}, 14:42:23 INFO - 'svgr': {'tests': ['tsvgx', 14:42:23 INFO - 'tsvgr_opacity', 14:42:23 INFO - 'tart', 14:42:23 INFO - 'tscrollx', 14:42:23 INFO - 'cart']}, 14:42:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['tsvgx', 14:42:23 INFO - 'tsvgr_opacity', 14:42:23 INFO - 'tart', 14:42:23 INFO - 'tscrollx', 14:42:23 INFO - 'cart']}, 14:42:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'tests': ['tp5o']}, 14:42:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'talos_options': ['--e10s'], 14:42:23 INFO - 'tests': ['tp5o']}, 14:42:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'talos_options': ['--xperf_path', 14:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:23 INFO - 'tests': ['tp5n']}, 14:42:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:42:23 INFO - 'talos_options': ['--e10s', 14:42:23 INFO - '--xperf_path', 14:42:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:42:23 INFO - 'tests': ['tp5n']}}, 14:42:23 INFO - 'talos.zip': {'path': '', 14:42:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:42:23 INFO - Running post-action listener: _resource_record_post_action 14:42:23 INFO - ##### 14:42:23 INFO - ##### Running create-virtualenv step. 14:42:23 INFO - ##### 14:42:23 INFO - Running pre-action listener: _resource_record_pre_action 14:42:23 INFO - Running main action method: create_virtualenv 14:42:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:42:23 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:42:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:42:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:42:23 INFO - Using real prefix '/usr' 14:42:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:42:23 INFO - Installing distribute.............................................................................................................................................................................................done. 14:42:25 INFO - Installing pip.................done. 14:42:25 INFO - Return code: 0 14:42:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:42:25 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:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:25 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:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:25 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:25 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:42:25 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:42:25 INFO - Using env: {'DISPLAY': ':0', 14:42:25 INFO - 'HOME': '/home/cltbld', 14:42:25 INFO - 'LANG': 'en_US.UTF-8', 14:42:25 INFO - 'LANGUAGE': 'en_US:en', 14:42:25 INFO - 'LOGNAME': 'cltbld', 14:42:25 INFO - 'MAIL': '/var/mail/cltbld', 14:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:25 INFO - 'MOZ_NO_REMOTE': '1', 14:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:25 INFO - 'NO_EM_RESTART': '1', 14:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:25 INFO - 'SHELL': '/bin/bash', 14:42:25 INFO - 'SHLVL': '1', 14:42:25 INFO - 'TERM': 'linux', 14:42:25 INFO - 'TMOUT': '86400', 14:42:25 INFO - 'USER': 'cltbld', 14:42:25 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:25 INFO - '_': '/tools/buildbot/bin/python'} 14:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:26 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:42:26 INFO - Cleaning up... 14:42:26 INFO - Return code: 0 14:42:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:26 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:26 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:42:26 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:42:26 INFO - Using env: {'DISPLAY': ':0', 14:42:26 INFO - 'HOME': '/home/cltbld', 14:42:26 INFO - 'LANG': 'en_US.UTF-8', 14:42:26 INFO - 'LANGUAGE': 'en_US:en', 14:42:26 INFO - 'LOGNAME': 'cltbld', 14:42:26 INFO - 'MAIL': '/var/mail/cltbld', 14:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:26 INFO - 'MOZ_NO_REMOTE': '1', 14:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:26 INFO - 'NO_EM_RESTART': '1', 14:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:26 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:26 INFO - 'SHELL': '/bin/bash', 14:42:26 INFO - 'SHLVL': '1', 14:42:26 INFO - 'TERM': 'linux', 14:42:26 INFO - 'TMOUT': '86400', 14:42:26 INFO - 'USER': 'cltbld', 14:42:26 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:26 INFO - '_': '/tools/buildbot/bin/python'} 14:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:26 INFO - Downloading/unpacking psutil>=0.7.1 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:27 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:42:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:42:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:27 INFO - Installing collected packages: psutil 14:42:27 INFO - Running setup.py install for psutil 14:42:27 INFO - building 'psutil._psutil_linux' extension 14:42:27 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:42:27 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:42:27 INFO - building 'psutil._psutil_posix' extension 14:42:27 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:42:27 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:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:42:27 INFO - Successfully installed psutil 14:42:27 INFO - Cleaning up... 14:42:27 INFO - Return code: 0 14:42:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:42:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:42:27 INFO - Using env: {'DISPLAY': ':0', 14:42:27 INFO - 'HOME': '/home/cltbld', 14:42:27 INFO - 'LANG': 'en_US.UTF-8', 14:42:27 INFO - 'LANGUAGE': 'en_US:en', 14:42:27 INFO - 'LOGNAME': 'cltbld', 14:42:27 INFO - 'MAIL': '/var/mail/cltbld', 14:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:27 INFO - 'MOZ_NO_REMOTE': '1', 14:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:27 INFO - 'NO_EM_RESTART': '1', 14:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:27 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:27 INFO - 'SHELL': '/bin/bash', 14:42:27 INFO - 'SHLVL': '1', 14:42:27 INFO - 'TERM': 'linux', 14:42:27 INFO - 'TMOUT': '86400', 14:42:27 INFO - 'USER': 'cltbld', 14:42:27 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:27 INFO - '_': '/tools/buildbot/bin/python'} 14:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:42:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:42:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:42:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:42:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:42:29 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:42:29 INFO - Installing collected packages: mozsystemmonitor 14:42:29 INFO - Running setup.py install for mozsystemmonitor 14:42:29 INFO - Successfully installed mozsystemmonitor 14:42:29 INFO - Cleaning up... 14:42:29 INFO - Return code: 0 14:42:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:42: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:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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', '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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:42: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 blobuploader==1.2.4 14:42:29 INFO - Using env: {'DISPLAY': ':0', 14:42:29 INFO - 'HOME': '/home/cltbld', 14:42:29 INFO - 'LANG': 'en_US.UTF-8', 14:42:29 INFO - 'LANGUAGE': 'en_US:en', 14:42:29 INFO - 'LOGNAME': 'cltbld', 14:42:29 INFO - 'MAIL': '/var/mail/cltbld', 14:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:29 INFO - 'MOZ_NO_REMOTE': '1', 14:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:29 INFO - 'NO_EM_RESTART': '1', 14:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:29 INFO - 'SHELL': '/bin/bash', 14:42:29 INFO - 'SHLVL': '1', 14:42:29 INFO - 'TERM': 'linux', 14:42:29 INFO - 'TMOUT': '86400', 14:42:29 INFO - 'USER': 'cltbld', 14:42:29 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:29 INFO - '_': '/tools/buildbot/bin/python'} 14:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:42:30 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:42:30 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:42:30 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:42:30 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:42:30 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:42:30 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:42:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:42:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:42:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:42:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:42:31 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:42:31 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:42:31 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:42:31 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:42:31 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:42:31 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:42:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:42:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:42:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:42: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:42: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:42: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:42: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:42: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:42: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:42:32 INFO - Downloading docopt-0.6.1.tar.gz 14:42:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:42:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:42:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:42:32 INFO - Running setup.py install for blobuploader 14:42:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:42:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:42:32 INFO - Running setup.py install for requests 14:42:32 INFO - Running setup.py install for docopt 14:42:33 INFO - Successfully installed blobuploader requests docopt 14:42:33 INFO - Cleaning up... 14:42:33 INFO - Return code: 0 14:42:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:33 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:33 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:42:33 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:42:33 INFO - Using env: {'DISPLAY': ':0', 14:42:33 INFO - 'HOME': '/home/cltbld', 14:42:33 INFO - 'LANG': 'en_US.UTF-8', 14:42:33 INFO - 'LANGUAGE': 'en_US:en', 14:42:33 INFO - 'LOGNAME': 'cltbld', 14:42:33 INFO - 'MAIL': '/var/mail/cltbld', 14:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:33 INFO - 'MOZ_NO_REMOTE': '1', 14:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:33 INFO - 'NO_EM_RESTART': '1', 14:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:33 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:33 INFO - 'SHELL': '/bin/bash', 14:42:33 INFO - 'SHLVL': '1', 14:42:33 INFO - 'TERM': 'linux', 14:42:33 INFO - 'TMOUT': '86400', 14:42:33 INFO - 'USER': 'cltbld', 14:42:33 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:33 INFO - '_': '/tools/buildbot/bin/python'} 14:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:42:33 INFO - Running setup.py (path:/tmp/pip-d6tgoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:42:33 INFO - Running setup.py (path:/tmp/pip-yxHckE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:42:33 INFO - Running setup.py (path:/tmp/pip-M7915_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:42:33 INFO - Running setup.py (path:/tmp/pip-Bvw1PU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:42:33 INFO - Running setup.py (path:/tmp/pip-UyQEP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:42:33 INFO - Running setup.py (path:/tmp/pip-LelhHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:42:33 INFO - Running setup.py (path:/tmp/pip-pt6pyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:42:33 INFO - Running setup.py (path:/tmp/pip-vLG0Wf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:42:33 INFO - Running setup.py (path:/tmp/pip-hW0YaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:42:33 INFO - Running setup.py (path:/tmp/pip-9s3Sgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:42:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:42:33 INFO - Running setup.py (path:/tmp/pip-lYtoH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:42:34 INFO - Running setup.py (path:/tmp/pip-W1QSvt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:42:34 INFO - Running setup.py (path:/tmp/pip-1BCAhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:42:34 INFO - Running setup.py (path:/tmp/pip-d0PWVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:42:34 INFO - Running setup.py (path:/tmp/pip-plJoM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:42:34 INFO - Running setup.py (path:/tmp/pip-_Ur1gH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:42:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:42:34 INFO - Running setup.py (path:/tmp/pip-Nu6OgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:42:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:42:34 INFO - Running setup.py install for manifestparser 14:42:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:42:34 INFO - Running setup.py install for mozcrash 14:42:34 INFO - Running setup.py install for mozdebug 14:42:34 INFO - Running setup.py install for mozdevice 14:42:34 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:42:34 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:42:34 INFO - Running setup.py install for mozfile 14:42:35 INFO - Running setup.py install for mozhttpd 14:42:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozinfo 14:42:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozInstall 14:42:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozleak 14:42:35 INFO - Running setup.py install for mozlog 14:42:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for moznetwork 14:42:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozprocess 14:42:35 INFO - Running setup.py install for mozprofile 14:42:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozrunner 14:42:35 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:42:35 INFO - Running setup.py install for mozscreenshot 14:42:36 INFO - Running setup.py install for moztest 14:42:36 INFO - Running setup.py install for mozversion 14:42:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:42:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:42:36 INFO - Cleaning up... 14:42:36 INFO - Return code: 0 14:42:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:42:36 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:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:36 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:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:36 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:36 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:42:36 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:42:36 INFO - Using env: {'DISPLAY': ':0', 14:42:36 INFO - 'HOME': '/home/cltbld', 14:42:36 INFO - 'LANG': 'en_US.UTF-8', 14:42:36 INFO - 'LANGUAGE': 'en_US:en', 14:42:36 INFO - 'LOGNAME': 'cltbld', 14:42:36 INFO - 'MAIL': '/var/mail/cltbld', 14:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:36 INFO - 'MOZ_NO_REMOTE': '1', 14:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:36 INFO - 'NO_EM_RESTART': '1', 14:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:36 INFO - 'SHELL': '/bin/bash', 14:42:36 INFO - 'SHLVL': '1', 14:42:36 INFO - 'TERM': 'linux', 14:42:36 INFO - 'TMOUT': '86400', 14:42:36 INFO - 'USER': 'cltbld', 14:42:36 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:36 INFO - '_': '/tools/buildbot/bin/python'} 14:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:42:36 INFO - Running setup.py (path:/tmp/pip-VMie5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:42:36 INFO - Running setup.py (path:/tmp/pip-C7HwvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:42:36 INFO - Running setup.py (path:/tmp/pip-WFJpkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:42:36 INFO - Running setup.py (path:/tmp/pip-zgS6Ut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:42:36 INFO - Running setup.py (path:/tmp/pip-IxJfO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:42:36 INFO - Running setup.py (path:/tmp/pip-nnv6dw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:42:36 INFO - Running setup.py (path:/tmp/pip-jbYViG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:42:36 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:42:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:42:37 INFO - Running setup.py (path:/tmp/pip-su4djT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:42:37 INFO - Running setup.py (path:/tmp/pip-4wSy9q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:42:37 INFO - Running setup.py (path:/tmp/pip-6CZ2_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:42:37 INFO - Running setup.py (path:/tmp/pip-PhVBVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:42:37 INFO - Running setup.py (path:/tmp/pip-mGSf9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:42:37 INFO - Running setup.py (path:/tmp/pip-xxXnWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:42:37 INFO - Running setup.py (path:/tmp/pip-l28BIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:42:37 INFO - Running setup.py (path:/tmp/pip-RPyFkL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:42:37 INFO - Running setup.py (path:/tmp/pip-a4It3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:42:37 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:42:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:42:37 INFO - Running setup.py (path:/tmp/pip-DQ9t1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:37 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:42:39 INFO - Downloading blessings-1.5.1.tar.gz 14:42:39 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:42:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:42:39 INFO - Installing collected packages: blessings 14:42:39 INFO - Running setup.py install for blessings 14:42:39 INFO - Successfully installed blessings 14:42:39 INFO - Cleaning up... 14:42:39 INFO - Return code: 0 14:42:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:42:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:42:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:42:39 INFO - Reading from file tmpfile_stdout 14:42:39 INFO - Current package versions: 14:42:39 INFO - argparse == 1.2.1 14:42:39 INFO - blessings == 1.5.1 14:42:39 INFO - blobuploader == 1.2.4 14:42:39 INFO - docopt == 0.6.1 14:42:39 INFO - manifestparser == 1.1 14:42:39 INFO - mozInstall == 1.12 14:42:39 INFO - mozcrash == 0.16 14:42:39 INFO - mozdebug == 0.1 14:42:39 INFO - mozdevice == 0.47 14:42:39 INFO - mozfile == 1.2 14:42:39 INFO - mozhttpd == 0.7 14:42:39 INFO - mozinfo == 0.9 14:42:39 INFO - mozleak == 0.1 14:42:39 INFO - mozlog == 3.1 14:42:39 INFO - moznetwork == 0.27 14:42:39 INFO - mozprocess == 0.22 14:42:39 INFO - mozprofile == 0.28 14:42:39 INFO - mozrunner == 6.11 14:42:39 INFO - mozscreenshot == 0.1 14:42:39 INFO - mozsystemmonitor == 0.0 14:42:39 INFO - moztest == 0.7 14:42:39 INFO - mozversion == 1.4 14:42:39 INFO - psutil == 3.1.1 14:42:39 INFO - requests == 1.2.3 14:42:39 INFO - wsgiref == 0.1.2 14:42:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:39 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:39 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:42:39 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:42:39 INFO - Using env: {'DISPLAY': ':0', 14:42:39 INFO - 'HOME': '/home/cltbld', 14:42:39 INFO - 'LANG': 'en_US.UTF-8', 14:42:39 INFO - 'LANGUAGE': 'en_US:en', 14:42:39 INFO - 'LOGNAME': 'cltbld', 14:42:39 INFO - 'MAIL': '/var/mail/cltbld', 14:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:39 INFO - 'MOZ_NO_REMOTE': '1', 14:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:39 INFO - 'NO_EM_RESTART': '1', 14:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:39 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:39 INFO - 'SHELL': '/bin/bash', 14:42:39 INFO - 'SHLVL': '1', 14:42:39 INFO - 'TERM': 'linux', 14:42:39 INFO - 'TMOUT': '86400', 14:42:39 INFO - 'USER': 'cltbld', 14:42:39 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:39 INFO - '_': '/tools/buildbot/bin/python'} 14:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 INFO - Cleaning up... 14:42:40 INFO - Return code: 0 14:42:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:42: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:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42: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', '--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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:40 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:42:40 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:42:40 INFO - Using env: {'DISPLAY': ':0', 14:42:40 INFO - 'HOME': '/home/cltbld', 14:42:40 INFO - 'LANG': 'en_US.UTF-8', 14:42:40 INFO - 'LANGUAGE': 'en_US:en', 14:42:40 INFO - 'LOGNAME': 'cltbld', 14:42:40 INFO - 'MAIL': '/var/mail/cltbld', 14:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:40 INFO - 'MOZ_NO_REMOTE': '1', 14:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:40 INFO - 'NO_EM_RESTART': '1', 14:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:40 INFO - 'SHELL': '/bin/bash', 14:42:40 INFO - 'SHLVL': '1', 14:42:40 INFO - 'TERM': 'linux', 14:42:40 INFO - 'TMOUT': '86400', 14:42:40 INFO - 'USER': 'cltbld', 14:42:40 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:40 INFO - '_': '/tools/buildbot/bin/python'} 14:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:40 INFO - Downloading/unpacking jsonschema 14:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:42:42 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:42:42 INFO - Downloading/unpacking functools32 (from jsonschema) 14:42: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:42: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:42: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:42: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:42: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:42: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:42:42 INFO - Downloading functools32-3.2.3-2.tar.gz 14:42:42 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:42:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:42:42 INFO - warning: no files found matching '*.txt' 14:42:42 INFO - no previously-included directories found matching 'build' 14:42:42 INFO - no previously-included directories found matching 'dist' 14:42:42 INFO - no previously-included directories found matching '.git*' 14:42:42 INFO - Installing collected packages: jsonschema, functools32 14:42:42 INFO - Running setup.py install for functools32 14:42:42 INFO - warning: no files found matching '*.txt' 14:42:42 INFO - no previously-included directories found matching 'build' 14:42:42 INFO - no previously-included directories found matching 'dist' 14:42:42 INFO - no previously-included directories found matching '.git*' 14:42:42 INFO - Successfully installed jsonschema functools32 14:42:42 INFO - Cleaning up... 14:42:42 INFO - Return code: 0 14:42:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:42:42 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 0x7f14aa27ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1296630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', '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:42:42 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:42:42 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:42:42 INFO - Using env: {'DISPLAY': ':0', 14:42:42 INFO - 'HOME': '/home/cltbld', 14:42:42 INFO - 'LANG': 'en_US.UTF-8', 14:42:42 INFO - 'LANGUAGE': 'en_US:en', 14:42:42 INFO - 'LOGNAME': 'cltbld', 14:42:42 INFO - 'MAIL': '/var/mail/cltbld', 14:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:42 INFO - 'MOZ_NO_REMOTE': '1', 14:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:42:42 INFO - 'NO_EM_RESTART': '1', 14:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:42:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:42:42 INFO - 'SHELL': '/bin/bash', 14:42:42 INFO - 'SHLVL': '1', 14:42:42 INFO - 'TERM': 'linux', 14:42:42 INFO - 'TMOUT': '86400', 14:42:42 INFO - 'USER': 'cltbld', 14:42:42 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:42 INFO - '_': '/tools/buildbot/bin/python'} 14:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:42:42 INFO - Downloading/unpacking flake8 14:42: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:42: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:42: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:42: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:42: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:42: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:42:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:42:44 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:42:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:42: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:42: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:42: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:42: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:42: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:42: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:42:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:42:44 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:42:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:42: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:42: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:42: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:42: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:42: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:42: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:42:44 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:42:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:42: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:42: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:42: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:42: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:42: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:42: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:42:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:42:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:42:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:42:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:42:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:42:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:42:45 INFO - no previously-included directories found matching 'docs/_build' 14:42:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:42:45 INFO - Running setup.py install for pep8 14:42:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:42:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:42:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:42:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:42:45 INFO - no previously-included directories found matching 'docs/_build' 14:42:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:42:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:42:45 INFO - Cleaning up... 14:42:45 INFO - Return code: 0 14:42:45 INFO - Running post-action listener: _resource_record_post_action 14:42:45 INFO - Running post-action listener: _start_resource_monitoring 14:42:45 INFO - Starting resource monitoring. 14:42:45 INFO - ##### 14:42:45 INFO - ##### Running install step. 14:42:45 INFO - ##### 14:42:45 INFO - Running pre-action listener: _resource_record_pre_action 14:42:45 INFO - Running main action method: install 14:42:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:42:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:42:45 INFO - Reading from file tmpfile_stdout 14:42:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:42:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:42:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:42:45 INFO - Reading from file tmpfile_stdout 14:42:45 INFO - Output received: 14:42:45 INFO - Usage: mozinstall [options] installer 14:42:45 INFO - Options: 14:42:45 INFO - -h, --help show this help message and exit 14:42:45 INFO - -d DEST, --destination=DEST 14:42:45 INFO - Directory to install application into. [default: 14:42:45 INFO - "/builds/slave/test-pgo"] 14:42:45 INFO - --app=APP Application being installed. [default: firefox] 14:42:45 INFO - mkdir: /builds/slave/test-pgo/build/application 14:42:45 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:42:45 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:43:01 INFO - Reading from file tmpfile_stdout 14:43:01 INFO - Output received: 14:43:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:43:01 INFO - Running post-action listener: _resource_record_post_action 14:43:01 INFO - ##### 14:43:01 INFO - ##### Running run-tests step. 14:43:01 INFO - ##### 14:43:01 INFO - Running pre-action listener: _resource_record_pre_action 14:43:01 INFO - Running main action method: run_tests 14:43:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:43:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:43:01 INFO - Python 2.7.3 14:43:01 INFO - Return code: 0 14:43:01 INFO - grabbing minidump binary from tooltool 14:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:01 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 0x1327840>, '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 0x12946b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1294b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:43:01 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:43:01 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:43:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:43:01 INFO - Return code: 0 14:43:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:43:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:43:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:43:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:43:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:43:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:43:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:43:02 INFO - Return code: 0 14:43:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:43:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:43:02 INFO - Using env: {'DISPLAY': ':0', 14:43:02 INFO - 'HOME': '/home/cltbld', 14:43:02 INFO - 'LANG': 'en_US.UTF-8', 14:43:02 INFO - 'LANGUAGE': 'en_US:en', 14:43:02 INFO - 'LOGNAME': 'cltbld', 14:43:02 INFO - 'MAIL': '/var/mail/cltbld', 14:43:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:43:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:43:02 INFO - 'MOZ_NO_REMOTE': '1', 14:43:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:43:02 INFO - 'NO_EM_RESTART': '1', 14:43:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:43:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:43:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:43:02 INFO - 'SHELL': '/bin/bash', 14:43:02 INFO - 'SHLVL': '1', 14:43:02 INFO - 'TERM': 'linux', 14:43:02 INFO - 'TMOUT': '86400', 14:43:02 INFO - 'USER': 'cltbld', 14:43:02 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445', 14:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:43:02 INFO - '_': '/tools/buildbot/bin/python'} 14:43:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sr0OyqbMSQufBa975mH0Tg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:43:02 INFO - mozversion application_buildid: 20151221113009 14:43:02 INFO - mozversion application_changeset: 6587e9c69c362f1674b3e158be23311139411441 14:43:02 INFO - mozversion application_display_name: Nightly 14:43:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:43:02 INFO - mozversion application_name: Firefox 14:43:02 INFO - mozversion application_remotingname: firefox 14:43:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:43:02 INFO - mozversion application_vendor: Mozilla 14:43:02 INFO - mozversion application_version: 46.0a1 14:43:02 INFO - mozversion platform_buildid: 20151221113009 14:43:02 INFO - mozversion platform_changeset: 6587e9c69c362f1674b3e158be23311139411441 14:43:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:43:02 INFO - mozversion platform_version: 46.0a1 14:43:02 INFO - using testdate: 1450737782 14:43:02 INFO - actual date: 1450737782 14:43:02 INFO - starting webserver on 'localhost:34509' 14:43:02 INFO - SUITE-START | Running 3 tests 14:43:02 INFO - TEST-START | dromaeo_css 14:43:02 INFO - operating with platform_type : linux_ 14:43:02 INFO - Initialising browser for dromaeo_css test... 14:43:02 INFO - TEST-INFO | started process 24066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmhDTBE/profile http://localhost:34509/getInfo.html) 14:43:07 INFO - PROCESS | 24066 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 14:43:07 INFO - PROCESS | 24066 | __metrics Screen width/height:1600/1200 14:43:07 INFO - PROCESS | 24066 | colorDepth:24 14:43:07 INFO - PROCESS | 24066 | Browser inner width/height: 1024/697 14:43:07 INFO - PROCESS | 24066 | __metrics 14:43:07 INFO - PROCESS | 24066 | 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:43:07 INFO - PROCESS | 24066 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:07 ERROR - PROCESS | 24066 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:43:07 INFO - TEST-INFO | 24066: exit 0 14:43:07 INFO - Browser initialized. 14:43:07 INFO - Running cycle 1/1 for dromaeo_css test... 14:43:07 INFO - TEST-INFO | started process 24166 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmhDTBE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:19 INFO - PROCESS | 24166 | RSS: Main: 149524480 14:43:19 INFO - PROCESS | 24166 | 14:44:10 INFO - PROCESS | 24166 | 1450737850403 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:46:18 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34509/tests/dromaeo/cssquery-ext.html) 14:46:20 INFO - PROCESS | 24166 | RSS: Main: 290140160 14:46:20 INFO - PROCESS | 24166 | 14:49:22 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-ext.html (next: http://localhost:34509/tests/dromaeo/cssquery-jquery.html) 14:49:22 INFO - PROCESS | 24166 | RSS: Main: 221679616 14:49:22 INFO - PROCESS | 24166 | 14:52:24 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34509/tests/dromaeo/cssquery-mootools.html) 14:52:25 INFO - PROCESS | 24166 | RSS: Main: 226156544 14:52:25 INFO - PROCESS | 24166 | 14:55:27 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34509/tests/dromaeo/cssquery-prototype.html) 14:55:27 INFO - PROCESS | 24166 | RSS: Main: 210759680 14:55:27 INFO - PROCESS | 24166 | 14:58:30 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34509/tests/dromaeo/cssquery-yui.html) 14:58:31 INFO - PROCESS | 24166 | RSS: Main: 215728128 14:58:31 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | Cycle 1(1): loaded http://localhost:34509/tests/dromaeo/cssquery-yui.html (next: http://localhost:34509/tests/dromaeo/cssquery-dojo.html) 15:01:33 INFO - PROCESS | 24166 | RSS: Main: 260542464 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | __start_tp_report 15:01:33 INFO - PROCESS | 24166 | _x_x_mozilla_page_load 15:01:33 INFO - PROCESS | 24166 | _x_x_mozilla_page_load_details 15:01:33 INFO - PROCESS | 24166 | |i|pagename|runs| 15:01:33 INFO - PROCESS | 24166 | |0;dojo.html;3134.1851118709137;3144.5754823098873;3151.3697260547883;3152.55864179015;3174.1271150433636;5006.948540806435;5110.182370820669;5187.974060129699;5205.4013788414395;5295.523402893738;5172;5242.161254199329;5242.606804489669;5251.291075704778;5275.6043296752805;4763.142634325829;4803.807847686088;4815.831445899376;4897.755112244391;4905.950940490585;326.5806932228741;4679.976600116995;4829.2756086587115;4836.661433699643;4875.098106850226;4770.880727981794;4807.783649735753;4867.148249056437;4871.683340582851;4877.829275975324;4839.177339852198;4842.12841688496;4842.806287748521;4847.345608342864;4879.609631229493;4687.695299805502;4809.5430934061205;4823.252395878644;4825.131476334259;4872.244802055651;5026.070177017264;5060.84817455477;5066.36670416198;5071.56891664209;5115.130427827241;5649;5652.06740887753;5657;5669.433056694339;5678.034734095214;5695.202671625976;5709.857253568653;5719.48524632785;5725.713714314309;5808.12878068289;5318.627696061278;5344.839654810362;5379.757910894019;5384.057789886793;5409.83770486886;5778.3643799182055;5785.797497087582;5789.421057894177;5791.160281759121;5829.562782791308;5396.83809485716;5560.694161821139;5594.216809646653;5595.804146854841;5613.186088017214;5536.114221724505;5538.44615538451;5587.776488940478;5623.325200975827;5660.603757737002;5653.830385088454;5692.516136128475;5696.316442026983;5699;5701.828945131652;5518.172274158828;5626.521745651584;5699.230603868425;5711.514521265656;5711.657300561979;4381.3427985801745;4432.512423633398;4437.600615944581;4472.485664148599;4478.283474644041;3947.486826712509;3952;3963.3460479020637;3964.0684439156776;3968.583298753647;5179.507946745053;5261.421243663271;5268.894622107537;5364.91952620711;5435.211894275308;5602.327720673546;5674.77300907959;5689.573282003867;5694.259746233046;5734.885302294014;5413.458654134555;5437.728113594305;5439.646422982493;5441.755121019563;5444.128939369682;4877.219644856806;4886.60907127429;4965.925511117264;5012.8496145115705;5056.089903817275;5738.340090889517;5779;5868.823935281948;5912.438318359749;5914.349421563625;5649.350324712711;5656.490915817596;5658.094704847204;5658.717064146858;5672.347680016685;5571.832845014656;5697.829065128053;5776.711164441677;5778;5789.768409263751;5542.3626282977975;5562.082256427644;5637.2107904894165;5643.915341269802;5686.715664216856;5599.524040456607;5630.887382252414;5632.183333416713;5636.070048441961;5651.547876169979;5379.731013449234;5494.340679118532;5498.202760599771;5516.889662206813;5540.085885828793;5456.399796022355;5477.917831232455;5493.890122197454;5502.147167189092;5537.1140617501005;5460.645058071213;5508.531774799187;5518.503334699896;5519.530839878656;5521.475459831309;5409.540189083972;5499.560035197254;5511.448855114457;5653.3216014076925;5741.3971532988435;5424.864378390572;5434.347878254476;5493.066178749702;5527.640703354269;5575.665460072409 15:01:33 INFO - PROCESS | 24166 | |1;ext.html;565.3159676791082;594.1355327997763;600.8377738010737;607.4017093163236;613.9785107521236;29691;39119.80440097799;39693.2061358773;39808.800955995255;39823.203535929264;42385;42396.364054539205;42476.36285455721;42769.7861510692;42796;7565.735199268027;7692.423068269874;8348.33213342931;8503.532305723184;8505.702300419487;10569.788604227911;10744.677659670184;10825.24223304369;10827.025567698905;10843.728906777314;10460.424676642782;10530.736731581734;10533.894661053406;10542;10548.208884333706;7822.295993360625;8021.19788021199;8035.035795704494;10419.322744021652;10594.735131621694;10301.124404425633;10462.424566648831;10468.790624187473;10473.79052418955;10478.528466219039;40084;40490.79754601208;40509.189816203805;40524.18951620951;40634.390484142765;3243.3189030303665;3310.702036816674;3384.9830750846336;3557.1640664443835;3953.802309884523;29169.41661166786;29565.55651665227;29667;29676.258093547833;29774.404511909856;3338.382399256121;3367.1413789483768;3428.5371474851077;3487.232808782064;3502.404591219499;261643;264017;264138;264305;264493;52036;52836.73581632144;57056.14415783767;57592.13611795827;58004.70997644985;58437;58790;58798.70600646969;59000;59032.40967590355;14860.851391486163;14923.253837308092;14986.70026599462;15096.622584435258;15184.240787960778;10482.947585262025;10511.947440262902;10513.579456821795;10521.473926303654;10579.523921423555;19152;19277.614447710966;19301.841889486393;19310.131044102767;19339.323123690883;7340.596267205248;7550.924490755132;7628.956652973932;7676.961615192;7720.884186737204;997.3567049253191;1003.1322905686675;1004.231762701534;1045.6862941117633;1059.8516207730925;26612.669366531984;26667.866660666572;26728.331791705365;26771.86614066917;27127.86436067807;1010.5099026971913;1023.6826583759058;1036.7511797168777;1067.9305845120043;1106.6016234155697;12871.935640321926;13262.668433289053;13265.66835829112;13277.336133193496;15046.172460514557;268491;271305;272870;272912;273011;48307.75846120817;48310;48475.75762121167;48613.5138648609;48699.26951095736;1142.5772464188137;1304.9869501304865;1325.8872995795273;1326.0452474218548;1349.466960550577;19749.703754443406;27319.453610928067;28503.572446413735;29319.267018324714;29530.852345738134;49357;49822;49880.750596246784;49888.25167622561;49899;295393;298532;303485;305766;308383;30097.398052039276;30390.54414183833;30589.54115688222;30768.230794230323;30890.691093088783;36862.44706329461;37893.81053094717;38029.429558557196;38093;38278.61721382862;35160.64839351574;36101.81949090238;38008.80995595004;38742.80628596839;40047.599524004385;35543.289134216655;36043.27913441769;36357.63642363543;36385.63614363822;36387;34607.13482162966;34981.65018349886;35000.29999400049;35368.11579710528;35796.64203357933;26820;27884.58173127364;29635.407291854473;30021.249468763457;30372.088837334915;23019.068375092276;24412.973326658033;24570.63283305004;24745.505089897742;24759.62860557129 15:01:33 INFO - PROCESS | 24166 | |2;jquery.html;356.11505409058486;357.52092196456744;361.21976530693706;365.8938907716762;366.4283717400854;13846.945350469257;14044.438222471088;16556.586085347873;16863.32546698132;17355.479335619937;12483.251004939688;12556.37218139094;13129.277889716086;15894.443694470696;16734.330626774943;5319.255304257397;5439.945600543983;5460.5085542301185;5469;5478.369987451434;3740.0836794985266;3870.980645096771;5133.845984620468;5496.5434159947645;5537.1140617501205;5492.258545096401;5640.887182256352;5663.575231857607;5683.488486036256;5685.346185188715;5547.916781248265;5631.239782629354;5633.408492108331;5800.651960882318;5860.765569377219;5196.92204616931;5226.686398816083;5234.790608375661;5237.319148510669;5250.212468129773;19094.61810763777;19865.702014469796;20343.28798492046;20371.287004954756;20666.276680316118;2051.6204502166997;2078.3381254166034;2134.466383404149;2137.1130980643015;2198.274569392097;9280.72157835266;9487.241020718326;9527.90472095277;9679.419234845931;9687.32188746788;1819.3450357871288;1830.1672738903767;1858.2845604442252;1890.744804183514;1907.7901430842596;60743.39256607422;63654.68172659107;63660.36339636637;65133.67433162804;65832.670836646;9937.65218217359;9949.303548751517;10096.091351778376;10158.288919775692;10217.693469195936;13111.409986550629;13180.340982951006;13182.934085329513;13192.142510736772;13204.141730787467;7376.852462950711;7377.188509263977;7446.85106297871;7505.812354691177;7598.088229412506;7268.164161121539;7276.854462910712;7300.56196628204;7323.377512911356;7324.67038983247;4454.153710794939;4520.751358675238;4529.750863702528;4572.0627271409285;4572.314152877095;1760.392664530735;1787.5888545634316;1813.5919418130816;1830.3776715916651;1900.6483800496953;862.9525376104249;885.9202671759573;891.3893982621925;896.7713233125511;948.8671585977969;15369.385224591115;16002.919985399998;16820.831791682172;16893.83106168947;17137.228824702917;816.7993050216172;891.2869704236584;895.2032690905099;906.5512571277128;917.312015988009;8644.913550864536;8924.06297338783;8943.418677785923;8969.14793094655;9125.087491250822;538806;546563;555512;556418;579825;79965.20034799694;81748.59125704333;82718;82933.58533207416;83292;1148.3511815824033;1155.6013175454455;1163.2380790582183;1166.1603645375317;1179.2806388103422;14256.857431425968;14272.64318392007;14442.541148432347;14587.05184163026;14785.630359241106;32125.678743213204;32180;32216.67783322137;32637.18407039843;33472.49791253182;42456.78771606122;43051.13897722091;43054.569454305056;43964.68105956826;45050.09899802051;9456.574454149717;9603.423794572349;9636.566354513923;9647.372920760128;9683.709488715349;11790;16377.67244655124;17006.57483562921;17210.741838872178;17347.479575612753;14085.647858803202;14101.224432656303;14441.855581444472;14482.710345792815;14788.778168327268;13578.728425431633;14050.156990580597;14219.573412797632;14421;14652;11750.882491174978;14400.351984160947;14787.630309242355;15226.543203703906;15388.692226155637;8435.493870367798;9525.190358819578;9564.4739539326;9639.084286992724;9673.70978870635;7943.761687149395;10709.303895246783;13704.588862334145;13910.374033168735;15161.848381516043 15:01:33 INFO - PROCESS | 24166 | |3;mootools.html;1316.466830933471;1475.9557213283601;1532.7700844873264;1646.9011859288444;1778.048743922002;6737.696803643836;7482.43881708872;7691.269329413697;7695.038120234971;7721.884171737428;7569;7721.575313357763;7727.381809455244;7730.690772369098;7737.961310193441;2024.9797502025012;2059.588082383522;2066.0392917293457;2284.223364056225;2332.47519308156;2047.805458481442;2307.457747429353;2347.8708671023173;2353.035255545227;2355.3640517060385;2266.3087758233733;2295.931122066341;2308.2613563659634;2320.6983092197993;2321.5589038082794;2284.657301404786;2303.6890019847356;2327.615943369342;2329.9534009319805;2333.381653861728;2306.4003359126746;2335.637976113705;2339.4970081432402;2340.1107579119825;2340.742518322983;7606.353459955911;7624.046994125734;7682.1549629540705;7683.346915512188;7687.385009199306;4511.1654343946475;4511.368408422791;4574.1080489304595;4576.26779715244;4581.725096494221;2874.195225336909;2922.941541169165;2924.824510529375;2940.955885661717;2952.689967553419;905.6151135767273;927.4620719982394;938.5823308627663;946.2032849321541;991.2367477042709;9857.753556161082;9884.456354900478;9902.108810207115;9921.255905807093;9965.55155018026;4069.4709687740406;4069.715119941635;4114.753114813121;4119.237940980928;4133.524644665842;8561.785955351166;8568.443051201652;8569.314454843598;8571.871421928676;8578.528180950108;4541.886452838706;4549.522300158502;4570.565796249351;4574;4575.313702944585;4171.499420069611;4172.4784401949755;4173.207090652766;4176.081262122329;4183.853565125206;3140.481820499592;3186.187522181875;3637.799921004317;3655.177585043344;3678.9632103679155;1099.6041425086962;1129.3731978751707;1159.6115301373966;1160.5647882044234;1170.9297442153497;1001.2690735762789;1001.4642166441065;1049.2235745548392;1067.3595842494597;1155.3876445483907;7118.5017048806085;7155.499115062;7158.463115266376;7168.2831716827895;7182.533135346186;1097.1113398147527;1099.2195541165702;1103.6578660615235;1133.9376334301692;1136.7783282260045;5651.943480565224;5687.459691329317;5779.2775903012125;5805.158252053428;5810.4770570648;8908.643654253758;9053.049429809775;9135.862962055575;9158.587863546156;9161.175494205554;8904.8664270036;9008.32437567172;9062.093790621017;9176;9176.403533770284;7210.999999999895;7242.529235599669;7246.130464344313;7292.744753933587;7328.413726901835;6908.620025898624;6992.545484543489;7027.402670773042;7038.824029399306;7043.647817608997;8096.352291816523;8126.959365203136;8181.79545511367;8273.669053237803;8332.125126861834;8153.592320383838;8392.32861371101;8450.19723126302;8517.276031537142;8519.659213631385;6763.6618169092335;6844.828879278058;6856.5200435969;6857.965710171417;6874.175098988154;6495.837604059936;6590.439812615981;6940.09778728762;7373.483856130019;7457.552546847207;6855.897161542681;6907.13660792401;6958.652067396509;7030;7071.646417678992;6688.063671085954;6710.228323742832;6719.160104986877;6793.5244532882225;6801.761938332134;6698.799036028927;6711;6719.462443004646;6740.224874139537;6750.493712971645;6289.905651415141;6436.388543088399;6465.159529261354;6467.935320646733;6490.026496025445;6365;6415.294317624965;6429.839254018687;6430.742770289136;6432.710528026344 15:01:33 INFO - PROCESS | 24166 | |4;prototype.html;347.7322461704488;348.11752208152325;348.28080014769483;356.5133592646038;359.4320972862875;5935.4954828839545;5980.61126026808;5991.850203744898;5999.610025348349;6023.457888790008;5649.12438572022;5707.229524014268;5777.45114214149;5877.441643043904;5919.348871624129;4585.403897493321;4589.747563883985;4593.999999999992;4595.333676616889;4616.215243408612;4388.341748737683;4597.195490789099;4597.471290801567;4609.67732258742;4616.446026476828;4383.408239887623;4420.668449866257;4569.314602809572;4590.816367345302;4594.517575654559;4539.977300113512;4559.270516717343;4564.566366195206;4577.8397756078375;4591.724496530185;4053;4056.1279324944985;4068.4914385701786;4069.0030942419003;4071.1043570414463;5486.1222204447095;5601.859953501154;5606.046972014768;5618.747156377973;5625.324961004665;5349.812756553541;5357.491038351351;5357.892842143136;5361.517463428271;5363.061464243741;6284.937150628527;6288.968555157241;6290.276618188876;6294.370562943669;6297.748090076391;4513.345564893105;4514.593686568224;4516.503184649686;4517.254652982254;4520.412346394981;6367.267764207083;6530.869382612369;6540.247871494791;6547.607143571353;6555.672216389209;4522.773861306987;4559.133764584784;4559.612432943237;4560.95439045612;4561.882338827008;4615.446146462379;4617.053504031665;4618.884527886763;4619.95380046202;4624.375709279271;5298.019866324742;5305.920411193835;5307.946920530745;5310.230016647564;5314.256004159421;6222.875542489125;6343.714532846033;6347.587406818634;6364;6376.7130479128555;1609.4769200010044;1629.535582359022;1631.7144499712504;1634.1584084196647;1634.7466142747655;1062.1661995333625;1086.8641419822522;1091.0943916549245;1091.3779145886767;1094.458243169636;6094.146819445281;6097.420745029215;6105.96947015271;6111.236095488064;6111.8472038198515;6545.9018114728315;6548.836279092966;6549.869002619921;6552;6554.8361290968105;5915.585908986416;5995.310539288038;6000.429959153874;6126.111713801474;6159.784407545714;3544.929101418009;3558.0393293810525;3567.126054116758;3567.5897271813556;3571.4821350904494;6711.261761206263;6713.966430167818;6714.764983225564;6721.8655626887185;6726.7981960541265;6639.834004149935;6772.492063095189;6786;6792.728290868409;6796.082528858639;6698.162729658793;6698.363655452724;6701.061851340816;6703.497237707192;6710.899336509956;6581.901271480836;6588.934110659024;6591;6603.966980165068;6607.735690572324;6383.808485745435;6532.771353002622;6541.215054193527;6543.934560654333;6550.705218265094;6686.765963191265;6689.5986240825705;6692.364225398579;6692.431143352675;6697.832554186184;4556;4556.908861822679;4557.316402539645;4560.110778398313;4562.315652652129;6430.453411460078;6592.80221593353;6593.571417857824;6594.868102638016;6606.933930660824;6402.519811014099;6408.29508754046;6410.173100666288;6415.679216039086;6418.839529011812;6395.16862807832;6401.455876250571;6402.9679851602305;6410.358964103739;6413.390727880844;6058.848528786815;6202.131701561875;6206.689665516797;6217;6288.874222515433;6358.872822543616;6365.490760739037;6409.423151916163;6410;6423.550351475352;6224.595401298901;6230.50155987529;6290.968545157245;6295.811125666238;6296.496280297657 15:01:33 INFO - PROCESS | 24166 | |5;yui.html;830.4892491117964;834.0991728932753;837.2464781696473;840.4831028917216;843.5191940593857;12638;12857.807132893015;12863.228206307616;12925.74148517029;13002;15241.695166096672;15298.158601276926;15326.310316035777;15344.539663810103;15359.923200383982;693.143967200507;830.1573902488964;843.5234092737614;843.641452382738;843.9620217090215;695.6556504530265;809.3282575462352;819.5697258939045;820.7004443378183;820.7127505373102;874.1389731114847;875.2691502595309;877.1579283887476;878.41585345745;880.5905254056862;715.7101373943535;723.3995783499682;864.5417928497906;871.2202578692066;871.2246100970142;641.3906788550848;641.5733537197758;641.6759536434117;645.3868824616586;646.9967650161766;13751.312434378242;13834.861651383459;13880.097793643381;13891.166530008231;13892.93053534736;11902.821457678141;12418.565350212699;12439.93780031103;12540.372981350896;12807.423665935055;10221.488925553767;10423.79152416955;10563.41901195434;10805.297655652435;10898.564057437692;3290.7696461247724;3336.7163791077787;3377.054424761071;3379.662033796625;3415.2315728960784;47593;47720.76139619314;47759.52240477585;47774.5222547777;47903;9785.608575657036;9795.167410770022;9813;9870.407775533491;10352.896471035343;17706.29174833018;17761.911190443963;17763.911180444273;17800.109994500483;18315.908420457814;6831.2144103427745;6974.9537569365;7221.31397517235;7334.486585938933;7421.591812450367;3579.0873327301892;3664.59689434162;3732.6267373263;3740.121071548184;3823.967528767217;2899.869505872241;2928.575356573285;2935.5890175375466;2946.204524778298;2947.469455497988;564.432745091189;578.3233616668424;588.7203578300273;593.5844908564022;604.268834709997;613.1691557939017;631.4506379449816;638.2373064188344;645.7743570863473;651.9413252807175;7592.316691497792;8611;8642.740717778477;8777.42946708462;9173.266138708887;542.4765101676901;642.1584488637759;648.2642201101689;659.6932426421737;682.9965850170718;3467.687908088284;3641.344557979536;3768.6419790119894;3774.54705435344;3794.165283637595;49523;51412.22881656778;51689;52365.47634523682;55442.44557554454;49748;49989.50010499921;50152.498475014785;50859;51000.74499627478;44226;45313.773431132635;45361;45470.31794523085;46200;8140.267375936194;8549.87175192385;8637.412472155776;8672.306215502871;8829.293656507336;33723.66276337205;33969.830150849084;34112;34561.827190863885;35216.471752923215;41977.370339445544;45265;45820.54179458163;47448.2882756752;49552.256716150005;10546.894531054591;10749.355038697391;10858.565657373932;11107.44462776874;11158.944205278922;12052.939735301617;12334.568290109803;12386.31875246834;12506.312152831682;12596.937015314865;10483.633072842718;10813.189010824377;11080.279781814157;11256.718582035515;11314.717132071764;11328.546858125583;11652.417379131179;11715.589954351557;11785.233959792586;12146.939265303618;10997.560097596006;11042.33745975244;11113.277636953571;11199.552017919192;11372.829407559058;9499.192568631745;9803.901960980298;9931;10113.342632728849;10118.13995810335;8572.571371431279;8641.654333826576;9025.41334813235;9151.86272205904;9460.148586627236 15:01:33 INFO - PROCESS | 24166 | __end_tp_report 15:01:33 INFO - PROCESS | 24166 | __start_cc_report 15:01:33 INFO - PROCESS | 24166 | _x_x_mozilla_cycle_collect,1017 15:01:33 INFO - PROCESS | 24166 | __end_cc_report 15:01:33 INFO - PROCESS | 24166 | __startTimestamp1450738893765__endTimestamp 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | ------- Summary: start ------- 15:01:33 INFO - PROCESS | 24166 | Number of tests: 6 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#0] dojo.html Cycles:165 Average:5232.71 Median:5477.92 stddev:687.25 (12.5%) stddev-sans-first:669.35 15:01:33 INFO - PROCESS | 24166 | Values: 3134.2 3144.6 3151.4 3152.6 3174.1 5006.9 5110.2 5188.0 5205.4 5295.5 5172.0 5242.2 5242.6 5251.3 5275.6 4763.1 4803.8 4815.8 4897.8 4906.0 326.6 4680.0 4829.3 4836.7 4875.1 4770.9 4807.8 4867.1 4871.7 4877.8 4839.2 4842.1 4842.8 4847.3 4879.6 4687.7 4809.5 4823.3 4825.1 4872.2 5026.1 5060.8 5066.4 5071.6 5115.1 5649.0 5652.1 5657.0 5669.4 5678.0 5695.2 5709.9 5719.5 5725.7 5808.1 5318.6 5344.8 5379.8 5384.1 5409.8 5778.4 5785.8 5789.4 5791.2 5829.6 5396.8 5560.7 5594.2 5595.8 5613.2 5536.1 5538.4 5587.8 5623.3 5660.6 5653.8 5692.5 5696.3 5699.0 5701.8 5518.2 5626.5 5699.2 5711.5 5711.7 4381.3 4432.5 4437.6 4472.5 4478.3 3947.5 3952.0 3963.3 3964.1 3968.6 5179.5 5261.4 5268.9 5364.9 5435.2 5602.3 5674.8 5689.6 5694.3 5734.9 5413.5 5437.7 5439.6 5441.8 5444.1 4877.2 4886.6 4965.9 5012.8 5056.1 5738.3 5779.0 5868.8 5912.4 5914.3 5649.4 5656.5 5658.1 5658.7 5672.3 5571.8 5697.8 5776.7 5778.0 5789.8 5542.4 5562.1 5637.2 5643.9 5686.7 5599.5 5630.9 5632.2 5636.1 5651.5 5379.7 5494.3 5498.2 5516.9 5540.1 5456.4 5477.9 5493.9 5502.1 5537.1 5460.6 5508.5 5518.5 5519.5 5521.5 5409.5 5499.6 5511.4 5653.3 5741.4 5424.9 5434.3 5493.1 5527.6 5575.7 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#1] ext.html Cycles:180 Average:44732.21 Median:30381.32 stddev:72958.25 (240.1%) stddev-sans-first:73087.55 15:01:33 INFO - PROCESS | 24166 | Values: 565.3 594.1 600.8 607.4 614.0 29691.0 39119.8 39693.2 39808.8 39823.2 42385.0 42396.4 42476.4 42769.8 42796.0 7565.7 7692.4 8348.3 8503.5 8505.7 10569.8 10744.7 10825.2 10827.0 10843.7 10460.4 10530.7 10533.9 10542.0 10548.2 7822.3 8021.2 8035.0 10419.3 10594.7 10301.1 10462.4 10468.8 10473.8 10478.5 40084.0 40490.8 40509.2 40524.2 40634.4 3243.3 3310.7 3385.0 3557.2 3953.8 29169.4 29565.6 29667.0 29676.3 29774.4 3338.4 3367.1 3428.5 3487.2 3502.4 261643.0 264017.0 264138.0 264305.0 264493.0 52036.0 52836.7 57056.1 57592.1 58004.7 58437.0 58790.0 58798.7 59000.0 59032.4 14860.9 14923.3 14986.7 15096.6 15184.2 10482.9 10511.9 10513.6 10521.5 10579.5 19152.0 19277.6 19301.8 19310.1 19339.3 7340.6 7550.9 7629.0 7677.0 7720.9 997.4 1003.1 1004.2 1045.7 1059.9 26612.7 26667.9 26728.3 26771.9 27127.9 1010.5 1023.7 1036.8 1067.9 1106.6 12871.9 13262.7 13265.7 13277.3 15046.2 268491.0 271305.0 272870.0 272912.0 273011.0 48307.8 48310.0 48475.8 48613.5 48699.3 1142.6 1305.0 1325.9 1326.0 1349.5 19749.7 27319.5 28503.6 29319.3 29530.9 49357.0 49822.0 49880.8 49888.3 49899.0 295393.0 298532.0 303485.0 305766.0 308383.0 30097.4 30390.5 30589.5 30768.2 30890.7 36862.4 37893.8 38029.4 38093.0 38278.6 35160.6 36101.8 38008.8 38742.8 40047.6 35543.3 36043.3 36357.6 36385.6 36387.0 34607.1 34981.7 35000.3 35368.1 35796.6 26820.0 27884.6 29635.4 30021.2 30372.1 23019.1 24413.0 24570.6 24745.5 24759.6 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#2] jquery.html Cycles:180 Average:29033.35 Median:43052.85 stddev:90836.72 (211.0%) stddev-sans-first:91066.02 15:01:33 INFO - PROCESS | 24166 | Values: 356.1 357.5 361.2 365.9 366.4 13846.9 14044.4 16556.6 16863.3 17355.5 12483.3 12556.4 13129.3 15894.4 16734.3 5319.3 5439.9 5460.5 5469.0 5478.4 3740.1 3871.0 5133.8 5496.5 5537.1 5492.3 5640.9 5663.6 5683.5 5685.3 5547.9 5631.2 5633.4 5800.7 5860.8 5196.9 5226.7 5234.8 5237.3 5250.2 19094.6 19865.7 20343.3 20371.3 20666.3 2051.6 2078.3 2134.5 2137.1 2198.3 9280.7 9487.2 9527.9 9679.4 9687.3 1819.3 1830.2 1858.3 1890.7 1907.8 60743.4 63654.7 63660.4 65133.7 65832.7 9937.7 9949.3 10096.1 10158.3 10217.7 13111.4 13180.3 13182.9 13192.1 13204.1 7376.9 7377.2 7446.9 7505.8 7598.1 7268.2 7276.9 7300.6 7323.4 7324.7 4454.2 4520.8 4529.8 4572.1 4572.3 1760.4 1787.6 1813.6 1830.4 1900.6 863.0 885.9 891.4 896.8 948.9 15369.4 16002.9 16820.8 16893.8 17137.2 816.8 891.3 895.2 906.6 917.3 8644.9 8924.1 8943.4 8969.1 9125.1 538806.0 546563.0 555512.0 556418.0 579825.0 79965.2 81748.6 82718.0 82933.6 83292.0 1148.4 1155.6 1163.2 1166.2 1179.3 14256.9 14272.6 14442.5 14587.1 14785.6 32125.7 32180.0 32216.7 32637.2 33472.5 42456.8 43051.1 43054.6 43964.7 45050.1 9456.6 9603.4 9636.6 9647.4 9683.7 11790.0 16377.7 17006.6 17210.7 17347.5 14085.6 14101.2 14441.9 14482.7 14788.8 13578.7 14050.2 14219.6 14421.0 14652.0 11750.9 14400.4 14787.6 15226.5 15388.7 8435.5 9525.2 9564.5 9639.1 9673.7 7943.8 10709.3 13704.6 13910.4 15161.8 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#3] mootools.html Cycles:180 Average:5313.19 Median:6543.14 stddev:2717.30 (41.5%) stddev-sans-first:2708.32 15:01:33 INFO - PROCESS | 24166 | Values: 1316.5 1476.0 1532.8 1646.9 1778.0 6737.7 7482.4 7691.3 7695.0 7721.9 7569.0 7721.6 7727.4 7730.7 7738.0 2025.0 2059.6 2066.0 2284.2 2332.5 2047.8 2307.5 2347.9 2353.0 2355.4 2266.3 2295.9 2308.3 2320.7 2321.6 2284.7 2303.7 2327.6 2330.0 2333.4 2306.4 2335.6 2339.5 2340.1 2340.7 7606.4 7624.0 7682.2 7683.3 7687.4 4511.2 4511.4 4574.1 4576.3 4581.7 2874.2 2922.9 2924.8 2941.0 2952.7 905.6 927.5 938.6 946.2 991.2 9857.8 9884.5 9902.1 9921.3 9965.6 4069.5 4069.7 4114.8 4119.2 4133.5 8561.8 8568.4 8569.3 8571.9 8578.5 4541.9 4549.5 4570.6 4574.0 4575.3 4171.5 4172.5 4173.2 4176.1 4183.9 3140.5 3186.2 3637.8 3655.2 3679.0 1099.6 1129.4 1159.6 1160.6 1170.9 1001.3 1001.5 1049.2 1067.4 1155.4 7118.5 7155.5 7158.5 7168.3 7182.5 1097.1 1099.2 1103.7 1133.9 1136.8 5651.9 5687.5 5779.3 5805.2 5810.5 8908.6 9053.0 9135.9 9158.6 9161.2 8904.9 9008.3 9062.1 9176.0 9176.4 7211.0 7242.5 7246.1 7292.7 7328.4 6908.6 6992.5 7027.4 7038.8 7043.6 8096.4 8127.0 8181.8 8273.7 8332.1 8153.6 8392.3 8450.2 8517.3 8519.7 6763.7 6844.8 6856.5 6858.0 6874.2 6495.8 6590.4 6940.1 7373.5 7457.6 6855.9 6907.1 6958.7 7030.0 7071.6 6688.1 6710.2 6719.2 6793.5 6801.8 6698.8 6711.0 6719.5 6740.2 6750.5 6289.9 6436.4 6465.2 6467.9 6490.0 6365.0 6415.3 6429.8 6430.7 6432.7 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#4] prototype.html Cycles:180 Average:5312.04 Median:6000.02 stddev:1585.08 (26.4%) stddev-sans-first:1545.11 15:01:33 INFO - PROCESS | 24166 | Values: 347.7 348.1 348.3 356.5 359.4 5935.5 5980.6 5991.9 5999.6 6023.5 5649.1 5707.2 5777.5 5877.4 5919.3 4585.4 4589.7 4594.0 4595.3 4616.2 4388.3 4597.2 4597.5 4609.7 4616.4 4383.4 4420.7 4569.3 4590.8 4594.5 4540.0 4559.3 4564.6 4577.8 4591.7 4053.0 4056.1 4068.5 4069.0 4071.1 5486.1 5601.9 5606.0 5618.7 5625.3 5349.8 5357.5 5357.9 5361.5 5363.1 6284.9 6289.0 6290.3 6294.4 6297.7 4513.3 4514.6 4516.5 4517.3 4520.4 6367.3 6530.9 6540.2 6547.6 6555.7 4522.8 4559.1 4559.6 4561.0 4561.9 4615.4 4617.1 4618.9 4620.0 4624.4 5298.0 5305.9 5307.9 5310.2 5314.3 6222.9 6343.7 6347.6 6364.0 6376.7 1609.5 1629.5 1631.7 1634.2 1634.7 1062.2 1086.9 1091.1 1091.4 1094.5 6094.1 6097.4 6106.0 6111.2 6111.8 6545.9 6548.8 6549.9 6552.0 6554.8 5915.6 5995.3 6000.4 6126.1 6159.8 3544.9 3558.0 3567.1 3567.6 3571.5 6711.3 6714.0 6714.8 6721.9 6726.8 6639.8 6772.5 6786.0 6792.7 6796.1 6698.2 6698.4 6701.1 6703.5 6710.9 6581.9 6588.9 6591.0 6604.0 6607.7 6383.8 6532.8 6541.2 6543.9 6550.7 6686.8 6689.6 6692.4 6692.4 6697.8 4556.0 4556.9 4557.3 4560.1 4562.3 6430.5 6592.8 6593.6 6594.9 6606.9 6402.5 6408.3 6410.2 6415.7 6418.8 6395.2 6401.5 6403.0 6410.4 6413.4 6058.8 6202.1 6206.7 6217.0 6288.9 6358.9 6365.5 6409.4 6410.0 6423.6 6224.6 6230.5 6291.0 6295.8 6296.5 15:01:33 INFO - PROCESS | 24166 | 15:01:33 INFO - PROCESS | 24166 | [#5] yui.html Cycles:180 Average:13589.77 Median:46824.14 stddev:15497.46 (33.1%) stddev-sans-first:15511.31 15:01:33 INFO - PROCESS | 24166 | Values: 830.5 834.1 837.2 840.5 843.5 12638.0 12857.8 12863.2 12925.7 13002.0 15241.7 15298.2 15326.3 15344.5 15359.9 693.1 830.2 843.5 843.6 844.0 695.7 809.3 819.6 820.7 820.7 874.1 875.3 877.2 878.4 880.6 715.7 723.4 864.5 871.2 871.2 641.4 641.6 641.7 645.4 647.0 13751.3 13834.9 13880.1 13891.2 13892.9 11902.8 12418.6 12439.9 12540.4 12807.4 10221.5 10423.8 10563.4 10805.3 10898.6 3290.8 3336.7 3377.1 3379.7 3415.2 47593.0 47720.8 47759.5 47774.5 47903.0 9785.6 9795.2 9813.0 9870.4 10352.9 17706.3 17761.9 17763.9 17800.1 18315.9 6831.2 6975.0 7221.3 7334.5 7421.6 3579.1 3664.6 3732.6 3740.1 3824.0 2899.9 2928.6 2935.6 2946.2 2947.5 564.4 578.3 588.7 593.6 604.3 613.2 631.5 638.2 645.8 651.9 7592.3 8611.0 8642.7 8777.4 9173.3 542.5 642.2 648.3 659.7 683.0 3467.7 3641.3 3768.6 3774.5 3794.2 49523.0 51412.2 51689.0 52365.5 55442.4 49748.0 49989.5 50152.5 50859.0 51000.7 44226.0 45313.8 45361.0 45470.3 46200.0 8140.3 8549.9 8637.4 8672.3 8829.3 33723.7 33969.8 34112.0 34561.8 35216.5 41977.4 45265.0 45820.5 47448.3 49552.3 10546.9 10749.4 10858.6 11107.4 11158.9 12052.9 12334.6 12386.3 12506.3 12596.9 10483.6 10813.2 11080.3 11256.7 11314.7 11328.5 11652.4 11715.6 11785.2 12146.9 10997.6 11042.3 11113.3 11199.6 11372.8 9499.2 9803.9 9931.0 10113.3 10118.1 8572.6 8641.7 9025.4 9151.9 9460.1 15:01:33 INFO - PROCESS | 24166 | -------- Summary: end -------- 15:01:33 INFO - PROCESS | 24166 | 15:01:34 INFO - TEST-INFO | 24166: exit 0 15:01:34 INFO - TEST-OK | dromaeo_css | took 1111657ms 15:01:34 INFO - TEST-START | kraken 15:01:34 INFO - operating with platform_type : linux_ 15:01:34 INFO - Initialising browser for kraken test... 15:01:34 INFO - TEST-INFO | started process 24351 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNrKhLD/profile http://localhost:34509/getInfo.html) 15:01:38 INFO - PROCESS | 24351 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 15:01:38 INFO - PROCESS | 24351 | __metrics Screen width/height:1600/1200 15:01:38 INFO - PROCESS | 24351 | colorDepth:24 15:01:38 INFO - PROCESS | 24351 | Browser inner width/height: 1024/697 15:01:38 INFO - PROCESS | 24351 | __metrics 15:01:38 INFO - PROCESS | 24351 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:01:38 INFO - PROCESS | 24351 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:39 INFO - TEST-INFO | 24351: exit 0 15:01:39 INFO - Browser initialized. 15:01:39 INFO - Running cycle 1/1 for kraken test... 15:01:39 INFO - TEST-INFO | started process 24431 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNrKhLD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:51 INFO - PROCESS | 24431 | RSS: Main: 150605824 15:01:51 INFO - PROCESS | 24431 | 15:01:53 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34509/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:54 INFO - PROCESS | 24431 | RSS: Main: 186011648 15:01:54 INFO - PROCESS | 24431 | 15:01:56 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34509/tests/kraken/driver.html?testName=audio-dft) 15:01:57 INFO - PROCESS | 24431 | RSS: Main: 176091136 15:01:57 INFO - PROCESS | 24431 | 15:02:00 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34509/tests/kraken/driver.html?testName=audio-fft) 15:02:00 INFO - PROCESS | 24431 | RSS: Main: 161316864 15:02:00 INFO - PROCESS | 24431 | 15:02:02 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34509/tests/kraken/driver.html?testName=audio-oscillator) 15:02:03 INFO - PROCESS | 24431 | RSS: Main: 162426880 15:02:03 INFO - PROCESS | 24431 | 15:02:05 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:02:06 INFO - PROCESS | 24431 | RSS: Main: 164126720 15:02:06 INFO - PROCESS | 24431 | 15:02:09 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34509/tests/kraken/driver.html?testName=imaging-darkroom) 15:02:09 INFO - PROCESS | 24431 | RSS: Main: 163926016 15:02:09 INFO - PROCESS | 24431 | 15:02:13 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34509/tests/kraken/driver.html?testName=imaging-desaturate) 15:02:13 INFO - PROCESS | 24431 | RSS: Main: 167522304 15:02:13 INFO - PROCESS | 24431 | 15:02:16 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34509/tests/kraken/driver.html?testName=json-parse-financial) 15:02:17 INFO - PROCESS | 24431 | RSS: Main: 164892672 15:02:17 INFO - PROCESS | 24431 | 15:02:18 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:02:19 INFO - PROCESS | 24431 | RSS: Main: 176975872 15:02:19 INFO - PROCESS | 24431 | 15:02:20 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:02:21 INFO - PROCESS | 24431 | RSS: Main: 175304704 15:02:21 INFO - PROCESS | 24431 | 15:02:23 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:02:24 INFO - PROCESS | 24431 | RSS: Main: 184479744 15:02:24 INFO - PROCESS | 24431 | 15:02:26 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:02:27 INFO - PROCESS | 24431 | RSS: Main: 192172032 15:02:27 INFO - PROCESS | 24431 | 15:02:29 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:02:30 INFO - PROCESS | 24431 | RSS: Main: 189104128 15:02:30 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | Cycle 1(1): loaded http://localhost:34509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34509/tests/kraken/driver.html?testName=ai-astar) 15:02:32 INFO - PROCESS | 24431 | RSS: Main: 248029184 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | __start_tp_report 15:02:32 INFO - PROCESS | 24431 | _x_x_mozilla_page_load 15:02:32 INFO - PROCESS | 24431 | _x_x_mozilla_page_load_details 15:02:32 INFO - PROCESS | 24431 | |i|pagename|runs| 15:02:32 INFO - PROCESS | 24431 | |0;ai-astar;109;112;103;110;110;110;99;109;109;108 15:02:32 INFO - PROCESS | 24431 | |1;audio-beat-detection;152;121;148;171;129;161;146;125;160;124 15:02:32 INFO - PROCESS | 24431 | |2;audio-dft;161;161;162;160;161;161;160;163;163;162 15:02:32 INFO - PROCESS | 24431 | |3;audio-fft;72;71;80;96;71;77;71;124;93;70 15:02:32 INFO - PROCESS | 24431 | |4;audio-oscillator;92;92;138;93;93;92;136;92;94;134 15:02:32 INFO - PROCESS | 24431 | |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;111;110 15:02:32 INFO - PROCESS | 24431 | |6;imaging-darkroom;146;146;145;146;145;145;145;145;146;145 15:02:32 INFO - PROCESS | 24431 | |7;imaging-desaturate;95;96;96;96;96;95;95;96;95;96 15:02:32 INFO - PROCESS | 24431 | |8;json-parse-financial;58;57;57;57;58;57;60;65;55;55 15:02:32 INFO - PROCESS | 24431 | |9;json-stringify-tinderbox;66;67;67;67;75;68;69;67;70;68 15:02:32 INFO - PROCESS | 24431 | |10;stanford-crypto-aes;86;83;86;85;87;85;85;85;84;91 15:02:32 INFO - PROCESS | 24431 | |11;stanford-crypto-ccm;124;120;123;121;119;127;124;126;122;126 15:02:32 INFO - PROCESS | 24431 | |12;stanford-crypto-pbkdf2;151;156;152;159;158;148;154;154;149;141 15:02:32 INFO - PROCESS | 24431 | |13;stanford-crypto-sha256-iterative;68;68;69;76;71;69;69;67;68;68 15:02:32 INFO - PROCESS | 24431 | __end_tp_report 15:02:32 INFO - PROCESS | 24431 | __start_cc_report 15:02:32 INFO - PROCESS | 24431 | _x_x_mozilla_cycle_collect,938 15:02:32 INFO - PROCESS | 24431 | __end_cc_report 15:02:32 INFO - PROCESS | 24431 | __startTimestamp1450738952358__endTimestamp 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | ------- Summary: start ------- 15:02:32 INFO - PROCESS | 24431 | Number of tests: 14 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.90 (3.5%) stddev-sans-first:4.12 15:02:32 INFO - PROCESS | 24431 | Values: 109.0 112.0 103.0 110.0 110.0 110.0 99.0 109.0 109.0 108.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.00 stddev:17.86 (11.9%) stddev-sans-first:18.69 15:02:32 INFO - PROCESS | 24431 | Values: 152.0 121.0 148.0 171.0 129.0 161.0 146.0 125.0 160.0 124.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 15:02:32 INFO - PROCESS | 24431 | Values: 161.0 161.0 162.0 160.0 161.0 161.0 160.0 163.0 163.0 162.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:17.37 (23.3%) stddev-sans-first:18.00 15:02:32 INFO - PROCESS | 24431 | Values: 72.0 71.0 80.0 96.0 71.0 77.0 71.0 124.0 93.0 70.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:21.01 (22.8%) stddev-sans-first:21.70 15:02:32 INFO - PROCESS | 24431 | Values: 92.0 92.0 138.0 93.0 93.0 92.0 136.0 92.0 94.0 134.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:02:32 INFO - PROCESS | 24431 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 111.0 110.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:02:32 INFO - PROCESS | 24431 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:02:32 INFO - PROCESS | 24431 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:2.88 (5.0%) stddev-sans-first:3.06 15:02:32 INFO - PROCESS | 24431 | Values: 58.0 57.0 57.0 57.0 58.0 57.0 60.0 65.0 55.0 55.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:2.59 (3.8%) stddev-sans-first:2.60 15:02:32 INFO - PROCESS | 24431 | Values: 66.0 67.0 67.0 67.0 75.0 68.0 69.0 67.0 70.0 68.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.16 (2.5%) stddev-sans-first:2.29 15:02:32 INFO - PROCESS | 24431 | Values: 86.0 83.0 86.0 85.0 87.0 85.0 85.0 85.0 84.0 91.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:2.70 (2.2%) stddev-sans-first:2.85 15:02:32 INFO - PROCESS | 24431 | Values: 124.0 120.0 123.0 121.0 119.0 127.0 124.0 126.0 122.0 126.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:154.00 stddev:5.33 (3.5%) stddev-sans-first:5.63 15:02:32 INFO - PROCESS | 24431 | Values: 151.0 156.0 152.0 159.0 158.0 148.0 154.0 154.0 149.0 141.0 15:02:32 INFO - PROCESS | 24431 | 15:02:32 INFO - PROCESS | 24431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.58 (3.7%) stddev-sans-first:2.70 15:02:32 INFO - PROCESS | 24431 | Values: 68.0 68.0 69.0 76.0 71.0 69.0 69.0 67.0 68.0 68.0 15:02:32 INFO - PROCESS | 24431 | -------- Summary: end -------- 15:02:32 INFO - PROCESS | 24431 | 15:02:33 INFO - TEST-INFO | 24431: exit 0 15:02:33 INFO - TEST-OK | kraken | took 58770ms 15:02:33 INFO - TEST-START | v8_7 15:02:33 INFO - operating with platform_type : linux_ 15:02:33 INFO - Initialising browser for v8_7 test... 15:02:33 INFO - TEST-INFO | started process 24681 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIfnikp/profile http://localhost:34509/getInfo.html) 15:02:36 INFO - PROCESS | 24681 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 15:02:36 INFO - PROCESS | 24681 | __metrics Screen width/height:1600/1200 15:02:36 INFO - PROCESS | 24681 | colorDepth:24 15:02:36 INFO - PROCESS | 24681 | Browser inner width/height: 1024/697 15:02:36 INFO - PROCESS | 24681 | __metrics 15:02:37 INFO - PROCESS | 24681 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:02:37 INFO - PROCESS | 24681 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:37 INFO - TEST-INFO | 24681: exit 0 15:02:37 INFO - Browser initialized. 15:02:37 INFO - Running cycle 1/1 for v8_7 test... 15:02:37 INFO - TEST-INFO | started process 24764 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIfnikp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:49 INFO - PROCESS | 24764 | RSS: Main: 149737472 15:02:49 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | Cycle 1(1): loaded http://localhost:34509/tests/v8_7/run.html (next: http://localhost:34509/tests/v8_7/run.html) 15:03:11 INFO - PROCESS | 24764 | RSS: Main: 540950528 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | __start_tp_report 15:03:11 INFO - PROCESS | 24764 | _x_x_mozilla_page_load 15:03:11 INFO - PROCESS | 24764 | _x_x_mozilla_page_load_details 15:03:11 INFO - PROCESS | 24764 | |i|pagename|runs| 15:03:11 INFO - PROCESS | 24764 | |0;Richards;165.26194017517767 15:03:11 INFO - PROCESS | 24764 | |1;DeltaBlue;188.64365214110546 15:03:11 INFO - PROCESS | 24764 | |2;Encrypt;279.9552071668533 15:03:11 INFO - PROCESS | 24764 | |3;Decrypt;5117.34693877551 15:03:11 INFO - PROCESS | 24764 | |4;RayTrace;1992.03187250996 15:03:11 INFO - PROCESS | 24764 | |5;Earley;766.4624808575804 15:03:11 INFO - PROCESS | 24764 | |6;Boyer;12207.317073170732 15:03:11 INFO - PROCESS | 24764 | |7;RegExp;25025 15:03:11 INFO - PROCESS | 24764 | |8;Splay;584.927536231884 15:03:11 INFO - PROCESS | 24764 | |9;NavierStokes;4826.923076923077 15:03:11 INFO - PROCESS | 24764 | __end_tp_report 15:03:11 INFO - PROCESS | 24764 | __startTimestamp1450738991394__endTimestamp 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | ------- Summary: start ------- 15:03:11 INFO - PROCESS | 24764 | Number of tests: 10 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#0] Richards Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 165.3 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 188.6 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 280.0 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 5117.3 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 1992.0 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#5] Earley Cycles:1 Average:766.46 Median:766.46 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 766.5 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 12207.3 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 25025.0 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#8] Splay Cycles:1 Average:584.93 Median:584.93 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 584.9 15:03:11 INFO - PROCESS | 24764 | 15:03:11 INFO - PROCESS | 24764 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 15:03:11 INFO - PROCESS | 24764 | Values: 4826.9 15:03:11 INFO - PROCESS | 24764 | -------- Summary: end -------- 15:03:11 INFO - PROCESS | 24764 | 15:03:12 INFO - TEST-INFO | 24764: exit 0 15:03:12 INFO - TEST-OK | v8_7 | took 38977ms 15:03:12 INFO - SUITE-END | took 1209s 15:03:12 INFO - Completed test suite (00:20:09) 15:03:12 INFO - Working with test: dromaeo_css 15:03:12 INFO - Generating results file: dromaeo_css 15:03:12 INFO - Working with test: kraken 15:03:12 INFO - Generating results file: kraken 15:03:12 INFO - javascript benchmark 15:03:12 INFO - Working with test: v8_7 15:03:12 INFO - Generating results file: v8_7 15:03:12 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:03:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 15:03:12 INFO - process_Request line: dromaeo_css 6898.52 graph.html#tests=[[72,64,35]] 15:03:12 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:03:12 INFO - process_Request line: kraken 1508.30 graph.html#tests=[[232,64,35]] 15:03:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:03:12 INFO - process_Request line: v8_7 20063.37 graph.html#tests=[[230,64,35]] 15:03:12 INFO - RETURN: dromaeo_css: 6898.52 15:03:12 INFO - RETURN: kraken: 1508.30 15:03:12 INFO - RETURN: v8_7: 20063.37 15:03:12 INFO - javascript benchmark 15:03:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.1851118709137, 3144.5754823098873, 3151.3697260547883, 3152.55864179015, 3174.1271150433636, 5006.948540806435, 5110.182370820669, 5187.974060129699, 5205.4013788414395, 5295.523402893738, 5172.0, 5242.161254199329, 5242.606804489669, 5251.291075704778, 5275.6043296752805, 4763.142634325829, 4803.807847686088, 4815.831445899376, 4897.755112244391, 4905.950940490585, 326.5806932228741, 4679.976600116995, 4829.2756086587115, 4836.661433699643, 4875.098106850226, 4770.880727981794, 4807.783649735753, 4867.148249056437, 4871.683340582851, 4877.829275975324, 4839.177339852198, 4842.12841688496, 4842.806287748521, 4847.345608342864, 4879.609631229493, 4687.695299805502, 4809.5430934061205, 4823.252395878644, 4825.131476334259, 4872.244802055651, 5026.070177017264, 5060.84817455477, 5066.36670416198, 5071.56891664209, 5115.130427827241, 5649.0, 5652.06740887753, 5657.0, 5669.433056694339, 5678.034734095214, 5695.202671625976, 5709.857253568653, 5719.48524632785, 5725.713714314309, 5808.12878068289, 5318.627696061278, 5344.839654810362, 5379.757910894019, 5384.057789886793, 5409.83770486886, 5778.3643799182055, 5785.797497087582, 5789.421057894177, 5791.160281759121, 5829.562782791308, 5396.83809485716, 5560.694161821139, 5594.216809646653, 5595.804146854841, 5613.186088017214, 5536.114221724505, 5538.44615538451, 5587.776488940478, 5623.325200975827, 5660.603757737002, 5653.830385088454, 5692.516136128475, 5696.316442026983, 5699.0, 5701.828945131652, 5518.172274158828, 5626.521745651584, 5699.230603868425, 5711.514521265656, 5711.657300561979, 4381.3427985801745, 4432.512423633398, 4437.600615944581, 4472.485664148599, 4478.283474644041, 3947.486826712509, 3952.0, 3963.3460479020637, 3964.0684439156776, 3968.583298753647, 5179.507946745053, 5261.421243663271, 5268.894622107537, 5364.91952620711, 5435.211894275308, 5602.327720673546, 5674.77300907959, 5689.573282003867, 5694.259746233046, 5734.885302294014, 5413.458654134555, 5437.728113594305, 5439.646422982493, 5441.755121019563, 5444.128939369682, 4877.219644856806, 4886.60907127429, 4965.925511117264, 5012.8496145115705, 5056.089903817275, 5738.340090889517, 5779.0, 5868.823935281948, 5912.438318359749, 5914.349421563625, 5649.350324712711, 5656.490915817596, 5658.094704847204, 5658.717064146858, 5672.347680016685, 5571.832845014656, 5697.829065128053, 5776.711164441677, 5778.0, 5789.768409263751, 5542.3626282977975, 5562.082256427644, 5637.2107904894165, 5643.915341269802, 5686.715664216856, 5599.524040456607, 5630.887382252414, 5632.183333416713, 5636.070048441961, 5651.547876169979, 5379.731013449234, 5494.340679118532, 5498.202760599771, 5516.889662206813, 5540.085885828793, 5456.399796022355, 5477.917831232455, 5493.890122197454, 5502.147167189092, 5537.1140617501005, 5460.645058071213, 5508.531774799187, 5518.503334699896, 5519.530839878656, 5521.475459831309, 5409.540189083972, 5499.560035197254, 5511.448855114457, 5653.3216014076925, 5741.3971532988435, 5424.864378390572, 5434.347878254476, 5493.066178749702, 5527.640703354269, 5575.665460072409], "unit": "score", "name": "dojo.html", "value": 5190.971783107125}, {"lowerIsBetter": false, "replicates": [565.3159676791082, 594.1355327997763, 600.8377738010737, 607.4017093163236, 613.9785107521236, 29691.0, 39119.80440097799, 39693.2061358773, 39808.800955995255, 39823.203535929264, 42385.0, 42396.364054539205, 42476.36285455721, 42769.7861510692, 42796.0, 7565.735199268027, 7692.423068269874, 8348.33213342931, 8503.532305723184, 8505.702300419487, 10569.788604227911, 10744.677659670184, 10825.24223304369, 10827.025567698905, 10843.728906777314, 10460.424676642782, 10530.736731581734, 10533.894661053406, 10542.0, 10548.208884333706, 7822.295993360625, 8021.19788021199, 8035.035795704494, 10419.322744021652, 10594.735131621694, 10301.124404425633, 10462.424566648831, 10468.790624187473, 10473.79052418955, 10478.528466219039, 40084.0, 40490.79754601208, 40509.189816203805, 40524.18951620951, 40634.390484142765, 3243.3189030303665, 3310.702036816674, 3384.9830750846336, 3557.1640664443835, 3953.802309884523, 29169.41661166786, 29565.55651665227, 29667.0, 29676.258093547833, 29774.404511909856, 3338.382399256121, 3367.1413789483768, 3428.5371474851077, 3487.232808782064, 3502.404591219499, 261643.0, 264017.0, 264138.0, 264305.0, 264493.0, 52036.0, 52836.73581632144, 57056.14415783767, 57592.13611795827, 58004.70997644985, 58437.0, 58790.0, 58798.70600646969, 59000.0, 59032.40967590355, 14860.851391486163, 14923.253837308092, 14986.70026599462, 15096.622584435258, 15184.240787960778, 10482.947585262025, 10511.947440262902, 10513.579456821795, 10521.473926303654, 10579.523921423555, 19152.0, 19277.614447710966, 19301.841889486393, 19310.131044102767, 19339.323123690883, 7340.596267205248, 7550.924490755132, 7628.956652973932, 7676.961615192, 7720.884186737204, 997.3567049253191, 1003.1322905686675, 1004.231762701534, 1045.6862941117633, 1059.8516207730925, 26612.669366531984, 26667.866660666572, 26728.331791705365, 26771.86614066917, 27127.86436067807, 1010.5099026971913, 1023.6826583759058, 1036.7511797168777, 1067.9305845120043, 1106.6016234155697, 12871.935640321926, 13262.668433289053, 13265.66835829112, 13277.336133193496, 15046.172460514557, 268491.0, 271305.0, 272870.0, 272912.0, 273011.0, 48307.75846120817, 48310.0, 48475.75762121167, 48613.5138648609, 48699.26951095736, 1142.5772464188137, 1304.9869501304865, 1325.8872995795273, 1326.0452474218548, 1349.466960550577, 19749.703754443406, 27319.453610928067, 28503.572446413735, 29319.267018324714, 29530.852345738134, 49357.0, 49822.0, 49880.750596246784, 49888.25167622561, 49899.0, 295393.0, 298532.0, 303485.0, 305766.0, 308383.0, 30097.398052039276, 30390.54414183833, 30589.54115688222, 30768.230794230323, 30890.691093088783, 36862.44706329461, 37893.81053094717, 38029.429558557196, 38093.0, 38278.61721382862, 35160.64839351574, 36101.81949090238, 38008.80995595004, 38742.80628596839, 40047.599524004385, 35543.289134216655, 36043.27913441769, 36357.63642363543, 36385.63614363822, 36387.0, 34607.13482162966, 34981.65018349886, 35000.29999400049, 35368.11579710528, 35796.64203357933, 26820.0, 27884.58173127364, 29635.407291854473, 30021.249468763457, 30372.088837334915, 23019.068375092276, 24412.973326658033, 24570.63283305004, 24745.505089897742, 24759.62860557129], "unit": "score", "name": "ext.html", "value": 18228.944476345445}, {"lowerIsBetter": false, "replicates": [356.11505409058486, 357.52092196456744, 361.21976530693706, 365.8938907716762, 366.4283717400854, 13846.945350469257, 14044.438222471088, 16556.586085347873, 16863.32546698132, 17355.479335619937, 12483.251004939688, 12556.37218139094, 13129.277889716086, 15894.443694470696, 16734.330626774943, 5319.255304257397, 5439.945600543983, 5460.5085542301185, 5469.0, 5478.369987451434, 3740.0836794985266, 3870.980645096771, 5133.845984620468, 5496.5434159947645, 5537.1140617501205, 5492.258545096401, 5640.887182256352, 5663.575231857607, 5683.488486036256, 5685.346185188715, 5547.916781248265, 5631.239782629354, 5633.408492108331, 5800.651960882318, 5860.765569377219, 5196.92204616931, 5226.686398816083, 5234.790608375661, 5237.319148510669, 5250.212468129773, 19094.61810763777, 19865.702014469796, 20343.28798492046, 20371.287004954756, 20666.276680316118, 2051.6204502166997, 2078.3381254166034, 2134.466383404149, 2137.1130980643015, 2198.274569392097, 9280.72157835266, 9487.241020718326, 9527.90472095277, 9679.419234845931, 9687.32188746788, 1819.3450357871288, 1830.1672738903767, 1858.2845604442252, 1890.744804183514, 1907.7901430842596, 60743.39256607422, 63654.68172659107, 63660.36339636637, 65133.67433162804, 65832.670836646, 9937.65218217359, 9949.303548751517, 10096.091351778376, 10158.288919775692, 10217.693469195936, 13111.409986550629, 13180.340982951006, 13182.934085329513, 13192.142510736772, 13204.141730787467, 7376.852462950711, 7377.188509263977, 7446.85106297871, 7505.812354691177, 7598.088229412506, 7268.164161121539, 7276.854462910712, 7300.56196628204, 7323.377512911356, 7324.67038983247, 4454.153710794939, 4520.751358675238, 4529.750863702528, 4572.0627271409285, 4572.314152877095, 1760.392664530735, 1787.5888545634316, 1813.5919418130816, 1830.3776715916651, 1900.6483800496953, 862.9525376104249, 885.9202671759573, 891.3893982621925, 896.7713233125511, 948.8671585977969, 15369.385224591115, 16002.919985399998, 16820.831791682172, 16893.83106168947, 17137.228824702917, 816.7993050216172, 891.2869704236584, 895.2032690905099, 906.5512571277128, 917.312015988009, 8644.913550864536, 8924.06297338783, 8943.418677785923, 8969.14793094655, 9125.087491250822, 538806.0, 546563.0, 555512.0, 556418.0, 579825.0, 79965.20034799694, 81748.59125704333, 82718.0, 82933.58533207416, 83292.0, 1148.3511815824033, 1155.6013175454455, 1163.2380790582183, 1166.1603645375317, 1179.2806388103422, 14256.857431425968, 14272.64318392007, 14442.541148432347, 14587.05184163026, 14785.630359241106, 32125.678743213204, 32180.0, 32216.67783322137, 32637.18407039843, 33472.49791253182, 42456.78771606122, 43051.13897722091, 43054.569454305056, 43964.68105956826, 45050.09899802051, 9456.574454149717, 9603.423794572349, 9636.566354513923, 9647.372920760128, 9683.709488715349, 11790.0, 16377.67244655124, 17006.57483562921, 17210.741838872178, 17347.479575612753, 14085.647858803202, 14101.224432656303, 14441.855581444472, 14482.710345792815, 14788.778168327268, 13578.728425431633, 14050.156990580597, 14219.573412797632, 14421.0, 14652.0, 11750.882491174978, 14400.351984160947, 14787.630309242355, 15226.543203703906, 15388.692226155637, 8435.493870367798, 9525.190358819578, 9564.4739539326, 9639.084286992724, 9673.70978870635, 7943.761687149395, 10709.303895246783, 13704.588862334145, 13910.374033168735, 15161.848381516043], "unit": "score", "name": "jquery.html", "value": 8696.64853919191}, {"lowerIsBetter": false, "replicates": [1316.466830933471, 1475.9557213283601, 1532.7700844873264, 1646.9011859288444, 1778.048743922002, 6737.696803643836, 7482.43881708872, 7691.269329413697, 7695.038120234971, 7721.884171737428, 7569.0, 7721.575313357763, 7727.381809455244, 7730.690772369098, 7737.961310193441, 2024.9797502025012, 2059.588082383522, 2066.0392917293457, 2284.223364056225, 2332.47519308156, 2047.805458481442, 2307.457747429353, 2347.8708671023173, 2353.035255545227, 2355.3640517060385, 2266.3087758233733, 2295.931122066341, 2308.2613563659634, 2320.6983092197993, 2321.5589038082794, 2284.657301404786, 2303.6890019847356, 2327.615943369342, 2329.9534009319805, 2333.381653861728, 2306.4003359126746, 2335.637976113705, 2339.4970081432402, 2340.1107579119825, 2340.742518322983, 7606.353459955911, 7624.046994125734, 7682.1549629540705, 7683.346915512188, 7687.385009199306, 4511.1654343946475, 4511.368408422791, 4574.1080489304595, 4576.26779715244, 4581.725096494221, 2874.195225336909, 2922.941541169165, 2924.824510529375, 2940.955885661717, 2952.689967553419, 905.6151135767273, 927.4620719982394, 938.5823308627663, 946.2032849321541, 991.2367477042709, 9857.753556161082, 9884.456354900478, 9902.108810207115, 9921.255905807093, 9965.55155018026, 4069.4709687740406, 4069.715119941635, 4114.753114813121, 4119.237940980928, 4133.524644665842, 8561.785955351166, 8568.443051201652, 8569.314454843598, 8571.871421928676, 8578.528180950108, 4541.886452838706, 4549.522300158502, 4570.565796249351, 4574.0, 4575.313702944585, 4171.499420069611, 4172.4784401949755, 4173.207090652766, 4176.081262122329, 4183.853565125206, 3140.481820499592, 3186.187522181875, 3637.799921004317, 3655.177585043344, 3678.9632103679155, 1099.6041425086962, 1129.3731978751707, 1159.6115301373966, 1160.5647882044234, 1170.9297442153497, 1001.2690735762789, 1001.4642166441065, 1049.2235745548392, 1067.3595842494597, 1155.3876445483907, 7118.5017048806085, 7155.499115062, 7158.463115266376, 7168.2831716827895, 7182.533135346186, 1097.1113398147527, 1099.2195541165702, 1103.6578660615235, 1133.9376334301692, 1136.7783282260045, 5651.943480565224, 5687.459691329317, 5779.2775903012125, 5805.158252053428, 5810.4770570648, 8908.643654253758, 9053.049429809775, 9135.862962055575, 9158.587863546156, 9161.175494205554, 8904.8664270036, 9008.32437567172, 9062.093790621017, 9176.0, 9176.403533770284, 7210.999999999895, 7242.529235599669, 7246.130464344313, 7292.744753933587, 7328.413726901835, 6908.620025898624, 6992.545484543489, 7027.402670773042, 7038.824029399306, 7043.647817608997, 8096.352291816523, 8126.959365203136, 8181.79545511367, 8273.669053237803, 8332.125126861834, 8153.592320383838, 8392.32861371101, 8450.19723126302, 8517.276031537142, 8519.659213631385, 6763.6618169092335, 6844.828879278058, 6856.5200435969, 6857.965710171417, 6874.175098988154, 6495.837604059936, 6590.439812615981, 6940.09778728762, 7373.483856130019, 7457.552546847207, 6855.897161542681, 6907.13660792401, 6958.652067396509, 7030.0, 7071.646417678992, 6688.063671085954, 6710.228323742832, 6719.160104986877, 6793.5244532882225, 6801.761938332134, 6698.799036028927, 6711.0, 6719.462443004646, 6740.224874139537, 6750.493712971645, 6289.905651415141, 6436.388543088399, 6465.159529261354, 6467.935320646733, 6490.026496025445, 6365.0, 6415.294317624965, 6429.839254018687, 6430.742770289136, 6432.710528026344], "unit": "score", "name": "mootools.html", "value": 4375.298389047871}, {"lowerIsBetter": false, "replicates": [347.7322461704488, 348.11752208152325, 348.28080014769483, 356.5133592646038, 359.4320972862875, 5935.4954828839545, 5980.61126026808, 5991.850203744898, 5999.610025348349, 6023.457888790008, 5649.12438572022, 5707.229524014268, 5777.45114214149, 5877.441643043904, 5919.348871624129, 4585.403897493321, 4589.747563883985, 4593.999999999992, 4595.333676616889, 4616.215243408612, 4388.341748737683, 4597.195490789099, 4597.471290801567, 4609.67732258742, 4616.446026476828, 4383.408239887623, 4420.668449866257, 4569.314602809572, 4590.816367345302, 4594.517575654559, 4539.977300113512, 4559.270516717343, 4564.566366195206, 4577.8397756078375, 4591.724496530185, 4053.0, 4056.1279324944985, 4068.4914385701786, 4069.0030942419003, 4071.1043570414463, 5486.1222204447095, 5601.859953501154, 5606.046972014768, 5618.747156377973, 5625.324961004665, 5349.812756553541, 5357.491038351351, 5357.892842143136, 5361.517463428271, 5363.061464243741, 6284.937150628527, 6288.968555157241, 6290.276618188876, 6294.370562943669, 6297.748090076391, 4513.345564893105, 4514.593686568224, 4516.503184649686, 4517.254652982254, 4520.412346394981, 6367.267764207083, 6530.869382612369, 6540.247871494791, 6547.607143571353, 6555.672216389209, 4522.773861306987, 4559.133764584784, 4559.612432943237, 4560.95439045612, 4561.882338827008, 4615.446146462379, 4617.053504031665, 4618.884527886763, 4619.95380046202, 4624.375709279271, 5298.019866324742, 5305.920411193835, 5307.946920530745, 5310.230016647564, 5314.256004159421, 6222.875542489125, 6343.714532846033, 6347.587406818634, 6364.0, 6376.7130479128555, 1609.4769200010044, 1629.535582359022, 1631.7144499712504, 1634.1584084196647, 1634.7466142747655, 1062.1661995333625, 1086.8641419822522, 1091.0943916549245, 1091.3779145886767, 1094.458243169636, 6094.146819445281, 6097.420745029215, 6105.96947015271, 6111.236095488064, 6111.8472038198515, 6545.9018114728315, 6548.836279092966, 6549.869002619921, 6552.0, 6554.8361290968105, 5915.585908986416, 5995.310539288038, 6000.429959153874, 6126.111713801474, 6159.784407545714, 3544.929101418009, 3558.0393293810525, 3567.126054116758, 3567.5897271813556, 3571.4821350904494, 6711.261761206263, 6713.966430167818, 6714.764983225564, 6721.8655626887185, 6726.7981960541265, 6639.834004149935, 6772.492063095189, 6786.0, 6792.728290868409, 6796.082528858639, 6698.162729658793, 6698.363655452724, 6701.061851340816, 6703.497237707192, 6710.899336509956, 6581.901271480836, 6588.934110659024, 6591.0, 6603.966980165068, 6607.735690572324, 6383.808485745435, 6532.771353002622, 6541.215054193527, 6543.934560654333, 6550.705218265094, 6686.765963191265, 6689.5986240825705, 6692.364225398579, 6692.431143352675, 6697.832554186184, 4556.0, 4556.908861822679, 4557.316402539645, 4560.110778398313, 4562.315652652129, 6430.453411460078, 6592.80221593353, 6593.571417857824, 6594.868102638016, 6606.933930660824, 6402.519811014099, 6408.29508754046, 6410.173100666288, 6415.679216039086, 6418.839529011812, 6395.16862807832, 6401.455876250571, 6402.9679851602305, 6410.358964103739, 6413.390727880844, 6058.848528786815, 6202.131701561875, 6206.689665516797, 6217.0, 6288.874222515433, 6358.872822543616, 6365.490760739037, 6409.423151916163, 6410.0, 6423.550351475352, 6224.595401298901, 6230.50155987529, 6290.968545157245, 6295.811125666238, 6296.496280297657], "unit": "score", "name": "prototype.html", "value": 4802.149796068675}, {"lowerIsBetter": false, "replicates": [830.4892491117964, 834.0991728932753, 837.2464781696473, 840.4831028917216, 843.5191940593857, 12638.0, 12857.807132893015, 12863.228206307616, 12925.74148517029, 13002.0, 15241.695166096672, 15298.158601276926, 15326.310316035777, 15344.539663810103, 15359.923200383982, 693.143967200507, 830.1573902488964, 843.5234092737614, 843.641452382738, 843.9620217090215, 695.6556504530265, 809.3282575462352, 819.5697258939045, 820.7004443378183, 820.7127505373102, 874.1389731114847, 875.2691502595309, 877.1579283887476, 878.41585345745, 880.5905254056862, 715.7101373943535, 723.3995783499682, 864.5417928497906, 871.2202578692066, 871.2246100970142, 641.3906788550848, 641.5733537197758, 641.6759536434117, 645.3868824616586, 646.9967650161766, 13751.312434378242, 13834.861651383459, 13880.097793643381, 13891.166530008231, 13892.93053534736, 11902.821457678141, 12418.565350212699, 12439.93780031103, 12540.372981350896, 12807.423665935055, 10221.488925553767, 10423.79152416955, 10563.41901195434, 10805.297655652435, 10898.564057437692, 3290.7696461247724, 3336.7163791077787, 3377.054424761071, 3379.662033796625, 3415.2315728960784, 47593.0, 47720.76139619314, 47759.52240477585, 47774.5222547777, 47903.0, 9785.608575657036, 9795.167410770022, 9813.0, 9870.407775533491, 10352.896471035343, 17706.29174833018, 17761.911190443963, 17763.911180444273, 17800.109994500483, 18315.908420457814, 6831.2144103427745, 6974.9537569365, 7221.31397517235, 7334.486585938933, 7421.591812450367, 3579.0873327301892, 3664.59689434162, 3732.6267373263, 3740.121071548184, 3823.967528767217, 2899.869505872241, 2928.575356573285, 2935.5890175375466, 2946.204524778298, 2947.469455497988, 564.432745091189, 578.3233616668424, 588.7203578300273, 593.5844908564022, 604.268834709997, 613.1691557939017, 631.4506379449816, 638.2373064188344, 645.7743570863473, 651.9413252807175, 7592.316691497792, 8611.0, 8642.740717778477, 8777.42946708462, 9173.266138708887, 542.4765101676901, 642.1584488637759, 648.2642201101689, 659.6932426421737, 682.9965850170718, 3467.687908088284, 3641.344557979536, 3768.6419790119894, 3774.54705435344, 3794.165283637595, 49523.0, 51412.22881656778, 51689.0, 52365.47634523682, 55442.44557554454, 49748.0, 49989.50010499921, 50152.498475014785, 50859.0, 51000.74499627478, 44226.0, 45313.773431132635, 45361.0, 45470.31794523085, 46200.0, 8140.267375936194, 8549.87175192385, 8637.412472155776, 8672.306215502871, 8829.293656507336, 33723.66276337205, 33969.830150849084, 34112.0, 34561.827190863885, 35216.471752923215, 41977.370339445544, 45265.0, 45820.54179458163, 47448.2882756752, 49552.256716150005, 10546.894531054591, 10749.355038697391, 10858.565657373932, 11107.44462776874, 11158.944205278922, 12052.939735301617, 12334.568290109803, 12386.31875246834, 12506.312152831682, 12596.937015314865, 10483.633072842718, 10813.189010824377, 11080.279781814157, 11256.718582035515, 11314.717132071764, 11328.546858125583, 11652.417379131179, 11715.589954351557, 11785.233959792586, 12146.939265303618, 10997.560097596006, 11042.33745975244, 11113.277636953571, 11199.552017919192, 11372.829407559058, 9499.192568631745, 9803.901960980298, 9931.0, 10113.342632728849, 10118.13995810335, 8572.571371431279, 8641.654333826576, 9025.41334813235, 9151.86272205904, 9460.148586627236], "unit": "score", "name": "yui.html", "value": 6232.88634973289}], "name": "dromaeo_css", "value": 6898.515217760607}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 103.0, 110.0, 110.0, 110.0, 99.0, 109.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [152.0, 121.0, 148.0, 171.0, 129.0, 161.0, 146.0, 125.0, 160.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 80.0, 96.0, 71.0, 77.0, 71.0, 124.0, 93.0, 70.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 93.0, 93.0, 92.0, 136.0, 92.0, 94.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 58.0, 57.0, 60.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 75.0, 68.0, 69.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 86.0, 85.0, 87.0, 85.0, 85.0, 85.0, 84.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 123.0, 121.0, 119.0, 127.0, 124.0, 126.0, 122.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [151.0, 156.0, 152.0, 159.0, 158.0, 148.0, 154.0, 154.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 76.0, 71.0, 69.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1508.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "Richards", "value": 213.61240199999997}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [766.4624808575804], "unit": "score", "name": "Earley", "value": 869.5311468531465}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [584.927536231884], "unit": "score", "name": "Splay", "value": 139.31811199207138}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20063.366383407767}]} 15:03:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20063.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6898.52"}}} 15:03:12 INFO - Return code: 0 15:03:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:03:12 ERROR - # TBPL SUCCESS # 15:03:12 INFO - Running post-action listener: _resource_record_post_action 15:03:12 INFO - Running post-run listener: _resource_record_post_run 15:03:13 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557334528; Read time: 8; Write time: 406508 15:03:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235397120; Read time: 0; Write time: 234544 15:03:13 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321937408; Read time: 8; Write time: 171964 15:03:13 INFO - Running post-run listener: _upload_blobber_files 15:03:13 INFO - Blob upload gear active. 15:03:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:03:13 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:03:13 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:03:13 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:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 15:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:15 INFO - (blobuploader) - INFO - Done attempting. 15:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:03:16 INFO - (blobuploader) - INFO - Done attempting. 15:03:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:03:16 INFO - Return code: 0 15:03:16 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:03:16 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:03:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bfd64336129cbb2bb8b8fd2781157142ee97ba5494fef5d16bc79460bafe9ec921ee949a7b1c03e299ba922f3605302db3d8e66adc512c9887755bf35a4346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01b4591845aff3a83e1d4995d312e4b8bb733828de277f26f227564fc783c1c06d5dad9a43afe0670374357025b79b458617f231f1a4d4304a5225fa36aea0e"} 15:03:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:03:16 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:03:16 INFO - Contents: 15:03:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bfd64336129cbb2bb8b8fd2781157142ee97ba5494fef5d16bc79460bafe9ec921ee949a7b1c03e299ba922f3605302db3d8e66adc512c9887755bf35a4346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01b4591845aff3a83e1d4995d312e4b8bb733828de277f26f227564fc783c1c06d5dad9a43afe0670374357025b79b458617f231f1a4d4304a5225fa36aea0e"} 15:03:16 INFO - Copying logs to upload dir... 15:03:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.250256 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-21 15:03:15.795441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:03:15.802490) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bfd64336129cbb2bb8b8fd2781157142ee97ba5494fef5d16bc79460bafe9ec921ee949a7b1c03e299ba922f3605302db3d8e66adc512c9887755bf35a4346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01b4591845aff3a83e1d4995d312e4b8bb733828de277f26f227564fc783c1c06d5dad9a43afe0670374357025b79b458617f231f1a4d4304a5225fa36aea0e"} 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.011422 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/99bfd64336129cbb2bb8b8fd2781157142ee97ba5494fef5d16bc79460bafe9ec921ee949a7b1c03e299ba922f3605302db3d8e66adc512c9887755bf35a4346", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01b4591845aff3a83e1d4995d312e4b8bb733828de277f26f227564fc783c1c06d5dad9a43afe0670374357025b79b458617f231f1a4d4304a5225fa36aea0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 15:03:15.828828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:03:15.829181) ========= 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=fce1c2174958ee92775f70ae000001a3-1450737731.717137-364602445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 15:03:15.912192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:03:15.912553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 15:03:15.913098) ========= ========= Total master_lag: 0.24 =========