builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1451491132.34 results: success (0) buildid: 20151230053005 builduid: c7bf2b0130124ab79f1d4ca425ddc312 revision: d627f895e22602d801fdae9b5172978d1cb04165 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.335410) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.335886) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.336180) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006424 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.360122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.360461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.377950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.378214) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.427155) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.427472) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.427845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.428132) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 07:58:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-30 07:58:53 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.598677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.599004) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:52.651448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-30 07:58:52.651814) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d627f895e22602d801fdae9b5172978d1cb04165 --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 d627f895e22602d801fdae9b5172978d1cb04165 --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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 07:58:53,181 truncating revision to first 12 chars 2015-12-30 07:58:53,181 Setting DEBUG logging. 2015-12-30 07:58:53,181 attempt 1/10 2015-12-30 07:58:53,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d627f895e226?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 07:58:54,069 unpacking tar archive at: b2g-inbound-d627f895e226/testing/mozharness/ program finished with exit code 0 elapsedTime=1.177669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-30 07:58:53.842498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:53.842808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:53.851137) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:53.851542) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 07:58:53.852122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-30 07:58:53.852420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --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', '--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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:58:54 INFO - MultiFileLogger online at 20151230 07:58:54 in /builds/slave/test-pgo 07:58:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:58:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:58:54 INFO - {'append_to_log': False, 07:58:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:58:54 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:58:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:58:54 INFO - 'branch': 'B2G-Inbound', 07:58:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:54 INFO - 'config_files': ('talos/linux_config.py',), 07:58:54 INFO - 'default_actions': ('clobber', 07:58:54 INFO - 'read-buildbot-config', 07:58:54 INFO - 'download-and-extract', 07:58:54 INFO - 'populate-webroot', 07:58:54 INFO - 'create-virtualenv', 07:58:54 INFO - 'install', 07:58:54 INFO - 'run-tests'), 07:58:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:54 INFO - 'download_minidump_stackwalk': True, 07:58:54 INFO - 'download_symbols': 'ondemand', 07:58:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:58:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:58:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:58:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:58:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:54 INFO - 'installer_path': 'installer.exe', 07:58:54 INFO - 'log_level': 'info', 07:58:54 INFO - 'log_name': 'talos', 07:58:54 INFO - 'log_to_console': True, 07:58:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:58:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:58:54 INFO - 'opt_config_files': (), 07:58:54 INFO - 'pip_index': False, 07:58:54 INFO - 'sps_profile': False, 07:58:54 INFO - 'sps_profile_interval': 0, 07:58:54 INFO - 'suite': 'dromaeojs', 07:58:54 INFO - 'system_bits': '32', 07:58:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:54 INFO - 'title': 'talos-linux64-ix-064', 07:58:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:54 INFO - 'use_talos_json': True, 07:58:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:58:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:54 INFO - 'work_dir': 'build'} 07:58:54 INFO - ##### 07:58:54 INFO - ##### Running clobber step. 07:58:54 INFO - ##### 07:58:54 INFO - Running pre-action listener: _resource_record_pre_action 07:58:54 INFO - Running main action method: clobber 07:58:54 INFO - rmtree: /builds/slave/test-pgo/build 07:58:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:58:55 INFO - Running post-action listener: _resource_record_post_action 07:58:55 INFO - ##### 07:58:55 INFO - ##### Running read-buildbot-config step. 07:58:55 INFO - ##### 07:58:55 INFO - Running pre-action listener: _resource_record_pre_action 07:58:55 INFO - Running main action method: read_buildbot_config 07:58:55 INFO - Using buildbot properties: 07:58:55 INFO - { 07:58:55 INFO - "project": "", 07:58:55 INFO - "product": "firefox", 07:58:55 INFO - "script_repo_revision": "production", 07:58:55 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:58:55 INFO - "repository": "", 07:58:55 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:58:55 INFO - "buildid": "20151230053005", 07:58:55 INFO - "pgo_build": "True", 07:58:55 INFO - "basedir": "/builds/slave/test-pgo", 07:58:55 INFO - "buildnumber": 5, 07:58:55 INFO - "slavename": "talos-linux64-ix-064", 07:58:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:58:55 INFO - "platform": "ubuntu64_hw", 07:58:55 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:58:55 INFO - "branch": "b2g-inbound", 07:58:55 INFO - "repo_path": "integration/b2g-inbound", 07:58:55 INFO - "revision": "d627f895e22602d801fdae9b5172978d1cb04165", 07:58:55 INFO - "stage_platform": "linux64-pgo", 07:58:55 INFO - "builduid": "c7bf2b0130124ab79f1d4ca425ddc312", 07:58:55 INFO - "slavebuilddir": "test" 07:58:55 INFO - } 07:58:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:58:55 INFO - Running post-action listener: _resource_record_post_action 07:58:55 INFO - ##### 07:58:55 INFO - ##### Running download-and-extract step. 07:58:55 INFO - ##### 07:58:55 INFO - Running pre-action listener: _resource_record_pre_action 07:58:55 INFO - Running main action method: download_and_extract 07:58:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:55 INFO - https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:58:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/test_packages.json 07:58:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/test_packages.json 07:58:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:58:57 INFO - Downloaded 1302 bytes. 07:58:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:58:57 INFO - Using the following test package requirements: 07:58:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:58:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'jsshell-linux-x86_64.zip'], 07:58:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:58:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:58:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:58:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:58:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:58:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:57 INFO - https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:58:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:58:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:58:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:58:59 INFO - Downloaded 23202477 bytes. 07:58:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:58:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:58:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:59:00 INFO - Return code: 0 07:59:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:00 INFO - https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:59:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:59:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:59:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:59:03 INFO - Downloaded 23202477 bytes. 07:59:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:59:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:59:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:59:05 INFO - Return code: 0 07:59: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')]} 07:59:05 INFO - https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:59:06 INFO - Downloaded 11132285 bytes. 07:59:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:59:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:59:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:59:06 INFO - Return code: 0 07:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:06 INFO - https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:59:07 INFO - Downloaded 54944899 bytes. 07:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:59:07 INFO - mkdir: /builds/slave/test-pgo/properties 07:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:59:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:59:07 INFO - Contents: 07:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:59:07 INFO - Running post-action listener: _resource_record_post_action 07:59:07 INFO - Running post-action listener: set_extra_try_arguments 07:59:07 INFO - ##### 07:59:07 INFO - ##### Running populate-webroot step. 07:59:07 INFO - ##### 07:59:07 INFO - Running pre-action listener: _resource_record_pre_action 07:59:07 INFO - Running main action method: populate_webroot 07:59:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:59:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:59:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:59:07 INFO - '--tppagecycles', 07:59:07 INFO - '7'], 07:59:07 INFO - 'tests': ['tsvgm']}}, 07:59:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:59:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:59:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:59:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:59:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'tests': ['damp', 'tps']}, 07:59:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['damp', 'tps']}, 07:59:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:59:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:07 INFO - 'other': {'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'other_l64': {'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'other_nol64': {'tests': ['a11yr', 07:59:07 INFO - 'ts_paint', 07:59:07 INFO - 'tpaint', 07:59:07 INFO - 'sessionrestore', 07:59:07 INFO - 'sessionrestore_no_auto_restore']}, 07:59:07 INFO - 'svgr': {'tests': ['tsvgx', 07:59:07 INFO - 'tsvgr_opacity', 07:59:07 INFO - 'tart', 07:59:07 INFO - 'tscrollx', 07:59:07 INFO - 'cart']}, 07:59:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['tsvgx', 07:59:07 INFO - 'tsvgr_opacity', 07:59:07 INFO - 'tart', 07:59:07 INFO - 'tscrollx', 07:59:07 INFO - 'cart']}, 07:59:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'tests': ['tp5o']}, 07:59:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'talos_options': ['--e10s'], 07:59:07 INFO - 'tests': ['tp5o']}, 07:59:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'talos_options': ['--xperf_path', 07:59:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:07 INFO - 'tests': ['tp5n']}, 07:59:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:59:07 INFO - 'talos_options': ['--e10s', 07:59:07 INFO - '--xperf_path', 07:59:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:07 INFO - 'tests': ['tp5n']}}, 07:59:07 INFO - 'talos.zip': {'path': '', 07:59:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:59:07 INFO - Running post-action listener: _resource_record_post_action 07:59:07 INFO - ##### 07:59:07 INFO - ##### Running create-virtualenv step. 07:59:07 INFO - ##### 07:59:07 INFO - Running pre-action listener: _resource_record_pre_action 07:59:07 INFO - Running main action method: create_virtualenv 07:59:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:59:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:59:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:59:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:07 INFO - Using real prefix '/usr' 07:59:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:59:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:10 INFO - Installing pip.................done. 07:59:10 INFO - Return code: 0 07:59:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:10 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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:59:10 INFO - Using env: {'DISPLAY': ':0', 07:59:10 INFO - 'HOME': '/home/cltbld', 07:59:10 INFO - 'LANG': 'en_US.UTF-8', 07:59:10 INFO - 'LANGUAGE': 'en_US:en', 07:59:10 INFO - 'LOGNAME': 'cltbld', 07:59:10 INFO - 'MAIL': '/var/mail/cltbld', 07:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:10 INFO - 'MOZ_NO_REMOTE': '1', 07:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:10 INFO - 'NO_EM_RESTART': '1', 07:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:10 INFO - 'SHELL': '/bin/bash', 07:59:10 INFO - 'SHLVL': '1', 07:59:10 INFO - 'TERM': 'linux', 07:59:10 INFO - 'TMOUT': '86400', 07:59:10 INFO - 'USER': 'cltbld', 07:59:10 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:10 INFO - '_': '/tools/buildbot/bin/python'} 07:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:59:10 INFO - Cleaning up... 07:59:10 INFO - Return code: 0 07:59:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:10 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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:59:10 INFO - Using env: {'DISPLAY': ':0', 07:59:10 INFO - 'HOME': '/home/cltbld', 07:59:10 INFO - 'LANG': 'en_US.UTF-8', 07:59:10 INFO - 'LANGUAGE': 'en_US:en', 07:59:10 INFO - 'LOGNAME': 'cltbld', 07:59:10 INFO - 'MAIL': '/var/mail/cltbld', 07:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:10 INFO - 'MOZ_NO_REMOTE': '1', 07:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:10 INFO - 'NO_EM_RESTART': '1', 07:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:10 INFO - 'SHELL': '/bin/bash', 07:59:10 INFO - 'SHLVL': '1', 07:59:10 INFO - 'TERM': 'linux', 07:59:10 INFO - 'TMOUT': '86400', 07:59:10 INFO - 'USER': 'cltbld', 07:59:10 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:10 INFO - '_': '/tools/buildbot/bin/python'} 07:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:10 INFO - Downloading/unpacking psutil>=0.7.1 07:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:59:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:59:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:12 INFO - Installing collected packages: psutil 07:59:12 INFO - Running setup.py install for psutil 07:59:12 INFO - building 'psutil._psutil_linux' extension 07:59:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:59:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:59:12 INFO - building 'psutil._psutil_posix' extension 07:59:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:59:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:59:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:12 INFO - Successfully installed psutil 07:59:12 INFO - Cleaning up... 07:59:12 INFO - Return code: 0 07:59:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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', '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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:59: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 mozsystemmonitor==0.0.0 07:59:13 INFO - Using env: {'DISPLAY': ':0', 07:59:13 INFO - 'HOME': '/home/cltbld', 07:59:13 INFO - 'LANG': 'en_US.UTF-8', 07:59:13 INFO - 'LANGUAGE': 'en_US:en', 07:59:13 INFO - 'LOGNAME': 'cltbld', 07:59:13 INFO - 'MAIL': '/var/mail/cltbld', 07:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:13 INFO - 'MOZ_NO_REMOTE': '1', 07:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:13 INFO - 'NO_EM_RESTART': '1', 07:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:13 INFO - 'SHELL': '/bin/bash', 07:59:13 INFO - 'SHLVL': '1', 07:59:13 INFO - 'TERM': 'linux', 07:59:13 INFO - 'TMOUT': '86400', 07:59:13 INFO - 'USER': 'cltbld', 07:59:13 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:13 INFO - '_': '/tools/buildbot/bin/python'} 07:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:59:14 INFO - Installing collected packages: mozsystemmonitor 07:59:14 INFO - Running setup.py install for mozsystemmonitor 07:59:15 INFO - Successfully installed mozsystemmonitor 07:59:15 INFO - Cleaning up... 07:59:15 INFO - Return code: 0 07:59:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:15 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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:59:15 INFO - Using env: {'DISPLAY': ':0', 07:59:15 INFO - 'HOME': '/home/cltbld', 07:59:15 INFO - 'LANG': 'en_US.UTF-8', 07:59:15 INFO - 'LANGUAGE': 'en_US:en', 07:59:15 INFO - 'LOGNAME': 'cltbld', 07:59:15 INFO - 'MAIL': '/var/mail/cltbld', 07:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:15 INFO - 'MOZ_NO_REMOTE': '1', 07:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:15 INFO - 'NO_EM_RESTART': '1', 07:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:15 INFO - 'SHELL': '/bin/bash', 07:59:15 INFO - 'SHLVL': '1', 07:59:15 INFO - 'TERM': 'linux', 07:59:15 INFO - 'TMOUT': '86400', 07:59:15 INFO - 'USER': 'cltbld', 07:59:15 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:15 INFO - '_': '/tools/buildbot/bin/python'} 07:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59: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 07:59:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:59:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:17 INFO - Downloading docopt-0.6.1.tar.gz 07:59:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:59:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:17 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:17 INFO - Running setup.py install for blobuploader 07:59:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:59:17 INFO - Running setup.py install for requests 07:59:18 INFO - Running setup.py install for docopt 07:59:18 INFO - Successfully installed blobuploader requests docopt 07:59:18 INFO - Cleaning up... 07:59:18 INFO - Return code: 0 07:59:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:18 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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:59:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:18 INFO - Using env: {'DISPLAY': ':0', 07:59:18 INFO - 'HOME': '/home/cltbld', 07:59:18 INFO - 'LANG': 'en_US.UTF-8', 07:59:18 INFO - 'LANGUAGE': 'en_US:en', 07:59:18 INFO - 'LOGNAME': 'cltbld', 07:59:18 INFO - 'MAIL': '/var/mail/cltbld', 07:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:18 INFO - 'MOZ_NO_REMOTE': '1', 07:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:18 INFO - 'NO_EM_RESTART': '1', 07:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:18 INFO - 'SHELL': '/bin/bash', 07:59:18 INFO - 'SHLVL': '1', 07:59:18 INFO - 'TERM': 'linux', 07:59:18 INFO - 'TMOUT': '86400', 07:59:18 INFO - 'USER': 'cltbld', 07:59:18 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:18 INFO - '_': '/tools/buildbot/bin/python'} 07:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:59:18 INFO - Running setup.py (path:/tmp/pip-wiPX5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:59:18 INFO - Running setup.py (path:/tmp/pip-Fo5w4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:59:18 INFO - Running setup.py (path:/tmp/pip-g3WN3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:59:18 INFO - Running setup.py (path:/tmp/pip-MCvEN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:59:18 INFO - Running setup.py (path:/tmp/pip-qpS51W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:59:18 INFO - Running setup.py (path:/tmp/pip-5CtMeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:59:18 INFO - Running setup.py (path:/tmp/pip-oWhtDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:59:19 INFO - Running setup.py (path:/tmp/pip-0Tand8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:59:19 INFO - Running setup.py (path:/tmp/pip-vyAtGb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:59:19 INFO - Running setup.py (path:/tmp/pip-Gp8V40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:59:19 INFO - Running setup.py (path:/tmp/pip-4KZ_3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:59:19 INFO - Running setup.py (path:/tmp/pip-MAgX8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:59:19 INFO - Running setup.py (path:/tmp/pip-FijsNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:59:19 INFO - Running setup.py (path:/tmp/pip-0SetE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:59:19 INFO - Running setup.py (path:/tmp/pip-KrL2FP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:59:19 INFO - Running setup.py (path:/tmp/pip-AXI1Cr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:59:19 INFO - Running setup.py (path:/tmp/pip-OWo161-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:59:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:19 INFO - Running setup.py install for manifestparser 07:59:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:59:19 INFO - Running setup.py install for mozcrash 07:59:19 INFO - Running setup.py install for mozdebug 07:59:20 INFO - Running setup.py install for mozdevice 07:59:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for mozfile 07:59:20 INFO - Running setup.py install for mozhttpd 07:59:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for mozinfo 07:59:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for mozInstall 07:59:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for mozleak 07:59:20 INFO - Running setup.py install for mozlog 07:59:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for moznetwork 07:59:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:59:20 INFO - Running setup.py install for mozprocess 07:59:21 INFO - Running setup.py install for mozprofile 07:59:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:59:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:59:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:59:21 INFO - Running setup.py install for mozrunner 07:59:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:59:21 INFO - Running setup.py install for mozscreenshot 07:59:21 INFO - Running setup.py install for moztest 07:59:21 INFO - Running setup.py install for mozversion 07:59:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:59:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:21 INFO - Cleaning up... 07:59:21 INFO - Return code: 0 07:59:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:21 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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:21 INFO - Using env: {'DISPLAY': ':0', 07:59:21 INFO - 'HOME': '/home/cltbld', 07:59:21 INFO - 'LANG': 'en_US.UTF-8', 07:59:21 INFO - 'LANGUAGE': 'en_US:en', 07:59:21 INFO - 'LOGNAME': 'cltbld', 07:59:21 INFO - 'MAIL': '/var/mail/cltbld', 07:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:21 INFO - 'MOZ_NO_REMOTE': '1', 07:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:21 INFO - 'NO_EM_RESTART': '1', 07:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:21 INFO - 'SHELL': '/bin/bash', 07:59:21 INFO - 'SHLVL': '1', 07:59:21 INFO - 'TERM': 'linux', 07:59:21 INFO - 'TMOUT': '86400', 07:59:21 INFO - 'USER': 'cltbld', 07:59:21 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:21 INFO - '_': '/tools/buildbot/bin/python'} 07:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:59:21 INFO - Running setup.py (path:/tmp/pip-7GrbdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:59:21 INFO - Running setup.py (path:/tmp/pip-YVZgwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:59:21 INFO - Running setup.py (path:/tmp/pip-gtRdNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:59:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:59:22 INFO - Running setup.py (path:/tmp/pip-WDZldS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:59:22 INFO - Running setup.py (path:/tmp/pip-qsRyHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:59:22 INFO - Running setup.py (path:/tmp/pip-BY76ou-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:59:22 INFO - Running setup.py (path:/tmp/pip-t8fOa1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:59:22 INFO - Running setup.py (path:/tmp/pip-2hVEZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:59:22 INFO - Running setup.py (path:/tmp/pip-QCwzFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:59:22 INFO - Running setup.py (path:/tmp/pip-wpyCLT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:59:22 INFO - Running setup.py (path:/tmp/pip-KXpbb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:59:22 INFO - Running setup.py (path:/tmp/pip-OtgHsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:59:22 INFO - Running setup.py (path:/tmp/pip-5wqSA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:59:22 INFO - Running setup.py (path:/tmp/pip-P49kDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:59:22 INFO - Running setup.py (path:/tmp/pip-7cCuNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:59:22 INFO - Running setup.py (path:/tmp/pip-Fw77GO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:59:22 INFO - Running setup.py (path:/tmp/pip-Mwzhfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:59:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:24 INFO - Downloading blessings-1.5.1.tar.gz 07:59:24 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:59:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:24 INFO - Installing collected packages: blessings 07:59:24 INFO - Running setup.py install for blessings 07:59:24 INFO - Successfully installed blessings 07:59:24 INFO - Cleaning up... 07:59:24 INFO - Return code: 0 07:59:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:59:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:59:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:59:25 INFO - Reading from file tmpfile_stdout 07:59:25 INFO - Current package versions: 07:59:25 INFO - argparse == 1.2.1 07:59:25 INFO - blessings == 1.5.1 07:59:25 INFO - blobuploader == 1.2.4 07:59:25 INFO - docopt == 0.6.1 07:59:25 INFO - manifestparser == 1.1 07:59:25 INFO - mozInstall == 1.12 07:59:25 INFO - mozcrash == 0.16 07:59:25 INFO - mozdebug == 0.1 07:59:25 INFO - mozdevice == 0.47 07:59:25 INFO - mozfile == 1.2 07:59:25 INFO - mozhttpd == 0.7 07:59:25 INFO - mozinfo == 0.9 07:59:25 INFO - mozleak == 0.1 07:59:25 INFO - mozlog == 3.1 07:59:25 INFO - moznetwork == 0.27 07:59:25 INFO - mozprocess == 0.22 07:59:25 INFO - mozprofile == 0.28 07:59:25 INFO - mozrunner == 6.11 07:59:25 INFO - mozscreenshot == 0.1 07:59:25 INFO - mozsystemmonitor == 0.0 07:59:25 INFO - moztest == 0.7 07:59:25 INFO - mozversion == 1.4 07:59:25 INFO - psutil == 3.1.1 07:59:25 INFO - requests == 1.2.3 07:59:25 INFO - wsgiref == 0.1.2 07:59:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:59:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:25 INFO - Using env: {'DISPLAY': ':0', 07:59:25 INFO - 'HOME': '/home/cltbld', 07:59:25 INFO - 'LANG': 'en_US.UTF-8', 07:59:25 INFO - 'LANGUAGE': 'en_US:en', 07:59:25 INFO - 'LOGNAME': 'cltbld', 07:59:25 INFO - 'MAIL': '/var/mail/cltbld', 07:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:25 INFO - 'MOZ_NO_REMOTE': '1', 07:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:25 INFO - 'NO_EM_RESTART': '1', 07:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:25 INFO - 'SHELL': '/bin/bash', 07:59:25 INFO - 'SHLVL': '1', 07:59:25 INFO - 'TERM': 'linux', 07:59:25 INFO - 'TMOUT': '86400', 07:59:25 INFO - 'USER': 'cltbld', 07:59:25 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:25 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:59:25 INFO - Cleaning up... 07:59:25 INFO - Return code: 0 07:59:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:59:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:59:25 INFO - Using env: {'DISPLAY': ':0', 07:59:25 INFO - 'HOME': '/home/cltbld', 07:59:25 INFO - 'LANG': 'en_US.UTF-8', 07:59:25 INFO - 'LANGUAGE': 'en_US:en', 07:59:25 INFO - 'LOGNAME': 'cltbld', 07:59:25 INFO - 'MAIL': '/var/mail/cltbld', 07:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:25 INFO - 'MOZ_NO_REMOTE': '1', 07:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:25 INFO - 'NO_EM_RESTART': '1', 07:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:25 INFO - 'SHELL': '/bin/bash', 07:59:25 INFO - 'SHLVL': '1', 07:59:25 INFO - 'TERM': 'linux', 07:59:25 INFO - 'TMOUT': '86400', 07:59:25 INFO - 'USER': 'cltbld', 07:59:25 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:25 INFO - '_': '/tools/buildbot/bin/python'} 07:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:25 INFO - Downloading/unpacking jsonschema 07:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:59:27 INFO - Downloading/unpacking functools32 (from jsonschema) 07:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:59:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:27 INFO - warning: no files found matching '*.txt' 07:59:27 INFO - no previously-included directories found matching 'build' 07:59:27 INFO - no previously-included directories found matching 'dist' 07:59:27 INFO - no previously-included directories found matching '.git*' 07:59:27 INFO - Installing collected packages: jsonschema, functools32 07:59:27 INFO - Running setup.py install for functools32 07:59:27 INFO - warning: no files found matching '*.txt' 07:59:27 INFO - no previously-included directories found matching 'build' 07:59:27 INFO - no previously-included directories found matching 'dist' 07:59:27 INFO - no previously-included directories found matching '.git*' 07:59:27 INFO - Successfully installed jsonschema functools32 07:59:27 INFO - Cleaning up... 07:59:27 INFO - Return code: 0 07:59:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4013210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:59:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:59:27 INFO - Using env: {'DISPLAY': ':0', 07:59:27 INFO - 'HOME': '/home/cltbld', 07:59:27 INFO - 'LANG': 'en_US.UTF-8', 07:59:27 INFO - 'LANGUAGE': 'en_US:en', 07:59:27 INFO - 'LOGNAME': 'cltbld', 07:59:27 INFO - 'MAIL': '/var/mail/cltbld', 07:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:27 INFO - 'MOZ_NO_REMOTE': '1', 07:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:27 INFO - 'NO_EM_RESTART': '1', 07:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:27 INFO - 'SHELL': '/bin/bash', 07:59:27 INFO - 'SHLVL': '1', 07:59:27 INFO - 'TERM': 'linux', 07:59:27 INFO - 'TMOUT': '86400', 07:59:27 INFO - 'USER': 'cltbld', 07:59:27 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:27 INFO - '_': '/tools/buildbot/bin/python'} 07:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:27 INFO - Downloading/unpacking flake8 07:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:59:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:59:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:59:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:59:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:59:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:59:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:59:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:59:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:59:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:59:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:59:30 INFO - no previously-included directories found matching 'docs/_build' 07:59:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:59:30 INFO - Running setup.py install for pep8 07:59:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:59:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:59:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:59:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:59:30 INFO - no previously-included directories found matching 'docs/_build' 07:59:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:59:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:59:30 INFO - Cleaning up... 07:59:30 INFO - Return code: 0 07:59:30 INFO - Running post-action listener: _resource_record_post_action 07:59:30 INFO - Running post-action listener: _start_resource_monitoring 07:59:30 INFO - Starting resource monitoring. 07:59:30 INFO - ##### 07:59:30 INFO - ##### Running install step. 07:59:30 INFO - ##### 07:59:30 INFO - Running pre-action listener: _resource_record_pre_action 07:59:30 INFO - Running main action method: install 07:59:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:59:30 INFO - Reading from file tmpfile_stdout 07:59:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:59:30 INFO - Reading from file tmpfile_stdout 07:59:30 INFO - Output received: 07:59:30 INFO - Usage: mozinstall [options] installer 07:59:30 INFO - Options: 07:59:30 INFO - -h, --help show this help message and exit 07:59:30 INFO - -d DEST, --destination=DEST 07:59:30 INFO - Directory to install application into. [default: 07:59:30 INFO - "/builds/slave/test-pgo"] 07:59:30 INFO - --app=APP Application being installed. [default: firefox] 07:59:30 INFO - mkdir: /builds/slave/test-pgo/build/application 07:59:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:59:46 INFO - Reading from file tmpfile_stdout 07:59:46 INFO - Output received: 07:59:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:59:46 INFO - Running post-action listener: _resource_record_post_action 07:59:46 INFO - ##### 07:59:46 INFO - ##### Running run-tests step. 07:59:46 INFO - ##### 07:59:46 INFO - Running pre-action listener: _resource_record_pre_action 07:59:46 INFO - Running main action method: run_tests 07:59:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:59:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:59:46 INFO - Python 2.7.3 07:59:46 INFO - Return code: 0 07:59:46 INFO - grabbing minidump binary from tooltool 07:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:46 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 0x27b6840>, '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 0x27236b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2723b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:59:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:59:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:59:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:46 INFO - Return code: 0 07:59:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:59:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:59:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:59:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:59:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:59:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:59:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:59:47 INFO - Return code: 0 07:59:47 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/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:59:47 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/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:59:47 INFO - Using env: {'DISPLAY': ':0', 07:59:47 INFO - 'HOME': '/home/cltbld', 07:59:47 INFO - 'LANG': 'en_US.UTF-8', 07:59:47 INFO - 'LANGUAGE': 'en_US:en', 07:59:47 INFO - 'LOGNAME': 'cltbld', 07:59:47 INFO - 'MAIL': '/var/mail/cltbld', 07:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:47 INFO - 'MOZ_NO_REMOTE': '1', 07:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:47 INFO - 'NO_EM_RESTART': '1', 07:59:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 07:59:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:59:47 INFO - 'SHELL': '/bin/bash', 07:59:47 INFO - 'SHLVL': '1', 07:59:47 INFO - 'TERM': 'linux', 07:59:47 INFO - 'TMOUT': '86400', 07:59:47 INFO - 'USER': 'cltbld', 07:59:47 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397', 07:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:47 INFO - '_': '/tools/buildbot/bin/python'} 07:59:47 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/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:59:47 INFO - mozversion application_buildid: 20151230053005 07:59:47 INFO - mozversion application_changeset: d627f895e22602d801fdae9b5172978d1cb04165 07:59:47 INFO - mozversion application_display_name: Nightly 07:59:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:47 INFO - mozversion application_name: Firefox 07:59:47 INFO - mozversion application_remotingname: firefox 07:59:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:59:47 INFO - mozversion application_vendor: Mozilla 07:59:47 INFO - mozversion application_version: 46.0a1 07:59:47 INFO - mozversion platform_buildid: 20151230053005 07:59:47 INFO - mozversion platform_changeset: d627f895e22602d801fdae9b5172978d1cb04165 07:59:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:59:47 INFO - mozversion platform_version: 46.0a1 07:59:47 INFO - using testdate: 1451491187 07:59:47 INFO - actual date: 1451491187 07:59:47 INFO - starting webserver on 'localhost:44066' 07:59:47 INFO - SUITE-START | Running 3 tests 07:59:47 INFO - TEST-START | dromaeo_css 07:59:47 INFO - operating with platform_type : linux_ 07:59:47 INFO - Initialising browser for dromaeo_css test... 07:59:47 INFO - TEST-INFO | started process 22358 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVERXsl/profile http://localhost:44066/getInfo.html) 07:59:51 INFO - PROCESS | 22358 | __metrics Screen width/height:1600/1200 07:59:51 INFO - PROCESS | 22358 | colorDepth:24 07:59:51 INFO - PROCESS | 22358 | Browser inner width/height: 1024/697 07:59:51 INFO - PROCESS | 22358 | __metrics 07:59:51 INFO - PROCESS | 22358 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:59:51 INFO - PROCESS | 22358 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:52 INFO - TEST-INFO | 22358: exit 0 07:59:52 INFO - Browser initialized. 07:59:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:52 INFO - TEST-INFO | started process 22453 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVERXsl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:04 INFO - PROCESS | 22453 | RSS: Main: 148918272 08:00:04 INFO - PROCESS | 22453 | 08:00:55 INFO - PROCESS | 22453 | 1451491255292 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] 08:03:04 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44066/tests/dromaeo/cssquery-ext.html) 08:03:06 INFO - PROCESS | 22453 | RSS: Main: 330711040 08:03:06 INFO - PROCESS | 22453 | 08:06:08 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-ext.html (next: http://localhost:44066/tests/dromaeo/cssquery-jquery.html) 08:06:09 INFO - PROCESS | 22453 | RSS: Main: 233271296 08:06:09 INFO - PROCESS | 22453 | 08:09:11 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44066/tests/dromaeo/cssquery-mootools.html) 08:09:12 INFO - PROCESS | 22453 | RSS: Main: 239177728 08:09:12 INFO - PROCESS | 22453 | 08:12:13 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44066/tests/dromaeo/cssquery-prototype.html) 08:12:14 INFO - PROCESS | 22453 | RSS: Main: 217989120 08:12:14 INFO - PROCESS | 22453 | 08:15:16 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44066/tests/dromaeo/cssquery-yui.html) 08:15:17 INFO - PROCESS | 22453 | RSS: Main: 219111424 08:15:17 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | Cycle 1(1): loaded http://localhost:44066/tests/dromaeo/cssquery-yui.html (next: http://localhost:44066/tests/dromaeo/cssquery-dojo.html) 08:18:20 INFO - PROCESS | 22453 | RSS: Main: 282046464 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | __start_tp_report 08:18:20 INFO - PROCESS | 22453 | _x_x_mozilla_page_load 08:18:20 INFO - PROCESS | 22453 | _x_x_mozilla_page_load_details 08:18:20 INFO - PROCESS | 22453 | |i|pagename|runs| 08:18:20 INFO - PROCESS | 22453 | |0;dojo.html;3092.659807421184;3151.8424078796056;3211.662775408582;3211.823349715766;3240.060382489078;5020.598352131829;5121.411037730652;5210.6613070150415;5217.4260831308575;5255.947440525599;5155.329807125068;5165.7158856262895;5224.8693782655455;5268.394134674504;5304.098303288441;4731.313959475882;4769.689970151946;4773.474917759044;4775.235962246042;4831.299461578086;4859.659823812334;4884.3406140171155;4888.266759985995;4897.33885925399;4918.704877707331;4704.600108990757;4740.976295118537;4806.927896081562;4826.806927722887;4843.15244832153;4745.406824146981;4757.95242047582;4787.473377928425;4790.976045119787;4813.687110337817;4692.085043416535;4731.455882573479;4741.051789642051;4773.331733557305;4782.33047373368;4935.185694360426;4943.678660887031;5016.498350164954;5022.372203474566;5025.547700706918;5687.260656114679;5691;5693.829185124453;5696.430356964312;5715.428457154293;5677.17680936262;5689.6017278790505;5713.685747283897;5717.828465146053;5724.971375143139;5180.948190518085;5277.076511610453;5291.3385826771655;5297.708626025528;5331.093714068617;5729.742161602738;5739.13912913058;5739.827805165852;5754.223179870663;5774.162746401748;5525.281713377235;5532.114861622121;5543.390227075019;5547.362053363834;5580.525655319262;5434.864128396743;5503.284573005563;5565.220869078333;5608.971955140199;5638.323401191883;5591.832245032656;5613.831585052455;5616.157576363578;5641.717914104278;5646.97176514123;5604.299462567179;5615.719214039364;5616.85957851057;5618.325800903917;5630.0991841305195;4257.616814486649;4377.409049778303;4377.518472967971;4378.190034843564;4420.80106395213;3884.669803066771;3895.182011777502;3926.6858651307825;3930.1746633206776;3961.445397644332;5171.560417364566;5171.974140129275;5173.094708426086;5174.844754657366;5175.068487672255;5437.429069947599;5598.1602759586385;5606.330918042907;5606.775728970795;5649.4915457608195;5158.97420512895;5182.714950677749;5256.78972841082;5262.079136151158;5277.736113194325;4822.324874517571;4825.855224343275;4827.058723548875;4830;4873;5583.330000399978;5619.943800562024;5622.606417550814;5624.859378515488;5625.156226566048;5443.129099344244;5452.890942181055;5534.695591742332;5634.7464364104535;5678.68767217807;5661.66030038199;5666.886662266814;5669;5681.8863622726485;5682.857928551819;5431.755570999236;5536.806211782568;5544.63959842609;5546.61173717852;5554.694491802989;5554.722263886871;5597.720113994365;5619.943800561942;5633;5636.943630563642;5429.995450841607;5466.234727138283;5467.781288748405;5479.287692599936;5486.204500347507;5443.183522471661;5462.235287059894;5486.31421072366;5581.665100093845;5586.441355864381;5474.972625136849;5485.725713714378;5488.094464413327;5494.313210848644;5504.311961004874;5534.280543529316;5558.527525160245;5585.69278689676;5594.384617692132;5646.9152962704775;5268.868278293074;5273.630845840754;5371.731413429391;5382.703951282717;5429.511343979061 08:18:20 INFO - PROCESS | 22453 | |1;ext.html;529.6557237795432;529.9920501192481;533.2827347217993;551.5064017704153;558.832350294912;27898.58152127717;28440.57339139912;28474.85762571187;35192.64807351926;35864.641353586456;38847;39046.41430378547;39278;39353.40969885454;39354.606453935456;8424;8514.403991720583;8551.059383467813;8561.743147705578;8604.655813767442;7533.7363192288;7675.3092221700035;10020.949895250513;10184.28709990301;10195;9923.503824808768;9991.400515969066;10031.749206269866;10048.346857454242;10053.798924021516;7507.549547027196;7664.846703065908;9918.256130790183;9941.65204217849;9999.50002499872;7385.9630701846145;10075.193984481224;10270.9486452568;10277.280590358603;10283.125934295595;36058.09854753626;36102;36356.81821590875;36554.63445365566;36556.817215914016;3313.3207692422993;3378.273671160712;3393.881214157517;3696.3346597612417;3905.8253250282887;27976.160715178576;28170.15489535317;28346.14961551136;28562.285942851388;28587.285317867012;3550.1124718820297;3607.134287770916;3614.475900994341;3641.745077844552;3694.6674799267926;272957;274007;274521.62739186373;274545;274640;51358.743206284475;52554.73722631439;57238.42761572414;57612;57780;62043.37956620376;63223.6838815803;63257;63280.68359658265;63331;13521.59435216945;13837.169769813843;13842.446302148002;13843.131177290938;13845.792313115311;11044.723881903017;11144.164187685956;11160.218784684994;11204.15968802343;11208.831867521994;18618;18806.341778037702;18856.622867542574;19522.219111235674;19617.509562260773;7002.194747603989;7037.824054398681;7138.785836424916;7230.2046774854725;7339.376153026946;962.7015625156224;1033.6227277043974;1033.8449232615017;1042.817506936283;1066.2642776484201;27994;28198.71801282002;28335.71664283372;28590;28688.426231475252;1050.3907733514543;1145.2441388683596;1172.3903570143477;1179.6578992092197;1211.0674780419029;14908.701825963637;15186.544403667907;15400.19757915655;15488.84511154874;15569.766453503207;313657;323651;323958;326096;328940;50710.492895071315;51060.48939510557;51134.74432627887;51137.744311278206;51293.7435312821;1366.296357375952;1369.383777300219;1381.894484412466;1393.4217299820664;1394.1286695815115;25393.873030634728;28125;28279.151625451268;28416.289592760346;29370.559441607966;41026.79486602548;41383.586164137974;41530;41666.375004375564;41741.58258417377;197930;198822;199568;199643;200195;30213.546796797626;30776;31097.68902310948;31550.842245788623;31560.053198404086;37324.62675373212;37389.08872901613;37643.62356376401;37781;38186;32088.5186722204;32273;32475.35049299048;32703.509447357832;32782.672173278916;29139.417211656073;32390.35219295648;33440.33119337551;33895.83052084724;35503.64496355003;32843;32852.67147328592;33108.66891331056;33140;36042.27915441729;27841.092649565177;29008.709912901446;30193;30317.545236821905;30328.848355758964;23317.76682233156;23638.29085127449;25181.370465738502;25363.11229107046;25803 08:18:20 INFO - PROCESS | 22453 | |2;jquery.html;334.43146650693825;339.78423700949895;343.962164161942;345.0838025043509;347.5152162732989;14055.648608784786;14418.783718244234;16080.919595402022;16191.919040404797;17010.999999999985;15896.84103158968;16027.519174424757;16078.919605401956;16094.919525402385;16102.919485402586;5047.343845300115;5302.575793936495;5311.2298716686055;5319.441458646825;5323.1749078892835;3964.960350396488;4083.5508094109623;5242.449542797989;5765.625234359774;5952.077427998667;5808.912866307009;5858.941410585903;5861.443162899518;5880.794172203952;5885.941140588604;5699.2306038684665;5836.708164591753;5842.766289348442;5843.474087332118;5847.122931560258;5113.130767769451;5128.025675121715;5130.71781052042;5132.076226279269;5136.280920671109;18102.818971810375;18328.083595820157;18732.90633546837;18989.43642608244;19018.334358297532;2088.98955505223;2092.215419217793;2118.1527389044504;2186.1364760919346;2220.04538048639;8466;8591.914080859175;8945.55272236392;9604.279679024101;9760.267979901464;1733.8006129295165;1762.4272111563794;1769.3984045424488;1773.654137443199;1776.8223177682257;52913.735431322595;53213.201801973;54445;56550;58449;9859.50702464874;10214;10264.538095785707;10289.684820915234;10317.432541210306;13266.07137500385;13269.07116501855;13271.137376070525;13275.867241327656;13302.736240057178;7666.769996900102;7736.574488403192;7753.573553454614;7764.301212890754;7808.297253247121;7598.316151546387;7644.579548124795;7647;7647.847043059219;7697.345725613273;4400.163968845909;4459.241928872099;4463.486699029653;4474.0604473060375;4481.887952801141;1634.133909028217;1697.2192791316133;1753.219817181342;1814.7878255487976;1821;934.1079269297804;950.6815216902415;997.546116516983;1012.1902478017704;1032.8244198486275;16773.7483937741;16870.15649217534;16881.071541065114;17004.234809433605;17139.468123280483;959.3045042344245;969.1713584884963;973.7808992976524;1017.1710056304089;1040.8750949886062;9570.521473926276;9684.51577421126;9746.707598772047;9751.366161199641;9772.169365604002;527798;528019;538426;542090;543265;73420;74503.62748186225;75255;75690.62154689191;76761.23238767653;1085.8371244313573;1097.7914196302677;1153.135148638521;1170.9121815863843;1182.781185480689;14813;15107.39570417215;15258;15327.003744756556;15539.766903496682;33170.5024424629;34346.313073738886;34810.82594587011;34982.82508587441;35125.29749405049;43750.343744843216;44890;45084.77457612691;45343.7732811347;47647.76176119097;9548.283878708986;9593.13661770444;9859.161971232526;9865.852012219679;9867.40795552269;11627.244229125079;11709.590164344207;12657.746845062862;14708.705825883208;17605.73591396156;14448.638784030063;14539.854601454274;14618.976671632883;14714.632134196303;15149.166795826335;13607.251601161635;13770.65573360674;13900.096493727875;14240.501582444565;14771.778423323443;11292.825238819836;11882.405879706153;12063.526976969875;13327.933360333136;13684.52104176349;9314.161725444743;9350.95324523373;9463.952680236831;9557.330986831133;9577.952110239683;12776.233425994471;13090.607281781562;13262.33688315561;13334.666633334244;13395.598132056053 08:18:20 INFO - PROCESS | 22453 | |3;mootools.html;1328.2893651896238;1440.8631180037892;1456.9125852448853;1597.400974634512;1783.857291416686;6401.23185217774;6961.825954351138;7010.263922288156;7028.051213086232;7045.718171273155;6811.080504131941;6920.723171073151;6926.099607051076;6983;7027;1970.6255811395788;2003.7896020917813;2159.995602045045;2163.405063607505;2205.2502149269244;2193.4187440328246;2200.8899555022185;2202.262242148874;2203.4821816873023;2206.8013878750908;2089.8119169274764;2179.2917301876873;2180.6292930201903;2188.2341180586827;2188.3872515695552;2179.3788770200495;2190.616642087636;2209.856359336646;2214.1032881682945;2219.7336319641586;2226.0428015953134;2233.8994745236505;2262.4457008032973;2262.875541845198;2262.8981695823563;7067.964660176717;7188.388986936116;7206.855862882765;7214.350708436214;7217.170025447036;4401.493828209733;4428.623566996809;4477.037436951038;4483.753393563353;4485.798139083749;2877.4820532304175;2956.659984101834;2986.7461265792435;2999.910002699901;3003.174127115039;936.1153709744294;945.5272363818091;946.2099147212086;960.8469836196592;968.5593055159885;9821.508924553744;9846.65536706219;9847.310688251826;9848.60605575776;9852.211823054138;4042.4542686737504;4094.4472496213225;4116.320807066861;4153.605407486284;4155.771432571177;8384.958075209584;8452.1547845215;8456.704015359433;8460.78848028792;8472.322214222848;4523.389342438729;4529;4531.682782205214;4557.498675145731;4563.817447302137;4145.419641250227;4177.91644167121;4177.979110104491;4181.142865712522;4186.1836941796055;3222.7905186162825;3275.361304545638;3459.7405194610506;3485.5120283160377;3504.456809194579;1125.9887401126048;1130.773845230957;1131.5586921100778;1145.6906635208447;1147.3689470791032;1054.5887104029434;1055.646358469921;1102.0081926266425;1187.4122309456702;1299.5516546791341;6724.630145342053;6744.595324280559;6783.966080169567;6797.388235058868;6807.795766127024;1122.5060973171942;1125.5610311978335;1130.5816847766214;1137.2778285788418;1144.6852115668257;5432.130859062531;5497.642653227607;5499.037668408093;5525.668459892339;5528.087865502228;7954.403419743427;8102;8159.184081591793;8271.33829293655;8505;8063.5968201589685;8219.054808696957;8262.215089566482;8269.62786674601;8276.08963014068;6555.737770489127;6617.272100068989;6717.865642687118;6746.561473504206;6769.1876974763345;6631.602103873783;6691.464682825265;6701.296363881722;6703.966480167568;6708.966455167693;7674.8081297968;7730.690772369042;7772.844543108993;7858;7877.330426913776;7822.217778222132;7893.723719669784;7942.523448593103;7966.880496792437;8020.799480013046;6354.26925903527;6419.45434638061;6424.871502570016;6455.580387274812;6472.805815825533;6194.4115309045565;6285.340039295808;6710.6309152997055;6855.828604284933;6932.341427564374;6373.74505019794;6449.097126402214;6480.546361754632;6532.934670653232;6565.96717016431;6270.467010304175;6276.905846412399;6311.305756366888;6478.060681201106;6487;6321.873562528632;6444.162258906312;6455.741770329322;6463.418292353711;6469.029645553204;6005.159277701038;6031.095335699505;6041.154238406714;6048;6049.546284028627;5700.429957004267;5722.685252311163;5785.942140578541;5909;5961.582689211714 08:18:20 INFO - PROCESS | 22453 | |4;prototype.html;313.6596792480159;320.5992509363295;325.9934801303974;328.2646871008941;337.360701470713;5899.380565040673;5906.05503119501;5918.4081591840795;5928.584999050068;5938.228030356053;5637.267155269809;5755.6258843175165;5758.596898217126;5855.4144585541535;5896.496393419672;4542.591166794988;4555.20283950309;4556.179887620227;4561.0649816787645;4561.475430325505;4336.8265269389185;4543.182227199103;4562.270036794113;4563.954360456402;4568.497465278817;4346.043870348518;4380.956190438087;4484.618807401374;4492.573205545485;4504.054148628792;4423.623991960687;4424.889377765549;4449.31035689467;4472.619827314682;4479.238529450001;3899.395593682984;3925.7055720820767;3932.3315036443873;3940.54683711374;3942.546607140187;5474.72626368684;5571.359293681197;5610.214569960168;5611.046122159243;5625.46558076982;5304.814331498379;5309.123994540896;5310.336207974004;5318.468153184689;5320.946790532123;6243.219597550306;6251.78118765841;6255.280642726099;6258.3428739982555;6260.499160067184;4441.133978874121;4456.442944631921;4457.175422546807;4457.64338852891;4460.843870464518;6386.489080873519;6568.408843204134;6571.2771595124495;6581.111549940744;6591.769288074895;4570.862874113782;4572.862814115582;4574.588287054181;4578.9771051144535;4579.313103034505;4639.536046395401;4640.559146881041;4641.350210970467;4642.628589712815;4643.024964757439;5297.8145764898045;5298;5300.31095957523;5307.548858347007;5330.813421530305;6191.226096737908;6348.904766428507;6355.872882542323;6356.237251529754;6368.808935731936;1610.919454027294;1615.8545730884277;1616.6281755196371;1617.159077279808;1620.5462470508276;1104.6520346090956;1108.695108845074;1113.5991043224433;1115.5928086248623;1136.8749437561862;5935.73289201987;5941.435563621449;5948.167256584082;5950.375210602911;5950.940490595125;6505.869882602321;6511.446527045254;6513.250976137805;6514.1531600891585;6516.869662606721;5781.075027995501;5849.385814489502;5920.2007728956905;6001.4298641628975;6010.9699451502465;3512.666296701809;3539.911502212414;3542.4155014422845;3544.858205671744;3548.5741710994844;6675.599464032173;6683.43190828785;6684;6690.933090669128;6696.497762667819;6654.8060291574;6735.797926062226;6764.729410823512;6767.729290828312;6779.186497620317;6662.367075127952;6669.666516674244;6678.933210667831;6680.665966701743;6691.498137639794;6437.8390540235;6514.413702766774;6518.869622607616;6525.053867189136;6572.244191917991;6388.552801303864;6430.807075787734;6444.516661250519;6491;6502.707378167899;6641.50188735837;6666.000099985041;6670.899936500859;6684.06423100776;6685.732570697118;4601.608863246662;4601.884952876205;4603.700759450625;4605.769711514344;4609.562091601292;6473.77341793035;6580.045893345534;6590.505712071518;6592.70332835014;6601.669916504059;6375.9362406377195;6394.26465956421;6394.729870895951;6403.039544068427;6417.550771445954;6375.426211640789;6392.93607063942;6393.2967373587935;6407.551471397144;6416.101745755691;6072.392760723892;6248.218972628421;6283.59156654816;6295.464885484785;6302.495800336053;6390.041493775971;6391.392817682313;6395.976643737165;6397.368670988868;6400.711967961546;6238.220222472191;6244.812655620339;6247.656378899204;6252.437280644764;6262 08:18:20 INFO - PROCESS | 22453 | |5;yui.html;731.1628185727345;733.065341689346;772.09279097061;863.6372723456147;870.1385628228054;11985;12185.147039707224;12203.145779795417;12217.816732748994;12226.633201003973;9237.538123093853;11339.716507087327;11400.600978965738;11434.542618295258;11491.253068550539;817.5421763812284;837.0875745437472;837.1753822484848;837.4305472278847;838.6771093129158;822.7449490657915;825.3685930263354;831.5010993403939;832.675256649907;833.2417500074934;859.8409294280547;864.7449002544233;867.5835598912525;870.1081391573624;876.7808047988003;869.0744357259498;870.5908223135116;872.2760109109424;872.7818045488627;874.1782724239195;643.8454770855008;644.1175589442447;645.1387397823911;645.686841881687;645.699749616426;10697.358158510437;10832.941741069171;10899.12806975448;10907.18196135293;10911.399873006982;10194.133498652624;10301.381917084924;10451.529681164366;10614.946925265402;10685.626003089932;9944.602215911355;9960;10069;10121.139703125244;10149.797004059952;3654.8720794772057;3669.2294618130227;3684.1342284563107;3748.5126933498473;3810.1046254130256;45558;46369.30446043278;46481.51388645831;46737.76631116857;46840;9397.530123493798;9676.612935482643;9820.607175712892;9905.851412228822;10250.384976901261;17376.21807018687;17409.564760880825;17436.302547897943;17439.389621363192;17441.7383739244;6858.931410685829;6904.896426553606;6942.305769423017;7187.1734750504365;7226.241244669339;3843.8846834595006;3967.3652215645934;4043.8989025274605;4096.897577560525;4175.0188705654145;3067.8772849085785;3101.069679096262;3101.7518598512065;3103.9844800776305;3105.223694076481;531.5773959702046;537.9462053794589;551.4210079416677;562.1567648527209;568.8236646639555;624.537841996919;640.2157357237347;643.2988043033116;680.6086500262369;694.5344028698102;8363.498190108612;8367.748967530984;8434.367422443342;8447.619857106321;8533.871991920127;662.2615783401569;665.733706517397;679.8062552172607;697.8011266788941;755.3956834532352;3860.6911447084167;4153.210889930903;4243.766592837424;4276.593723596254;4342;59387;59437.70281148653;59660;59688;60020;46087;46347.768261158475;52932;53280.33598320068;54116.72941635267;51258.99999999925;51424.48575514197;51443.228351574006;51734.22398664023;53292;8422.957885210535;8490.617922193393;8515.446495977742;8674.262687671619;8878.467291962503;32195.35609287848;32802.50796238011;33667.32665346728;35809;35880.4617930726;43650.34524482199;43744.90637734082;43805.34291985686;46393.53606463892;47194.52805471901;10674.146068314361;10768.569257229623;11082.833757493483;11192.72018199519;11240.494177762184;12531.12282140278;12580.87419125797;12670.936645316715;13123.803142952673;13126.803097953729;11191.2725672831;11332.716682083013;12016.939915300367;12322.075844311534;12424;11673.533058677558;11726.41367931617;12032.27806331623;12070.818937716116;12312.322822244505;11505.827412588651;11701.180917335705;11884.049276058067;12019.819702704292;12145.939270303592;9612.387612387613;9666.709998700051;9891.851622225528;9972.451515166735;10185.134263587677;8417.452865563719;8897.555122243992;8929.196372326522;9325.487098209664;9349.719508414759 08:18:20 INFO - PROCESS | 22453 | __end_tp_report 08:18:20 INFO - PROCESS | 22453 | __start_cc_report 08:18:20 INFO - PROCESS | 22453 | _x_x_mozilla_cycle_collect,1419 08:18:20 INFO - PROCESS | 22453 | __end_cc_report 08:18:20 INFO - PROCESS | 22453 | __startTimestamp1451492300494__endTimestamp 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | ------- Summary: start ------- 08:18:20 INFO - PROCESS | 22453 | Number of tests: 6 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#0] dojo.html Cycles:165 Average:5204.69 Median:5434.86 stddev:558.92 (10.3%) stddev-sans-first:535.51 08:18:20 INFO - PROCESS | 22453 | Values: 3092.7 3151.8 3211.7 3211.8 3240.1 5020.6 5121.4 5210.7 5217.4 5255.9 5155.3 5165.7 5224.9 5268.4 5304.1 4731.3 4769.7 4773.5 4775.2 4831.3 4859.7 4884.3 4888.3 4897.3 4918.7 4704.6 4741.0 4806.9 4826.8 4843.2 4745.4 4758.0 4787.5 4791.0 4813.7 4692.1 4731.5 4741.1 4773.3 4782.3 4935.2 4943.7 5016.5 5022.4 5025.5 5687.3 5691.0 5693.8 5696.4 5715.4 5677.2 5689.6 5713.7 5717.8 5725.0 5180.9 5277.1 5291.3 5297.7 5331.1 5729.7 5739.1 5739.8 5754.2 5774.2 5525.3 5532.1 5543.4 5547.4 5580.5 5434.9 5503.3 5565.2 5609.0 5638.3 5591.8 5613.8 5616.2 5641.7 5647.0 5604.3 5615.7 5616.9 5618.3 5630.1 4257.6 4377.4 4377.5 4378.2 4420.8 3884.7 3895.2 3926.7 3930.2 3961.4 5171.6 5172.0 5173.1 5174.8 5175.1 5437.4 5598.2 5606.3 5606.8 5649.5 5159.0 5182.7 5256.8 5262.1 5277.7 4822.3 4825.9 4827.1 4830.0 4873.0 5583.3 5619.9 5622.6 5624.9 5625.2 5443.1 5452.9 5534.7 5634.7 5678.7 5661.7 5666.9 5669.0 5681.9 5682.9 5431.8 5536.8 5544.6 5546.6 5554.7 5554.7 5597.7 5619.9 5633.0 5636.9 5430.0 5466.2 5467.8 5479.3 5486.2 5443.2 5462.2 5486.3 5581.7 5586.4 5475.0 5485.7 5488.1 5494.3 5504.3 5534.3 5558.5 5585.7 5594.4 5646.9 5268.9 5273.6 5371.7 5382.7 5429.5 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#1] ext.html Cycles:180 Average:42907.88 Median:177962.00 stddev:70759.36 (39.8%) stddev-sans-first:70886.31 08:18:20 INFO - PROCESS | 22453 | Values: 529.7 530.0 533.3 551.5 558.8 27898.6 28440.6 28474.9 35192.6 35864.6 38847.0 39046.4 39278.0 39353.4 39354.6 8424.0 8514.4 8551.1 8561.7 8604.7 7533.7 7675.3 10020.9 10184.3 10195.0 9923.5 9991.4 10031.7 10048.3 10053.8 7507.5 7664.8 9918.3 9941.7 9999.5 7386.0 10075.2 10270.9 10277.3 10283.1 36058.1 36102.0 36356.8 36554.6 36556.8 3313.3 3378.3 3393.9 3696.3 3905.8 27976.2 28170.2 28346.1 28562.3 28587.3 3550.1 3607.1 3614.5 3641.7 3694.7 272957.0 274007.0 274521.6 274545.0 274640.0 51358.7 52554.7 57238.4 57612.0 57780.0 62043.4 63223.7 63257.0 63280.7 63331.0 13521.6 13837.2 13842.4 13843.1 13845.8 11044.7 11144.2 11160.2 11204.2 11208.8 18618.0 18806.3 18856.6 19522.2 19617.5 7002.2 7037.8 7138.8 7230.2 7339.4 962.7 1033.6 1033.8 1042.8 1066.3 27994.0 28198.7 28335.7 28590.0 28688.4 1050.4 1145.2 1172.4 1179.7 1211.1 14908.7 15186.5 15400.2 15488.8 15569.8 313657.0 323651.0 323958.0 326096.0 328940.0 50710.5 51060.5 51134.7 51137.7 51293.7 1366.3 1369.4 1381.9 1393.4 1394.1 25393.9 28125.0 28279.2 28416.3 29370.6 41026.8 41383.6 41530.0 41666.4 41741.6 197930.0 198822.0 199568.0 199643.0 200195.0 30213.5 30776.0 31097.7 31550.8 31560.1 37324.6 37389.1 37643.6 37781.0 38186.0 32088.5 32273.0 32475.4 32703.5 32782.7 29139.4 32390.4 33440.3 33895.8 35503.6 32843.0 32852.7 33108.7 33140.0 36042.3 27841.1 29008.7 30193.0 30317.5 30328.8 23317.8 23638.3 25181.4 25363.1 25803.0 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#2] jquery.html Cycles:180 Average:28162.73 Median:34896.83 stddev:87465.76 (250.6%) stddev-sans-first:87686.16 08:18:20 INFO - PROCESS | 22453 | Values: 334.4 339.8 344.0 345.1 347.5 14055.6 14418.8 16080.9 16191.9 17011.0 15896.8 16027.5 16078.9 16094.9 16102.9 5047.3 5302.6 5311.2 5319.4 5323.2 3965.0 4083.6 5242.4 5765.6 5952.1 5808.9 5858.9 5861.4 5880.8 5885.9 5699.2 5836.7 5842.8 5843.5 5847.1 5113.1 5128.0 5130.7 5132.1 5136.3 18102.8 18328.1 18732.9 18989.4 19018.3 2089.0 2092.2 2118.2 2186.1 2220.0 8466.0 8591.9 8945.6 9604.3 9760.3 1733.8 1762.4 1769.4 1773.7 1776.8 52913.7 53213.2 54445.0 56550.0 58449.0 9859.5 10214.0 10264.5 10289.7 10317.4 13266.1 13269.1 13271.1 13275.9 13302.7 7666.8 7736.6 7753.6 7764.3 7808.3 7598.3 7644.6 7647.0 7647.8 7697.3 4400.2 4459.2 4463.5 4474.1 4481.9 1634.1 1697.2 1753.2 1814.8 1821.0 934.1 950.7 997.5 1012.2 1032.8 16773.7 16870.2 16881.1 17004.2 17139.5 959.3 969.2 973.8 1017.2 1040.9 9570.5 9684.5 9746.7 9751.4 9772.2 527798.0 528019.0 538426.0 542090.0 543265.0 73420.0 74503.6 75255.0 75690.6 76761.2 1085.8 1097.8 1153.1 1170.9 1182.8 14813.0 15107.4 15258.0 15327.0 15539.8 33170.5 34346.3 34810.8 34982.8 35125.3 43750.3 44890.0 45084.8 45343.8 47647.8 9548.3 9593.1 9859.2 9865.9 9867.4 11627.2 11709.6 12657.7 14708.7 17605.7 14448.6 14539.9 14619.0 14714.6 15149.2 13607.3 13770.7 13900.1 14240.5 14771.8 11292.8 11882.4 12063.5 13327.9 13684.5 9314.2 9351.0 9464.0 9557.3 9578.0 12776.2 13090.6 13262.3 13334.7 13395.6 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#3] mootools.html Cycles:180 Average:5045.61 Median:6232.44 stddev:2521.79 (40.5%) stddev-sans-first:2513.38 08:18:20 INFO - PROCESS | 22453 | Values: 1328.3 1440.9 1456.9 1597.4 1783.9 6401.2 6961.8 7010.3 7028.1 7045.7 6811.1 6920.7 6926.1 6983.0 7027.0 1970.6 2003.8 2160.0 2163.4 2205.3 2193.4 2200.9 2202.3 2203.5 2206.8 2089.8 2179.3 2180.6 2188.2 2188.4 2179.4 2190.6 2209.9 2214.1 2219.7 2226.0 2233.9 2262.4 2262.9 2262.9 7068.0 7188.4 7206.9 7214.4 7217.2 4401.5 4428.6 4477.0 4483.8 4485.8 2877.5 2956.7 2986.7 2999.9 3003.2 936.1 945.5 946.2 960.8 968.6 9821.5 9846.7 9847.3 9848.6 9852.2 4042.5 4094.4 4116.3 4153.6 4155.8 8385.0 8452.2 8456.7 8460.8 8472.3 4523.4 4529.0 4531.7 4557.5 4563.8 4145.4 4177.9 4178.0 4181.1 4186.2 3222.8 3275.4 3459.7 3485.5 3504.5 1126.0 1130.8 1131.6 1145.7 1147.4 1054.6 1055.6 1102.0 1187.4 1299.6 6724.6 6744.6 6784.0 6797.4 6807.8 1122.5 1125.6 1130.6 1137.3 1144.7 5432.1 5497.6 5499.0 5525.7 5528.1 7954.4 8102.0 8159.2 8271.3 8505.0 8063.6 8219.1 8262.2 8269.6 8276.1 6555.7 6617.3 6717.9 6746.6 6769.2 6631.6 6691.5 6701.3 6704.0 6709.0 7674.8 7730.7 7772.8 7858.0 7877.3 7822.2 7893.7 7942.5 7966.9 8020.8 6354.3 6419.5 6424.9 6455.6 6472.8 6194.4 6285.3 6710.6 6855.8 6932.3 6373.7 6449.1 6480.5 6532.9 6566.0 6270.5 6276.9 6311.3 6478.1 6487.0 6321.9 6444.2 6455.7 6463.4 6469.0 6005.2 6031.1 6041.2 6048.0 6049.5 5700.4 5722.7 5785.9 5909.0 5961.6 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#4] prototype.html Cycles:180 Average:5281.40 Median:5924.39 stddev:1582.56 (26.7%) stddev-sans-first:1542.45 08:18:20 INFO - PROCESS | 22453 | Values: 313.7 320.6 326.0 328.3 337.4 5899.4 5906.1 5918.4 5928.6 5938.2 5637.3 5755.6 5758.6 5855.4 5896.5 4542.6 4555.2 4556.2 4561.1 4561.5 4336.8 4543.2 4562.3 4564.0 4568.5 4346.0 4381.0 4484.6 4492.6 4504.1 4423.6 4424.9 4449.3 4472.6 4479.2 3899.4 3925.7 3932.3 3940.5 3942.5 5474.7 5571.4 5610.2 5611.0 5625.5 5304.8 5309.1 5310.3 5318.5 5320.9 6243.2 6251.8 6255.3 6258.3 6260.5 4441.1 4456.4 4457.2 4457.6 4460.8 6386.5 6568.4 6571.3 6581.1 6591.8 4570.9 4572.9 4574.6 4579.0 4579.3 4639.5 4640.6 4641.4 4642.6 4643.0 5297.8 5298.0 5300.3 5307.5 5330.8 6191.2 6348.9 6355.9 6356.2 6368.8 1610.9 1615.9 1616.6 1617.2 1620.5 1104.7 1108.7 1113.6 1115.6 1136.9 5935.7 5941.4 5948.2 5950.4 5950.9 6505.9 6511.4 6513.3 6514.2 6516.9 5781.1 5849.4 5920.2 6001.4 6011.0 3512.7 3539.9 3542.4 3544.9 3548.6 6675.6 6683.4 6684.0 6690.9 6696.5 6654.8 6735.8 6764.7 6767.7 6779.2 6662.4 6669.7 6678.9 6680.7 6691.5 6437.8 6514.4 6518.9 6525.1 6572.2 6388.6 6430.8 6444.5 6491.0 6502.7 6641.5 6666.0 6670.9 6684.1 6685.7 4601.6 4601.9 4603.7 4605.8 4609.6 6473.8 6580.0 6590.5 6592.7 6601.7 6375.9 6394.3 6394.7 6403.0 6417.6 6375.4 6392.9 6393.3 6407.6 6416.1 6072.4 6248.2 6283.6 6295.5 6302.5 6390.0 6391.4 6396.0 6397.4 6400.7 6238.2 6244.8 6247.7 6252.4 6262.0 08:18:20 INFO - PROCESS | 22453 | 08:18:20 INFO - PROCESS | 22453 | [#5] yui.html Cycles:180 Average:13702.53 Median:49226.76 stddev:16318.71 (33.2%) stddev-sans-first:16335.42 08:18:20 INFO - PROCESS | 22453 | Values: 731.2 733.1 772.1 863.6 870.1 11985.0 12185.1 12203.1 12217.8 12226.6 9237.5 11339.7 11400.6 11434.5 11491.3 817.5 837.1 837.2 837.4 838.7 822.7 825.4 831.5 832.7 833.2 859.8 864.7 867.6 870.1 876.8 869.1 870.6 872.3 872.8 874.2 643.8 644.1 645.1 645.7 645.7 10697.4 10832.9 10899.1 10907.2 10911.4 10194.1 10301.4 10451.5 10614.9 10685.6 9944.6 9960.0 10069.0 10121.1 10149.8 3654.9 3669.2 3684.1 3748.5 3810.1 45558.0 46369.3 46481.5 46737.8 46840.0 9397.5 9676.6 9820.6 9905.9 10250.4 17376.2 17409.6 17436.3 17439.4 17441.7 6858.9 6904.9 6942.3 7187.2 7226.2 3843.9 3967.4 4043.9 4096.9 4175.0 3067.9 3101.1 3101.8 3104.0 3105.2 531.6 537.9 551.4 562.2 568.8 624.5 640.2 643.3 680.6 694.5 8363.5 8367.7 8434.4 8447.6 8533.9 662.3 665.7 679.8 697.8 755.4 3860.7 4153.2 4243.8 4276.6 4342.0 59387.0 59437.7 59660.0 59688.0 60020.0 46087.0 46347.8 52932.0 53280.3 54116.7 51259.0 51424.5 51443.2 51734.2 53292.0 8423.0 8490.6 8515.4 8674.3 8878.5 32195.4 32802.5 33667.3 35809.0 35880.5 43650.3 43744.9 43805.3 46393.5 47194.5 10674.1 10768.6 11082.8 11192.7 11240.5 12531.1 12580.9 12670.9 13123.8 13126.8 11191.3 11332.7 12016.9 12322.1 12424.0 11673.5 11726.4 12032.3 12070.8 12312.3 11505.8 11701.2 11884.0 12019.8 12145.9 9612.4 9666.7 9891.9 9972.5 10185.1 8417.5 8897.6 8929.2 9325.5 9349.7 08:18:20 INFO - PROCESS | 22453 | -------- Summary: end -------- 08:18:20 INFO - PROCESS | 22453 | 08:18:21 INFO - TEST-INFO | 22453: exit 0 08:18:21 INFO - TEST-OK | dromaeo_css | took 1113376ms 08:18:21 INFO - TEST-START | kraken 08:18:21 INFO - operating with platform_type : linux_ 08:18:21 INFO - Initialising browser for kraken test... 08:18:21 INFO - TEST-INFO | started process 22649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7WHIYU/profile http://localhost:44066/getInfo.html) 08:18:25 INFO - PROCESS | 22649 | __metrics Screen width/height:1600/1200 08:18:25 INFO - PROCESS | 22649 | colorDepth:24 08:18:25 INFO - PROCESS | 22649 | Browser inner width/height: 1024/697 08:18:25 INFO - PROCESS | 22649 | __metrics 08:18:25 INFO - PROCESS | 22649 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:18:25 INFO - PROCESS | 22649 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:26 INFO - TEST-INFO | 22649: exit 0 08:18:26 INFO - Browser initialized. 08:18:26 INFO - Running cycle 1/1 for kraken test... 08:18:26 INFO - TEST-INFO | started process 22730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7WHIYU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:37 INFO - PROCESS | 22730 | RSS: Main: 149786624 08:18:37 INFO - PROCESS | 22730 | 08:18:40 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44066/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:41 INFO - PROCESS | 22730 | RSS: Main: 183635968 08:18:41 INFO - PROCESS | 22730 | 08:18:43 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44066/tests/kraken/driver.html?testName=audio-dft) 08:18:44 INFO - PROCESS | 22730 | RSS: Main: 173731840 08:18:44 INFO - PROCESS | 22730 | 08:18:47 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44066/tests/kraken/driver.html?testName=audio-fft) 08:18:47 INFO - PROCESS | 22730 | RSS: Main: 159784960 08:18:47 INFO - PROCESS | 22730 | 08:18:49 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44066/tests/kraken/driver.html?testName=audio-oscillator) 08:18:50 INFO - PROCESS | 22730 | RSS: Main: 163020800 08:18:50 INFO - PROCESS | 22730 | 08:18:52 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:53 INFO - PROCESS | 22730 | RSS: Main: 165216256 08:18:53 INFO - PROCESS | 22730 | 08:18:55 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44066/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:56 INFO - PROCESS | 22730 | RSS: Main: 163868672 08:18:56 INFO - PROCESS | 22730 | 08:18:59 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44066/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:00 INFO - PROCESS | 22730 | RSS: Main: 166879232 08:19:00 INFO - PROCESS | 22730 | 08:19:03 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44066/tests/kraken/driver.html?testName=json-parse-financial) 08:19:03 INFO - PROCESS | 22730 | RSS: Main: 164343808 08:19:03 INFO - PROCESS | 22730 | 08:19:05 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:06 INFO - PROCESS | 22730 | RSS: Main: 178208768 08:19:06 INFO - PROCESS | 22730 | 08:19:07 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:08 INFO - PROCESS | 22730 | RSS: Main: 175702016 08:19:08 INFO - PROCESS | 22730 | 08:19:10 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:11 INFO - PROCESS | 22730 | RSS: Main: 187117568 08:19:11 INFO - PROCESS | 22730 | 08:19:13 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:14 INFO - PROCESS | 22730 | RSS: Main: 194076672 08:19:14 INFO - PROCESS | 22730 | 08:19:16 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:17 INFO - PROCESS | 22730 | RSS: Main: 193699840 08:19:17 INFO - PROCESS | 22730 | 08:19:18 INFO - PROCESS | 22730 | Cycle 1(1): loaded http://localhost:44066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44066/tests/kraken/driver.html?testName=ai-astar) 08:19:19 INFO - PROCESS | 22730 | RSS: Main: 251015168 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | __start_tp_report 08:19:19 INFO - PROCESS | 22730 | _x_x_mozilla_page_load 08:19:19 INFO - PROCESS | 22730 | _x_x_mozilla_page_load_details 08:19:19 INFO - PROCESS | 22730 | |i|pagename|runs| 08:19:19 INFO - PROCESS | 22730 | |0;ai-astar;108;111;106;110;111;112;100;112;113;102 08:19:19 INFO - PROCESS | 22730 | |1;audio-beat-detection;146;125;149;165;134;149;148;127;167;125 08:19:19 INFO - PROCESS | 22730 | |2;audio-dft;161;160;162;160;164;162;160;159;161;161 08:19:19 INFO - PROCESS | 22730 | |3;audio-fft;72;73;86;96;71;72;71;96;90;74 08:19:19 INFO - PROCESS | 22730 | |4;audio-oscillator;97;97;142;96;97;96;148;95;97;150 08:19:19 INFO - PROCESS | 22730 | |5;imaging-gaussian-blur;108;109;109;109;109;109;110;109;109;109 08:19:19 INFO - PROCESS | 22730 | |6;imaging-darkroom;148;146;147;145;146;145;145;145;146;145 08:19:19 INFO - PROCESS | 22730 | |7;imaging-desaturate;96;95;96;96;96;96;95;97;95;96 08:19:19 INFO - PROCESS | 22730 | |8;json-parse-financial;56;58;57;57;56;56;58;74;56;56 08:19:19 INFO - PROCESS | 22730 | |9;json-stringify-tinderbox;67;68;67;68;69;72;68;68;68;68 08:19:19 INFO - PROCESS | 22730 | |10;stanford-crypto-aes;86;86;87;88;95;86;86;87;88;94 08:19:19 INFO - PROCESS | 22730 | |11;stanford-crypto-ccm;120;124;120;125;122;113;120;122;120;122 08:19:19 INFO - PROCESS | 22730 | |12;stanford-crypto-pbkdf2;140;141;156;150;150;140;151;149;150;141 08:19:19 INFO - PROCESS | 22730 | |13;stanford-crypto-sha256-iterative;66;69;71;65;66;67;67;68;70;67 08:19:19 INFO - PROCESS | 22730 | __end_tp_report 08:19:19 INFO - PROCESS | 22730 | __start_cc_report 08:19:19 INFO - PROCESS | 22730 | _x_x_mozilla_cycle_collect,921 08:19:19 INFO - PROCESS | 22730 | __end_cc_report 08:19:19 INFO - PROCESS | 22730 | __startTimestamp1451492359112__endTimestamp 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | ------- Summary: start ------- 08:19:19 INFO - PROCESS | 22730 | Number of tests: 14 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#0] ai-astar Cycles:10 Average:108.50 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:4.75 08:19:19 INFO - PROCESS | 22730 | Values: 108.0 111.0 106.0 110.0 111.0 112.0 100.0 112.0 113.0 102.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.50 stddev:15.45 (10.4%) stddev-sans-first:16.36 08:19:19 INFO - PROCESS | 22730 | Values: 146.0 125.0 149.0 165.0 134.0 149.0 148.0 127.0 167.0 125.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 08:19:19 INFO - PROCESS | 22730 | Values: 161.0 160.0 162.0 160.0 164.0 162.0 160.0 159.0 161.0 161.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#3] audio-fft Cycles:10 Average:80.10 Median:80.00 stddev:10.66 (13.3%) stddev-sans-first:10.90 08:19:19 INFO - PROCESS | 22730 | Values: 72.0 73.0 86.0 96.0 71.0 72.0 71.0 96.0 90.0 74.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:96.50 stddev:24.36 (25.2%) stddev-sans-first:25.26 08:19:19 INFO - PROCESS | 22730 | Values: 97.0 97.0 142.0 96.0 97.0 96.0 148.0 95.0 97.0 150.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 08:19:19 INFO - PROCESS | 22730 | Values: 108.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:0.73 08:19:19 INFO - PROCESS | 22730 | Values: 148.0 146.0 147.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:19:19 INFO - PROCESS | 22730 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 97.0 95.0 96.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:5.54 (9.7%) stddev-sans-first:5.81 08:19:19 INFO - PROCESS | 22730 | Values: 56.0 58.0 57.0 57.0 56.0 56.0 58.0 74.0 56.0 56.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.42 08:19:19 INFO - PROCESS | 22730 | Values: 67.0 68.0 67.0 68.0 69.0 72.0 68.0 68.0 68.0 68.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:87.50 stddev:3.37 (3.8%) stddev-sans-first:3.47 08:19:19 INFO - PROCESS | 22730 | Values: 86.0 86.0 87.0 88.0 95.0 86.0 86.0 87.0 88.0 94.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.00 stddev:3.26 (2.7%) stddev-sans-first:3.44 08:19:19 INFO - PROCESS | 22730 | Values: 120.0 124.0 120.0 125.0 122.0 113.0 120.0 122.0 120.0 122.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:5.75 (3.8%) stddev-sans-first:5.55 08:19:19 INFO - PROCESS | 22730 | Values: 140.0 141.0 156.0 150.0 150.0 140.0 151.0 149.0 150.0 141.0 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - PROCESS | 22730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.90 (2.8%) stddev-sans-first:1.92 08:19:19 INFO - PROCESS | 22730 | Values: 66.0 69.0 71.0 65.0 66.0 67.0 67.0 68.0 70.0 67.0 08:19:19 INFO - PROCESS | 22730 | -------- Summary: end -------- 08:19:19 INFO - PROCESS | 22730 | 08:19:19 INFO - TEST-INFO | 22730: exit 0 08:19:20 INFO - TEST-OK | kraken | took 58796ms 08:19:20 INFO - TEST-START | v8_7 08:19:20 INFO - operating with platform_type : linux_ 08:19:20 INFO - Initialising browser for v8_7 test... 08:19:20 INFO - TEST-INFO | started process 22981 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVQOLbi/profile http://localhost:44066/getInfo.html) 08:19:24 INFO - PROCESS | 22981 | __metrics Screen width/height:1600/1200 08:19:24 INFO - PROCESS | 22981 | colorDepth:24 08:19:24 INFO - PROCESS | 22981 | Browser inner width/height: 1024/697 08:19:24 INFO - PROCESS | 22981 | __metrics 08:19:24 INFO - PROCESS | 22981 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:24 INFO - PROCESS | 22981 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:24 INFO - TEST-INFO | 22981: exit 0 08:19:24 INFO - Browser initialized. 08:19:24 INFO - Running cycle 1/1 for v8_7 test... 08:19:24 INFO - TEST-INFO | started process 23065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVQOLbi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:36 INFO - PROCESS | 23065 | RSS: Main: 149901312 08:19:36 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:44066/tests/v8_7/run.html (next: http://localhost:44066/tests/v8_7/run.html) 08:19:58 INFO - PROCESS | 23065 | RSS: Main: 555937792 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | __start_tp_report 08:19:58 INFO - PROCESS | 23065 | _x_x_mozilla_page_load 08:19:58 INFO - PROCESS | 23065 | _x_x_mozilla_page_load_details 08:19:58 INFO - PROCESS | 23065 | |i|pagename|runs| 08:19:58 INFO - PROCESS | 23065 | |0;Richards;166.14055490945339 08:19:58 INFO - PROCESS | 23065 | |1;DeltaBlue;191.0949742021785 08:19:58 INFO - PROCESS | 23065 | |2;Encrypt;281.6901408450704 08:19:58 INFO - PROCESS | 23065 | |3;Decrypt;5181.347150259067 08:19:58 INFO - PROCESS | 23065 | |4;RayTrace;1101.3215859030836 08:19:58 INFO - PROCESS | 23065 | |5;Earley;807.7544426494346 08:19:58 INFO - PROCESS | 23065 | |6;Boyer;12358.024691358025 08:19:58 INFO - PROCESS | 23065 | |7;RegExp;26578.947368421053 08:19:58 INFO - PROCESS | 23065 | |8;Splay;576.036866359447 08:19:58 INFO - PROCESS | 23065 | |9;NavierStokes;4845.410628019324 08:19:58 INFO - PROCESS | 23065 | __end_tp_report 08:19:58 INFO - PROCESS | 23065 | __startTimestamp1451492398338__endTimestamp 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | ------- Summary: start ------- 08:19:58 INFO - PROCESS | 23065 | Number of tests: 10 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 166.1 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 191.1 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#2] Encrypt Cycles:1 Average:281.69 Median:281.69 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 281.7 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 5181.3 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 1101.3 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#5] Earley Cycles:1 Average:807.75 Median:807.75 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 807.8 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 12358.0 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#7] RegExp Cycles:1 Average:26578.95 Median:26578.95 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 26578.9 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#8] Splay Cycles:1 Average:576.04 Median:576.04 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 576.0 08:19:58 INFO - PROCESS | 23065 | 08:19:58 INFO - PROCESS | 23065 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 08:19:58 INFO - PROCESS | 23065 | Values: 4845.4 08:19:58 INFO - PROCESS | 23065 | -------- Summary: end -------- 08:19:58 INFO - PROCESS | 23065 | 08:19:59 INFO - TEST-INFO | 23065: exit 0 08:19:59 INFO - TEST-OK | v8_7 | took 39226ms 08:19:59 INFO - SUITE-END | took 1211s 08:19:59 INFO - Completed test suite (00:20:11) 08:19:59 INFO - Working with test: dromaeo_css 08:19:59 INFO - Generating results file: dromaeo_css 08:19:59 INFO - Working with test: kraken 08:19:59 INFO - Generating results file: kraken 08:19:59 INFO - javascript benchmark 08:19:59 INFO - Working with test: v8_7 08:19:59 INFO - Generating results file: v8_7 08:19:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:19:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:19:59 INFO - process_Request line: dromaeo_css 6810.44 graph.html#tests=[[72,201,35]] 08:19:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:19:59 INFO - process_Request line: kraken 1505.40 graph.html#tests=[[232,201,35]] 08:19:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:19:59 INFO - process_Request line: v8_7 20977.28 graph.html#tests=[[230,201,35]] 08:19:59 INFO - RETURN: dromaeo_css: 6810.44 08:19:59 INFO - RETURN: kraken: 1505.40 08:19:59 INFO - RETURN: v8_7: 20977.28 08:19:59 INFO - javascript benchmark 08:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3092.659807421184, 3151.8424078796056, 3211.662775408582, 3211.823349715766, 3240.060382489078, 5020.598352131829, 5121.411037730652, 5210.6613070150415, 5217.4260831308575, 5255.947440525599, 5155.329807125068, 5165.7158856262895, 5224.8693782655455, 5268.394134674504, 5304.098303288441, 4731.313959475882, 4769.689970151946, 4773.474917759044, 4775.235962246042, 4831.299461578086, 4859.659823812334, 4884.3406140171155, 4888.266759985995, 4897.33885925399, 4918.704877707331, 4704.600108990757, 4740.976295118537, 4806.927896081562, 4826.806927722887, 4843.15244832153, 4745.406824146981, 4757.95242047582, 4787.473377928425, 4790.976045119787, 4813.687110337817, 4692.085043416535, 4731.455882573479, 4741.051789642051, 4773.331733557305, 4782.33047373368, 4935.185694360426, 4943.678660887031, 5016.498350164954, 5022.372203474566, 5025.547700706918, 5687.260656114679, 5691.0, 5693.829185124453, 5696.430356964312, 5715.428457154293, 5677.17680936262, 5689.6017278790505, 5713.685747283897, 5717.828465146053, 5724.971375143139, 5180.948190518085, 5277.076511610453, 5291.3385826771655, 5297.708626025528, 5331.093714068617, 5729.742161602738, 5739.13912913058, 5739.827805165852, 5754.223179870663, 5774.162746401748, 5525.281713377235, 5532.114861622121, 5543.390227075019, 5547.362053363834, 5580.525655319262, 5434.864128396743, 5503.284573005563, 5565.220869078333, 5608.971955140199, 5638.323401191883, 5591.832245032656, 5613.831585052455, 5616.157576363578, 5641.717914104278, 5646.97176514123, 5604.299462567179, 5615.719214039364, 5616.85957851057, 5618.325800903917, 5630.0991841305195, 4257.616814486649, 4377.409049778303, 4377.518472967971, 4378.190034843564, 4420.80106395213, 3884.669803066771, 3895.182011777502, 3926.6858651307825, 3930.1746633206776, 3961.445397644332, 5171.560417364566, 5171.974140129275, 5173.094708426086, 5174.844754657366, 5175.068487672255, 5437.429069947599, 5598.1602759586385, 5606.330918042907, 5606.775728970795, 5649.4915457608195, 5158.97420512895, 5182.714950677749, 5256.78972841082, 5262.079136151158, 5277.736113194325, 4822.324874517571, 4825.855224343275, 4827.058723548875, 4830.0, 4873.0, 5583.330000399978, 5619.943800562024, 5622.606417550814, 5624.859378515488, 5625.156226566048, 5443.129099344244, 5452.890942181055, 5534.695591742332, 5634.7464364104535, 5678.68767217807, 5661.66030038199, 5666.886662266814, 5669.0, 5681.8863622726485, 5682.857928551819, 5431.755570999236, 5536.806211782568, 5544.63959842609, 5546.61173717852, 5554.694491802989, 5554.722263886871, 5597.720113994365, 5619.943800561942, 5633.0, 5636.943630563642, 5429.995450841607, 5466.234727138283, 5467.781288748405, 5479.287692599936, 5486.204500347507, 5443.183522471661, 5462.235287059894, 5486.31421072366, 5581.665100093845, 5586.441355864381, 5474.972625136849, 5485.725713714378, 5488.094464413327, 5494.313210848644, 5504.311961004874, 5534.280543529316, 5558.527525160245, 5585.69278689676, 5594.384617692132, 5646.9152962704775, 5268.868278293074, 5273.630845840754, 5371.731413429391, 5382.703951282717, 5429.511343979061], "unit": "score", "name": "dojo.html", "value": 5169.768658249841}, {"lowerIsBetter": false, "replicates": [529.6557237795432, 529.9920501192481, 533.2827347217993, 551.5064017704153, 558.832350294912, 27898.58152127717, 28440.57339139912, 28474.85762571187, 35192.64807351926, 35864.641353586456, 38847.0, 39046.41430378547, 39278.0, 39353.40969885454, 39354.606453935456, 8424.0, 8514.403991720583, 8551.059383467813, 8561.743147705578, 8604.655813767442, 7533.7363192288, 7675.3092221700035, 10020.949895250513, 10184.28709990301, 10195.0, 9923.503824808768, 9991.400515969066, 10031.749206269866, 10048.346857454242, 10053.798924021516, 7507.549547027196, 7664.846703065908, 9918.256130790183, 9941.65204217849, 9999.50002499872, 7385.9630701846145, 10075.193984481224, 10270.9486452568, 10277.280590358603, 10283.125934295595, 36058.09854753626, 36102.0, 36356.81821590875, 36554.63445365566, 36556.817215914016, 3313.3207692422993, 3378.273671160712, 3393.881214157517, 3696.3346597612417, 3905.8253250282887, 27976.160715178576, 28170.15489535317, 28346.14961551136, 28562.285942851388, 28587.285317867012, 3550.1124718820297, 3607.134287770916, 3614.475900994341, 3641.745077844552, 3694.6674799267926, 272957.0, 274007.0, 274521.62739186373, 274545.0, 274640.0, 51358.743206284475, 52554.73722631439, 57238.42761572414, 57612.0, 57780.0, 62043.37956620376, 63223.6838815803, 63257.0, 63280.68359658265, 63331.0, 13521.59435216945, 13837.169769813843, 13842.446302148002, 13843.131177290938, 13845.792313115311, 11044.723881903017, 11144.164187685956, 11160.218784684994, 11204.15968802343, 11208.831867521994, 18618.0, 18806.341778037702, 18856.622867542574, 19522.219111235674, 19617.509562260773, 7002.194747603989, 7037.824054398681, 7138.785836424916, 7230.2046774854725, 7339.376153026946, 962.7015625156224, 1033.6227277043974, 1033.8449232615017, 1042.817506936283, 1066.2642776484201, 27994.0, 28198.71801282002, 28335.71664283372, 28590.0, 28688.426231475252, 1050.3907733514543, 1145.2441388683596, 1172.3903570143477, 1179.6578992092197, 1211.0674780419029, 14908.701825963637, 15186.544403667907, 15400.19757915655, 15488.84511154874, 15569.766453503207, 313657.0, 323651.0, 323958.0, 326096.0, 328940.0, 50710.492895071315, 51060.48939510557, 51134.74432627887, 51137.744311278206, 51293.7435312821, 1366.296357375952, 1369.383777300219, 1381.894484412466, 1393.4217299820664, 1394.1286695815115, 25393.873030634728, 28125.0, 28279.151625451268, 28416.289592760346, 29370.559441607966, 41026.79486602548, 41383.586164137974, 41530.0, 41666.375004375564, 41741.58258417377, 197930.0, 198822.0, 199568.0, 199643.0, 200195.0, 30213.546796797626, 30776.0, 31097.68902310948, 31550.842245788623, 31560.053198404086, 37324.62675373212, 37389.08872901613, 37643.62356376401, 37781.0, 38186.0, 32088.5186722204, 32273.0, 32475.35049299048, 32703.509447357832, 32782.672173278916, 29139.417211656073, 32390.35219295648, 33440.33119337551, 33895.83052084724, 35503.64496355003, 32843.0, 32852.67147328592, 33108.66891331056, 33140.0, 36042.27915441729, 27841.092649565177, 29008.709912901446, 30193.0, 30317.545236821905, 30328.848355758964, 23317.76682233156, 23638.29085127449, 25181.370465738502, 25363.11229107046, 25803.0], "unit": "score", "name": "ext.html", "value": 17772.71565576816}, {"lowerIsBetter": false, "replicates": [334.43146650693825, 339.78423700949895, 343.962164161942, 345.0838025043509, 347.5152162732989, 14055.648608784786, 14418.783718244234, 16080.919595402022, 16191.919040404797, 17010.999999999985, 15896.84103158968, 16027.519174424757, 16078.919605401956, 16094.919525402385, 16102.919485402586, 5047.343845300115, 5302.575793936495, 5311.2298716686055, 5319.441458646825, 5323.1749078892835, 3964.960350396488, 4083.5508094109623, 5242.449542797989, 5765.625234359774, 5952.077427998667, 5808.912866307009, 5858.941410585903, 5861.443162899518, 5880.794172203952, 5885.941140588604, 5699.2306038684665, 5836.708164591753, 5842.766289348442, 5843.474087332118, 5847.122931560258, 5113.130767769451, 5128.025675121715, 5130.71781052042, 5132.076226279269, 5136.280920671109, 18102.818971810375, 18328.083595820157, 18732.90633546837, 18989.43642608244, 19018.334358297532, 2088.98955505223, 2092.215419217793, 2118.1527389044504, 2186.1364760919346, 2220.04538048639, 8466.0, 8591.914080859175, 8945.55272236392, 9604.279679024101, 9760.267979901464, 1733.8006129295165, 1762.4272111563794, 1769.3984045424488, 1773.654137443199, 1776.8223177682257, 52913.735431322595, 53213.201801973, 54445.0, 56550.0, 58449.0, 9859.50702464874, 10214.0, 10264.538095785707, 10289.684820915234, 10317.432541210306, 13266.07137500385, 13269.07116501855, 13271.137376070525, 13275.867241327656, 13302.736240057178, 7666.769996900102, 7736.574488403192, 7753.573553454614, 7764.301212890754, 7808.297253247121, 7598.316151546387, 7644.579548124795, 7647.0, 7647.847043059219, 7697.345725613273, 4400.163968845909, 4459.241928872099, 4463.486699029653, 4474.0604473060375, 4481.887952801141, 1634.133909028217, 1697.2192791316133, 1753.219817181342, 1814.7878255487976, 1821.0, 934.1079269297804, 950.6815216902415, 997.546116516983, 1012.1902478017704, 1032.8244198486275, 16773.7483937741, 16870.15649217534, 16881.071541065114, 17004.234809433605, 17139.468123280483, 959.3045042344245, 969.1713584884963, 973.7808992976524, 1017.1710056304089, 1040.8750949886062, 9570.521473926276, 9684.51577421126, 9746.707598772047, 9751.366161199641, 9772.169365604002, 527798.0, 528019.0, 538426.0, 542090.0, 543265.0, 73420.0, 74503.62748186225, 75255.0, 75690.62154689191, 76761.23238767653, 1085.8371244313573, 1097.7914196302677, 1153.135148638521, 1170.9121815863843, 1182.781185480689, 14813.0, 15107.39570417215, 15258.0, 15327.003744756556, 15539.766903496682, 33170.5024424629, 34346.313073738886, 34810.82594587011, 34982.82508587441, 35125.29749405049, 43750.343744843216, 44890.0, 45084.77457612691, 45343.7732811347, 47647.76176119097, 9548.283878708986, 9593.13661770444, 9859.161971232526, 9865.852012219679, 9867.40795552269, 11627.244229125079, 11709.590164344207, 12657.746845062862, 14708.705825883208, 17605.73591396156, 14448.638784030063, 14539.854601454274, 14618.976671632883, 14714.632134196303, 15149.166795826335, 13607.251601161635, 13770.65573360674, 13900.096493727875, 14240.501582444565, 14771.778423323443, 11292.825238819836, 11882.405879706153, 12063.526976969875, 13327.933360333136, 13684.52104176349, 9314.161725444743, 9350.95324523373, 9463.952680236831, 9557.330986831133, 9577.952110239683, 12776.233425994471, 13090.607281781562, 13262.33688315561, 13334.666633334244, 13395.598132056053], "unit": "score", "name": "jquery.html", "value": 8692.911934115275}, {"lowerIsBetter": false, "replicates": [1328.2893651896238, 1440.8631180037892, 1456.9125852448853, 1597.400974634512, 1783.857291416686, 6401.23185217774, 6961.825954351138, 7010.263922288156, 7028.051213086232, 7045.718171273155, 6811.080504131941, 6920.723171073151, 6926.099607051076, 6983.0, 7027.0, 1970.6255811395788, 2003.7896020917813, 2159.995602045045, 2163.405063607505, 2205.2502149269244, 2193.4187440328246, 2200.8899555022185, 2202.262242148874, 2203.4821816873023, 2206.8013878750908, 2089.8119169274764, 2179.2917301876873, 2180.6292930201903, 2188.2341180586827, 2188.3872515695552, 2179.3788770200495, 2190.616642087636, 2209.856359336646, 2214.1032881682945, 2219.7336319641586, 2226.0428015953134, 2233.8994745236505, 2262.4457008032973, 2262.875541845198, 2262.8981695823563, 7067.964660176717, 7188.388986936116, 7206.855862882765, 7214.350708436214, 7217.170025447036, 4401.493828209733, 4428.623566996809, 4477.037436951038, 4483.753393563353, 4485.798139083749, 2877.4820532304175, 2956.659984101834, 2986.7461265792435, 2999.910002699901, 3003.174127115039, 936.1153709744294, 945.5272363818091, 946.2099147212086, 960.8469836196592, 968.5593055159885, 9821.508924553744, 9846.65536706219, 9847.310688251826, 9848.60605575776, 9852.211823054138, 4042.4542686737504, 4094.4472496213225, 4116.320807066861, 4153.605407486284, 4155.771432571177, 8384.958075209584, 8452.1547845215, 8456.704015359433, 8460.78848028792, 8472.322214222848, 4523.389342438729, 4529.0, 4531.682782205214, 4557.498675145731, 4563.817447302137, 4145.419641250227, 4177.91644167121, 4177.979110104491, 4181.142865712522, 4186.1836941796055, 3222.7905186162825, 3275.361304545638, 3459.7405194610506, 3485.5120283160377, 3504.456809194579, 1125.9887401126048, 1130.773845230957, 1131.5586921100778, 1145.6906635208447, 1147.3689470791032, 1054.5887104029434, 1055.646358469921, 1102.0081926266425, 1187.4122309456702, 1299.5516546791341, 6724.630145342053, 6744.595324280559, 6783.966080169567, 6797.388235058868, 6807.795766127024, 1122.5060973171942, 1125.5610311978335, 1130.5816847766214, 1137.2778285788418, 1144.6852115668257, 5432.130859062531, 5497.642653227607, 5499.037668408093, 5525.668459892339, 5528.087865502228, 7954.403419743427, 8102.0, 8159.184081591793, 8271.33829293655, 8505.0, 8063.5968201589685, 8219.054808696957, 8262.215089566482, 8269.62786674601, 8276.08963014068, 6555.737770489127, 6617.272100068989, 6717.865642687118, 6746.561473504206, 6769.1876974763345, 6631.602103873783, 6691.464682825265, 6701.296363881722, 6703.966480167568, 6708.966455167693, 7674.8081297968, 7730.690772369042, 7772.844543108993, 7858.0, 7877.330426913776, 7822.217778222132, 7893.723719669784, 7942.523448593103, 7966.880496792437, 8020.799480013046, 6354.26925903527, 6419.45434638061, 6424.871502570016, 6455.580387274812, 6472.805815825533, 6194.4115309045565, 6285.340039295808, 6710.6309152997055, 6855.828604284933, 6932.341427564374, 6373.74505019794, 6449.097126402214, 6480.546361754632, 6532.934670653232, 6565.96717016431, 6270.467010304175, 6276.905846412399, 6311.305756366888, 6478.060681201106, 6487.0, 6321.873562528632, 6444.162258906312, 6455.741770329322, 6463.418292353711, 6469.029645553204, 6005.159277701038, 6031.095335699505, 6041.154238406714, 6048.0, 6049.546284028627, 5700.429957004267, 5722.685252311163, 5785.942140578541, 5909.0, 5961.582689211714], "unit": "score", "name": "mootools.html", "value": 4205.449327905994}, {"lowerIsBetter": false, "replicates": [313.6596792480159, 320.5992509363295, 325.9934801303974, 328.2646871008941, 337.360701470713, 5899.380565040673, 5906.05503119501, 5918.4081591840795, 5928.584999050068, 5938.228030356053, 5637.267155269809, 5755.6258843175165, 5758.596898217126, 5855.4144585541535, 5896.496393419672, 4542.591166794988, 4555.20283950309, 4556.179887620227, 4561.0649816787645, 4561.475430325505, 4336.8265269389185, 4543.182227199103, 4562.270036794113, 4563.954360456402, 4568.497465278817, 4346.043870348518, 4380.956190438087, 4484.618807401374, 4492.573205545485, 4504.054148628792, 4423.623991960687, 4424.889377765549, 4449.31035689467, 4472.619827314682, 4479.238529450001, 3899.395593682984, 3925.7055720820767, 3932.3315036443873, 3940.54683711374, 3942.546607140187, 5474.72626368684, 5571.359293681197, 5610.214569960168, 5611.046122159243, 5625.46558076982, 5304.814331498379, 5309.123994540896, 5310.336207974004, 5318.468153184689, 5320.946790532123, 6243.219597550306, 6251.78118765841, 6255.280642726099, 6258.3428739982555, 6260.499160067184, 4441.133978874121, 4456.442944631921, 4457.175422546807, 4457.64338852891, 4460.843870464518, 6386.489080873519, 6568.408843204134, 6571.2771595124495, 6581.111549940744, 6591.769288074895, 4570.862874113782, 4572.862814115582, 4574.588287054181, 4578.9771051144535, 4579.313103034505, 4639.536046395401, 4640.559146881041, 4641.350210970467, 4642.628589712815, 4643.024964757439, 5297.8145764898045, 5298.0, 5300.31095957523, 5307.548858347007, 5330.813421530305, 6191.226096737908, 6348.904766428507, 6355.872882542323, 6356.237251529754, 6368.808935731936, 1610.919454027294, 1615.8545730884277, 1616.6281755196371, 1617.159077279808, 1620.5462470508276, 1104.6520346090956, 1108.695108845074, 1113.5991043224433, 1115.5928086248623, 1136.8749437561862, 5935.73289201987, 5941.435563621449, 5948.167256584082, 5950.375210602911, 5950.940490595125, 6505.869882602321, 6511.446527045254, 6513.250976137805, 6514.1531600891585, 6516.869662606721, 5781.075027995501, 5849.385814489502, 5920.2007728956905, 6001.4298641628975, 6010.9699451502465, 3512.666296701809, 3539.911502212414, 3542.4155014422845, 3544.858205671744, 3548.5741710994844, 6675.599464032173, 6683.43190828785, 6684.0, 6690.933090669128, 6696.497762667819, 6654.8060291574, 6735.797926062226, 6764.729410823512, 6767.729290828312, 6779.186497620317, 6662.367075127952, 6669.666516674244, 6678.933210667831, 6680.665966701743, 6691.498137639794, 6437.8390540235, 6514.413702766774, 6518.869622607616, 6525.053867189136, 6572.244191917991, 6388.552801303864, 6430.807075787734, 6444.516661250519, 6491.0, 6502.707378167899, 6641.50188735837, 6666.000099985041, 6670.899936500859, 6684.06423100776, 6685.732570697118, 4601.608863246662, 4601.884952876205, 4603.700759450625, 4605.769711514344, 4609.562091601292, 6473.77341793035, 6580.045893345534, 6590.505712071518, 6592.70332835014, 6601.669916504059, 6375.9362406377195, 6394.26465956421, 6394.729870895951, 6403.039544068427, 6417.550771445954, 6375.426211640789, 6392.93607063942, 6393.2967373587935, 6407.551471397144, 6416.101745755691, 6072.392760723892, 6248.218972628421, 6283.59156654816, 6295.464885484785, 6302.495800336053, 6390.041493775971, 6391.392817682313, 6395.976643737165, 6397.368670988868, 6400.711967961546, 6238.220222472191, 6244.812655620339, 6247.656378899204, 6252.437280644764, 6262.0], "unit": "score", "name": "prototype.html", "value": 4766.783318683827}, {"lowerIsBetter": false, "replicates": [731.1628185727345, 733.065341689346, 772.09279097061, 863.6372723456147, 870.1385628228054, 11985.0, 12185.147039707224, 12203.145779795417, 12217.816732748994, 12226.633201003973, 9237.538123093853, 11339.716507087327, 11400.600978965738, 11434.542618295258, 11491.253068550539, 817.5421763812284, 837.0875745437472, 837.1753822484848, 837.4305472278847, 838.6771093129158, 822.7449490657915, 825.3685930263354, 831.5010993403939, 832.675256649907, 833.2417500074934, 859.8409294280547, 864.7449002544233, 867.5835598912525, 870.1081391573624, 876.7808047988003, 869.0744357259498, 870.5908223135116, 872.2760109109424, 872.7818045488627, 874.1782724239195, 643.8454770855008, 644.1175589442447, 645.1387397823911, 645.686841881687, 645.699749616426, 10697.358158510437, 10832.941741069171, 10899.12806975448, 10907.18196135293, 10911.399873006982, 10194.133498652624, 10301.381917084924, 10451.529681164366, 10614.946925265402, 10685.626003089932, 9944.602215911355, 9960.0, 10069.0, 10121.139703125244, 10149.797004059952, 3654.8720794772057, 3669.2294618130227, 3684.1342284563107, 3748.5126933498473, 3810.1046254130256, 45558.0, 46369.30446043278, 46481.51388645831, 46737.76631116857, 46840.0, 9397.530123493798, 9676.612935482643, 9820.607175712892, 9905.851412228822, 10250.384976901261, 17376.21807018687, 17409.564760880825, 17436.302547897943, 17439.389621363192, 17441.7383739244, 6858.931410685829, 6904.896426553606, 6942.305769423017, 7187.1734750504365, 7226.241244669339, 3843.8846834595006, 3967.3652215645934, 4043.8989025274605, 4096.897577560525, 4175.0188705654145, 3067.8772849085785, 3101.069679096262, 3101.7518598512065, 3103.9844800776305, 3105.223694076481, 531.5773959702046, 537.9462053794589, 551.4210079416677, 562.1567648527209, 568.8236646639555, 624.537841996919, 640.2157357237347, 643.2988043033116, 680.6086500262369, 694.5344028698102, 8363.498190108612, 8367.748967530984, 8434.367422443342, 8447.619857106321, 8533.871991920127, 662.2615783401569, 665.733706517397, 679.8062552172607, 697.8011266788941, 755.3956834532352, 3860.6911447084167, 4153.210889930903, 4243.766592837424, 4276.593723596254, 4342.0, 59387.0, 59437.70281148653, 59660.0, 59688.0, 60020.0, 46087.0, 46347.768261158475, 52932.0, 53280.33598320068, 54116.72941635267, 51258.99999999925, 51424.48575514197, 51443.228351574006, 51734.22398664023, 53292.0, 8422.957885210535, 8490.617922193393, 8515.446495977742, 8674.262687671619, 8878.467291962503, 32195.35609287848, 32802.50796238011, 33667.32665346728, 35809.0, 35880.4617930726, 43650.34524482199, 43744.90637734082, 43805.34291985686, 46393.53606463892, 47194.52805471901, 10674.146068314361, 10768.569257229623, 11082.833757493483, 11192.72018199519, 11240.494177762184, 12531.12282140278, 12580.87419125797, 12670.936645316715, 13123.803142952673, 13126.803097953729, 11191.2725672831, 11332.716682083013, 12016.939915300367, 12322.075844311534, 12424.0, 11673.533058677558, 11726.41367931617, 12032.27806331623, 12070.818937716116, 12312.322822244505, 11505.827412588651, 11701.180917335705, 11884.049276058067, 12019.819702704292, 12145.939270303592, 9612.387612387613, 9666.709998700051, 9891.851622225528, 9972.451515166735, 10185.134263587677, 8417.452865563719, 8897.555122243992, 8929.196372326522, 9325.487098209664, 9349.719508414759], "unit": "score", "name": "yui.html", "value": 6231.3871790680505}], "name": "dromaeo_css", "value": 6810.444069917935}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 106.0, 110.0, 111.0, 112.0, 100.0, 112.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [146.0, 125.0, 149.0, 165.0, 134.0, 149.0, 148.0, 127.0, 167.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 160.0, 164.0, 162.0, 160.0, 159.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 96.0, 71.0, 72.0, 71.0, 96.0, 90.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 96.0, 97.0, 96.0, 148.0, 95.0, 97.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 57.0, 56.0, 56.0, 58.0, 74.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 72.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 88.0, 95.0, 86.0, 86.0, 87.0, 88.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.3}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 120.0, 125.0, 122.0, 113.0, 120.0, 122.0, 120.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 156.0, 150.0, 150.0, 140.0, 151.0, 149.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 71.0, 65.0, 66.0, 67.0, 67.0, 68.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1505.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [281.6901408450704], "unit": "score", "name": "Encrypt", "value": 944.9425500000004}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [807.7544426494346], "unit": "score", "name": "Earley", "value": 825.0811940000001}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [26578.947368421053], "unit": "score", "name": "RegExp", "value": 34.27468316831682}, {"lowerIsBetter": false, "replicates": [576.036866359447], "unit": "score", "name": "Splay", "value": 141.46837599999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20977.27598936182}]} 08:19:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20977.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6810.44"}}} 08:19:59 INFO - Return code: 0 08:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:19:59 INFO - # TBPL SUCCESS # 08:19:59 INFO - Running post-action listener: _resource_record_post_action 08:19:59 INFO - Running post-run listener: _resource_record_post_run 08:20:00 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 561565696; Read time: 332; Write time: 560984 08:20:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 252796928; Read time: 176; Write time: 357896 08:20:00 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 308768768; Read time: 156; Write time: 203088 08:20:00 INFO - Running post-run listener: _upload_blobber_files 08:20:00 INFO - Blob upload gear active. 08:20:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:20:00 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 08:20:00 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'] 08:20:00 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 08:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:02 INFO - (blobuploader) - INFO - Done attempting. 08:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:04 INFO - (blobuploader) - INFO - Done attempting. 08:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:04 INFO - Return code: 0 08:20:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d9fb60a4f62a154649cef133bfefd1c3ad8a88e109ae792c34a8cafd76d0e295992430fd593f3238777d9d8ac99eb3fb93229a900a6233b89032e31f862b72c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/155b9085073b73bc01dbed837abe9ed40c981b5daa7138197776ff74fec40ff9296d807e8b2dd4fa43b9e5ea1de58960f0a0c1a04e45f961090029a5bc27da7c"} 08:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:20:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:20:04 INFO - Contents: 08:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/d9fb60a4f62a154649cef133bfefd1c3ad8a88e109ae792c34a8cafd76d0e295992430fd593f3238777d9d8ac99eb3fb93229a900a6233b89032e31f862b72c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/155b9085073b73bc01dbed837abe9ed40c981b5daa7138197776ff74fec40ff9296d807e8b2dd4fa43b9e5ea1de58960f0a0c1a04e45f961090029a5bc27da7c"} 08:20:04 INFO - Copying logs to upload dir... 08:20:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.742167 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-30 08:20:03.586328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 08:20:03.589966) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 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/d9fb60a4f62a154649cef133bfefd1c3ad8a88e109ae792c34a8cafd76d0e295992430fd593f3238777d9d8ac99eb3fb93229a900a6233b89032e31f862b72c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/155b9085073b73bc01dbed837abe9ed40c981b5daa7138197776ff74fec40ff9296d807e8b2dd4fa43b9e5ea1de58960f0a0c1a04e45f961090029a5bc27da7c"} build_url:https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/ID6SoSXAS8OyYKhhNzVmIg/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/d9fb60a4f62a154649cef133bfefd1c3ad8a88e109ae792c34a8cafd76d0e295992430fd593f3238777d9d8ac99eb3fb93229a900a6233b89032e31f862b72c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/155b9085073b73bc01dbed837abe9ed40c981b5daa7138197776ff74fec40ff9296d807e8b2dd4fa43b9e5ea1de58960f0a0c1a04e45f961090029a5bc27da7c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 08:20:03.615216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:20:03.615575) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1451489501.478080-155628397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:20:03.698508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:20:03.698832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:20:03.699145) ========= ========= Total master_lag: 0.20 =========