builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1450903132.59 results: success (0) buildid: 20151223083227 builduid: 8f817ad6247c4adcb34b46b113169ba6 revision: e418ef9b7e83612a1ab4a7c7e59563273a74f6cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.590204) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.590725) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.591021) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006250 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.613793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.614101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.641765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.642142) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.010212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.692034) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.692495) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.692867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.693144) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 12:38:53-- 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% 29.7M=0s 2015-12-23 12:38:53 (29.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.867752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.868101) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.072041 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.950548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:52.950906) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e418ef9b7e83612a1ab4a7c7e59563273a74f6cb --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/b2g-inbound --rev e418ef9b7e83612a1ab4a7c7e59563273a74f6cb --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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 12:38:53,962 truncating revision to first 12 chars 2015-12-23 12:38:53,962 Setting DEBUG logging. 2015-12-23 12:38:53,962 attempt 1/10 2015-12-23 12:38:53,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e418ef9b7e83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 12:38:54,210 unpacking tar archive at: b2g-inbound-e418ef9b7e83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:53.467756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:53.468073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:53.477027) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:53.477358) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:38:53.477780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-23 12:38:53.478074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:38:54 INFO - MultiFileLogger online at 20151223 12:38:54 in /builds/slave/test-pgo 12:38:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 12:38:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:38:54 INFO - {'append_to_log': False, 12:38:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:38:54 INFO - 'blob_upload_branch': 'B2G-Inbound', 12:38:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:38:54 INFO - 'branch': 'B2G-Inbound', 12:38:54 INFO - 'buildbot_json_path': 'buildprops.json', 12:38:54 INFO - 'config_files': ('talos/linux_config.py',), 12:38:54 INFO - 'default_actions': ('clobber', 12:38:54 INFO - 'read-buildbot-config', 12:38:54 INFO - 'download-and-extract', 12:38:54 INFO - 'populate-webroot', 12:38:54 INFO - 'create-virtualenv', 12:38:54 INFO - 'install', 12:38:54 INFO - 'run-tests'), 12:38:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:38:54 INFO - 'download_minidump_stackwalk': True, 12:38:54 INFO - 'download_symbols': 'ondemand', 12:38:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:38:54 INFO - 'tooltool.py': '/tools/tooltool.py', 12:38:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:38:54 INFO - '/tools/misc-python/virtualenv.py')}, 12:38:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:38:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:38:54 INFO - 'installer_path': 'installer.exe', 12:38:54 INFO - 'log_level': 'info', 12:38:54 INFO - 'log_name': 'talos', 12:38:54 INFO - 'log_to_console': True, 12:38:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:38:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:38:54 INFO - 'opt_config_files': (), 12:38:54 INFO - 'pip_index': False, 12:38:54 INFO - 'sps_profile': False, 12:38:54 INFO - 'sps_profile_interval': 0, 12:38:54 INFO - 'suite': 'dromaeojs', 12:38:54 INFO - 'system_bits': '64', 12:38:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:38:54 INFO - 'title': 'talos-linux64-ix-067', 12:38:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:38:54 INFO - 'use_talos_json': True, 12:38:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:38:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:38:54 INFO - 'work_dir': 'build'} 12:38:54 INFO - ##### 12:38:54 INFO - ##### Running clobber step. 12:38:54 INFO - ##### 12:38:54 INFO - Running pre-action listener: _resource_record_pre_action 12:38:54 INFO - Running main action method: clobber 12:38:54 INFO - rmtree: /builds/slave/test-pgo/build 12:38:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:38:59 INFO - Running post-action listener: _resource_record_post_action 12:38:59 INFO - ##### 12:38:59 INFO - ##### Running read-buildbot-config step. 12:38:59 INFO - ##### 12:38:59 INFO - Running pre-action listener: _resource_record_pre_action 12:38:59 INFO - Running main action method: read_buildbot_config 12:38:59 INFO - Using buildbot properties: 12:38:59 INFO - { 12:38:59 INFO - "project": "", 12:38:59 INFO - "product": "firefox", 12:38:59 INFO - "script_repo_revision": "production", 12:38:59 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 12:38:59 INFO - "repository": "", 12:38:59 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 12:38:59 INFO - "buildid": "20151223083227", 12:38:59 INFO - "pgo_build": "True", 12:38:59 INFO - "basedir": "/builds/slave/test-pgo", 12:38:59 INFO - "buildnumber": 149, 12:38:59 INFO - "slavename": "talos-linux64-ix-067", 12:38:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:38:59 INFO - "platform": "ubuntu64_hw", 12:38:59 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 12:38:59 INFO - "branch": "b2g-inbound", 12:38:59 INFO - "repo_path": "integration/b2g-inbound", 12:38:59 INFO - "revision": "e418ef9b7e83612a1ab4a7c7e59563273a74f6cb", 12:38:59 INFO - "stage_platform": "linux64-pgo", 12:38:59 INFO - "builduid": "8f817ad6247c4adcb34b46b113169ba6", 12:38:59 INFO - "slavebuilddir": "test" 12:38:59 INFO - } 12:38:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:38:59 INFO - Running post-action listener: _resource_record_post_action 12:38:59 INFO - ##### 12:38:59 INFO - ##### Running download-and-extract step. 12:38:59 INFO - ##### 12:38:59 INFO - Running pre-action listener: _resource_record_pre_action 12:38:59 INFO - Running main action method: download_and_extract 12:38:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:38:59 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')]} 12:38:59 INFO - https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/test_packages.json 12:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/test_packages.json 12:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:38:59 INFO - Downloaded 1302 bytes. 12:38:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:38:59 INFO - Using the following test package requirements: 12:38:59 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:59 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:38:59 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'jsshell-linux-x86_64.zip'], 12:38:59 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:38:59 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:59 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:38:59 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:38:59 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:38:59 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:59 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:38:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:38:59 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')]} 12:38:59 INFO - https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:00 INFO - Downloaded 23180693 bytes. 12:39:00 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 12:39:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:00 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 12:39:01 INFO - Return code: 0 12:39:01 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 12:39: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')]} 12:39:01 INFO - https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:02 INFO - Downloaded 23180693 bytes. 12:39:02 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 12:39:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:39:02 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 12:39:04 INFO - Return code: 0 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:05 INFO - Downloaded 11132277 bytes. 12:39:05 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 12:39:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:05 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 12:39:05 INFO - Return code: 0 12:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:05 INFO - https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3P_gLqmoRhuclabXXhb4RQ/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 12:39:06 INFO - Downloaded 54834402 bytes. 12:39:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:06 INFO - mkdir: /builds/slave/test-pgo/properties 12:39:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:39:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:39:06 INFO - Contents: 12:39:06 INFO - build_url:https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:39:06 INFO - Running post-action listener: _resource_record_post_action 12:39:06 INFO - Running post-action listener: set_extra_try_arguments 12:39:06 INFO - ##### 12:39:06 INFO - ##### Running populate-webroot step. 12:39:06 INFO - ##### 12:39:06 INFO - Running pre-action listener: _resource_record_pre_action 12:39:06 INFO - Running main action method: populate_webroot 12:39:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:06 INFO - '--tppagecycles', 12:39:06 INFO - '7'], 12:39:06 INFO - 'tests': ['tsvgm']}}, 12:39:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:39:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:39:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'tests': ['damp', 'tps']}, 12:39:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['damp', 'tps']}, 12:39:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:39:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:06 INFO - 'other': {'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'other_l64': {'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'other_nol64': {'tests': ['a11yr', 12:39:06 INFO - 'ts_paint', 12:39:06 INFO - 'tpaint', 12:39:06 INFO - 'sessionrestore', 12:39:06 INFO - 'sessionrestore_no_auto_restore']}, 12:39:06 INFO - 'svgr': {'tests': ['tsvgx', 12:39:06 INFO - 'tsvgr_opacity', 12:39:06 INFO - 'tart', 12:39:06 INFO - 'tscrollx', 12:39:06 INFO - 'cart']}, 12:39:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['tsvgx', 12:39:06 INFO - 'tsvgr_opacity', 12:39:06 INFO - 'tart', 12:39:06 INFO - 'tscrollx', 12:39:06 INFO - 'cart']}, 12:39:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'tests': ['tp5o']}, 12:39:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'talos_options': ['--e10s'], 12:39:06 INFO - 'tests': ['tp5o']}, 12:39:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'talos_options': ['--xperf_path', 12:39:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:06 INFO - 'tests': ['tp5n']}, 12:39:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:06 INFO - 'talos_options': ['--e10s', 12:39:06 INFO - '--xperf_path', 12:39:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:06 INFO - 'tests': ['tp5n']}}, 12:39:06 INFO - 'talos.zip': {'path': '', 12:39:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:06 INFO - Running post-action listener: _resource_record_post_action 12:39:06 INFO - ##### 12:39:06 INFO - ##### Running create-virtualenv step. 12:39:06 INFO - ##### 12:39:06 INFO - Running pre-action listener: _resource_record_pre_action 12:39:06 INFO - Running main action method: create_virtualenv 12:39:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:39:06 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 12:39:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:39:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:06 INFO - Using real prefix '/usr' 12:39:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:39:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:09 INFO - Installing pip.................done. 12:39:09 INFO - Return code: 0 12:39:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:39:09 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')]} 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:09 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')]} 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:09 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:09 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 12:39:09 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 12:39:09 INFO - Using env: {'DISPLAY': ':0', 12:39:09 INFO - 'HOME': '/home/cltbld', 12:39:09 INFO - 'LANG': 'en_US.UTF-8', 12:39:09 INFO - 'LANGUAGE': 'en_US:en', 12:39:09 INFO - 'LOGNAME': 'cltbld', 12:39:09 INFO - 'MAIL': '/var/mail/cltbld', 12:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:09 INFO - 'MOZ_NO_REMOTE': '1', 12:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:09 INFO - 'NO_EM_RESTART': '1', 12:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:09 INFO - 'SHELL': '/bin/bash', 12:39:09 INFO - 'SHLVL': '1', 12:39:09 INFO - 'TERM': 'linux', 12:39:09 INFO - 'TMOUT': '86400', 12:39:09 INFO - 'USER': 'cltbld', 12:39:09 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:09 INFO - '_': '/tools/buildbot/bin/python'} 12:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:09 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 12:39:09 INFO - Cleaning up... 12:39:09 INFO - Return code: 0 12:39:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:39:09 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')]} 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:09 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')]} 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:09 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:09 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 12:39:09 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 12:39:09 INFO - Using env: {'DISPLAY': ':0', 12:39:09 INFO - 'HOME': '/home/cltbld', 12:39:09 INFO - 'LANG': 'en_US.UTF-8', 12:39:09 INFO - 'LANGUAGE': 'en_US:en', 12:39:09 INFO - 'LOGNAME': 'cltbld', 12:39:09 INFO - 'MAIL': '/var/mail/cltbld', 12:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:09 INFO - 'MOZ_NO_REMOTE': '1', 12:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:09 INFO - 'NO_EM_RESTART': '1', 12:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:09 INFO - 'SHELL': '/bin/bash', 12:39:09 INFO - 'SHLVL': '1', 12:39:09 INFO - 'TERM': 'linux', 12:39:09 INFO - 'TMOUT': '86400', 12:39:09 INFO - 'USER': 'cltbld', 12:39:09 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:09 INFO - '_': '/tools/buildbot/bin/python'} 12:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:09 INFO - Downloading/unpacking psutil>=0.7.1 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:11 INFO - Installing collected packages: psutil 12:39:11 INFO - Running setup.py install for psutil 12:39:11 INFO - building 'psutil._psutil_linux' extension 12:39:11 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 12:39:11 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 12:39:11 INFO - building 'psutil._psutil_posix' extension 12:39:11 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 12:39:11 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 12:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:11 INFO - Successfully installed psutil 12:39:11 INFO - Cleaning up... 12:39:11 INFO - Return code: 0 12:39:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:39:11 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')]} 12:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:11 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')]} 12:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:11 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:11 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 12:39:11 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 12:39:11 INFO - Using env: {'DISPLAY': ':0', 12:39:11 INFO - 'HOME': '/home/cltbld', 12:39:11 INFO - 'LANG': 'en_US.UTF-8', 12:39:11 INFO - 'LANGUAGE': 'en_US:en', 12:39:11 INFO - 'LOGNAME': 'cltbld', 12:39:11 INFO - 'MAIL': '/var/mail/cltbld', 12:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:11 INFO - 'MOZ_NO_REMOTE': '1', 12:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:11 INFO - 'NO_EM_RESTART': '1', 12:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:11 INFO - 'SHELL': '/bin/bash', 12:39:11 INFO - 'SHLVL': '1', 12:39:11 INFO - 'TERM': 'linux', 12:39:11 INFO - 'TMOUT': '86400', 12:39:11 INFO - 'USER': 'cltbld', 12:39:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:11 INFO - '_': '/tools/buildbot/bin/python'} 12:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39:12 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 12:39:12 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 12:39:12 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 12:39:12 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 12:39:12 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 12:39:12 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 12:39:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:39:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:39:13 INFO - Installing collected packages: mozsystemmonitor 12:39:13 INFO - Running setup.py install for mozsystemmonitor 12:39:13 INFO - Successfully installed mozsystemmonitor 12:39:13 INFO - Cleaning up... 12:39:13 INFO - Return code: 0 12:39:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:39:13 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')]} 12:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:13 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')]} 12:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:13 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:13 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 12:39:13 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 12:39:13 INFO - Using env: {'DISPLAY': ':0', 12:39:13 INFO - 'HOME': '/home/cltbld', 12:39:13 INFO - 'LANG': 'en_US.UTF-8', 12:39:13 INFO - 'LANGUAGE': 'en_US:en', 12:39:13 INFO - 'LOGNAME': 'cltbld', 12:39:13 INFO - 'MAIL': '/var/mail/cltbld', 12:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:13 INFO - 'MOZ_NO_REMOTE': '1', 12:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:13 INFO - 'NO_EM_RESTART': '1', 12:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:13 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:13 INFO - 'SHELL': '/bin/bash', 12:39:13 INFO - 'SHLVL': '1', 12:39:13 INFO - 'TERM': 'linux', 12:39:13 INFO - 'TMOUT': '86400', 12:39:13 INFO - 'USER': 'cltbld', 12:39:13 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:13 INFO - '_': '/tools/buildbot/bin/python'} 12:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:39:14 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 12:39:14 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 12:39:14 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 12:39:14 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 12:39:14 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 12:39:14 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 12:39:15 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:39:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:15 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 12:39:15 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 12:39:15 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 12:39:15 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 12:39:15 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 12:39:15 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 12:39:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:39:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:39:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:39:16 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 12:39:16 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 12:39:16 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 12:39:16 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 12:39:16 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 12:39:16 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 12:39:16 INFO - Downloading docopt-0.6.1.tar.gz 12:39:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:39:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:39:16 INFO - Installing collected packages: blobuploader, requests, docopt 12:39:16 INFO - Running setup.py install for blobuploader 12:39:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:39:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:39:16 INFO - Running setup.py install for requests 12:39:17 INFO - Running setup.py install for docopt 12:39:17 INFO - Successfully installed blobuploader requests docopt 12:39:17 INFO - Cleaning up... 12:39:17 INFO - Return code: 0 12:39:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:39: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')]} 12:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:17 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:17 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 12:39:17 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 12:39:17 INFO - Using env: {'DISPLAY': ':0', 12:39:17 INFO - 'HOME': '/home/cltbld', 12:39:17 INFO - 'LANG': 'en_US.UTF-8', 12:39:17 INFO - 'LANGUAGE': 'en_US:en', 12:39:17 INFO - 'LOGNAME': 'cltbld', 12:39:17 INFO - 'MAIL': '/var/mail/cltbld', 12:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:17 INFO - 'MOZ_NO_REMOTE': '1', 12:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:17 INFO - 'NO_EM_RESTART': '1', 12:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:17 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:17 INFO - 'SHELL': '/bin/bash', 12:39:17 INFO - 'SHLVL': '1', 12:39:17 INFO - 'TERM': 'linux', 12:39:17 INFO - 'TMOUT': '86400', 12:39:17 INFO - 'USER': 'cltbld', 12:39:17 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:17 INFO - '_': '/tools/buildbot/bin/python'} 12:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:17 INFO - Running setup.py (path:/tmp/pip-4w4lCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:17 INFO - Running setup.py (path:/tmp/pip-exOuiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:17 INFO - Running setup.py (path:/tmp/pip-opBsfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:17 INFO - Running setup.py (path:/tmp/pip-xl9bdg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:17 INFO - Running setup.py (path:/tmp/pip-CIkY34-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:17 INFO - Running setup.py (path:/tmp/pip-qh0pfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:17 INFO - Running setup.py (path:/tmp/pip-CJCTUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:17 INFO - Running setup.py (path:/tmp/pip-orSJ6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:17 INFO - Running setup.py (path:/tmp/pip-7Wj3Ao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:18 INFO - Running setup.py (path:/tmp/pip-cfWKhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:18 INFO - Running setup.py (path:/tmp/pip-VCkegX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:18 INFO - Running setup.py (path:/tmp/pip-Y6hI1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:18 INFO - Running setup.py (path:/tmp/pip-eMSjUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:18 INFO - Running setup.py (path:/tmp/pip-PQScbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:18 INFO - Running setup.py (path:/tmp/pip-_wJ_Pv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:18 INFO - Running setup.py (path:/tmp/pip-W0rABm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:18 INFO - Running setup.py (path:/tmp/pip-0SUUQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:39:18 INFO - Running setup.py install for manifestparser 12:39:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:39:18 INFO - Running setup.py install for mozcrash 12:39:18 INFO - Running setup.py install for mozdebug 12:39:18 INFO - Running setup.py install for mozdevice 12:39:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozfile 12:39:19 INFO - Running setup.py install for mozhttpd 12:39:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozinfo 12:39:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozInstall 12:39:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozleak 12:39:19 INFO - Running setup.py install for mozlog 12:39:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for moznetwork 12:39:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozprocess 12:39:19 INFO - Running setup.py install for mozprofile 12:39:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:39:19 INFO - Running setup.py install for mozrunner 12:39:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:39:20 INFO - Running setup.py install for mozscreenshot 12:39:20 INFO - Running setup.py install for moztest 12:39:20 INFO - Running setup.py install for mozversion 12:39:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:39:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:20 INFO - Cleaning up... 12:39:20 INFO - Return code: 0 12:39:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:39: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')]} 12:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:20 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:20 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 12:39:20 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 12:39:20 INFO - Using env: {'DISPLAY': ':0', 12:39:20 INFO - 'HOME': '/home/cltbld', 12:39:20 INFO - 'LANG': 'en_US.UTF-8', 12:39:20 INFO - 'LANGUAGE': 'en_US:en', 12:39:20 INFO - 'LOGNAME': 'cltbld', 12:39:20 INFO - 'MAIL': '/var/mail/cltbld', 12:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:20 INFO - 'MOZ_NO_REMOTE': '1', 12:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:20 INFO - 'NO_EM_RESTART': '1', 12:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:20 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:20 INFO - 'SHELL': '/bin/bash', 12:39:20 INFO - 'SHLVL': '1', 12:39:20 INFO - 'TERM': 'linux', 12:39:20 INFO - 'TMOUT': '86400', 12:39:20 INFO - 'USER': 'cltbld', 12:39:20 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:20 INFO - '_': '/tools/buildbot/bin/python'} 12:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:20 INFO - Running setup.py (path:/tmp/pip-5xQzLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:39:20 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)) 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:20 INFO - Running setup.py (path:/tmp/pip-fhwK3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:39:20 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)) 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:20 INFO - Running setup.py (path:/tmp/pip-qY0jQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:39:20 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)) 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:20 INFO - Running setup.py (path:/tmp/pip-0ltOgB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:39:20 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)) 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:20 INFO - Running setup.py (path:/tmp/pip-JL_rdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:39:20 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)) 12:39:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:20 INFO - Running setup.py (path:/tmp/pip-k3aa8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:21 INFO - Running setup.py (path:/tmp/pip-1Gs2AP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:21 INFO - Running setup.py (path:/tmp/pip-jaZ0tL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:21 INFO - Running setup.py (path:/tmp/pip-AZcF_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:21 INFO - Running setup.py (path:/tmp/pip-bWmXmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:21 INFO - Running setup.py (path:/tmp/pip-oMS61K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:21 INFO - Running setup.py (path:/tmp/pip-fMD_gF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:21 INFO - Running setup.py (path:/tmp/pip-1PXaCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:21 INFO - Running setup.py (path:/tmp/pip-cxPbJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:21 INFO - Running setup.py (path:/tmp/pip-__6ud7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:21 INFO - Running setup.py (path:/tmp/pip-HzpkEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:39:21 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)) 12:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:21 INFO - Running setup.py (path:/tmp/pip-FOYDXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:39:21 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)) 12:39:21 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)) 12:39:21 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)) 12:39:21 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)) 12:39:21 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)) 12:39:21 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)) 12:39:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:39:21 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 12:39:21 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 12:39:21 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 12:39:21 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 12:39:21 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 12:39:21 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 12:39:23 INFO - Downloading blessings-1.5.1.tar.gz 12:39:23 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 12:39:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:23 INFO - Installing collected packages: blessings 12:39:23 INFO - Running setup.py install for blessings 12:39:23 INFO - Successfully installed blessings 12:39:23 INFO - Cleaning up... 12:39:23 INFO - Return code: 0 12:39:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:39:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:39:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:39:24 INFO - Reading from file tmpfile_stdout 12:39:24 INFO - Current package versions: 12:39:24 INFO - argparse == 1.2.1 12:39:24 INFO - blessings == 1.5.1 12:39:24 INFO - blobuploader == 1.2.4 12:39:24 INFO - docopt == 0.6.1 12:39:24 INFO - manifestparser == 1.1 12:39:24 INFO - mozInstall == 1.12 12:39:24 INFO - mozcrash == 0.16 12:39:24 INFO - mozdebug == 0.1 12:39:24 INFO - mozdevice == 0.47 12:39:24 INFO - mozfile == 1.2 12:39:24 INFO - mozhttpd == 0.7 12:39:24 INFO - mozinfo == 0.9 12:39:24 INFO - mozleak == 0.1 12:39:24 INFO - mozlog == 3.1 12:39:24 INFO - moznetwork == 0.27 12:39:24 INFO - mozprocess == 0.22 12:39:24 INFO - mozprofile == 0.28 12:39:24 INFO - mozrunner == 6.11 12:39:24 INFO - mozscreenshot == 0.1 12:39:24 INFO - mozsystemmonitor == 0.0 12:39:24 INFO - moztest == 0.7 12:39:24 INFO - mozversion == 1.4 12:39:24 INFO - psutil == 3.1.1 12:39:24 INFO - requests == 1.2.3 12:39:24 INFO - wsgiref == 0.1.2 12:39:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:24 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 12:39:24 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 12:39:24 INFO - Using env: {'DISPLAY': ':0', 12:39:24 INFO - 'HOME': '/home/cltbld', 12:39:24 INFO - 'LANG': 'en_US.UTF-8', 12:39:24 INFO - 'LANGUAGE': 'en_US:en', 12:39:24 INFO - 'LOGNAME': 'cltbld', 12:39:24 INFO - 'MAIL': '/var/mail/cltbld', 12:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:24 INFO - 'MOZ_NO_REMOTE': '1', 12:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:24 INFO - 'NO_EM_RESTART': '1', 12:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:24 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:24 INFO - 'SHELL': '/bin/bash', 12:39:24 INFO - 'SHLVL': '1', 12:39:24 INFO - 'TERM': 'linux', 12:39:24 INFO - 'TMOUT': '86400', 12:39:24 INFO - 'USER': 'cltbld', 12:39:24 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:24 INFO - '_': '/tools/buildbot/bin/python'} 12:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 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)) 12:39:24 INFO - Cleaning up... 12:39:24 INFO - Return code: 0 12:39:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 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 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39:24 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 12:39:24 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 12:39:24 INFO - Using env: {'DISPLAY': ':0', 12:39:24 INFO - 'HOME': '/home/cltbld', 12:39:24 INFO - 'LANG': 'en_US.UTF-8', 12:39:24 INFO - 'LANGUAGE': 'en_US:en', 12:39:24 INFO - 'LOGNAME': 'cltbld', 12:39:24 INFO - 'MAIL': '/var/mail/cltbld', 12:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:24 INFO - 'MOZ_NO_REMOTE': '1', 12:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:24 INFO - 'NO_EM_RESTART': '1', 12:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:24 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:24 INFO - 'SHELL': '/bin/bash', 12:39:24 INFO - 'SHLVL': '1', 12:39:24 INFO - 'TERM': 'linux', 12:39:24 INFO - 'TMOUT': '86400', 12:39:24 INFO - 'USER': 'cltbld', 12:39:24 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:24 INFO - '_': '/tools/buildbot/bin/python'} 12:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:24 INFO - Downloading/unpacking jsonschema 12:39:24 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 12:39:24 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 12:39:24 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 12:39:24 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 12:39:24 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 12:39:24 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 12:39:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:26 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 12:39:26 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:26 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:39:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:26 INFO - warning: no files found matching '*.txt' 12:39:26 INFO - no previously-included directories found matching 'build' 12:39:26 INFO - no previously-included directories found matching 'dist' 12:39:26 INFO - no previously-included directories found matching '.git*' 12:39:26 INFO - Installing collected packages: jsonschema, functools32 12:39:26 INFO - Running setup.py install for functools32 12:39:26 INFO - warning: no files found matching '*.txt' 12:39:26 INFO - no previously-included directories found matching 'build' 12:39:26 INFO - no previously-included directories found matching 'dist' 12:39:26 INFO - no previously-included directories found matching '.git*' 12:39:26 INFO - Successfully installed jsonschema functools32 12:39:26 INFO - Cleaning up... 12:39:26 INFO - Return code: 0 12:39:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:39: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')]} 12:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f245d95ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29af360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, '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': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', '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 12:39: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', 'flake8'] in /builds/slave/test-pgo/build 12:39: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 flake8 12:39:26 INFO - Using env: {'DISPLAY': ':0', 12:39:26 INFO - 'HOME': '/home/cltbld', 12:39:26 INFO - 'LANG': 'en_US.UTF-8', 12:39:26 INFO - 'LANGUAGE': 'en_US:en', 12:39:26 INFO - 'LOGNAME': 'cltbld', 12:39:26 INFO - 'MAIL': '/var/mail/cltbld', 12:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:26 INFO - 'MOZ_NO_REMOTE': '1', 12:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:26 INFO - 'NO_EM_RESTART': '1', 12:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:26 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:26 INFO - 'SHELL': '/bin/bash', 12:39:26 INFO - 'SHLVL': '1', 12:39:26 INFO - 'TERM': 'linux', 12:39:26 INFO - 'TMOUT': '86400', 12:39:26 INFO - 'USER': 'cltbld', 12:39:26 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:26 INFO - '_': '/tools/buildbot/bin/python'} 12:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:26 INFO - Downloading/unpacking flake8 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:28 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 12:39:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:28 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 12:39:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:28 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 12:39:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:39:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:29 INFO - no previously-included directories found matching 'docs/_build' 12:39:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:29 INFO - Running setup.py install for pep8 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:29 INFO - no previously-included directories found matching 'docs/_build' 12:39:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:39:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:29 INFO - Cleaning up... 12:39:29 INFO - Return code: 0 12:39:29 INFO - Running post-action listener: _resource_record_post_action 12:39:29 INFO - Running post-action listener: _start_resource_monitoring 12:39:29 INFO - Starting resource monitoring. 12:39:29 INFO - ##### 12:39:29 INFO - ##### Running install step. 12:39:29 INFO - ##### 12:39:29 INFO - Running pre-action listener: _resource_record_pre_action 12:39:29 INFO - Running main action method: install 12:39:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:39:29 INFO - Reading from file tmpfile_stdout 12:39:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:39:29 INFO - Reading from file tmpfile_stdout 12:39:29 INFO - Output received: 12:39:29 INFO - Usage: mozinstall [options] installer 12:39:29 INFO - Options: 12:39:29 INFO - -h, --help show this help message and exit 12:39:29 INFO - -d DEST, --destination=DEST 12:39:29 INFO - Directory to install application into. [default: 12:39:29 INFO - "/builds/slave/test-pgo"] 12:39:29 INFO - --app=APP Application being installed. [default: firefox] 12:39:29 INFO - mkdir: /builds/slave/test-pgo/build/application 12:39:29 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'] 12:39:29 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 12:39:45 INFO - Reading from file tmpfile_stdout 12:39:45 INFO - Output received: 12:39:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:39:45 INFO - Running post-action listener: _resource_record_post_action 12:39:45 INFO - ##### 12:39:45 INFO - ##### Running run-tests step. 12:39:45 INFO - ##### 12:39:45 INFO - Running pre-action listener: _resource_record_pre_action 12:39:45 INFO - Running main action method: run_tests 12:39:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:39:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:39:45 INFO - Python 2.7.3 12:39:45 INFO - Return code: 0 12:39:45 INFO - grabbing minidump binary from tooltool 12:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:45 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 0x2a3e540>, '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 0x2a3f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:39:45 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 12:39:45 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 12:39:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:45 INFO - Return code: 0 12:39:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:39:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:39:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:39:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:39:46 INFO - Return code: 0 12:39:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 12:39:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 12:39:46 INFO - Using env: {'DISPLAY': ':0', 12:39:46 INFO - 'HOME': '/home/cltbld', 12:39:46 INFO - 'LANG': 'en_US.UTF-8', 12:39:46 INFO - 'LANGUAGE': 'en_US:en', 12:39:46 INFO - 'LOGNAME': 'cltbld', 12:39:46 INFO - 'MAIL': '/var/mail/cltbld', 12:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:46 INFO - 'MOZ_NO_REMOTE': '1', 12:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:46 INFO - 'NO_EM_RESTART': '1', 12:39:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:39:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:39:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:39:46 INFO - 'SHELL': '/bin/bash', 12:39:46 INFO - 'SHLVL': '1', 12:39:46 INFO - 'TERM': 'linux', 12:39:46 INFO - 'TMOUT': '86400', 12:39:46 INFO - 'USER': 'cltbld', 12:39:46 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858', 12:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:46 INFO - '_': '/tools/buildbot/bin/python'} 12:39:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 12:39:46 INFO - mozversion application_buildid: 20151223083227 12:39:46 INFO - mozversion application_changeset: e418ef9b7e83612a1ab4a7c7e59563273a74f6cb 12:39:46 INFO - mozversion application_display_name: Nightly 12:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:46 INFO - mozversion application_name: Firefox 12:39:46 INFO - mozversion application_remotingname: firefox 12:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 12:39:46 INFO - mozversion application_vendor: Mozilla 12:39:46 INFO - mozversion application_version: 46.0a1 12:39:46 INFO - mozversion platform_buildid: 20151223083227 12:39:46 INFO - mozversion platform_changeset: e418ef9b7e83612a1ab4a7c7e59563273a74f6cb 12:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 12:39:46 INFO - mozversion platform_version: 46.0a1 12:39:46 INFO - using testdate: 1450903186 12:39:46 INFO - actual date: 1450903186 12:39:46 INFO - starting webserver on 'localhost:51769' 12:39:46 INFO - SUITE-START | Running 3 tests 12:39:46 INFO - TEST-START | dromaeo_css 12:39:46 INFO - operating with platform_type : linux_ 12:39:46 INFO - Initialising browser for dromaeo_css test... 12:39:46 INFO - TEST-INFO | started process 16802 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFNTAcA/profile http://localhost:51769/getInfo.html) 12:39:51 INFO - PROCESS | 16802 | __metrics Screen width/height:1600/1200 12:39:51 INFO - PROCESS | 16802 | colorDepth:24 12:39:51 INFO - PROCESS | 16802 | Browser inner width/height: 1024/697 12:39:51 INFO - PROCESS | 16802 | __metrics 12:39:51 INFO - PROCESS | 16802 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:39:51 INFO - PROCESS | 16802 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:52 INFO - TEST-INFO | 16802: exit 0 12:39:52 INFO - Browser initialized. 12:39:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:39:52 INFO - TEST-INFO | started process 16898 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFNTAcA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:04 INFO - PROCESS | 16898 | RSS: Main: 149405696 12:40:04 INFO - PROCESS | 16898 | 12:40:55 INFO - PROCESS | 16898 | 1450903255860 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] 12:43:04 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51769/tests/dromaeo/cssquery-ext.html) 12:43:05 INFO - PROCESS | 16898 | RSS: Main: 251154432 12:43:05 INFO - PROCESS | 16898 | 12:46:07 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-ext.html (next: http://localhost:51769/tests/dromaeo/cssquery-jquery.html) 12:46:08 INFO - PROCESS | 16898 | RSS: Main: 231751680 12:46:08 INFO - PROCESS | 16898 | 12:49:10 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51769/tests/dromaeo/cssquery-mootools.html) 12:49:11 INFO - PROCESS | 16898 | RSS: Main: 223539200 12:49:11 INFO - PROCESS | 16898 | 12:52:12 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51769/tests/dromaeo/cssquery-prototype.html) 12:52:13 INFO - PROCESS | 16898 | RSS: Main: 211361792 12:52:13 INFO - PROCESS | 16898 | 12:55:16 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51769/tests/dromaeo/cssquery-yui.html) 12:55:16 INFO - PROCESS | 16898 | RSS: Main: 213774336 12:55:16 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | Cycle 1(1): loaded http://localhost:51769/tests/dromaeo/cssquery-yui.html (next: http://localhost:51769/tests/dromaeo/cssquery-dojo.html) 12:58:19 INFO - PROCESS | 16898 | RSS: Main: 258482176 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | __start_tp_report 12:58:19 INFO - PROCESS | 16898 | _x_x_mozilla_page_load 12:58:19 INFO - PROCESS | 16898 | _x_x_mozilla_page_load_details 12:58:19 INFO - PROCESS | 16898 | |i|pagename|runs| 12:58:19 INFO - PROCESS | 16898 | |0;dojo.html;3135.2475405902583;3180.1731549797073;3231.7253033492166;3238.4980328049146;3255.7232635226005;5144.485551444863;5284.603654725892;5328.174133009385;5365.892682146355;5416.512513873756;5239.685618862862;5273.841784746454;5287.603429742775;5328.786848526054;5339.519443250107;4843.636727245453;4881.365422495071;4904.705717656934;4916.459189489154;4955.306257123987;4938.283948827418;5000.399952005764;5006.374203224597;5007.549320561149;5033.018561380532;4765.142274390609;4768.785404656799;4883.829065982709;4922.433920099181;4929.950700493003;4900.313956046157;4909.484504127051;4948.257761335828;4958.528939750718;4961.727105009223;4901.754912254373;4908.656394052417;4920.827771028033;4933.260010998343;4966.031623833318;5081.593472522226;5104.821331253388;5184.688918664892;5221.503957124105;5288.814891478818;5728.570357223225;5733.913991290134;5745.569082318842;5800.680962547058;5819.7090145492975;5736.827895163152;5753.165790960287;5761.971190144064;5764.827055188351;5777.59556831022;5280.392754833205;5364.624476286623;5365.382980957162;5368.489993450616;5381.67709937405;5768.653880767168;5826.271716035496;5826.708664566755;5830.621009634445;5881.911771323434;5644.491995720405;5724.255846739898;5726.513246374022;5731.914021289684;5781.768729250867;5543.057680194296;5583.3858275589655;5635;5769.74036168365;5815.447532484407;5655.4344565543115;5677.858053548612;5710.942890571124;5711.885762284731;5760.991826430358;5735.2257445245195;5751.4536119068625;5753.33836608787;5753.510951569164;5754.108113242454;4278.657707383401;4326.372675961968;4344.739315641072;4409.316555933835;4455.064436468313;3966.424868394067;3967.7024223183375;3992.2414741199077;3996.5603783583783;4011.7191796574543;5329.600279979017;5330.093884039723;5338.386085600206;5347.973260133675;5393.4336894626285;5562.694051827108;5642.294713160855;5757.65454072757;5760.0207964646115;5790.044642633919;5290.391604965402;5290.629655924048;5331.760070796746;5344.652597581145;5345.251664766935;4961.70229786214;4978.103941290602;4978.5270399312;4980.103581355318;5028.069807085701;5780.797672081457;5951.940480595225;5969.044952807443;5970.76116955317;5972.402759723993;5580.135079062752;5634.267545219259;5635.9436405635415;5638.21065050885;5667;5931.169636251015;5944.4352786485215;5946.613470124428;5949.375315591974;5958.851028724316;5504.862378440571;5598.664080155204;5599.1041433370465;5706.229658996149;5711.400302968294;5675.943240567707;5679.74441150141;5719.599628026164;5744.0522313817755;5783.016887129283;5622.8313150605545;5623.943760562342;5625;5695.202671625892;5715.142728590745;5592.580556458363;5599.160125981135;5599.272094627672;5600.467955544217;5601.859953501195;5343.091674415281;5399.055165346127;5450.5912056595125;5464.672119672832;5529;5668.178114173339;5682.403347648603;5683.431656834284;5698.1452782083015;5735.397783232867;5510;5555.611107222456;5557.221988921635;5558.861028474159;5563.109902415594 12:58:19 INFO - PROCESS | 16898 | |1;ext.html;553.472416131477;590.8581940334319;593.178447849728;602.6323942395138;672.4653900149384;30252.848735756317;30936.226594335152;30984.84507577459;30996.380072398537;39059.41410878832;41840.58159418405;42377.33849276577;42425.151496970044;42452;42482.787586062026;8413.242808147266;8580.613872375727;8583.52790596517;8587;8587.570621468902;7579.128400233961;7764.844703105934;8454.239118479336;8578.485290882536;10371.533281002374;10271.640492582761;10388.324758890685;10396.324238924484;10402.21983351248;10404.167666586654;10234.437105959169;10300.690979270634;10316.535755890965;10319.79360412795;10327.380357178556;7743.535387876689;7934.206579342077;7934.3255823255095;10060.24548158891;10326.58693652253;37120;37405.06487337838;37427.06432339186;37470.43794343087;37586.62413375859;3326.9833650831592;3339.482380231068;3351.8324083795715;3361.1429085583018;3467.809270490122;30876.69123308783;30906.688604691837;31052.8447357764;31537.369252615048;32201.838990804896;3749.2314075614436;3810.961890381116;3825.5218097737784;3839.865604703822;3900.798905038914;264570;266038;267707.6614616934;267709;268174;56490.71754641201;57891;59076.7046164775;59378.703106484194;59421.70289148526;69567.30432695709;70330.13184274914;70746;70761.64619176871;70961.64519177475;12738.872611273953;12892.742145157044;12917.935410323076;12920.353982300847;12926.935365323301;10131.493425328705;10217.642382516577;10222.488875556193;10231.772187337418;10252.58989640406;17501.074881762997;17607.29570817153;17662.381816636356;17728.55678608045;18623.348182813537;7848.332891704269;8079.960019990005;8137.0471086938705;8167.836643267101;8199.344052475788;929.5584597316221;984.1388784813288;995.7311525887969;1027.4913917610832;1070.1866581398194;25708.228753137435;26130.6080408794;26460.33849153748;26722.86638566795;27060.323491912466;1019.2915923433143;1087.505185140759;1116.1740312168936;1126.6732647532124;1164.870533957124;13985.510507132405;14142.292885355897;14175;14181;14281.571552853431;314227;315306;317598;317998;318897;52059;52627.210591841154;52795;52890.206646900326;52900;1303.4330066421137;1319.459021801057;1328.455333313337;1363.7477066742683;1367.8221831161886;23427.23726150173;24988;25657.61513577335;26095.73904261009;26362.736372636027;43287.783561082;43612;43632.345514817935;43723.34414983714;43732.34401484044;249074;251149;251567;252384;252793;27922.860385697943;33331;33806.154846129044;33966.83016584901;34198.82900585481;40822.79588602038;41086.178276434905;41233.58766412298;42113.15773684448;42311.7884410576;34992.30015399729;35149.47275790916;35364.115897102776;35429.46855797217;36011.45982810312;35153.47269790904;35429.46855797217;35556.28887422289;36142.27715445729;36150.819245904655;34127.73308967049;34656.133596660286;35086.29827403489;35215.82392088023;35282;30552.388952221274;31963.680363196072;32058.519122212718;32314.83842580772;32563.83718081489;24714.258572242863;24967.500649986534;25193.244202673948;25344.746552534238;25948 12:58:19 INFO - PROCESS | 16898 | |2;jquery.html;346.1191268222374;348.6879243077446;350.62132896471815;361.56250936366996;363.88355726167623;14255.144691318528;14624.780628290584;16387.918060409695;16723.916380418097;17373.478795636118;16243.593910152253;16288.674226515463;16375.83624163761;16731.749023764653;16748.748768768477;5499.450054994499;5602.803901863435;5655.179998900157;5656.773729050833;5659.405762394951;4072.165206132736;4188.267053265681;5532.585056120787;5981.342052374235;6162.568620196588;5908.763649454017;6045.7883974060915;6072.483838873701;6103.755849766004;6106.542009349294;6081.391860813927;6114.510839132859;6118.479929205978;6119.265688117454;6128;5289.735513224362;5354.411014788409;5358.812441564565;5362.678239305654;5392.137258038734;20564.58870822575;20673.896630516752;20808.791912080836;21046.894765526074;21061.052252648515;2170.5007848195005;2218.911243550256;2235.5528894221056;2243.371855880356;2492.850428974249;13385.86614133856;13433.261170635611;13448.462061517528;13558.525451609245;13573.728525429535;1878.19237727777;1890.4706682129026;1891.073374046721;1896.5732710140246;1919.3570153998428;56451;58458;59733;60043;60956;9426.293028022927;9443.244540436748;9483.241340692728;9488.051194880456;9493.572789224501;12190.81713774294;12244.938775306244;12265.754684906253;12266;12285.938570307091;6572.769953051716;6721.26066132725;6852.965735171292;6880.380765731008;6945.652717364112;6265.749370025239;6703.262641109474;6786.694598743068;6842.384185423336;6856.657167141623;5293.179557168645;5801.332846722681;5812.738426770806;5887.793927212527;5896.439838215363;1670.0647637323138;1732.870034747399;1790.1049475262369;1794.4526919289742;1805.1966874740615;932.4125800745622;947.6162154327509;991.6876184002016;997.9614207558044;1037.305005646219;15181.772273415907;17048.744268835977;17224.741628875578;17554.210060547306;18011.819881801275;914.3608438415145;965.5220665770488;966.2752935298527;998.5706146356991;1013.4780587997187;10283.331583447052;10359;10423.791524169474;10435.739106522398;10469.528871200815;379885;383486;386587;389849;511588;66107.33892661011;66300.6684966572;68388.97416538755;80031;85169;1102.8566286382718;1134.053065690158;1136.323887287063;1136.8237923121928;1159.4087015621924;15510.534683959499;15633.374665013727;15881.444149454714;15899.443519476763;15981.200939953189;32917.67082329146;34633.307333853685;35034.82482587571;35475.467867982516;35655;39614.40578391384;39725.60274397219;40943.18113637651;41224.587754122076;41317.58682413137;9160.862587061067;9164.95417522908;9188.770280742767;9210.355275130945;9221.262299015929;16384.836151638807;16824.242909068875;16890.493285201464;17244.655106898044;17472.388466403616;14116.647083822987;14635;14757.188354640597;15085.47200847965;15201.391944322104;13792;14273.357698903366;14429;14463.638409039859;14961.625959351104;15272.465463708717;15347.309371078552;15486.5354039379;15610.9219453902;15665.765013524579;9303.116203960613;9354.71935841926;9418.623255069995;9454.810903782023;9471.715848524555;10164.390136591828;10829.350238985686;14779.92610036943;15148.697026059637;15241.847581524044 12:58:19 INFO - PROCESS | 16898 | |3;mootools.html;1369.7604416778563;1718.974215386769;1762.2774662388415;1790.5165605286572;1817.0369704056855;6324.58890172139;7238;7385;7393.112826460819;7398.482106252564;7285.817854553638;7507.624618769067;7519.248075192478;7523.360514356286;7529.209433009537;1960.1571324330532;1992.6014797040577;1996;2224.410531209227;2254.1884921428273;2023.271622216001;2184.060853832851;2233.396982814639;2248.201888329644;2249.876256805875;2210.4473881529616;2229.7881701238357;2234.2850287907877;2298.3449716830705;2302.930912072632;2235.7764223577674;2245.4049676835652;2265.1732117777055;2265.592193405186;2275.6131457652154;2233.352327824929;2244.730632324115;2252.0653928619604;2253.6394176931612;2255.3459496745922;7466.2160473150625;7490.85018299631;7509.211532789088;7511.023566936318;7516.7369142080315;4529.04889973106;4545.159145558082;4586.4266966629175;4609.930851037204;4616.845788552861;3005.4289684959786;3022.607061082067;3076.9384612307854;3087.598612180402;3116.236522052112;962.9422234665942;981.3474039763548;1007.5113569918584;1013.4932533733133;1022.5756311130872;10240.692779216635;10265.948670256676;10274.075333219971;10277.948610256975;10283.331583447052;4164.104717485695;4208.537060923296;4219.683523735671;4246.745195288293;4277.251480990814;8928.375013749104;8930.642774289086;8933.062028487046;8936.151065648754;8937.910620893837;4656.85906952792;4662.254039353687;4670.78981445829;4678.719276843401;4690.179218636793;4232.851850185229;4267.914641707211;4269.765162916069;4269.935950960738;4271.722338048017;3082.553029810665;3123.859426325821;3559.6796288333658;3600.6039335673054;3620.637936206358;1154.1343992005995;1154.9480273387549;1160.4081918221598;1168.4333098447246;1181.8345431639577;945.7588314979636;947.7677968897664;982.1651596143221;1043.5356266461504;1352.939117739704;7145.928540714526;7186.964065179641;7210.206877243499;7215.530990485601;7215.639218039077;1122.9209723452514;1130.9151813614012;1146.6158836789602;1149.3793351590048;1180.557291015869;5670.744816483269;5718.771249149988;5725.828225153252;5728.05487094633;5732.226149469851;8657.653693852302;8697.434666746642;8745.562721863882;8782.91217087821;8783.077776833468;8669.869951950726;8748;8772.078931712205;8786.692465763668;8787.121287871161;6911.768376388369;7105.92894071063;7106.5736055836815;7111.751088711871;7183.748568800067;7186.029885965328;7243.855122897618;7245.818854528679;7258.165310989304;7265.382442492236;7748.535087894745;7999.84000320002;8203.671853125808;8204.138565450781;8221.958890205511;8193.303569196447;8304.626291816761;8327.292180164754;8332.50004999702;8333.208345207195;6706.865862682816;6893.586384816927;6903.1716194057035;6910;6929.5842249465195;6487.870242595216;6780.627065511444;6966.12923384577;7287;7365.373943214887;6216.347283535164;6251.718672659832;6312.337204593635;6344.429001389897;6352.745890164527;6630.569013014138;6663.900041499478;6718.529702920749;6723.361280678328;6750.493712971645;6425.935740642533;6694.430973367318;6695.4978376620975;6715.4627629790475;6718.798436046926;6277.623342599459;6311.905321420274;6312.7159277833525;6314.905276420949;6329.050642403677;6291.811245662638;6335.303116657072;6363.077353783583;6375.330590287953;6376.202974628171 12:58:19 INFO - PROCESS | 16898 | |4;prototype.html;336.28539353873015;338.4939515424441;338.87461639193504;347.2811280649056;348.24952227948773;5945.554083443737;5960.61256018359;5988.640681559099;5997.490213331861;6020.187274717911;5618.719064046792;5739.885202295952;5791.349465402362;5876.11858221267;5920.378360272174;4550.590446859782;4568.2462393705;4574.6340292776495;4578.084383123389;4582.08358328334;4367.475902891658;4579.129965306598;4581.244094724367;4582.1064892346;4594.977025114869;4401.2517871961845;4402.625776808975;4505.098980203972;4512.1426928883575;4533.705309154894;4508.075844451912;4528.796204170821;4531.43357080365;4532.13889361022;4539.341795439643;4008.719389642726;4009.8797036088963;4011.0373510357304;4011.1376054148204;4014.0566966762785;5544.251526044013;5656.208130861683;5658.603897727161;5667.263255776723;5668.858278543028;5340.813071542516;5344;5348.545373643245;5354.196870469422;5364.839054828361;6278.30938596754;6280.15217945576;6282.591631543935;6291.465225455841;6293.590916590407;4477.059817438342;4478.4178056852725;4480.507144214133;4482.21561226784;4487.775611219426;6347.746090156388;6544.70548825304;6576.210854697467;6577.6711164441585;6584.539082264291;4417.072414792865;4421.712588681726;4424;4428.402165707653;4432.601065904019;4489.281714925596;4493.236149854532;4493.258612328995;4495.64034877209;4497;5225.085610018232;5226.608004399685;5233.581313494988;5242.135047717084;5245.587029966258;6146.416090471398;6284.622922624657;6291.937080629226;6301.6534090625455;6340.651264180515;1556.494139404698;1569.3487202810934;1569.803774528184;1570.5288413475912;1573.3156077106496;1046.5029111172132;1070.0690399352613;1075.4945175767377;1091.2034215022918;1092.3118435385657;5967.403259674084;5973.820785376446;5985.311689155716;5986.132010858489;5986.952283350396;6466.288708242089;6495.6752162391695;6507.12153859223;6507.8698426031215;6513.088167656532;5796.594238403271;5856;5946.137810017523;5974.1934838796205;5980.43185897339;3512.051746028558;3527.100589349751;3536.8231588420476;3540.9822950885596;3543.3976224041976;6773.9322606774285;6785.457163426914;6792.728290868409;6792.76225332111;6800.65996700163;6557.606543607399;6574.737010519526;6666.96666516674;6696.497762667819;6702.195736511552;6690.698918548677;6697.430718388991;6706.362895524917;6710.83222919431;6716.328367163343;6520.576162549419;6521;6535.509836762357;6538.574992625464;6539.967300163468;6357.427831495188;6453.354664533696;6496.058071579689;6497.350264973654;6502.707378167899;6770.86458270822;6784.3894049535775;6790.456763458813;6794.3545363190415;6798.320167983162;4526.479454862733;4526.705764125321;4526.728396296233;4529.501754806903;4530.592246697813;6427.614343139427;6574.605523668595;6580.967095164494;6582.605043697394;6585.604863708193;6392.808215753535;6400.615963042233;6401;6401.071844582602;6406.327335629691;6360.904586431115;6379.6810159490915;6384.808455746335;6389.520785941166;6394.808155755335;6081.5742897996715;6263.404976527223;6274.372562743689;6275.497960163085;6278.529110316653;6428.935710642833;6430.614163150226;6440.581362211441;6441.967790161019;6447.806565803034;6248.250209974832;6286.717097730521;6295.087212354275;6299.96850015747;6301.6219026858535 12:58:19 INFO - PROCESS | 16898 | |5;yui.html;790.7153424767084;810.6838333050115;836.7071524966267;837.058309401923;860.384824850232;13752.793708094374;13921.860781392183;13949.511767088154;13988.720225595482;14001.859981400183;15070.47253346133;15223.467178648749;15227.314770835312;15263.6947261055;15292.082475051477;694.1669996004814;845.9280961118297;857.4083882121347;857.5626430520417;857.7169534053778;700.1528150937372;837.7654256808073;853.5774791478196;853.8036251662121;853.87191921212;874.5277550122958;885.4908427654093;887.7070566712969;889.0709208876739;889.8709687095368;721.9927800722004;728.6101935464554;879.3404946290283;885.4642941020686;885.5572213893054;644.1175589442494;649.3668673043792;649.860280039789;650.9804705858832;651.5439192565176;13614.591562253148;13759;13761.793573096411;13767;13767.449302027906;12425.689357766038;13006.934965325207;13096.672583185402;13098.47606095755;13563.660908477268;9904.108630223242;9991.700248992542;10141.290109692325;10148.746281342952;10525.421101839396;3555.3600351936643;3607.639236076371;3630.9273814523826;3631.891043268706;3746.250749850041;46330.53669463296;47414;47952.7602361986;48229;48241.27638085432;9653.986331435099;9693.854592181124;9751.756206094762;9776.51117444125;9834.655787047563;18974;19016;19016;19024;19051.428457146307;7500.774976750707;7526.811829704301;7610.124835643972;7731.922680773233;7847.686092556234;4015.6988225883174;4190.937135942963;4226.830926762895;4252.510961239435;4292.635126014324;2945.2047947054175;2985.11938978002;2989.417063672563;2994.4160888626943;2995.8352290624225;540.0522083743006;548.7942021741846;550.1884720037992;562.6511562830989;564.497597138547;507.713142074734;595.92733080455;626.317314127594;661.4377778887907;663.2571519897649;7742.4580279381025;8102.432829701982;8442.957785211034;9443.952780236055;9543.188828949616;521.452474901352;551.4265164229237;560.6467925207094;579.875326804739;645.4062262718311;3943.191645712622;3950.3876899080688;4072.9796351018053;4188.623023927861;4235.470566179228;53466;53698.73150634222;53988.730056349465;54143.72928135334;54215.45784542183;48294.517054829004;48603.75698121558;48635.27047094297;48958;49143;45952.08095838065;47821.5217847824;47953.76023119862;48051.75974120107;48400.5159948403;8354.45696029756;8549.444286121383;8782.209601135928;8884;9009.549522523717;34121.65878341185;34418.311633767684;34793;35275.470867936485;35816.82091589525;40390.19219615532;42132.78933605312;43468.347974781034;43535.34696979611;44184.33723494086;10638.468076596295;10846.783064338826;10902.727431813952;10962.671119866416;11420.428978551205;11475.081993440672;11519.07847372225;12050;12481.812772808233;12858.228506289652;10239.692809215736;10291.794164116525;10297.279190456897;10313.329633573794;11258.21192516516;10793.568257269935;11105.500252488497;11573.363465009505;11604.245724027911;11668.299902005907;7166.4073497813715;10933.45332733376;10973.890261097287;11006.174536909924;11411.372374519482;9637.42175469474;9639.951800240953;9805;9971.903090660167;10146.461709730462;8964.238039766433;9099.7270081895;9582.760430989281;9716.611335546782;10063.496825158567 12:58:19 INFO - PROCESS | 16898 | __end_tp_report 12:58:19 INFO - PROCESS | 16898 | __start_cc_report 12:58:19 INFO - PROCESS | 16898 | _x_x_mozilla_cycle_collect,837 12:58:19 INFO - PROCESS | 16898 | __end_cc_report 12:58:19 INFO - PROCESS | 16898 | __startTimestamp1450904299397__endTimestamp 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | ------- Summary: start ------- 12:58:19 INFO - PROCESS | 16898 | Number of tests: 6 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#0] dojo.html Cycles:165 Average:5322.39 Median:5543.06 stddev:581.35 (10.5%) stddev-sans-first:557.24 12:58:19 INFO - PROCESS | 16898 | Values: 3135.2 3180.2 3231.7 3238.5 3255.7 5144.5 5284.6 5328.2 5365.9 5416.5 5239.7 5273.8 5287.6 5328.8 5339.5 4843.6 4881.4 4904.7 4916.5 4955.3 4938.3 5000.4 5006.4 5007.5 5033.0 4765.1 4768.8 4883.8 4922.4 4930.0 4900.3 4909.5 4948.3 4958.5 4961.7 4901.8 4908.7 4920.8 4933.3 4966.0 5081.6 5104.8 5184.7 5221.5 5288.8 5728.6 5733.9 5745.6 5800.7 5819.7 5736.8 5753.2 5762.0 5764.8 5777.6 5280.4 5364.6 5365.4 5368.5 5381.7 5768.7 5826.3 5826.7 5830.6 5881.9 5644.5 5724.3 5726.5 5731.9 5781.8 5543.1 5583.4 5635.0 5769.7 5815.4 5655.4 5677.9 5710.9 5711.9 5761.0 5735.2 5751.5 5753.3 5753.5 5754.1 4278.7 4326.4 4344.7 4409.3 4455.1 3966.4 3967.7 3992.2 3996.6 4011.7 5329.6 5330.1 5338.4 5348.0 5393.4 5562.7 5642.3 5757.7 5760.0 5790.0 5290.4 5290.6 5331.8 5344.7 5345.3 4961.7 4978.1 4978.5 4980.1 5028.1 5780.8 5951.9 5969.0 5970.8 5972.4 5580.1 5634.3 5635.9 5638.2 5667.0 5931.2 5944.4 5946.6 5949.4 5958.9 5504.9 5598.7 5599.1 5706.2 5711.4 5675.9 5679.7 5719.6 5744.1 5783.0 5622.8 5623.9 5625.0 5695.2 5715.1 5592.6 5599.2 5599.3 5600.5 5601.9 5343.1 5399.1 5450.6 5464.7 5529.0 5668.2 5682.4 5683.4 5698.1 5735.4 5510.0 5555.6 5557.2 5558.9 5563.1 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#1] ext.html Cycles:180 Average:44822.60 Median:18328.99 stddev:73156.17 (399.1%) stddev-sans-first:73285.88 12:58:19 INFO - PROCESS | 16898 | Values: 553.5 590.9 593.2 602.6 672.5 30252.8 30936.2 30984.8 30996.4 39059.4 41840.6 42377.3 42425.2 42452.0 42482.8 8413.2 8580.6 8583.5 8587.0 8587.6 7579.1 7764.8 8454.2 8578.5 10371.5 10271.6 10388.3 10396.3 10402.2 10404.2 10234.4 10300.7 10316.5 10319.8 10327.4 7743.5 7934.2 7934.3 10060.2 10326.6 37120.0 37405.1 37427.1 37470.4 37586.6 3327.0 3339.5 3351.8 3361.1 3467.8 30876.7 30906.7 31052.8 31537.4 32201.8 3749.2 3811.0 3825.5 3839.9 3900.8 264570.0 266038.0 267707.7 267709.0 268174.0 56490.7 57891.0 59076.7 59378.7 59421.7 69567.3 70330.1 70746.0 70761.6 70961.6 12738.9 12892.7 12917.9 12920.4 12926.9 10131.5 10217.6 10222.5 10231.8 10252.6 17501.1 17607.3 17662.4 17728.6 18623.3 7848.3 8080.0 8137.0 8167.8 8199.3 929.6 984.1 995.7 1027.5 1070.2 25708.2 26130.6 26460.3 26722.9 27060.3 1019.3 1087.5 1116.2 1126.7 1164.9 13985.5 14142.3 14175.0 14181.0 14281.6 314227.0 315306.0 317598.0 317998.0 318897.0 52059.0 52627.2 52795.0 52890.2 52900.0 1303.4 1319.5 1328.5 1363.7 1367.8 23427.2 24988.0 25657.6 26095.7 26362.7 43287.8 43612.0 43632.3 43723.3 43732.3 249074.0 251149.0 251567.0 252384.0 252793.0 27922.9 33331.0 33806.2 33966.8 34198.8 40822.8 41086.2 41233.6 42113.2 42311.8 34992.3 35149.5 35364.1 35429.5 36011.5 35153.5 35429.5 35556.3 36142.3 36150.8 34127.7 34656.1 35086.3 35215.8 35282.0 30552.4 31963.7 32058.5 32314.8 32563.8 24714.3 24967.5 25193.2 25344.7 25948.0 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#2] jquery.html Cycles:180 Average:24994.00 Median:349.65 stddev:67646.69 (19346.7%) stddev-sans-first:67811.14 12:58:19 INFO - PROCESS | 16898 | Values: 346.1 348.7 350.6 361.6 363.9 14255.1 14624.8 16387.9 16723.9 17373.5 16243.6 16288.7 16375.8 16731.7 16748.7 5499.5 5602.8 5655.2 5656.8 5659.4 4072.2 4188.3 5532.6 5981.3 6162.6 5908.8 6045.8 6072.5 6103.8 6106.5 6081.4 6114.5 6118.5 6119.3 6128.0 5289.7 5354.4 5358.8 5362.7 5392.1 20564.6 20673.9 20808.8 21046.9 21061.1 2170.5 2218.9 2235.6 2243.4 2492.9 13385.9 13433.3 13448.5 13558.5 13573.7 1878.2 1890.5 1891.1 1896.6 1919.4 56451.0 58458.0 59733.0 60043.0 60956.0 9426.3 9443.2 9483.2 9488.1 9493.6 12190.8 12244.9 12265.8 12266.0 12285.9 6572.8 6721.3 6853.0 6880.4 6945.7 6265.7 6703.3 6786.7 6842.4 6856.7 5293.2 5801.3 5812.7 5887.8 5896.4 1670.1 1732.9 1790.1 1794.5 1805.2 932.4 947.6 991.7 998.0 1037.3 15181.8 17048.7 17224.7 17554.2 18011.8 914.4 965.5 966.3 998.6 1013.5 10283.3 10359.0 10423.8 10435.7 10469.5 379885.0 383486.0 386587.0 389849.0 511588.0 66107.3 66300.7 68389.0 80031.0 85169.0 1102.9 1134.1 1136.3 1136.8 1159.4 15510.5 15633.4 15881.4 15899.4 15981.2 32917.7 34633.3 35034.8 35475.5 35655.0 39614.4 39725.6 40943.2 41224.6 41317.6 9160.9 9165.0 9188.8 9210.4 9221.3 16384.8 16824.2 16890.5 17244.7 17472.4 14116.6 14635.0 14757.2 15085.5 15201.4 13792.0 14273.4 14429.0 14463.6 14961.6 15272.5 15347.3 15486.5 15610.9 15665.8 9303.1 9354.7 9418.6 9454.8 9471.7 10164.4 10829.4 14779.9 15148.7 15241.8 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#3] mootools.html Cycles:180 Average:5273.42 Median:6312.53 stddev:2685.39 (42.5%) stddev-sans-first:2676.89 12:58:19 INFO - PROCESS | 16898 | Values: 1369.8 1719.0 1762.3 1790.5 1817.0 6324.6 7238.0 7385.0 7393.1 7398.5 7285.8 7507.6 7519.2 7523.4 7529.2 1960.2 1992.6 1996.0 2224.4 2254.2 2023.3 2184.1 2233.4 2248.2 2249.9 2210.4 2229.8 2234.3 2298.3 2302.9 2235.8 2245.4 2265.2 2265.6 2275.6 2233.4 2244.7 2252.1 2253.6 2255.3 7466.2 7490.9 7509.2 7511.0 7516.7 4529.0 4545.2 4586.4 4609.9 4616.8 3005.4 3022.6 3076.9 3087.6 3116.2 962.9 981.3 1007.5 1013.5 1022.6 10240.7 10265.9 10274.1 10277.9 10283.3 4164.1 4208.5 4219.7 4246.7 4277.3 8928.4 8930.6 8933.1 8936.2 8937.9 4656.9 4662.3 4670.8 4678.7 4690.2 4232.9 4267.9 4269.8 4269.9 4271.7 3082.6 3123.9 3559.7 3600.6 3620.6 1154.1 1154.9 1160.4 1168.4 1181.8 945.8 947.8 982.2 1043.5 1352.9 7145.9 7187.0 7210.2 7215.5 7215.6 1122.9 1130.9 1146.6 1149.4 1180.6 5670.7 5718.8 5725.8 5728.1 5732.2 8657.7 8697.4 8745.6 8782.9 8783.1 8669.9 8748.0 8772.1 8786.7 8787.1 6911.8 7105.9 7106.6 7111.8 7183.7 7186.0 7243.9 7245.8 7258.2 7265.4 7748.5 7999.8 8203.7 8204.1 8222.0 8193.3 8304.6 8327.3 8332.5 8333.2 6706.9 6893.6 6903.2 6910.0 6929.6 6487.9 6780.6 6966.1 7287.0 7365.4 6216.3 6251.7 6312.3 6344.4 6352.7 6630.6 6663.9 6718.5 6723.4 6750.5 6425.9 6694.4 6695.5 6715.5 6718.8 6277.6 6311.9 6312.7 6314.9 6329.1 6291.8 6335.3 6363.1 6375.3 6376.2 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#4] prototype.html Cycles:180 Average:5284.44 Median:5970.61 stddev:1593.82 (26.7%) stddev-sans-first:1554.42 12:58:19 INFO - PROCESS | 16898 | Values: 336.3 338.5 338.9 347.3 348.2 5945.6 5960.6 5988.6 5997.5 6020.2 5618.7 5739.9 5791.3 5876.1 5920.4 4550.6 4568.2 4574.6 4578.1 4582.1 4367.5 4579.1 4581.2 4582.1 4595.0 4401.3 4402.6 4505.1 4512.1 4533.7 4508.1 4528.8 4531.4 4532.1 4539.3 4008.7 4009.9 4011.0 4011.1 4014.1 5544.3 5656.2 5658.6 5667.3 5668.9 5340.8 5344.0 5348.5 5354.2 5364.8 6278.3 6280.2 6282.6 6291.5 6293.6 4477.1 4478.4 4480.5 4482.2 4487.8 6347.7 6544.7 6576.2 6577.7 6584.5 4417.1 4421.7 4424.0 4428.4 4432.6 4489.3 4493.2 4493.3 4495.6 4497.0 5225.1 5226.6 5233.6 5242.1 5245.6 6146.4 6284.6 6291.9 6301.7 6340.7 1556.5 1569.3 1569.8 1570.5 1573.3 1046.5 1070.1 1075.5 1091.2 1092.3 5967.4 5973.8 5985.3 5986.1 5987.0 6466.3 6495.7 6507.1 6507.9 6513.1 5796.6 5856.0 5946.1 5974.2 5980.4 3512.1 3527.1 3536.8 3541.0 3543.4 6773.9 6785.5 6792.7 6792.8 6800.7 6557.6 6574.7 6667.0 6696.5 6702.2 6690.7 6697.4 6706.4 6710.8 6716.3 6520.6 6521.0 6535.5 6538.6 6540.0 6357.4 6453.4 6496.1 6497.4 6502.7 6770.9 6784.4 6790.5 6794.4 6798.3 4526.5 4526.7 4526.7 4529.5 4530.6 6427.6 6574.6 6581.0 6582.6 6585.6 6392.8 6400.6 6401.0 6401.1 6406.3 6360.9 6379.7 6384.8 6389.5 6394.8 6081.6 6263.4 6274.4 6275.5 6278.5 6428.9 6430.6 6440.6 6442.0 6447.8 6248.3 6286.7 6295.1 6300.0 6301.6 12:58:19 INFO - PROCESS | 16898 | 12:58:19 INFO - PROCESS | 16898 | [#5] yui.html Cycles:180 Average:13646.84 Median:48140.38 stddev:15477.78 (32.2%) stddev-sans-first:15491.09 12:58:19 INFO - PROCESS | 16898 | Values: 790.7 810.7 836.7 837.1 860.4 13752.8 13921.9 13949.5 13988.7 14001.9 15070.5 15223.5 15227.3 15263.7 15292.1 694.2 845.9 857.4 857.6 857.7 700.2 837.8 853.6 853.8 853.9 874.5 885.5 887.7 889.1 889.9 722.0 728.6 879.3 885.5 885.6 644.1 649.4 649.9 651.0 651.5 13614.6 13759.0 13761.8 13767.0 13767.4 12425.7 13006.9 13096.7 13098.5 13563.7 9904.1 9991.7 10141.3 10148.7 10525.4 3555.4 3607.6 3630.9 3631.9 3746.3 46330.5 47414.0 47952.8 48229.0 48241.3 9654.0 9693.9 9751.8 9776.5 9834.7 18974.0 19016.0 19016.0 19024.0 19051.4 7500.8 7526.8 7610.1 7731.9 7847.7 4015.7 4190.9 4226.8 4252.5 4292.6 2945.2 2985.1 2989.4 2994.4 2995.8 540.1 548.8 550.2 562.7 564.5 507.7 595.9 626.3 661.4 663.3 7742.5 8102.4 8443.0 9444.0 9543.2 521.5 551.4 560.6 579.9 645.4 3943.2 3950.4 4073.0 4188.6 4235.5 53466.0 53698.7 53988.7 54143.7 54215.5 48294.5 48603.8 48635.3 48958.0 49143.0 45952.1 47821.5 47953.8 48051.8 48400.5 8354.5 8549.4 8782.2 8884.0 9009.5 34121.7 34418.3 34793.0 35275.5 35816.8 40390.2 42132.8 43468.3 43535.3 44184.3 10638.5 10846.8 10902.7 10962.7 11420.4 11475.1 11519.1 12050.0 12481.8 12858.2 10239.7 10291.8 10297.3 10313.3 11258.2 10793.6 11105.5 11573.4 11604.2 11668.3 7166.4 10933.5 10973.9 11006.2 11411.4 9637.4 9640.0 9805.0 9971.9 10146.5 8964.2 9099.7 9582.8 9716.6 10063.5 12:58:19 INFO - PROCESS | 16898 | -------- Summary: end -------- 12:58:19 INFO - PROCESS | 16898 | 12:58:20 INFO - TEST-INFO | 16898: exit 0 12:58:20 INFO - TEST-OK | dromaeo_css | took 1113400ms 12:58:20 INFO - TEST-START | kraken 12:58:20 INFO - operating with platform_type : linux_ 12:58:20 INFO - Initialising browser for kraken test... 12:58:20 INFO - TEST-INFO | started process 17090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxeP7Yn/profile http://localhost:51769/getInfo.html) 12:58:24 INFO - PROCESS | 17090 | __metrics Screen width/height:1600/1200 12:58:24 INFO - PROCESS | 17090 | colorDepth:24 12:58:24 INFO - PROCESS | 17090 | Browser inner width/height: 1024/697 12:58:24 INFO - PROCESS | 17090 | __metrics 12:58:24 INFO - PROCESS | 17090 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:58:24 INFO - PROCESS | 17090 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:25 INFO - TEST-INFO | 17090: exit 0 12:58:25 INFO - Browser initialized. 12:58:25 INFO - Running cycle 1/1 for kraken test... 12:58:25 INFO - TEST-INFO | started process 17172 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxeP7Yn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:37 INFO - PROCESS | 17172 | RSS: Main: 149458944 12:58:37 INFO - PROCESS | 17172 | 12:58:39 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:40 INFO - PROCESS | 17172 | RSS: Main: 185778176 12:58:40 INFO - PROCESS | 17172 | 12:58:42 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-dft) 12:58:43 INFO - PROCESS | 17172 | RSS: Main: 177340416 12:58:43 INFO - PROCESS | 17172 | 12:58:46 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-fft) 12:58:46 INFO - PROCESS | 17172 | RSS: Main: 160362496 12:58:46 INFO - PROCESS | 17172 | 12:58:48 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator) 12:58:49 INFO - PROCESS | 17172 | RSS: Main: 161665024 12:58:49 INFO - PROCESS | 17172 | 12:58:51 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:52 INFO - PROCESS | 17172 | RSS: Main: 164388864 12:58:52 INFO - PROCESS | 17172 | 12:58:55 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:55 INFO - PROCESS | 17172 | RSS: Main: 164491264 12:58:55 INFO - PROCESS | 17172 | 12:58:58 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate) 12:58:59 INFO - PROCESS | 17172 | RSS: Main: 165376000 12:58:59 INFO - PROCESS | 17172 | 12:59:02 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial) 12:59:02 INFO - PROCESS | 17172 | RSS: Main: 164438016 12:59:02 INFO - PROCESS | 17172 | 12:59:04 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:04 INFO - PROCESS | 17172 | RSS: Main: 173907968 12:59:04 INFO - PROCESS | 17172 | 12:59:06 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:07 INFO - PROCESS | 17172 | RSS: Main: 173031424 12:59:07 INFO - PROCESS | 17172 | 12:59:09 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:09 INFO - PROCESS | 17172 | RSS: Main: 184094720 12:59:09 INFO - PROCESS | 17172 | 12:59:12 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:12 INFO - PROCESS | 17172 | RSS: Main: 192888832 12:59:12 INFO - PROCESS | 17172 | 12:59:15 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:16 INFO - PROCESS | 17172 | RSS: Main: 188645376 12:59:16 INFO - PROCESS | 17172 | 12:59:17 INFO - PROCESS | 17172 | Cycle 1(1): loaded http://localhost:51769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51769/tests/kraken/driver.html?testName=ai-astar) 12:59:18 INFO - PROCESS | 17172 | RSS: Main: 246640640 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | __start_tp_report 12:59:18 INFO - PROCESS | 17172 | _x_x_mozilla_page_load 12:59:18 INFO - PROCESS | 17172 | _x_x_mozilla_page_load_details 12:59:18 INFO - PROCESS | 17172 | |i|pagename|runs| 12:59:18 INFO - PROCESS | 17172 | |0;ai-astar;108;110;106;110;110;111;99;110;110;118 12:59:18 INFO - PROCESS | 17172 | |1;audio-beat-detection;154;126;145;160;128;151;151;133;168;125 12:59:18 INFO - PROCESS | 17172 | |2;audio-dft;159;166;160;161;160;162;159;162;160;161 12:59:18 INFO - PROCESS | 17172 | |3;audio-fft;70;72;81;93;70;77;72;126;98;71 12:59:18 INFO - PROCESS | 17172 | |4;audio-oscillator;94;93;138;93;94;94;136;93;92;131 12:59:18 INFO - PROCESS | 17172 | |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;110;110 12:59:18 INFO - PROCESS | 17172 | |6;imaging-darkroom;146;146;145;146;145;145;145;145;146;153 12:59:18 INFO - PROCESS | 17172 | |7;imaging-desaturate;96;95;96;96;97;96;96;96;96;96 12:59:18 INFO - PROCESS | 17172 | |8;json-parse-financial;59;59;58;59;60;66;57;67;56;57 12:59:18 INFO - PROCESS | 17172 | |9;json-stringify-tinderbox;68;68;67;68;68;69;68;69;69;68 12:59:18 INFO - PROCESS | 17172 | |10;stanford-crypto-aes;90;85;84;85;85;93;84;85;86;83 12:59:18 INFO - PROCESS | 17172 | |11;stanford-crypto-ccm;114;136;121;120;122;123;126;124;117;113 12:59:18 INFO - PROCESS | 17172 | |12;stanford-crypto-pbkdf2;140;150;150;151;144;139;151;152;151;139 12:59:18 INFO - PROCESS | 17172 | |13;stanford-crypto-sha256-iterative;68;66;65;65;65;66;67;65;69;67 12:59:18 INFO - PROCESS | 17172 | __end_tp_report 12:59:18 INFO - PROCESS | 17172 | __start_cc_report 12:59:18 INFO - PROCESS | 17172 | _x_x_mozilla_cycle_collect,935 12:59:18 INFO - PROCESS | 17172 | __end_cc_report 12:59:18 INFO - PROCESS | 17172 | __startTimestamp1450904358001__endTimestamp 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | ------- Summary: start ------- 12:59:18 INFO - PROCESS | 17172 | Number of tests: 14 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:4.71 (4.3%) stddev-sans-first:4.97 12:59:18 INFO - PROCESS | 17172 | Values: 108.0 110.0 106.0 110.0 110.0 111.0 99.0 110.0 110.0 118.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.00 stddev:15.25 (10.1%) stddev-sans-first:15.75 12:59:18 INFO - PROCESS | 17172 | Values: 154.0 126.0 145.0 160.0 128.0 151.0 151.0 133.0 168.0 125.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:2.05 (1.3%) stddev-sans-first:2.05 12:59:18 INFO - PROCESS | 17172 | Values: 159.0 166.0 160.0 161.0 160.0 162.0 159.0 162.0 160.0 161.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#3] audio-fft Cycles:10 Average:83.00 Median:74.50 stddev:18.07 (24.3%) stddev-sans-first:18.54 12:59:18 INFO - PROCESS | 17172 | Values: 70.0 72.0 81.0 93.0 70.0 77.0 72.0 126.0 98.0 71.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:93.00 stddev:20.23 (21.8%) stddev-sans-first:21.00 12:59:18 INFO - PROCESS | 17172 | Values: 94.0 93.0 138.0 93.0 94.0 94.0 136.0 93.0 92.0 131.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:59:18 INFO - PROCESS | 17172 | Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.44 (1.7%) stddev-sans-first:2.59 12:59:18 INFO - PROCESS | 17172 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 153.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 12:59:18 INFO - PROCESS | 17172 | Values: 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.00 stddev:3.74 (6.3%) stddev-sans-first:3.95 12:59:18 INFO - PROCESS | 17172 | Values: 59.0 59.0 58.0 59.0 60.0 66.0 57.0 67.0 56.0 57.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 12:59:18 INFO - PROCESS | 17172 | Values: 68.0 68.0 67.0 68.0 68.0 69.0 68.0 69.0 69.0 68.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.09 (3.6%) stddev-sans-first:2.92 12:59:18 INFO - PROCESS | 17172 | Values: 90.0 85.0 84.0 85.0 85.0 93.0 84.0 85.0 86.0 83.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.50 stddev:6.59 (5.4%) stddev-sans-first:6.39 12:59:18 INFO - PROCESS | 17172 | Values: 114.0 136.0 121.0 120.0 122.0 123.0 126.0 124.0 117.0 113.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:150.50 stddev:5.54 (3.7%) stddev-sans-first:5.32 12:59:18 INFO - PROCESS | 17172 | Values: 140.0 150.0 150.0 151.0 144.0 139.0 151.0 152.0 151.0 139.0 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - PROCESS | 17172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.42 (2.1%) stddev-sans-first:1.36 12:59:18 INFO - PROCESS | 17172 | Values: 68.0 66.0 65.0 65.0 65.0 66.0 67.0 65.0 69.0 67.0 12:59:18 INFO - PROCESS | 17172 | -------- Summary: end -------- 12:59:18 INFO - PROCESS | 17172 | 12:59:18 INFO - TEST-INFO | 17172: exit 0 12:59:18 INFO - TEST-OK | kraken | took 58704ms 12:59:18 INFO - TEST-START | v8_7 12:59:18 INFO - operating with platform_type : linux_ 12:59:18 INFO - Initialising browser for v8_7 test... 12:59:18 INFO - TEST-INFO | started process 17425 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKD_3dh/profile http://localhost:51769/getInfo.html) 12:59:22 INFO - PROCESS | 17425 | __metrics Screen width/height:1600/1200 12:59:22 INFO - PROCESS | 17425 | colorDepth:24 12:59:22 INFO - PROCESS | 17425 | Browser inner width/height: 1024/697 12:59:22 INFO - PROCESS | 17425 | __metrics 12:59:23 INFO - PROCESS | 17425 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:59:23 INFO - PROCESS | 17425 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:23 ERROR - PROCESS | 17425 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:59:23 INFO - TEST-INFO | 17425: exit 0 12:59:23 INFO - Browser initialized. 12:59:23 INFO - Running cycle 1/1 for v8_7 test... 12:59:23 INFO - TEST-INFO | started process 17508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKD_3dh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:35 INFO - PROCESS | 17508 | RSS: Main: 149692416 12:59:35 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | Cycle 1(1): loaded http://localhost:51769/tests/v8_7/run.html (next: http://localhost:51769/tests/v8_7/run.html) 12:59:57 INFO - PROCESS | 17508 | RSS: Main: 578109440 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | __start_tp_report 12:59:57 INFO - PROCESS | 17508 | _x_x_mozilla_page_load 12:59:57 INFO - PROCESS | 17508 | _x_x_mozilla_page_load_details 12:59:57 INFO - PROCESS | 17508 | |i|pagename|runs| 12:59:57 INFO - PROCESS | 17508 | |0;Richards;167.47613465081227 12:59:57 INFO - PROCESS | 17508 | |1;DeltaBlue;189.000189000189 12:59:57 INFO - PROCESS | 17508 | |2;Encrypt;279.6420581655481 12:59:57 INFO - PROCESS | 17508 | |3;Decrypt;5128.205128205128 12:59:57 INFO - PROCESS | 17508 | |4;RayTrace;1085.7763300760043 12:59:57 INFO - PROCESS | 17508 | |5;Earley;783.2550860719875 12:59:57 INFO - PROCESS | 17508 | |6;Boyer;11764.70588235294 12:59:57 INFO - PROCESS | 17508 | |7;RegExp;25325 12:59:57 INFO - PROCESS | 17508 | |8;Splay;660.2902374670184 12:59:57 INFO - PROCESS | 17508 | |9;NavierStokes;4830.917874396136 12:59:57 INFO - PROCESS | 17508 | __end_tp_report 12:59:57 INFO - PROCESS | 17508 | __startTimestamp1450904397274__endTimestamp 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | ------- Summary: start ------- 12:59:57 INFO - PROCESS | 17508 | Number of tests: 10 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 167.5 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 189.0 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 279.6 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 5128.2 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 1085.8 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#5] Earley Cycles:1 Average:783.26 Median:783.26 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 783.3 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#6] Boyer Cycles:1 Average:11764.71 Median:11764.71 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 11764.7 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#7] RegExp Cycles:1 Average:25325.00 Median:25325.00 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 25325.0 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#8] Splay Cycles:1 Average:660.29 Median:660.29 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 660.3 12:59:57 INFO - PROCESS | 17508 | 12:59:57 INFO - PROCESS | 17508 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:59:57 INFO - PROCESS | 17508 | Values: 4830.9 12:59:57 INFO - PROCESS | 17508 | -------- Summary: end -------- 12:59:57 INFO - PROCESS | 17508 | 12:59:58 INFO - TEST-INFO | 17508: exit 0 12:59:58 INFO - TEST-OK | v8_7 | took 39225ms 12:59:58 INFO - SUITE-END | took 1211s 12:59:58 INFO - Completed test suite (00:20:11) 12:59:58 INFO - Working with test: dromaeo_css 12:59:58 INFO - Generating results file: dromaeo_css 12:59:58 INFO - Working with test: kraken 12:59:58 INFO - Generating results file: kraken 12:59:58 INFO - javascript benchmark 12:59:58 INFO - Working with test: v8_7 12:59:58 INFO - Generating results file: v8_7 12:59:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 12:59:58 INFO - process_Request line: dromaeo_css 6942.01 graph.html#tests=[[72,201,35]] 12:59:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:58 INFO - process_Request line: kraken 1503.30 graph.html#tests=[[232,201,35]] 12:59:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:59:58 INFO - process_Request line: v8_7 21036.80 graph.html#tests=[[230,201,35]] 12:59:58 INFO - RETURN: dromaeo_css: 6942.01 12:59:58 INFO - RETURN: kraken: 1503.30 12:59:58 INFO - RETURN: v8_7: 21036.80 12:59:58 INFO - javascript benchmark 12:59:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3135.2475405902583, 3180.1731549797073, 3231.7253033492166, 3238.4980328049146, 3255.7232635226005, 5144.485551444863, 5284.603654725892, 5328.174133009385, 5365.892682146355, 5416.512513873756, 5239.685618862862, 5273.841784746454, 5287.603429742775, 5328.786848526054, 5339.519443250107, 4843.636727245453, 4881.365422495071, 4904.705717656934, 4916.459189489154, 4955.306257123987, 4938.283948827418, 5000.399952005764, 5006.374203224597, 5007.549320561149, 5033.018561380532, 4765.142274390609, 4768.785404656799, 4883.829065982709, 4922.433920099181, 4929.950700493003, 4900.313956046157, 4909.484504127051, 4948.257761335828, 4958.528939750718, 4961.727105009223, 4901.754912254373, 4908.656394052417, 4920.827771028033, 4933.260010998343, 4966.031623833318, 5081.593472522226, 5104.821331253388, 5184.688918664892, 5221.503957124105, 5288.814891478818, 5728.570357223225, 5733.913991290134, 5745.569082318842, 5800.680962547058, 5819.7090145492975, 5736.827895163152, 5753.165790960287, 5761.971190144064, 5764.827055188351, 5777.59556831022, 5280.392754833205, 5364.624476286623, 5365.382980957162, 5368.489993450616, 5381.67709937405, 5768.653880767168, 5826.271716035496, 5826.708664566755, 5830.621009634445, 5881.911771323434, 5644.491995720405, 5724.255846739898, 5726.513246374022, 5731.914021289684, 5781.768729250867, 5543.057680194296, 5583.3858275589655, 5635.0, 5769.74036168365, 5815.447532484407, 5655.4344565543115, 5677.858053548612, 5710.942890571124, 5711.885762284731, 5760.991826430358, 5735.2257445245195, 5751.4536119068625, 5753.33836608787, 5753.510951569164, 5754.108113242454, 4278.657707383401, 4326.372675961968, 4344.739315641072, 4409.316555933835, 4455.064436468313, 3966.424868394067, 3967.7024223183375, 3992.2414741199077, 3996.5603783583783, 4011.7191796574543, 5329.600279979017, 5330.093884039723, 5338.386085600206, 5347.973260133675, 5393.4336894626285, 5562.694051827108, 5642.294713160855, 5757.65454072757, 5760.0207964646115, 5790.044642633919, 5290.391604965402, 5290.629655924048, 5331.760070796746, 5344.652597581145, 5345.251664766935, 4961.70229786214, 4978.103941290602, 4978.5270399312, 4980.103581355318, 5028.069807085701, 5780.797672081457, 5951.940480595225, 5969.044952807443, 5970.76116955317, 5972.402759723993, 5580.135079062752, 5634.267545219259, 5635.9436405635415, 5638.21065050885, 5667.0, 5931.169636251015, 5944.4352786485215, 5946.613470124428, 5949.375315591974, 5958.851028724316, 5504.862378440571, 5598.664080155204, 5599.1041433370465, 5706.229658996149, 5711.400302968294, 5675.943240567707, 5679.74441150141, 5719.599628026164, 5744.0522313817755, 5783.016887129283, 5622.8313150605545, 5623.943760562342, 5625.0, 5695.202671625892, 5715.142728590745, 5592.580556458363, 5599.160125981135, 5599.272094627672, 5600.467955544217, 5601.859953501195, 5343.091674415281, 5399.055165346127, 5450.5912056595125, 5464.672119672832, 5529.0, 5668.178114173339, 5682.403347648603, 5683.431656834284, 5698.1452782083015, 5735.397783232867, 5510.0, 5555.611107222456, 5557.221988921635, 5558.861028474159, 5563.109902415594], "unit": "score", "name": "dojo.html", "value": 5285.2186814260385}, {"lowerIsBetter": false, "replicates": [553.472416131477, 590.8581940334319, 593.178447849728, 602.6323942395138, 672.4653900149384, 30252.848735756317, 30936.226594335152, 30984.84507577459, 30996.380072398537, 39059.41410878832, 41840.58159418405, 42377.33849276577, 42425.151496970044, 42452.0, 42482.787586062026, 8413.242808147266, 8580.613872375727, 8583.52790596517, 8587.0, 8587.570621468902, 7579.128400233961, 7764.844703105934, 8454.239118479336, 8578.485290882536, 10371.533281002374, 10271.640492582761, 10388.324758890685, 10396.324238924484, 10402.21983351248, 10404.167666586654, 10234.437105959169, 10300.690979270634, 10316.535755890965, 10319.79360412795, 10327.380357178556, 7743.535387876689, 7934.206579342077, 7934.3255823255095, 10060.24548158891, 10326.58693652253, 37120.0, 37405.06487337838, 37427.06432339186, 37470.43794343087, 37586.62413375859, 3326.9833650831592, 3339.482380231068, 3351.8324083795715, 3361.1429085583018, 3467.809270490122, 30876.69123308783, 30906.688604691837, 31052.8447357764, 31537.369252615048, 32201.838990804896, 3749.2314075614436, 3810.961890381116, 3825.5218097737784, 3839.865604703822, 3900.798905038914, 264570.0, 266038.0, 267707.6614616934, 267709.0, 268174.0, 56490.71754641201, 57891.0, 59076.7046164775, 59378.703106484194, 59421.70289148526, 69567.30432695709, 70330.13184274914, 70746.0, 70761.64619176871, 70961.64519177475, 12738.872611273953, 12892.742145157044, 12917.935410323076, 12920.353982300847, 12926.935365323301, 10131.493425328705, 10217.642382516577, 10222.488875556193, 10231.772187337418, 10252.58989640406, 17501.074881762997, 17607.29570817153, 17662.381816636356, 17728.55678608045, 18623.348182813537, 7848.332891704269, 8079.960019990005, 8137.0471086938705, 8167.836643267101, 8199.344052475788, 929.5584597316221, 984.1388784813288, 995.7311525887969, 1027.4913917610832, 1070.1866581398194, 25708.228753137435, 26130.6080408794, 26460.33849153748, 26722.86638566795, 27060.323491912466, 1019.2915923433143, 1087.505185140759, 1116.1740312168936, 1126.6732647532124, 1164.870533957124, 13985.510507132405, 14142.292885355897, 14175.0, 14181.0, 14281.571552853431, 314227.0, 315306.0, 317598.0, 317998.0, 318897.0, 52059.0, 52627.210591841154, 52795.0, 52890.206646900326, 52900.0, 1303.4330066421137, 1319.459021801057, 1328.455333313337, 1363.7477066742683, 1367.8221831161886, 23427.23726150173, 24988.0, 25657.61513577335, 26095.73904261009, 26362.736372636027, 43287.783561082, 43612.0, 43632.345514817935, 43723.34414983714, 43732.34401484044, 249074.0, 251149.0, 251567.0, 252384.0, 252793.0, 27922.860385697943, 33331.0, 33806.154846129044, 33966.83016584901, 34198.82900585481, 40822.79588602038, 41086.178276434905, 41233.58766412298, 42113.15773684448, 42311.7884410576, 34992.30015399729, 35149.47275790916, 35364.115897102776, 35429.46855797217, 36011.45982810312, 35153.47269790904, 35429.46855797217, 35556.28887422289, 36142.27715445729, 36150.819245904655, 34127.73308967049, 34656.133596660286, 35086.29827403489, 35215.82392088023, 35282.0, 30552.388952221274, 31963.680363196072, 32058.519122212718, 32314.83842580772, 32563.83718081489, 24714.258572242863, 24967.500649986534, 25193.244202673948, 25344.746552534238, 25948.0], "unit": "score", "name": "ext.html", "value": 18177.229172189367}, {"lowerIsBetter": false, "replicates": [346.1191268222374, 348.6879243077446, 350.62132896471815, 361.56250936366996, 363.88355726167623, 14255.144691318528, 14624.780628290584, 16387.918060409695, 16723.916380418097, 17373.478795636118, 16243.593910152253, 16288.674226515463, 16375.83624163761, 16731.749023764653, 16748.748768768477, 5499.450054994499, 5602.803901863435, 5655.179998900157, 5656.773729050833, 5659.405762394951, 4072.165206132736, 4188.267053265681, 5532.585056120787, 5981.342052374235, 6162.568620196588, 5908.763649454017, 6045.7883974060915, 6072.483838873701, 6103.755849766004, 6106.542009349294, 6081.391860813927, 6114.510839132859, 6118.479929205978, 6119.265688117454, 6128.0, 5289.735513224362, 5354.411014788409, 5358.812441564565, 5362.678239305654, 5392.137258038734, 20564.58870822575, 20673.896630516752, 20808.791912080836, 21046.894765526074, 21061.052252648515, 2170.5007848195005, 2218.911243550256, 2235.5528894221056, 2243.371855880356, 2492.850428974249, 13385.86614133856, 13433.261170635611, 13448.462061517528, 13558.525451609245, 13573.728525429535, 1878.19237727777, 1890.4706682129026, 1891.073374046721, 1896.5732710140246, 1919.3570153998428, 56451.0, 58458.0, 59733.0, 60043.0, 60956.0, 9426.293028022927, 9443.244540436748, 9483.241340692728, 9488.051194880456, 9493.572789224501, 12190.81713774294, 12244.938775306244, 12265.754684906253, 12266.0, 12285.938570307091, 6572.769953051716, 6721.26066132725, 6852.965735171292, 6880.380765731008, 6945.652717364112, 6265.749370025239, 6703.262641109474, 6786.694598743068, 6842.384185423336, 6856.657167141623, 5293.179557168645, 5801.332846722681, 5812.738426770806, 5887.793927212527, 5896.439838215363, 1670.0647637323138, 1732.870034747399, 1790.1049475262369, 1794.4526919289742, 1805.1966874740615, 932.4125800745622, 947.6162154327509, 991.6876184002016, 997.9614207558044, 1037.305005646219, 15181.772273415907, 17048.744268835977, 17224.741628875578, 17554.210060547306, 18011.819881801275, 914.3608438415145, 965.5220665770488, 966.2752935298527, 998.5706146356991, 1013.4780587997187, 10283.331583447052, 10359.0, 10423.791524169474, 10435.739106522398, 10469.528871200815, 379885.0, 383486.0, 386587.0, 389849.0, 511588.0, 66107.33892661011, 66300.6684966572, 68388.97416538755, 80031.0, 85169.0, 1102.8566286382718, 1134.053065690158, 1136.323887287063, 1136.8237923121928, 1159.4087015621924, 15510.534683959499, 15633.374665013727, 15881.444149454714, 15899.443519476763, 15981.200939953189, 32917.67082329146, 34633.307333853685, 35034.82482587571, 35475.467867982516, 35655.0, 39614.40578391384, 39725.60274397219, 40943.18113637651, 41224.587754122076, 41317.58682413137, 9160.862587061067, 9164.95417522908, 9188.770280742767, 9210.355275130945, 9221.262299015929, 16384.836151638807, 16824.242909068875, 16890.493285201464, 17244.655106898044, 17472.388466403616, 14116.647083822987, 14635.0, 14757.188354640597, 15085.47200847965, 15201.391944322104, 13792.0, 14273.357698903366, 14429.0, 14463.638409039859, 14961.625959351104, 15272.465463708717, 15347.309371078552, 15486.5354039379, 15610.9219453902, 15665.765013524579, 9303.116203960613, 9354.71935841926, 9418.623255069995, 9454.810903782023, 9471.715848524555, 10164.390136591828, 10829.350238985686, 14779.92610036943, 15148.697026059637, 15241.847581524044], "unit": "score", "name": "jquery.html", "value": 8924.119267846567}, {"lowerIsBetter": false, "replicates": [1369.7604416778563, 1718.974215386769, 1762.2774662388415, 1790.5165605286572, 1817.0369704056855, 6324.58890172139, 7238.0, 7385.0, 7393.112826460819, 7398.482106252564, 7285.817854553638, 7507.624618769067, 7519.248075192478, 7523.360514356286, 7529.209433009537, 1960.1571324330532, 1992.6014797040577, 1996.0, 2224.410531209227, 2254.1884921428273, 2023.271622216001, 2184.060853832851, 2233.396982814639, 2248.201888329644, 2249.876256805875, 2210.4473881529616, 2229.7881701238357, 2234.2850287907877, 2298.3449716830705, 2302.930912072632, 2235.7764223577674, 2245.4049676835652, 2265.1732117777055, 2265.592193405186, 2275.6131457652154, 2233.352327824929, 2244.730632324115, 2252.0653928619604, 2253.6394176931612, 2255.3459496745922, 7466.2160473150625, 7490.85018299631, 7509.211532789088, 7511.023566936318, 7516.7369142080315, 4529.04889973106, 4545.159145558082, 4586.4266966629175, 4609.930851037204, 4616.845788552861, 3005.4289684959786, 3022.607061082067, 3076.9384612307854, 3087.598612180402, 3116.236522052112, 962.9422234665942, 981.3474039763548, 1007.5113569918584, 1013.4932533733133, 1022.5756311130872, 10240.692779216635, 10265.948670256676, 10274.075333219971, 10277.948610256975, 10283.331583447052, 4164.104717485695, 4208.537060923296, 4219.683523735671, 4246.745195288293, 4277.251480990814, 8928.375013749104, 8930.642774289086, 8933.062028487046, 8936.151065648754, 8937.910620893837, 4656.85906952792, 4662.254039353687, 4670.78981445829, 4678.719276843401, 4690.179218636793, 4232.851850185229, 4267.914641707211, 4269.765162916069, 4269.935950960738, 4271.722338048017, 3082.553029810665, 3123.859426325821, 3559.6796288333658, 3600.6039335673054, 3620.637936206358, 1154.1343992005995, 1154.9480273387549, 1160.4081918221598, 1168.4333098447246, 1181.8345431639577, 945.7588314979636, 947.7677968897664, 982.1651596143221, 1043.5356266461504, 1352.939117739704, 7145.928540714526, 7186.964065179641, 7210.206877243499, 7215.530990485601, 7215.639218039077, 1122.9209723452514, 1130.9151813614012, 1146.6158836789602, 1149.3793351590048, 1180.557291015869, 5670.744816483269, 5718.771249149988, 5725.828225153252, 5728.05487094633, 5732.226149469851, 8657.653693852302, 8697.434666746642, 8745.562721863882, 8782.91217087821, 8783.077776833468, 8669.869951950726, 8748.0, 8772.078931712205, 8786.692465763668, 8787.121287871161, 6911.768376388369, 7105.92894071063, 7106.5736055836815, 7111.751088711871, 7183.748568800067, 7186.029885965328, 7243.855122897618, 7245.818854528679, 7258.165310989304, 7265.382442492236, 7748.535087894745, 7999.84000320002, 8203.671853125808, 8204.138565450781, 8221.958890205511, 8193.303569196447, 8304.626291816761, 8327.292180164754, 8332.50004999702, 8333.208345207195, 6706.865862682816, 6893.586384816927, 6903.1716194057035, 6910.0, 6929.5842249465195, 6487.870242595216, 6780.627065511444, 6966.12923384577, 7287.0, 7365.373943214887, 6216.347283535164, 6251.718672659832, 6312.337204593635, 6344.429001389897, 6352.745890164527, 6630.569013014138, 6663.900041499478, 6718.529702920749, 6723.361280678328, 6750.493712971645, 6425.935740642533, 6694.430973367318, 6695.4978376620975, 6715.4627629790475, 6718.798436046926, 6277.623342599459, 6311.905321420274, 6312.7159277833525, 6314.905276420949, 6329.050642403677, 6291.811245662638, 6335.303116657072, 6363.077353783583, 6375.330590287953, 6376.202974628171], "unit": "score", "name": "mootools.html", "value": 4361.401603231945}, {"lowerIsBetter": false, "replicates": [336.28539353873015, 338.4939515424441, 338.87461639193504, 347.2811280649056, 348.24952227948773, 5945.554083443737, 5960.61256018359, 5988.640681559099, 5997.490213331861, 6020.187274717911, 5618.719064046792, 5739.885202295952, 5791.349465402362, 5876.11858221267, 5920.378360272174, 4550.590446859782, 4568.2462393705, 4574.6340292776495, 4578.084383123389, 4582.08358328334, 4367.475902891658, 4579.129965306598, 4581.244094724367, 4582.1064892346, 4594.977025114869, 4401.2517871961845, 4402.625776808975, 4505.098980203972, 4512.1426928883575, 4533.705309154894, 4508.075844451912, 4528.796204170821, 4531.43357080365, 4532.13889361022, 4539.341795439643, 4008.719389642726, 4009.8797036088963, 4011.0373510357304, 4011.1376054148204, 4014.0566966762785, 5544.251526044013, 5656.208130861683, 5658.603897727161, 5667.263255776723, 5668.858278543028, 5340.813071542516, 5344.0, 5348.545373643245, 5354.196870469422, 5364.839054828361, 6278.30938596754, 6280.15217945576, 6282.591631543935, 6291.465225455841, 6293.590916590407, 4477.059817438342, 4478.4178056852725, 4480.507144214133, 4482.21561226784, 4487.775611219426, 6347.746090156388, 6544.70548825304, 6576.210854697467, 6577.6711164441585, 6584.539082264291, 4417.072414792865, 4421.712588681726, 4424.0, 4428.402165707653, 4432.601065904019, 4489.281714925596, 4493.236149854532, 4493.258612328995, 4495.64034877209, 4497.0, 5225.085610018232, 5226.608004399685, 5233.581313494988, 5242.135047717084, 5245.587029966258, 6146.416090471398, 6284.622922624657, 6291.937080629226, 6301.6534090625455, 6340.651264180515, 1556.494139404698, 1569.3487202810934, 1569.803774528184, 1570.5288413475912, 1573.3156077106496, 1046.5029111172132, 1070.0690399352613, 1075.4945175767377, 1091.2034215022918, 1092.3118435385657, 5967.403259674084, 5973.820785376446, 5985.311689155716, 5986.132010858489, 5986.952283350396, 6466.288708242089, 6495.6752162391695, 6507.12153859223, 6507.8698426031215, 6513.088167656532, 5796.594238403271, 5856.0, 5946.137810017523, 5974.1934838796205, 5980.43185897339, 3512.051746028558, 3527.100589349751, 3536.8231588420476, 3540.9822950885596, 3543.3976224041976, 6773.9322606774285, 6785.457163426914, 6792.728290868409, 6792.76225332111, 6800.65996700163, 6557.606543607399, 6574.737010519526, 6666.96666516674, 6696.497762667819, 6702.195736511552, 6690.698918548677, 6697.430718388991, 6706.362895524917, 6710.83222919431, 6716.328367163343, 6520.576162549419, 6521.0, 6535.509836762357, 6538.574992625464, 6539.967300163468, 6357.427831495188, 6453.354664533696, 6496.058071579689, 6497.350264973654, 6502.707378167899, 6770.86458270822, 6784.3894049535775, 6790.456763458813, 6794.3545363190415, 6798.320167983162, 4526.479454862733, 4526.705764125321, 4526.728396296233, 4529.501754806903, 4530.592246697813, 6427.614343139427, 6574.605523668595, 6580.967095164494, 6582.605043697394, 6585.604863708193, 6392.808215753535, 6400.615963042233, 6401.0, 6401.071844582602, 6406.327335629691, 6360.904586431115, 6379.6810159490915, 6384.808455746335, 6389.520785941166, 6394.808155755335, 6081.5742897996715, 6263.404976527223, 6274.372562743689, 6275.497960163085, 6278.529110316653, 6428.935710642833, 6430.614163150226, 6440.581362211441, 6441.967790161019, 6447.806565803034, 6248.250209974832, 6286.717097730521, 6295.087212354275, 6299.96850015747, 6301.6219026858535], "unit": "score", "name": "prototype.html", "value": 4767.560789014216}, {"lowerIsBetter": false, "replicates": [790.7153424767084, 810.6838333050115, 836.7071524966267, 837.058309401923, 860.384824850232, 13752.793708094374, 13921.860781392183, 13949.511767088154, 13988.720225595482, 14001.859981400183, 15070.47253346133, 15223.467178648749, 15227.314770835312, 15263.6947261055, 15292.082475051477, 694.1669996004814, 845.9280961118297, 857.4083882121347, 857.5626430520417, 857.7169534053778, 700.1528150937372, 837.7654256808073, 853.5774791478196, 853.8036251662121, 853.87191921212, 874.5277550122958, 885.4908427654093, 887.7070566712969, 889.0709208876739, 889.8709687095368, 721.9927800722004, 728.6101935464554, 879.3404946290283, 885.4642941020686, 885.5572213893054, 644.1175589442494, 649.3668673043792, 649.860280039789, 650.9804705858832, 651.5439192565176, 13614.591562253148, 13759.0, 13761.793573096411, 13767.0, 13767.449302027906, 12425.689357766038, 13006.934965325207, 13096.672583185402, 13098.47606095755, 13563.660908477268, 9904.108630223242, 9991.700248992542, 10141.290109692325, 10148.746281342952, 10525.421101839396, 3555.3600351936643, 3607.639236076371, 3630.9273814523826, 3631.891043268706, 3746.250749850041, 46330.53669463296, 47414.0, 47952.7602361986, 48229.0, 48241.27638085432, 9653.986331435099, 9693.854592181124, 9751.756206094762, 9776.51117444125, 9834.655787047563, 18974.0, 19016.0, 19016.0, 19024.0, 19051.428457146307, 7500.774976750707, 7526.811829704301, 7610.124835643972, 7731.922680773233, 7847.686092556234, 4015.6988225883174, 4190.937135942963, 4226.830926762895, 4252.510961239435, 4292.635126014324, 2945.2047947054175, 2985.11938978002, 2989.417063672563, 2994.4160888626943, 2995.8352290624225, 540.0522083743006, 548.7942021741846, 550.1884720037992, 562.6511562830989, 564.497597138547, 507.713142074734, 595.92733080455, 626.317314127594, 661.4377778887907, 663.2571519897649, 7742.4580279381025, 8102.432829701982, 8442.957785211034, 9443.952780236055, 9543.188828949616, 521.452474901352, 551.4265164229237, 560.6467925207094, 579.875326804739, 645.4062262718311, 3943.191645712622, 3950.3876899080688, 4072.9796351018053, 4188.623023927861, 4235.470566179228, 53466.0, 53698.73150634222, 53988.730056349465, 54143.72928135334, 54215.45784542183, 48294.517054829004, 48603.75698121558, 48635.27047094297, 48958.0, 49143.0, 45952.08095838065, 47821.5217847824, 47953.76023119862, 48051.75974120107, 48400.5159948403, 8354.45696029756, 8549.444286121383, 8782.209601135928, 8884.0, 9009.549522523717, 34121.65878341185, 34418.311633767684, 34793.0, 35275.470867936485, 35816.82091589525, 40390.19219615532, 42132.78933605312, 43468.347974781034, 43535.34696979611, 44184.33723494086, 10638.468076596295, 10846.783064338826, 10902.727431813952, 10962.671119866416, 11420.428978551205, 11475.081993440672, 11519.07847372225, 12050.0, 12481.812772808233, 12858.228506289652, 10239.692809215736, 10291.794164116525, 10297.279190456897, 10313.329633573794, 11258.21192516516, 10793.568257269935, 11105.500252488497, 11573.363465009505, 11604.245724027911, 11668.299902005907, 7166.4073497813715, 10933.45332733376, 10973.890261097287, 11006.174536909924, 11411.372374519482, 9637.42175469474, 9639.951800240953, 9805.0, 9971.903090660167, 10146.461709730462, 8964.238039766433, 9099.7270081895, 9582.760430989281, 9716.611335546782, 10063.496825158567], "unit": "score", "name": "yui.html", "value": 6277.621983670761}], "name": "dromaeo_css", "value": 6942.013429469566}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 110.0, 111.0, 99.0, 110.0, 110.0, 118.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 145.0, 160.0, 128.0, 151.0, 151.0, 133.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [159.0, 166.0, 160.0, 161.0, 160.0, 162.0, 159.0, 162.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 81.0, 93.0, 70.0, 77.0, 72.0, 126.0, 98.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 138.0, 93.0, 94.0, 94.0, 136.0, 93.0, 92.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 66.0, 57.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 84.0, 85.0, 85.0, 93.0, 84.0, 85.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [114.0, 136.0, 121.0, 120.0, 122.0, 123.0, 126.0, 124.0, 117.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 150.0, 151.0, 144.0, 139.0, 151.0, 152.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1503.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [783.2550860719875], "unit": "score", "name": "Earley", "value": 850.8888251748249}, {"lowerIsBetter": false, "replicates": [11764.70588235294], "unit": "score", "name": "Boyer", "value": 56.64935499999997}, {"lowerIsBetter": false, "replicates": [25325.0], "unit": "score", "name": "RegExp", "value": 35.97176702862781}, {"lowerIsBetter": false, "replicates": [660.2902374670184], "unit": "score", "name": "Splay", "value": 123.41693906093904}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21036.803931078673}]} 12:59:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21036.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1503.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6942.01"}}} 12:59:58 INFO - Return code: 0 12:59:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:59:58 ERROR - # TBPL SUCCESS # 12:59:58 INFO - Running post-action listener: _resource_record_post_action 12:59:58 INFO - Running post-run listener: _resource_record_post_run 12:59:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 200704; Write bytes: 546594816; Read time: 820; Write time: 412084 12:59:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235446272; Read time: 0; Write time: 246544 12:59:59 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 200704; Write bytes: 311148544; Read time: 820; Write time: 165540 12:59:59 INFO - Running post-run listener: _upload_blobber_files 12:59:59 INFO - Blob upload gear active. 12:59:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:59:59 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 12:59:59 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 12:59:59 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:00:00 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:00 INFO - (blobuploader) - INFO - Done attempting. 13:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:06 INFO - (blobuploader) - INFO - Done attempting. 13:00:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:06 INFO - Return code: 0 13:00:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:00:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/742654baa2224e1a648766ada49a87193b6c1ec254212c8605461fb91b685782552089af39acaf5cb8306429241ab69409a9b78d82332a30a6b053cd838da8dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/94fe9e1fc23a0b751e2c2f30124c27b47daebc793c062bedbe18f2586e29059c2ac040bf08905c6c860425043ff89948b5066695a569ee706b64f6ee0252ff96"} 13:00:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:00:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:00:06 INFO - Contents: 13:00:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/742654baa2224e1a648766ada49a87193b6c1ec254212c8605461fb91b685782552089af39acaf5cb8306429241ab69409a9b78d82332a30a6b053cd838da8dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/94fe9e1fc23a0b751e2c2f30124c27b47daebc793c062bedbe18f2586e29059c2ac040bf08905c6c860425043ff89948b5066695a569ee706b64f6ee0252ff96"} 13:00:06 INFO - Copying logs to upload dir... 13:00:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.836711 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-23 13:00:05.311087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 13:00:05.314782) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/742654baa2224e1a648766ada49a87193b6c1ec254212c8605461fb91b685782552089af39acaf5cb8306429241ab69409a9b78d82332a30a6b053cd838da8dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/94fe9e1fc23a0b751e2c2f30124c27b47daebc793c062bedbe18f2586e29059c2ac040bf08905c6c860425043ff89948b5066695a569ee706b64f6ee0252ff96"} build_url:https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011561 build_url: 'https://queue.taskcluster.net/v1/task/3P_gLqmoRhuclabXXhb4RQ/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/B2G-Inbound/sha512/742654baa2224e1a648766ada49a87193b6c1ec254212c8605461fb91b685782552089af39acaf5cb8306429241ab69409a9b78d82332a30a6b053cd838da8dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/94fe9e1fc23a0b751e2c2f30124c27b47daebc793c062bedbe18f2586e29059c2ac040bf08905c6c860425043ff89948b5066695a569ee706b64f6ee0252ff96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 13:00:05.340014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 13:00:05.340386) ========= 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=3e14eba40af1795cf0357910000001c3-1450903132.942370-79680858 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 13:00:05.424196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 13:00:05.424601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 13:00:05.425066) ========= ========= Total master_lag: 0.18 =========