builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1452870344.68 results: success (0) buildid: 20160115053010 builduid: 417d7b4b9e0b494ebe0a45a128f2e222 revision: ec373454cfa0ed618469564ea0e2a19003b6c213 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.682475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.683042) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.683388) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.707005) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.707329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.725084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.725402) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.774943) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.775283) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.775735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.776048) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 07:05:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-15 07:05:45 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.968104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:44.968478) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017688 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.018533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.018923) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev ec373454cfa0ed618469564ea0e2a19003b6c213 --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 ec373454cfa0ed618469564ea0e2a19003b6c213 --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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 07:05:45,146 truncating revision to first 12 chars 2016-01-15 07:05:45,146 Setting DEBUG logging. 2016-01-15 07:05:45,146 attempt 1/10 2016-01-15 07:05:45,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/ec373454cfa0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 07:05:45,415 unpacking tar archive at: b2g-inbound-ec373454cfa0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.597670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.598011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.607313) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.607642) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:05:45.608122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 07:05:45.608447) ========= /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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:45 INFO - MultiFileLogger online at 20160115 07:05:45 in /builds/slave/test-pgo 07:05:45 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:05:45 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:05:45 INFO - {'append_to_log': False, 07:05:45 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:05:45 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:05:45 INFO - 'branch': 'B2G-Inbound', 07:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:45 INFO - 'config_files': ('talos/linux_config.py',), 07:05:45 INFO - 'default_actions': ('clobber', 07:05:45 INFO - 'read-buildbot-config', 07:05:45 INFO - 'download-and-extract', 07:05:45 INFO - 'populate-webroot', 07:05:45 INFO - 'create-virtualenv', 07:05:45 INFO - 'install', 07:05:45 INFO - 'run-tests'), 07:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:45 INFO - 'download_minidump_stackwalk': True, 07:05:45 INFO - 'download_symbols': 'ondemand', 07:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:45 INFO - 'installer_path': 'installer.exe', 07:05:45 INFO - 'log_level': 'info', 07:05:45 INFO - 'log_name': 'talos', 07:05:45 INFO - 'log_to_console': True, 07:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:45 INFO - 'opt_config_files': (), 07:05:45 INFO - 'pip_index': False, 07:05:45 INFO - 'sps_profile': False, 07:05:45 INFO - 'sps_profile_interval': 0, 07:05:45 INFO - 'suite': 'dromaeojs', 07:05:45 INFO - 'system_bits': '32', 07:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:45 INFO - 'title': 'talos-linux64-ix-035', 07:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:45 INFO - 'use_talos_json': True, 07:05:45 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:45 INFO - 'work_dir': 'build'} 07:05:45 INFO - ##### 07:05:45 INFO - ##### Running clobber step. 07:05:45 INFO - ##### 07:05:45 INFO - Running pre-action listener: _resource_record_pre_action 07:05:45 INFO - Running main action method: clobber 07:05:45 INFO - rmtree: /builds/slave/test-pgo/build 07:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:05:46 INFO - Running post-action listener: _resource_record_post_action 07:05:46 INFO - ##### 07:05:46 INFO - ##### Running read-buildbot-config step. 07:05:46 INFO - ##### 07:05:46 INFO - Running pre-action listener: _resource_record_pre_action 07:05:46 INFO - Running main action method: read_buildbot_config 07:05:46 INFO - Using buildbot properties: 07:05:46 INFO - { 07:05:46 INFO - "project": "", 07:05:46 INFO - "product": "firefox", 07:05:46 INFO - "script_repo_revision": "production", 07:05:46 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:05:46 INFO - "repository": "", 07:05:46 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:05:46 INFO - "buildid": "20160115053010", 07:05:46 INFO - "pgo_build": "True", 07:05:46 INFO - "basedir": "/builds/slave/test-pgo", 07:05:46 INFO - "buildnumber": 17, 07:05:46 INFO - "slavename": "talos-linux64-ix-035", 07:05:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:05:46 INFO - "platform": "ubuntu64_hw", 07:05:46 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:05:46 INFO - "branch": "b2g-inbound", 07:05:46 INFO - "repo_path": "integration/b2g-inbound", 07:05:46 INFO - "revision": "ec373454cfa0ed618469564ea0e2a19003b6c213", 07:05:46 INFO - "stage_platform": "linux64-pgo", 07:05:46 INFO - "builduid": "417d7b4b9e0b494ebe0a45a128f2e222", 07:05:46 INFO - "slavebuilddir": "test" 07:05:46 INFO - } 07:05:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:05:46 INFO - Running post-action listener: _resource_record_post_action 07:05:46 INFO - ##### 07:05:46 INFO - ##### Running download-and-extract step. 07:05:46 INFO - ##### 07:05:46 INFO - Running pre-action listener: _resource_record_pre_action 07:05:46 INFO - Running main action method: download_and_extract 07:05:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:05: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:05:46 INFO - https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/test_packages.json 07:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/test_packages.json 07:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:05:47 INFO - Downloaded 1448 bytes. 07:05:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:05:47 INFO - Using the following test package requirements: 07:05:47 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:47 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:47 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:05:47 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'jsshell-linux-x86_64.zip'], 07:05:47 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:47 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:47 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:05:47 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:05:47 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:47 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:47 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:47 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05:47 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:05:47 INFO - https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:52 INFO - Downloaded 22440723 bytes. 07:05:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:05:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:05:53 INFO - Return code: 0 07:05:53 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:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:53 INFO - https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:56 INFO - Downloaded 22440723 bytes. 07:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:05:57 INFO - Return code: 0 07:05: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:05:57 INFO - https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:05:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:59 INFO - Downloaded 11132144 bytes. 07:05:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:05:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:05:59 INFO - Return code: 0 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:59 INFO - https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/THzJx7OGSBCPF8j8WT0mmA/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:06:02 INFO - Downloaded 55942780 bytes. 07:06:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:02 INFO - mkdir: /builds/slave/test-pgo/properties 07:06:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:06:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:06:02 INFO - Contents: 07:06:02 INFO - build_url:https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:02 INFO - Running post-action listener: _resource_record_post_action 07:06:02 INFO - Running post-action listener: set_extra_try_arguments 07:06:02 INFO - ##### 07:06:02 INFO - ##### Running populate-webroot step. 07:06:02 INFO - ##### 07:06:02 INFO - Running pre-action listener: _resource_record_pre_action 07:06:02 INFO - Running main action method: populate_webroot 07:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:02 INFO - '--tppagecycles', 07:06:02 INFO - '7'], 07:06:02 INFO - 'tests': ['tsvgm']}}, 07:06:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:06:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'tests': ['damp', 'tps']}, 07:06:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['damp', 'tps']}, 07:06:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:02 INFO - 'other': {'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'other_l64': {'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'other_nol64': {'tests': ['a11yr', 07:06:02 INFO - 'ts_paint', 07:06:02 INFO - 'tpaint', 07:06:02 INFO - 'sessionrestore', 07:06:02 INFO - 'sessionrestore_no_auto_restore']}, 07:06:02 INFO - 'svgr': {'tests': ['tsvgx', 07:06:02 INFO - 'tsvgr_opacity', 07:06:02 INFO - 'tart', 07:06:02 INFO - 'tscrollx', 07:06:02 INFO - 'cart']}, 07:06:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['tsvgx', 07:06:02 INFO - 'tsvgr_opacity', 07:06:02 INFO - 'tart', 07:06:02 INFO - 'tscrollx', 07:06:02 INFO - 'cart']}, 07:06:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'tests': ['tp5o']}, 07:06:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'talos_options': ['--e10s'], 07:06:02 INFO - 'tests': ['tp5o']}, 07:06:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'talos_options': ['--xperf_path', 07:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:02 INFO - 'tests': ['tp5n']}, 07:06:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:02 INFO - 'talos_options': ['--e10s', 07:06:02 INFO - '--xperf_path', 07:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:02 INFO - 'tests': ['tp5n']}}, 07:06:02 INFO - 'talos.zip': {'path': '', 07:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:02 INFO - Running post-action listener: _resource_record_post_action 07:06:02 INFO - ##### 07:06:02 INFO - ##### Running create-virtualenv step. 07:06:02 INFO - ##### 07:06:02 INFO - Running pre-action listener: _resource_record_pre_action 07:06:02 INFO - Running main action method: create_virtualenv 07:06:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:06:02 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:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:02 INFO - Using real prefix '/usr' 07:06:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:05 INFO - Installing pip.................done. 07:06:05 INFO - Return code: 0 07:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:06: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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:05 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 07:06:05 INFO - 'HOME': '/home/cltbld', 07:06:05 INFO - 'LANG': 'en_US.UTF-8', 07:06:05 INFO - 'LANGUAGE': 'en_US:en', 07:06:05 INFO - 'LOGNAME': 'cltbld', 07:06:05 INFO - 'MAIL': '/var/mail/cltbld', 07:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:05 INFO - 'MOZ_NO_REMOTE': '1', 07:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:05 INFO - 'NO_EM_RESTART': '1', 07:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:05 INFO - 'SHELL': '/bin/bash', 07:06:05 INFO - 'SHLVL': '1', 07:06:05 INFO - 'TERM': 'linux', 07:06:05 INFO - 'TMOUT': '86400', 07:06:05 INFO - 'USER': 'cltbld', 07:06:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:05 INFO - '_': '/tools/buildbot/bin/python'} 07:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:05 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:06:05 INFO - Cleaning up... 07:06:05 INFO - Return code: 0 07:06:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:06: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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:05 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 07:06:05 INFO - 'HOME': '/home/cltbld', 07:06:05 INFO - 'LANG': 'en_US.UTF-8', 07:06:05 INFO - 'LANGUAGE': 'en_US:en', 07:06:05 INFO - 'LOGNAME': 'cltbld', 07:06:05 INFO - 'MAIL': '/var/mail/cltbld', 07:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:05 INFO - 'MOZ_NO_REMOTE': '1', 07:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:05 INFO - 'NO_EM_RESTART': '1', 07:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:05 INFO - 'SHELL': '/bin/bash', 07:06:05 INFO - 'SHLVL': '1', 07:06:05 INFO - 'TERM': 'linux', 07:06:05 INFO - 'TMOUT': '86400', 07:06:05 INFO - 'USER': 'cltbld', 07:06:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:05 INFO - '_': '/tools/buildbot/bin/python'} 07:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:05 INFO - Downloading/unpacking psutil>=0.7.1 07:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:06:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:06:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:07 INFO - Installing collected packages: psutil 07:06:07 INFO - Running setup.py install for psutil 07:06:07 INFO - building 'psutil._psutil_linux' extension 07:06:07 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:06:07 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:06:07 INFO - building 'psutil._psutil_posix' extension 07:06:07 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:06:08 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:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:08 INFO - Successfully installed psutil 07:06:08 INFO - Cleaning up... 07:06:08 INFO - Return code: 0 07:06:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:06:08 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:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 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:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:08 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:06:08 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:06:08 INFO - Using env: {'DISPLAY': ':0', 07:06:08 INFO - 'HOME': '/home/cltbld', 07:06:08 INFO - 'LANG': 'en_US.UTF-8', 07:06:08 INFO - 'LANGUAGE': 'en_US:en', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MAIL': '/var/mail/cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SHLVL': '1', 07:06:08 INFO - 'TERM': 'linux', 07:06:08 INFO - 'TMOUT': '86400', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - '_': '/tools/buildbot/bin/python'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:06:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:06:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:10 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:06:10 INFO - Installing collected packages: mozsystemmonitor 07:06:10 INFO - Running setup.py install for mozsystemmonitor 07:06:10 INFO - Successfully installed mozsystemmonitor 07:06:10 INFO - Cleaning up... 07:06:10 INFO - Return code: 0 07:06:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:06: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:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', '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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:06: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 blobuploader==1.2.4 07:06:10 INFO - Using env: {'DISPLAY': ':0', 07:06:10 INFO - 'HOME': '/home/cltbld', 07:06:10 INFO - 'LANG': 'en_US.UTF-8', 07:06:10 INFO - 'LANGUAGE': 'en_US:en', 07:06:10 INFO - 'LOGNAME': 'cltbld', 07:06:10 INFO - 'MAIL': '/var/mail/cltbld', 07:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:10 INFO - 'MOZ_NO_REMOTE': '1', 07:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:10 INFO - 'NO_EM_RESTART': '1', 07:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:10 INFO - 'SHELL': '/bin/bash', 07:06:10 INFO - 'SHLVL': '1', 07:06:10 INFO - 'TERM': 'linux', 07:06:10 INFO - 'TMOUT': '86400', 07:06:10 INFO - 'USER': 'cltbld', 07:06:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:10 INFO - '_': '/tools/buildbot/bin/python'} 07:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:10 INFO - Downloading/unpacking blobuploader==1.2.4 07:06: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:06: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:06: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:06: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:06: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:06: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:06:12 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:06:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:06:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:06:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:12 INFO - Downloading docopt-0.6.1.tar.gz 07:06:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:06:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:12 INFO - Running setup.py install for blobuploader 07:06:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:06:13 INFO - Running setup.py install for requests 07:06:13 INFO - Running setup.py install for docopt 07:06:13 INFO - Successfully installed blobuploader requests docopt 07:06:13 INFO - Cleaning up... 07:06:13 INFO - Return code: 0 07:06:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:13 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 07:06:13 INFO - 'HOME': '/home/cltbld', 07:06:13 INFO - 'LANG': 'en_US.UTF-8', 07:06:13 INFO - 'LANGUAGE': 'en_US:en', 07:06:13 INFO - 'LOGNAME': 'cltbld', 07:06:13 INFO - 'MAIL': '/var/mail/cltbld', 07:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:13 INFO - 'MOZ_NO_REMOTE': '1', 07:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:13 INFO - 'NO_EM_RESTART': '1', 07:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:13 INFO - 'SHELL': '/bin/bash', 07:06:13 INFO - 'SHLVL': '1', 07:06:13 INFO - 'TERM': 'linux', 07:06:13 INFO - 'TMOUT': '86400', 07:06:13 INFO - 'USER': 'cltbld', 07:06:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:13 INFO - '_': '/tools/buildbot/bin/python'} 07:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:13 INFO - Running setup.py (path:/tmp/pip-HCEYd3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:13 INFO - Running setup.py (path:/tmp/pip-rnxu81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:13 INFO - Running setup.py (path:/tmp/pip-WAev2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:13 INFO - Running setup.py (path:/tmp/pip-YH4URX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:14 INFO - Running setup.py (path:/tmp/pip-Z6wv28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:14 INFO - Running setup.py (path:/tmp/pip-dwLZFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:14 INFO - Running setup.py (path:/tmp/pip-WXCXfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:14 INFO - Running setup.py (path:/tmp/pip-kRMsAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:14 INFO - Running setup.py (path:/tmp/pip-fz8O3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:14 INFO - Running setup.py (path:/tmp/pip-fYtjF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:14 INFO - Running setup.py (path:/tmp/pip-SLSsK7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:14 INFO - Running setup.py (path:/tmp/pip-y6j9bV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:14 INFO - Running setup.py (path:/tmp/pip-o71fQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:14 INFO - Running setup.py (path:/tmp/pip-_Pbloy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:14 INFO - Running setup.py (path:/tmp/pip-RSu13Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:14 INFO - Running setup.py (path:/tmp/pip-N4ocgE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:14 INFO - Running setup.py (path:/tmp/pip-_0S8og-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:14 INFO - Running setup.py install for manifestparser 07:06:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Running setup.py install for mozcrash 07:06:15 INFO - Running setup.py install for mozdebug 07:06:15 INFO - Running setup.py install for mozdevice 07:06:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Running setup.py install for mozfile 07:06:15 INFO - Running setup.py install for mozhttpd 07:06:15 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Running setup.py install for mozinfo 07:06:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Running setup.py install for mozInstall 07:06:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:06:15 INFO - Running setup.py install for mozleak 07:06:15 INFO - Running setup.py install for mozlog 07:06:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Running setup.py install for moznetwork 07:06:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Running setup.py install for mozprocess 07:06:16 INFO - Running setup.py install for mozprofile 07:06:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Running setup.py install for mozrunner 07:06:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Running setup.py install for mozscreenshot 07:06:16 INFO - Running setup.py install for moztest 07:06:16 INFO - Running setup.py install for mozversion 07:06:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:06:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:16 INFO - Cleaning up... 07:06:16 INFO - Return code: 0 07:06:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:16 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:16 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:06:16 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:06:16 INFO - Using env: {'DISPLAY': ':0', 07:06:16 INFO - 'HOME': '/home/cltbld', 07:06:16 INFO - 'LANG': 'en_US.UTF-8', 07:06:16 INFO - 'LANGUAGE': 'en_US:en', 07:06:16 INFO - 'LOGNAME': 'cltbld', 07:06:16 INFO - 'MAIL': '/var/mail/cltbld', 07:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:16 INFO - 'MOZ_NO_REMOTE': '1', 07:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:16 INFO - 'NO_EM_RESTART': '1', 07:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:16 INFO - 'SHELL': '/bin/bash', 07:06:16 INFO - 'SHLVL': '1', 07:06:16 INFO - 'TERM': 'linux', 07:06:16 INFO - 'TMOUT': '86400', 07:06:16 INFO - 'USER': 'cltbld', 07:06:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:16 INFO - '_': '/tools/buildbot/bin/python'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:16 INFO - Running setup.py (path:/tmp/pip-rZrtkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:17 INFO - Running setup.py (path:/tmp/pip-NlDkZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:17 INFO - Running setup.py (path:/tmp/pip-ZHMUyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:17 INFO - Running setup.py (path:/tmp/pip-v6KX1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:17 INFO - Running setup.py (path:/tmp/pip-GMMRKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:17 INFO - Running setup.py (path:/tmp/pip-Slugxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:17 INFO - Running setup.py (path:/tmp/pip-1ct44x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:17 INFO - Running setup.py (path:/tmp/pip-7qyqOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:17 INFO - Running setup.py (path:/tmp/pip-Gxu5R3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:17 INFO - Running setup.py (path:/tmp/pip-FDD1J9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:17 INFO - Running setup.py (path:/tmp/pip-LAxzln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:17 INFO - Running setup.py (path:/tmp/pip-lva6Hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:17 INFO - Running setup.py (path:/tmp/pip-eIWlXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:17 INFO - Running setup.py (path:/tmp/pip-Xm70pe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:17 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:06:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:17 INFO - Running setup.py (path:/tmp/pip-uG02Hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:18 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:06:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:18 INFO - Running setup.py (path:/tmp/pip-KACwmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:18 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:06:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:18 INFO - Running setup.py (path:/tmp/pip-ZsbqK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:18 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:18 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:06:19 INFO - Downloading blessings-1.5.1.tar.gz 07:06:19 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:06:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:19 INFO - Installing collected packages: blessings 07:06:19 INFO - Running setup.py install for blessings 07:06:20 INFO - Successfully installed blessings 07:06:20 INFO - Cleaning up... 07:06:20 INFO - Return code: 0 07:06:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:06:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:20 INFO - Reading from file tmpfile_stdout 07:06:20 INFO - Current package versions: 07:06:20 INFO - argparse == 1.2.1 07:06:20 INFO - blessings == 1.5.1 07:06:20 INFO - blobuploader == 1.2.4 07:06:20 INFO - docopt == 0.6.1 07:06:20 INFO - manifestparser == 1.1 07:06:20 INFO - mozInstall == 1.12 07:06:20 INFO - mozcrash == 0.16 07:06:20 INFO - mozdebug == 0.1 07:06:20 INFO - mozdevice == 0.48 07:06:20 INFO - mozfile == 1.2 07:06:20 INFO - mozhttpd == 0.7 07:06:20 INFO - mozinfo == 0.9 07:06:20 INFO - mozleak == 0.1 07:06:20 INFO - mozlog == 3.1 07:06:20 INFO - moznetwork == 0.27 07:06:20 INFO - mozprocess == 0.22 07:06:20 INFO - mozprofile == 0.28 07:06:20 INFO - mozrunner == 6.11 07:06:20 INFO - mozscreenshot == 0.1 07:06:20 INFO - mozsystemmonitor == 0.0 07:06:20 INFO - moztest == 0.7 07:06:20 INFO - mozversion == 1.4 07:06:20 INFO - psutil == 3.1.1 07:06:20 INFO - requests == 1.2.3 07:06:20 INFO - wsgiref == 0.1.2 07:06:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:06:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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:06:20 INFO - Using env: {'DISPLAY': ':0', 07:06:20 INFO - 'HOME': '/home/cltbld', 07:06:20 INFO - 'LANG': 'en_US.UTF-8', 07:06:20 INFO - 'LANGUAGE': 'en_US:en', 07:06:20 INFO - 'LOGNAME': 'cltbld', 07:06:20 INFO - 'MAIL': '/var/mail/cltbld', 07:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:20 INFO - 'MOZ_NO_REMOTE': '1', 07:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:20 INFO - 'NO_EM_RESTART': '1', 07:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:20 INFO - 'SHELL': '/bin/bash', 07:06:20 INFO - 'SHLVL': '1', 07:06:20 INFO - 'TERM': 'linux', 07:06:20 INFO - 'TMOUT': '86400', 07:06:20 INFO - 'USER': 'cltbld', 07:06:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:20 INFO - '_': '/tools/buildbot/bin/python'} 07:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 INFO - Cleaning up... 07:06:20 INFO - Return code: 0 07:06:20 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:20 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:06:20 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:06:20 INFO - Using env: {'DISPLAY': ':0', 07:06:20 INFO - 'HOME': '/home/cltbld', 07:06:20 INFO - 'LANG': 'en_US.UTF-8', 07:06:20 INFO - 'LANGUAGE': 'en_US:en', 07:06:20 INFO - 'LOGNAME': 'cltbld', 07:06:20 INFO - 'MAIL': '/var/mail/cltbld', 07:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:20 INFO - 'MOZ_NO_REMOTE': '1', 07:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:20 INFO - 'NO_EM_RESTART': '1', 07:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:20 INFO - 'SHELL': '/bin/bash', 07:06:20 INFO - 'SHLVL': '1', 07:06:20 INFO - 'TERM': 'linux', 07:06:20 INFO - 'TMOUT': '86400', 07:06:20 INFO - 'USER': 'cltbld', 07:06:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:20 INFO - '_': '/tools/buildbot/bin/python'} 07:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:20 INFO - Downloading/unpacking jsonschema 07:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:20 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:06:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:22 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:06:22 INFO - Downloading/unpacking functools32 (from jsonschema) 07:06:22 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:06:22 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:06:22 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:06:22 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:06:22 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:06:22 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:06:22 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:22 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:06:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:22 INFO - warning: no files found matching '*.txt' 07:06:22 INFO - no previously-included directories found matching 'build' 07:06:22 INFO - no previously-included directories found matching 'dist' 07:06:22 INFO - no previously-included directories found matching '.git*' 07:06:22 INFO - Installing collected packages: jsonschema, functools32 07:06:22 INFO - Running setup.py install for functools32 07:06:22 INFO - warning: no files found matching '*.txt' 07:06:22 INFO - no previously-included directories found matching 'build' 07:06:22 INFO - no previously-included directories found matching 'dist' 07:06:22 INFO - no previously-included directories found matching '.git*' 07:06:22 INFO - Successfully installed jsonschema functools32 07:06:22 INFO - Cleaning up... 07:06:22 INFO - Return code: 0 07:06:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:22 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 0x7fcc01eccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2901480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, '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': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', '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:06:22 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:06:22 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:06:22 INFO - Using env: {'DISPLAY': ':0', 07:06:22 INFO - 'HOME': '/home/cltbld', 07:06:22 INFO - 'LANG': 'en_US.UTF-8', 07:06:22 INFO - 'LANGUAGE': 'en_US:en', 07:06:22 INFO - 'LOGNAME': 'cltbld', 07:06:22 INFO - 'MAIL': '/var/mail/cltbld', 07:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:22 INFO - 'MOZ_NO_REMOTE': '1', 07:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:22 INFO - 'NO_EM_RESTART': '1', 07:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:22 INFO - 'SHELL': '/bin/bash', 07:06:22 INFO - 'SHLVL': '1', 07:06:22 INFO - 'TERM': 'linux', 07:06:22 INFO - 'TMOUT': '86400', 07:06:22 INFO - 'USER': 'cltbld', 07:06:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:22 INFO - '_': '/tools/buildbot/bin/python'} 07:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:23 INFO - Downloading/unpacking flake8 07:06: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:06: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:06: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:06: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:06: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:06: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:06:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:06:24 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:06:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:06:25 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:06:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:06: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:06: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:06: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:06: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:06: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:06: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:06:25 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:06:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:06: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:06: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:06: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:06: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:06: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:06: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:06:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:06:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:06:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:25 INFO - no previously-included directories found matching 'docs/_build' 07:06:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:06:25 INFO - Running setup.py install for pep8 07:06:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:25 INFO - no previously-included directories found matching 'docs/_build' 07:06:25 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:06:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:06:25 INFO - Cleaning up... 07:06:25 INFO - Return code: 0 07:06:25 INFO - Running post-action listener: _resource_record_post_action 07:06:25 INFO - Running post-action listener: _start_resource_monitoring 07:06:25 INFO - Starting resource monitoring. 07:06:25 INFO - ##### 07:06:25 INFO - ##### Running install step. 07:06:25 INFO - ##### 07:06:25 INFO - Running pre-action listener: _resource_record_pre_action 07:06:25 INFO - Running main action method: install 07:06:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:26 INFO - Reading from file tmpfile_stdout 07:06:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:06:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:06:26 INFO - Reading from file tmpfile_stdout 07:06:26 INFO - Output received: 07:06:26 INFO - Usage: mozinstall [options] installer 07:06:26 INFO - Options: 07:06:26 INFO - -h, --help show this help message and exit 07:06:26 INFO - -d DEST, --destination=DEST 07:06:26 INFO - Directory to install application into. [default: 07:06:26 INFO - "/builds/slave/test-pgo"] 07:06:26 INFO - --app=APP Application being installed. [default: firefox] 07:06:26 INFO - mkdir: /builds/slave/test-pgo/build/application 07:06:26 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:06:26 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:06:42 INFO - Reading from file tmpfile_stdout 07:06:42 INFO - Output received: 07:06:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:06:42 INFO - Running post-action listener: _resource_record_post_action 07:06:42 INFO - ##### 07:06:42 INFO - ##### Running run-tests step. 07:06:42 INFO - ##### 07:06:42 INFO - Running pre-action listener: _resource_record_pre_action 07:06:42 INFO - Running main action method: run_tests 07:06:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:06:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:06:42 INFO - Python 2.7.3 07:06:42 INFO - Return code: 0 07:06:42 INFO - grabbing minidump binary from tooltool 07:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:42 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 0x2990660>, '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 0x2991560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2991a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:06:42 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:06:42 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:06:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:42 INFO - Return code: 0 07:06:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:06:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:06:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:06:43 INFO - Return code: 0 07:06:43 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/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:06:43 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/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:06:43 INFO - Using env: {'DISPLAY': ':0', 07:06:43 INFO - 'HOME': '/home/cltbld', 07:06:43 INFO - 'LANG': 'en_US.UTF-8', 07:06:43 INFO - 'LANGUAGE': 'en_US:en', 07:06:43 INFO - 'LOGNAME': 'cltbld', 07:06:43 INFO - 'MAIL': '/var/mail/cltbld', 07:06:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:43 INFO - 'MOZ_NO_REMOTE': '1', 07:06:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:43 INFO - 'NO_EM_RESTART': '1', 07:06:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:06:43 INFO - 'SHELL': '/bin/bash', 07:06:43 INFO - 'SHLVL': '1', 07:06:43 INFO - 'TERM': 'linux', 07:06:43 INFO - 'TMOUT': '86400', 07:06:43 INFO - 'USER': 'cltbld', 07:06:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591', 07:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:43 INFO - '_': '/tools/buildbot/bin/python'} 07:06:43 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/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:06:43 INFO - mozversion application_buildid: 20160115053010 07:06:43 INFO - mozversion application_changeset: ec373454cfa0ed618469564ea0e2a19003b6c213 07:06:43 INFO - mozversion application_display_name: Nightly 07:06:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:43 INFO - mozversion application_name: Firefox 07:06:43 INFO - mozversion application_remotingname: firefox 07:06:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:06:43 INFO - mozversion application_vendor: Mozilla 07:06:43 INFO - mozversion application_version: 46.0a1 07:06:43 INFO - mozversion platform_buildid: 20160115053010 07:06:43 INFO - mozversion platform_changeset: ec373454cfa0ed618469564ea0e2a19003b6c213 07:06:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:06:43 INFO - mozversion platform_version: 46.0a1 07:06:43 INFO - using testdate: 1452870403 07:06:43 INFO - actual date: 1452870403 07:06:43 INFO - starting webserver on 'localhost:45578' 07:06:43 INFO - SUITE-START | Running 3 tests 07:06:43 INFO - TEST-START | dromaeo_css 07:06:43 INFO - operating with platform_type : linux_ 07:06:43 INFO - Initialising browser for dromaeo_css test... 07:06:43 INFO - TEST-INFO | started process 10331 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcnnXsl/profile http://localhost:45578/getInfo.html) 07:06:47 INFO - PROCESS | 10331 | __metrics Screen width/height:1600/1200 07:06:47 INFO - PROCESS | 10331 | colorDepth:24 07:06:47 INFO - PROCESS | 10331 | Browser inner width/height: 1024/697 07:06:47 INFO - PROCESS | 10331 | __metrics 07:06:47 INFO - PROCESS | 10331 | 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:06:47 INFO - PROCESS | 10331 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:48 INFO - TEST-INFO | 10331: exit 0 07:06:48 INFO - Browser initialized. 07:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:48 INFO - TEST-INFO | started process 10425 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcnnXsl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:00 INFO - PROCESS | 10425 | RSS: Main: 150167552 07:07:00 INFO - PROCESS | 10425 | 07:07:51 INFO - PROCESS | 10425 | 1452870471679 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] 07:09:59 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45578/tests/dromaeo/cssquery-ext.html) 07:10:00 INFO - PROCESS | 10425 | RSS: Main: 271290368 07:10:00 INFO - PROCESS | 10425 | 07:13:03 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-ext.html (next: http://localhost:45578/tests/dromaeo/cssquery-jquery.html) 07:13:03 INFO - PROCESS | 10425 | RSS: Main: 231550976 07:13:03 INFO - PROCESS | 10425 | 07:16:05 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45578/tests/dromaeo/cssquery-mootools.html) 07:16:06 INFO - PROCESS | 10425 | RSS: Main: 235917312 07:16:06 INFO - PROCESS | 10425 | 07:19:08 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45578/tests/dromaeo/cssquery-prototype.html) 07:19:08 INFO - PROCESS | 10425 | RSS: Main: 212582400 07:19:08 INFO - PROCESS | 10425 | 07:22:11 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45578/tests/dromaeo/cssquery-yui.html) 07:22:11 INFO - PROCESS | 10425 | RSS: Main: 218091520 07:22:11 INFO - PROCESS | 10425 | 07:25:14 INFO - PROCESS | 10425 | Cycle 1(1): loaded http://localhost:45578/tests/dromaeo/cssquery-yui.html (next: http://localhost:45578/tests/dromaeo/cssquery-dojo.html) 07:25:15 INFO - PROCESS | 10425 | RSS: Main: 284237824 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | __start_tp_report 07:25:15 INFO - PROCESS | 10425 | _x_x_mozilla_page_load 07:25:15 INFO - PROCESS | 10425 | _x_x_mozilla_page_load_details 07:25:15 INFO - PROCESS | 10425 | |i|pagename|runs| 07:25:15 INFO - PROCESS | 10425 | |0;dojo.html;3081.9829456279417;3084.6144231971;3110.0825256549315;3123.3597112591915;3148.118526812493;4987.900241995158;5072.9746351268195;5086.186210206359;5092.643514953955;5095.617828662851;5092.949070509294;5098.209777484496;5166.380034395868;5210.140326846066;5231.947680523203;4685.484596694352;4692.41344831896;4729.78715957781;4734.4081989751285;4791.544803243686;4716.976415117937;4728.787204575802;4758.428988521365;4761.547652972962;4813.831515896944;4555;4600.194965880957;4651.86044418668;4706.435227772655;4735.692180008288;4616.146012987574;4618.769061546909;4647.117047760915;4663.0207656392195;4690.671652984292;4626.514216007305;4627.8148874045;4633.142868569325;4648.581627653493;4675.812967481296;4887.682300650446;4958.752062396866;4964.975175124137;4978.178600530908;5071.695698258116;5470;5473.0969390050595;5476.069068258405;5478;5495.670259784426;5471.972640136773;5477.507024367826;5482.17767334903;5489.258950041733;5490;5049.570786483153;5110.463401342842;5118.053160165381;5130.358705161818;5175.249588809676;5560.805371812048;5561.388247292794;5587.972060139673;5607.943920560824;5613.410591887793;5364.436734142937;5367.114426119647;5376.086065368897;5379.515843574097;5384.6769193848495;5442.047641662693;5443.591730620219;5476.808311709071;5480.095784195642;5578.553715702734;5379.35447746273;5380.24676545284;5380.596455265792;5384.219288203189;5398.541124004425;5316.813911513079;5345.732713364317;5374.973125134427;5375.086235339923;5429.077056900336;4170.311898536707;4212.4523811904255;4257.978710106429;4277.721948073366;4305.138972205571;3804.6766024888193;3819.560750513671;3830.4254361845387;3859.556151042666;3868.729188956746;5107.821226257063;5112.565431938327;5112.769925353294;5114.4629813869005;5161.225816127536;5350.705711185844;5438.945610543923;5520;5547.55619550435;5605.047141985872;5051.393832740095;5061.924071138936;5081.110805609003;5090.312807770978;5133.383993920754;4566.45202575693;4710.081534100886;4710.458297295786;4712.246040633482;4724.858254252378;5547.972260138674;5585.972070139624;5627.465390787868;5713.657180569179;5739.196512488255;5466.316710411199;5473.0695781718;5476.123820188751;5488.231647569263;5492.505674489315;5541;5675.177099320493;5703.287089113861;5708.372079071216;5709.172170035405;5315.495027972336;5319.175527793198;5447.4824891635235;5473.370562385377;5525.033119204043;5385.27298814655;5390.865228369165;5392.487713667196;5393.164059570773;5395.487428694268;5208.609354298367;5278.023565640369;5282.920756188583;5288.524032837063;5295.788168473218;5242.318498595311;5357.517823395913;5373.9731301343245;5393.325834270716;5411.350637923474;5209.53114219722;5248.422673505835;5251.737413129252;5255.2379904912805;5288.444713305047;5342.171963345688;5365.839024829262;5378.220158077135;5389.110796718497;5431.891362172813;5164.509371609691;5237.607179461632;5271.209318602087;5312.335958005249;5354.143337066051 07:25:15 INFO - PROCESS | 10425 | |1;ext.html;526.6260954722147;528.8572085536903;534.5643300709921;549.7608540284975;559.3455656881448;28509.857450712745;28843.134705958855;28887.711122888766;28904.421911561756;28913.855430722844;27115.728842711567;37438;37450.62549374506;37471.812640936754;37597.812010939975;8475.788105297355;8646.178613031752;8649.481031138152;8652.783680407978;8653.870191947126;8285.792855178608;8412.621432035543;8491.830163396759;8505;8505.914940850605;8485;8535.061143274235;8572.828543429128;8573.314134869226;8581.95709021454;8446.324294056461;8642.351823613255;8730.38887277894;8732.432391894507;8737.038925718165;8565;8663.090375510543;8672.956635216846;8693.434926729742;8704.869426958601;40326.39510407346;41232.587674123475;41242.175156497;41246.1750764983;41314.586854131376;3150.984245078783;3197.904062878117;3221.8066915985114;3245.0589329094532;3553.91605560304;29589;30025.549616755765;30041.399172016656;30117.849410753024;30522.54216186759;3831.8467261309515;3905.6875449963936;3922.4508568800393;3934.449177115206;3941.9014524637114;274535;276243;276984;277194.59637825564;278270;51920.48079519232;52921;59138.70430647819;59784;61005;54113.72943135259;54188.72905635447;54259;54517.454825452034;54561.1807173494;14722.63193420173;14828.036177648633;14868.851311486747;14876.330565124596;14883.479078232427;10166.847497287547;10174.745631359276;10991.395473248887;11148.777024459465;11167.83248251277;19422.2231110754;19507.10212442242;20203.191872324944;20273.7698853129;20303.28938487146;7644.464887457936;7654.272844079804;7789.298963093235;7821.452498325063;7882.842343153105;911.8176364726949;972.5331840716354;985.7732721473958;1027.3219675014454;1070.973225669349;27815.30461738473;28478.288042798682;29159.85420072886;29240;29841;1035.471909326234;1072.1637123044038;1148.1102145836876;1171.0455978377595;1176.5470293936726;14042.648933776738;14496.275186240646;14496.782548261785;15077.623059423382;15348.693026139415;337451;344794;345277;345998;347566;52514.737426312626;52852.20721689178;52920.20619690708;52991.735041324544;53008.469915301124;1329.8936085113362;1347.9663008424868;1358.1986627889592;1360.115924648986;1371.7050834070724;28179.57730634083;28824.135275941757;29036.655332025646;29099;29420;46589;46883;46890.76554617205;46907.53092469032;47006.294905575756;250541;251461;251723;319528;323693;27153.1854044379;27487.86256068707;30965.225869352544;31772.68227317697;32325.838370807996;36259.45610815787;37621.62378376181;39986.600133999455;40641.18717625572;41037.79481102576;33482.49776253407;33724.15689607681;34264.31471370609;34554.481682774276;35018.824905875306;28434.57348139821;33666.49500257449;34869.651303487655;35483;37246.813765930994;33380.83309583534;34398.14004649904;34430.65569344274;34505.65494345125;34644.653553464144;29339.70660293455;30933.381332373676;31132.688673112978;31442.685573144892;31578;24059.879700602087;24117.46766589553;24188.153414630404;24201;24339.26982190537 07:25:15 INFO - PROCESS | 10425 | |2;jquery.html;355.80252959607407;362.7895820424156;365.13280957725397;369.7485709717392;370.2539383142966;13446.260455674934;13767.449302027906;15527;16289;17138.571535711628;15305.387784488606;15390.538283851474;16639.251233694482;16680.74978875318;16683.91658041708;5100.438951715309;5538.584606154534;5541.113421852504;5543.889122217553;5547.861303467405;4006.599340065999;4101.508847811641;5396.271503347037;5480.150576660624;5843.678597677126;5926.570106256414;6028.849278768044;6035.517158627321;6036.667983260941;6038.2150320458495;5907.7636894524385;6035.969820150871;6043.969780151093;6047.485963693091;6047.697615119227;4842.297866809328;5026.421961474404;5033;5329.493698098674;5355.169948657965;15925.601859953478;18798.718019229585;18873.150708218163;20006.899965500226;20009.599808003757;2085.3118470904565;2103.6739305407687;2201.438633148537;2249.3139592424304;2259.830512711537;9093.681721139728;9576.366499212772;12509.56216532417;12612.306323152223;13238.139520931205;1715.5711072231943;1774.4144432337298;1827.7898041725239;1847.5196448923377;1850.6576283387617;57553.71223143858;57770.133447998734;57816.71091644557;58422;60784.69607651978;9806.460644664612;10074.194064474825;10332.276740628235;10349;10353.741156470998;13213.867861321263;13335.666608334675;13367.933160334136;13369.799453008212;13406.731865362639;7372.631368431557;7418.554886706707;7726.9227307726205;7774.183710710294;7800.102988156321;7437;7476.738314158978;7484.738034168887;7523.736669216661;7552.622368881534;4455.487618923865;4477.619402350771;4482.551744825491;4483.932741008887;4497.055618320124;1690.797104347486;1726.818684038183;1763.8500727438054;1829.9817001830077;1852.2961274715522;868.3270465389373;874.8075423406967;894.5795476126341;924.2513564013171;1036.5646428500047;15354.769678454832;15397.307121179574;15458.845411545966;15557.222138893236;16661;888.9955550222207;892.1524551675934;898.8247291778172;905.922996545301;996.6710985374809;9047.592858321392;9251.167394934353;9881.901180988241;9950.402975821475;9977.700668979942;360920;515428;527588;558061;561752;52177.98875104663;62879.37120628827;64956.67521662361;66015.66992165009;66770.66614666993;1142.440204299887;1144.8797876223043;1163.5694792926672;1172.46066809267;1174.7944109780924;11720.824187637021;13782.448702052206;14860.554183374516;15032.173230472428;15159.848401515843;31580.368392632477;34045.97862064142;34112;35125;35321;40251;42405;42845.78577107094;43265;45273.77363113163;7009.614471204132;7279.490435669452;7361.374283185775;7537.811554710956;7575.431842611716;9954.45250511229;10477.895221047997;10773.24587278883;10780.838287425539;11423.600173993871;9260.583273752563;9493.382930109521;9695.757606059622;9755.414675119515;9791.706248812547;3119.906402807919;3328.850201740976;8882.200601945857;9365.050009247065;9988.650397236062;9379;9485.193758530602;10096.394216347042;10111.848322275318;10125.949370253102;7319.487635865438;7480.401567874448;7482.96258518704;7560.3573696236435;7621.3902887769955;9227.492487913229;9296.349255552317;9607.759806004906;9644;9995.250356223167 07:25:15 INFO - PROCESS | 10425 | |3;mootools.html;1297.0401902592084;1445.1618061524314;1445.5518789175355;1582.5568840724593;1755.657646758881;6707.731690732371;7341.045664063671;7455.850882982337;7476.102867655875;7484.588347640877;7509.737159199415;7672.271134242238;7677.539347639132;7690.500117492373;7695.230476952316;1978.2186036515568;2008.6183625111182;2260.3106052654016;2325.9418514537188;2348.9177878774244;2320.2575175943703;2323.9651405228933;2340.625499920013;2341.8126549876056;2342.754010828864;2239.6192647249927;2314.780095890896;2317.8841057947034;2319.0375993962484;2325.5697695926306;2240.641497360423;2284.314705588325;2313.710786151731;2314.109068008812;2328.2084091408833;2290.015293423827;2307.40007598024;2314.36355002374;2316.2356422380576;2323.035940084863;7721;7786.221377862225;7798.883016754753;7804.882926756047;7805.492642978245;4799.544043315879;4887.169181239163;4906.803727850882;4913.410390753097;4918.655694101414;3050.572919791231;3099.8450077496036;3145.51244557094;3149.921251968696;3150.716435520791;1006.8489726541004;1021;1041.2034793383068;1058.359692386103;1073.259450978822;10510.737231569196;10530.736731581695;10530.894691053069;10544.209184311207;10563.841542376871;4352.651787857028;4427.048184640318;4485.596296333346;4504.25679762842;4505.842295519707;9119.316051296179;9127.817443651222;9142;9144.268458523302;9163.083691630784;4920.286558449005;4920.655554111249;4940.925886111711;4951.207806750903;4956.826511072095;4466.419365482467;4510.548945105529;4512.661550383735;4519.706219095749;4520.2315606347;3457.187560923181;3536.0982949348268;3647.595675664888;3669.192777588926;3726.6832319252626;1150.1316506037888;1159.6636975277245;1164.5400066973668;1176.2060609089;1181.7282025134268;1006.3810756384917;1024.8923862994427;1025.7486915705551;1137.5790957345835;1304.315234501894;7188.604626745475;7253.274672532704;7268.890966635505;7271;7281.672324745399;1095.59462998691;1097.742030622803;1110.3615421132881;1115.1970581181536;1120.255030404788;5673.631213971079;5751.4536119068625;5768.653880767083;5770.653760774283;5775.5668324875805;9305.162535371848;9371.203447706885;9500.049995000445;9646.372985755903;9669.081437263449;9521.428714277166;9529.952350238205;9531.809363812685;9538.284628652878;9539.427634341822;7201;7236.7467138650945;7239.131304243525;7306.086739157606;7339.963300183572;7130.286971303036;7215.927840721525;7229.638518074181;7235.167955685163;7236.529625574321;8271.503709777433;8281.751547453587;8513.148685131437;8612.698555550525;8640.222379985831;8636.697715579925;8676.78308042304;8817.074207208407;8860.601272942604;8872.911270887209;6175.5677102602385;6958.965205173941;7146.535475194096;7162.89255661155;7168.856622867618;6715.093462382516;7148.821279468055;7330.743423980135;7363.263673632594;7380.298871607189;6841.555298905555;7035.507514474142;7057.258987806412;7095;7114.608696521741;6930.8613827724175;6940.097787287822;7003.5797852127;7056.047433596399;7086.539374940612;6627.768028118992;6944.236134025152;6996.755113571001;6998.6500674967065;7004.229534751275;6234;6274.247090349188;6280.560360774702;6281.96859015702;6290.119383286252;6366.172397588284;6366.29970703213;6394.6482943436695;6410.230772307353;6410.423061924449 07:25:15 INFO - PROCESS | 10425 | |4;prototype.html;332.98834540791074;341.4741298400463;343.46419585446705;344.65190157940475;347.1635050582421;5652.463016013472;5782.306123265209;5808.448197421249;5817.418258174186;5868.647881127135;5572.219889215513;5676.262085928834;5677.772889084442;5680.346760122577;5688.232088668028;4464.374987501744;4466.8436604718845;4470.619997300217;4472.552744725518;4474.798634061459;4329.523752387235;4411.4265145531035;4416.668749843759;4423.623991960671;4466.263066594008;4351.0862718829085;4429.579189976947;4429.911401771963;4436.66724995625;4439.689221754478;4458.242098843204;4463.509014008457;4482.753448560328;4488.05750792334;4496.797644106006;3975.5626881043063;3979.263836190314;3984.943989842694;3985.242803867285;3986.4618276532588;5325.7869685212545;5478.561715062785;5512.779488820443;5550.250716153349;5565.443455654402;5089.389273287192;5103.209002604603;5104.515071068243;5107.029664363759;5110.156824124015;5786.971065144689;6055.848603784896;6057.363976782419;6065.514758819284;6072.666003369813;4078.0008897819926;4191.077962848169;4295.506016808075;4298.763568003758;4310.849120280775;6276.811695649138;6388.680565971729;6389.265234498046;6390.93609063908;6399.744010239585;4394.231009573312;4400.22995975703;4402.053558484941;4403.8238470461465;4405.449318835145;4291.721038132511;4415.40392047076;4449.377087207794;4460.487043989918;4462.553744625511;5027.421846487628;5045.8738531537;5046.066477701637;5050.974745126251;5055.6713813602;6059.939400606026;6168.722407491674;6173.81478555644;6176.567640265138;6178.289496707846;1541.0522528644804;1560.149718403473;1561.7110834495654;1562.7108984837841;1563.9530814075597;1050.0654417568371;1050.3855244681795;1053.7154968158554;1058.3015209961388;1082.9891701082888;5821;5845.298564172242;5847.9415205848245;5854.677992710442;5858.882822343529;6307.337729538424;6316.905246421307;6322.936770632235;6330.810075697645;6330.968345158337;5804.88390232193;5824.534037277008;5837.7664893404635;5840.8247752567495;5843.3864444233595;3295.47272436409;3403.846826892796;3408.744344174197;3409.2329225924464;3409.5397121388296;6594.637294948824;6637.933620663828;6677.3656502632175;6679.632620205935;6683.532152749261;6485.513586480938;6495.902561461582;6496.447801936793;6499.057636642755;6500.414962653384;6465.515086368541;6546.476281897437;6623.205215374186;6661.833454163685;6667.366600172879;6094.146819445193;6271.871063208666;6307.842303942438;6317.052442133717;6319.399657032574;6115.84710382244;6191;6213.130161777264;6290.8427289316305;6307.590006649737;6607.9669601651685;6628.867422651617;6633.900491492535;6635.6350400728425;6639.269680335063;4251.128518653731;4330.52364239927;4334.06817534219;4335.3063509838275;4337.913241735211;6350.460210882126;6351.936480635134;6360.840978975562;6370.55406121567;6387.68061596909;6210.7515699373325;6211.3478084800445;6215.720292586935;6217.222847144107;6218.844528886814;6059.272887253558;6201.131841542097;6203.100550420254;6206.317305096526;6212.658303793335;6064.151018857276;6091.573589848668;6104.32852386246;6107.236595425572;6173.56785025044;6201.224846894138;6202.131701561695;6215.782447614311;6219.0982307566055;6220.626762394271;5939.524838012862;6095.512359011357;6102.0541816018585;6106.45041946227;6111.297200821962 07:25:15 INFO - PROCESS | 10425 | |5;yui.html;850.2857599616322;850.9531975741334;872.0973792125152;879.7580665317037;883.7481317824418;15570.610734731637;16098.919505402471;16114.435994740186;16115.51653450397;16158.434454794084;13982.230977296245;14048;14049.50826721065;14053.859461405384;14062;663.270402557188;801.9238172373615;802.0736049862418;805.7059173401725;806.8426656801926;669.5714742564762;807.8868958345836;828.5774255129897;828.6064119543229;829.4359835311985;828.9544075075869;857.8927634045745;862.1593945902757;862.8835107260534;863.1842908451516;691.7786308381345;699.0283505926766;833.3041910005122;844.9366297527679;846.6147902704316;619.2166908860295;624.0202881476084;631.8420394901275;632.9556931014831;633.7021599848064;14064.367103480368;14115.858841411557;14117.08238964464;14120.646983825487;14121.15273083608;12131.696707582292;12228.694282643006;12332;12545.623631290984;12864.09951303409;10349.689509314732;10526.941421785952;10644.201684873588;10704.892951070467;10799.190060745397;3539.486774417721;3596.730245231618;3626;3632;3714.0900479382726;50294.497055029344;51044.489555104345;51315;51415.48584514144;51426.74286628543;9799.510024498746;9801.9019809801;9826.80346393068;9828.21374290055;9875.654352097643;18110.90944545269;18148.546286342946;18152.09239538018;18169.909150454427;18174.45476635703;7284.198738138801;7337.19290878003;7434.330910217998;7527.849443011219;7560.470767046364;4155.91688166235;4257.254980378421;4327.156204540147;4357.172137293904;4364.388985542027;3161.1148878314107;3182.8885988990273;3183.6179658441133;3186.490161574137;3196.744260459158;543.8151028650278;556.290729320112;563.6730696196196;565.1748447267037;568.0967262053355;539.8285719987637;545.6562365709577;554.4594020829659;629.7386584567354;707.2679776431472;9368.62525498986;9370.90629093714;9435.622575096919;9556.569954352071;9635.373700709431;640.1092242014715;692.8267933016746;697.9930200698029;698.1308271202284;703.2931903437013;3930.7445016074435;4379.715318504351;4381.3208952612395;4455.309427038814;4500.0595639916155;53887.19169212465;54753.726231368586;54773.72613136909;54990;55010.44989550133;49789.502104978485;49887.75056124696;52005.47994520082;52317.47682523202;52848;43316.133677326274;44423.777881110385;46330.30504542434;46547.53452465432;47777;9016.549172541478;9071.727848164566;9079.319051071328;9088.454692718458;9167.04750928944;32369.35261294808;32588.185295367806;33577.49633755544;34406.65593344034;34484.65515344815;40147.79926100351;40228.59771402366;40798.184036319704;42366.5763342375;42438.36342454804;11755.764884702428;11777.234479758788;11825.526978920747;11896.583619573274;12045.156839021185;12301.87698123043;12361.752764944831;12726;12953.287569183785;12961.740765184832;11807.173497855068;12008.339541325311;12050.578229761917;12361.443735031766;12435.378231088229;10904.78190436171;11215.831762523732;11512.884871151182;11841.763164736829;12057.397130143634;11011.504482298476;11150.609728659458;11489.368084755419;11703.941480292544;12067.75864482688;9509.144177024102;9681.661141860282;9889.357191782512;9991.600335986479;10004.099631033241;9464.191823493727;9523.904760952579;9685.370450920667;10029.197664186702;10097 07:25:15 INFO - PROCESS | 10425 | __end_tp_report 07:25:15 INFO - PROCESS | 10425 | __start_cc_report 07:25:15 INFO - PROCESS | 10425 | _x_x_mozilla_cycle_collect,950 07:25:15 INFO - PROCESS | 10425 | __end_cc_report 07:25:15 INFO - PROCESS | 10425 | __startTimestamp1452871515047__endTimestamp 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | ------- Summary: start ------- 07:25:15 INFO - PROCESS | 10425 | Number of tests: 6 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#0] dojo.html Cycles:165 Average:5078.60 Median:5255.24 stddev:541.99 (10.3%) stddev-sans-first:520.52 07:25:15 INFO - PROCESS | 10425 | Values: 3082.0 3084.6 3110.1 3123.4 3148.1 4987.9 5073.0 5086.2 5092.6 5095.6 5092.9 5098.2 5166.4 5210.1 5231.9 4685.5 4692.4 4729.8 4734.4 4791.5 4717.0 4728.8 4758.4 4761.5 4813.8 4555.0 4600.2 4651.9 4706.4 4735.7 4616.1 4618.8 4647.1 4663.0 4690.7 4626.5 4627.8 4633.1 4648.6 4675.8 4887.7 4958.8 4965.0 4978.2 5071.7 5470.0 5473.1 5476.1 5478.0 5495.7 5472.0 5477.5 5482.2 5489.3 5490.0 5049.6 5110.5 5118.1 5130.4 5175.2 5560.8 5561.4 5588.0 5607.9 5613.4 5364.4 5367.1 5376.1 5379.5 5384.7 5442.0 5443.6 5476.8 5480.1 5578.6 5379.4 5380.2 5380.6 5384.2 5398.5 5316.8 5345.7 5375.0 5375.1 5429.1 4170.3 4212.5 4258.0 4277.7 4305.1 3804.7 3819.6 3830.4 3859.6 3868.7 5107.8 5112.6 5112.8 5114.5 5161.2 5350.7 5438.9 5520.0 5547.6 5605.0 5051.4 5061.9 5081.1 5090.3 5133.4 4566.5 4710.1 4710.5 4712.2 4724.9 5548.0 5586.0 5627.5 5713.7 5739.2 5466.3 5473.1 5476.1 5488.2 5492.5 5541.0 5675.2 5703.3 5708.4 5709.2 5315.5 5319.2 5447.5 5473.4 5525.0 5385.3 5390.9 5392.5 5393.2 5395.5 5208.6 5278.0 5282.9 5288.5 5295.8 5242.3 5357.5 5374.0 5393.3 5411.4 5209.5 5248.4 5251.7 5255.2 5288.4 5342.2 5365.8 5378.2 5389.1 5431.9 5164.5 5237.6 5271.2 5312.3 5354.1 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#1] ext.html Cycles:180 Average:45917.55 Median:189612.33 stddev:79247.32 (41.8%) stddev-sans-first:79396.35 07:25:15 INFO - PROCESS | 10425 | Values: 526.6 528.9 534.6 549.8 559.3 28509.9 28843.1 28887.7 28904.4 28913.9 27115.7 37438.0 37450.6 37471.8 37597.8 8475.8 8646.2 8649.5 8652.8 8653.9 8285.8 8412.6 8491.8 8505.0 8505.9 8485.0 8535.1 8572.8 8573.3 8582.0 8446.3 8642.4 8730.4 8732.4 8737.0 8565.0 8663.1 8673.0 8693.4 8704.9 40326.4 41232.6 41242.2 41246.2 41314.6 3151.0 3197.9 3221.8 3245.1 3553.9 29589.0 30025.5 30041.4 30117.8 30522.5 3831.8 3905.7 3922.5 3934.4 3941.9 274535.0 276243.0 276984.0 277194.6 278270.0 51920.5 52921.0 59138.7 59784.0 61005.0 54113.7 54188.7 54259.0 54517.5 54561.2 14722.6 14828.0 14868.9 14876.3 14883.5 10166.8 10174.7 10991.4 11148.8 11167.8 19422.2 19507.1 20203.2 20273.8 20303.3 7644.5 7654.3 7789.3 7821.5 7882.8 911.8 972.5 985.8 1027.3 1071.0 27815.3 28478.3 29159.9 29240.0 29841.0 1035.5 1072.2 1148.1 1171.0 1176.5 14042.6 14496.3 14496.8 15077.6 15348.7 337451.0 344794.0 345277.0 345998.0 347566.0 52514.7 52852.2 52920.2 52991.7 53008.5 1329.9 1348.0 1358.2 1360.1 1371.7 28179.6 28824.1 29036.7 29099.0 29420.0 46589.0 46883.0 46890.8 46907.5 47006.3 250541.0 251461.0 251723.0 319528.0 323693.0 27153.2 27487.9 30965.2 31772.7 32325.8 36259.5 37621.6 39986.6 40641.2 41037.8 33482.5 33724.2 34264.3 34554.5 35018.8 28434.6 33666.5 34869.7 35483.0 37246.8 33380.8 34398.1 34430.7 34505.7 34644.7 29339.7 30933.4 31132.7 31442.7 31578.0 24059.9 24117.5 24188.2 24201.0 24339.3 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#2] jquery.html Cycles:180 Average:26244.49 Median:4934.36 stddev:83312.08 (1688.4%) stddev-sans-first:83523.11 07:25:15 INFO - PROCESS | 10425 | Values: 355.8 362.8 365.1 369.7 370.3 13446.3 13767.4 15527.0 16289.0 17138.6 15305.4 15390.5 16639.3 16680.7 16683.9 5100.4 5538.6 5541.1 5543.9 5547.9 4006.6 4101.5 5396.3 5480.2 5843.7 5926.6 6028.8 6035.5 6036.7 6038.2 5907.8 6036.0 6044.0 6047.5 6047.7 4842.3 5026.4 5033.0 5329.5 5355.2 15925.6 18798.7 18873.2 20006.9 20009.6 2085.3 2103.7 2201.4 2249.3 2259.8 9093.7 9576.4 12509.6 12612.3 13238.1 1715.6 1774.4 1827.8 1847.5 1850.7 57553.7 57770.1 57816.7 58422.0 60784.7 9806.5 10074.2 10332.3 10349.0 10353.7 13213.9 13335.7 13367.9 13369.8 13406.7 7372.6 7418.6 7726.9 7774.2 7800.1 7437.0 7476.7 7484.7 7523.7 7552.6 4455.5 4477.6 4482.6 4483.9 4497.1 1690.8 1726.8 1763.9 1830.0 1852.3 868.3 874.8 894.6 924.3 1036.6 15354.8 15397.3 15458.8 15557.2 16661.0 889.0 892.2 898.8 905.9 996.7 9047.6 9251.2 9881.9 9950.4 9977.7 360920.0 515428.0 527588.0 558061.0 561752.0 52178.0 62879.4 64956.7 66015.7 66770.7 1142.4 1144.9 1163.6 1172.5 1174.8 11720.8 13782.4 14860.6 15032.2 15159.8 31580.4 34046.0 34112.0 35125.0 35321.0 40251.0 42405.0 42845.8 43265.0 45273.8 7009.6 7279.5 7361.4 7537.8 7575.4 9954.5 10477.9 10773.2 10780.8 11423.6 9260.6 9493.4 9695.8 9755.4 9791.7 3119.9 3328.9 8882.2 9365.1 9988.7 9379.0 9485.2 10096.4 10111.8 10125.9 7319.5 7480.4 7483.0 7560.4 7621.4 9227.5 9296.3 9607.8 9644.0 9995.3 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#3] mootools.html Cycles:180 Average:5464.43 Median:6204.78 stddev:2810.79 (45.3%) stddev-sans-first:2801.21 07:25:15 INFO - PROCESS | 10425 | Values: 1297.0 1445.2 1445.6 1582.6 1755.7 6707.7 7341.0 7455.9 7476.1 7484.6 7509.7 7672.3 7677.5 7690.5 7695.2 1978.2 2008.6 2260.3 2325.9 2348.9 2320.3 2324.0 2340.6 2341.8 2342.8 2239.6 2314.8 2317.9 2319.0 2325.6 2240.6 2284.3 2313.7 2314.1 2328.2 2290.0 2307.4 2314.4 2316.2 2323.0 7721.0 7786.2 7798.9 7804.9 7805.5 4799.5 4887.2 4906.8 4913.4 4918.7 3050.6 3099.8 3145.5 3149.9 3150.7 1006.8 1021.0 1041.2 1058.4 1073.3 10510.7 10530.7 10530.9 10544.2 10563.8 4352.7 4427.0 4485.6 4504.3 4505.8 9119.3 9127.8 9142.0 9144.3 9163.1 4920.3 4920.7 4940.9 4951.2 4956.8 4466.4 4510.5 4512.7 4519.7 4520.2 3457.2 3536.1 3647.6 3669.2 3726.7 1150.1 1159.7 1164.5 1176.2 1181.7 1006.4 1024.9 1025.7 1137.6 1304.3 7188.6 7253.3 7268.9 7271.0 7281.7 1095.6 1097.7 1110.4 1115.2 1120.3 5673.6 5751.5 5768.7 5770.7 5775.6 9305.2 9371.2 9500.0 9646.4 9669.1 9521.4 9530.0 9531.8 9538.3 9539.4 7201.0 7236.7 7239.1 7306.1 7340.0 7130.3 7215.9 7229.6 7235.2 7236.5 8271.5 8281.8 8513.1 8612.7 8640.2 8636.7 8676.8 8817.1 8860.6 8872.9 6175.6 6959.0 7146.5 7162.9 7168.9 6715.1 7148.8 7330.7 7363.3 7380.3 6841.6 7035.5 7057.3 7095.0 7114.6 6930.9 6940.1 7003.6 7056.0 7086.5 6627.8 6944.2 6996.8 6998.7 7004.2 6234.0 6274.2 6280.6 6282.0 6290.1 6366.2 6366.3 6394.6 6410.2 6410.4 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#4] prototype.html Cycles:180 Average:5141.13 Median:5819.21 stddev:1545.96 (26.6%) stddev-sans-first:1507.59 07:25:15 INFO - PROCESS | 10425 | Values: 333.0 341.5 343.5 344.7 347.2 5652.5 5782.3 5808.4 5817.4 5868.6 5572.2 5676.3 5677.8 5680.3 5688.2 4464.4 4466.8 4470.6 4472.6 4474.8 4329.5 4411.4 4416.7 4423.6 4466.3 4351.1 4429.6 4429.9 4436.7 4439.7 4458.2 4463.5 4482.8 4488.1 4496.8 3975.6 3979.3 3984.9 3985.2 3986.5 5325.8 5478.6 5512.8 5550.3 5565.4 5089.4 5103.2 5104.5 5107.0 5110.2 5787.0 6055.8 6057.4 6065.5 6072.7 4078.0 4191.1 4295.5 4298.8 4310.8 6276.8 6388.7 6389.3 6390.9 6399.7 4394.2 4400.2 4402.1 4403.8 4405.4 4291.7 4415.4 4449.4 4460.5 4462.6 5027.4 5045.9 5046.1 5051.0 5055.7 6059.9 6168.7 6173.8 6176.6 6178.3 1541.1 1560.1 1561.7 1562.7 1564.0 1050.1 1050.4 1053.7 1058.3 1083.0 5821.0 5845.3 5847.9 5854.7 5858.9 6307.3 6316.9 6322.9 6330.8 6331.0 5804.9 5824.5 5837.8 5840.8 5843.4 3295.5 3403.8 3408.7 3409.2 3409.5 6594.6 6637.9 6677.4 6679.6 6683.5 6485.5 6495.9 6496.4 6499.1 6500.4 6465.5 6546.5 6623.2 6661.8 6667.4 6094.1 6271.9 6307.8 6317.1 6319.4 6115.8 6191.0 6213.1 6290.8 6307.6 6608.0 6628.9 6633.9 6635.6 6639.3 4251.1 4330.5 4334.1 4335.3 4337.9 6350.5 6351.9 6360.8 6370.6 6387.7 6210.8 6211.3 6215.7 6217.2 6218.8 6059.3 6201.1 6203.1 6206.3 6212.7 6064.2 6091.6 6104.3 6107.2 6173.6 6201.2 6202.1 6215.8 6219.1 6220.6 5939.5 6095.5 6102.1 6106.5 6111.3 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - PROCESS | 10425 | [#5] yui.html Cycles:180 Average:13884.72 Median:46438.92 stddev:15637.34 (33.7%) stddev-sans-first:15650.57 07:25:15 INFO - PROCESS | 10425 | Values: 850.3 851.0 872.1 879.8 883.7 15570.6 16098.9 16114.4 16115.5 16158.4 13982.2 14048.0 14049.5 14053.9 14062.0 663.3 801.9 802.1 805.7 806.8 669.6 807.9 828.6 828.6 829.4 829.0 857.9 862.2 862.9 863.2 691.8 699.0 833.3 844.9 846.6 619.2 624.0 631.8 633.0 633.7 14064.4 14115.9 14117.1 14120.6 14121.2 12131.7 12228.7 12332.0 12545.6 12864.1 10349.7 10526.9 10644.2 10704.9 10799.2 3539.5 3596.7 3626.0 3632.0 3714.1 50294.5 51044.5 51315.0 51415.5 51426.7 9799.5 9801.9 9826.8 9828.2 9875.7 18110.9 18148.5 18152.1 18169.9 18174.5 7284.2 7337.2 7434.3 7527.8 7560.5 4155.9 4257.3 4327.2 4357.2 4364.4 3161.1 3182.9 3183.6 3186.5 3196.7 543.8 556.3 563.7 565.2 568.1 539.8 545.7 554.5 629.7 707.3 9368.6 9370.9 9435.6 9556.6 9635.4 640.1 692.8 698.0 698.1 703.3 3930.7 4379.7 4381.3 4455.3 4500.1 53887.2 54753.7 54773.7 54990.0 55010.4 49789.5 49887.8 52005.5 52317.5 52848.0 43316.1 44423.8 46330.3 46547.5 47777.0 9016.5 9071.7 9079.3 9088.5 9167.0 32369.4 32588.2 33577.5 34406.7 34484.7 40147.8 40228.6 40798.2 42366.6 42438.4 11755.8 11777.2 11825.5 11896.6 12045.2 12301.9 12361.8 12726.0 12953.3 12961.7 11807.2 12008.3 12050.6 12361.4 12435.4 10904.8 11215.8 11512.9 11841.8 12057.4 11011.5 11150.6 11489.4 11703.9 12067.8 9509.1 9681.7 9889.4 9991.6 10004.1 9464.2 9523.9 9685.4 10029.2 10097.0 07:25:15 INFO - PROCESS | 10425 | -------- Summary: end -------- 07:25:15 INFO - PROCESS | 10425 | 07:25:15 INFO - TEST-INFO | 10425: exit 0 07:25:15 INFO - TEST-OK | dromaeo_css | took 1112098ms 07:25:15 INFO - TEST-START | kraken 07:25:15 INFO - operating with platform_type : linux_ 07:25:15 INFO - Initialising browser for kraken test... 07:25:15 INFO - TEST-INFO | started process 10627 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyPy9_9/profile http://localhost:45578/getInfo.html) 07:25:19 INFO - PROCESS | 10627 | __metrics Screen width/height:1600/1200 07:25:19 INFO - PROCESS | 10627 | colorDepth:24 07:25:19 INFO - PROCESS | 10627 | Browser inner width/height: 1024/697 07:25:19 INFO - PROCESS | 10627 | __metrics 07:25:19 INFO - PROCESS | 10627 | 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:25:19 INFO - PROCESS | 10627 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:20 INFO - TEST-INFO | 10627: exit 0 07:25:20 INFO - Browser initialized. 07:25:20 INFO - Running cycle 1/1 for kraken test... 07:25:20 INFO - TEST-INFO | started process 10709 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyPy9_9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:32 INFO - PROCESS | 10709 | RSS: Main: 149794816 07:25:32 INFO - PROCESS | 10709 | 07:25:34 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:35 INFO - PROCESS | 10709 | RSS: Main: 187392000 07:25:35 INFO - PROCESS | 10709 | 07:25:37 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-dft) 07:25:38 INFO - PROCESS | 10709 | RSS: Main: 176107520 07:25:38 INFO - PROCESS | 10709 | 07:25:41 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-fft) 07:25:42 INFO - PROCESS | 10709 | RSS: Main: 162287616 07:25:42 INFO - PROCESS | 10709 | 07:25:44 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45578/tests/kraken/driver.html?testName=audio-oscillator) 07:25:44 INFO - PROCESS | 10709 | RSS: Main: 163540992 07:25:44 INFO - PROCESS | 10709 | 07:25:46 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:47 INFO - PROCESS | 10709 | RSS: Main: 167149568 07:25:47 INFO - PROCESS | 10709 | 07:25:50 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:50 INFO - PROCESS | 10709 | RSS: Main: 166141952 07:25:50 INFO - PROCESS | 10709 | 07:25:54 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45578/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:54 INFO - PROCESS | 10709 | RSS: Main: 167444480 07:25:54 INFO - PROCESS | 10709 | 07:25:57 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45578/tests/kraken/driver.html?testName=json-parse-financial) 07:25:58 INFO - PROCESS | 10709 | RSS: Main: 167493632 07:25:58 INFO - PROCESS | 10709 | 07:25:59 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45578/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:00 INFO - PROCESS | 10709 | RSS: Main: 174804992 07:26:00 INFO - PROCESS | 10709 | 07:26:02 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:02 INFO - PROCESS | 10709 | RSS: Main: 172113920 07:26:02 INFO - PROCESS | 10709 | 07:26:04 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:05 INFO - PROCESS | 10709 | RSS: Main: 183488512 07:26:05 INFO - PROCESS | 10709 | 07:26:07 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:08 INFO - PROCESS | 10709 | RSS: Main: 189243392 07:26:08 INFO - PROCESS | 10709 | 07:26:10 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:11 INFO - PROCESS | 10709 | RSS: Main: 188088320 07:26:11 INFO - PROCESS | 10709 | 07:26:12 INFO - PROCESS | 10709 | Cycle 1(1): loaded http://localhost:45578/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45578/tests/kraken/driver.html?testName=ai-astar) 07:26:13 INFO - PROCESS | 10709 | RSS: Main: 247345152 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | __start_tp_report 07:26:13 INFO - PROCESS | 10709 | _x_x_mozilla_page_load 07:26:13 INFO - PROCESS | 10709 | _x_x_mozilla_page_load_details 07:26:13 INFO - PROCESS | 10709 | |i|pagename|runs| 07:26:13 INFO - PROCESS | 10709 | |0;ai-astar;109;110;105;109;109;109;99;109;109;109 07:26:13 INFO - PROCESS | 10709 | |1;audio-beat-detection;154;133;146;173;127;150;153;138;165;124 07:26:13 INFO - PROCESS | 10709 | |2;audio-dft;161;159;160;159;159;160;160;162;162;162 07:26:13 INFO - PROCESS | 10709 | |3;audio-fft;72;72;97;103;71;72;72;128;88;72 07:26:13 INFO - PROCESS | 10709 | |4;audio-oscillator;96;96;148;96;96;96;140;96;96;143 07:26:13 INFO - PROCESS | 10709 | |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;109;110 07:26:13 INFO - PROCESS | 10709 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;145 07:26:13 INFO - PROCESS | 10709 | |7;imaging-desaturate;96;95;95;95;96;96;95;96;95;96 07:26:13 INFO - PROCESS | 10709 | |8;json-parse-financial;58;56;56;55;56;55;56;65;53;54 07:26:13 INFO - PROCESS | 10709 | |9;json-stringify-tinderbox;66;68;67;67;66;67;68;68;67;68 07:26:13 INFO - PROCESS | 10709 | |10;stanford-crypto-aes;81;80;81;81;81;83;82;84;81;83 07:26:13 INFO - PROCESS | 10709 | |11;stanford-crypto-ccm;114;114;119;113;111;113;117;115;115;113 07:26:13 INFO - PROCESS | 10709 | |12;stanford-crypto-pbkdf2;140;129;141;133;139;128;140;140;144;146 07:26:13 INFO - PROCESS | 10709 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;64;66;64;67;64 07:26:13 INFO - PROCESS | 10709 | __end_tp_report 07:26:13 INFO - PROCESS | 10709 | __start_cc_report 07:26:13 INFO - PROCESS | 10709 | _x_x_mozilla_cycle_collect,959 07:26:13 INFO - PROCESS | 10709 | __end_cc_report 07:26:13 INFO - PROCESS | 10709 | __startTimestamp1452871573192__endTimestamp 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | ------- Summary: start ------- 07:26:13 INFO - PROCESS | 10709 | Number of tests: 14 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.33 (3.1%) stddev-sans-first:3.50 07:26:13 INFO - PROCESS | 10709 | Values: 109.0 110.0 105.0 109.0 109.0 109.0 99.0 109.0 109.0 109.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:151.50 stddev:15.97 (10.5%) stddev-sans-first:16.70 07:26:13 INFO - PROCESS | 10709 | Values: 154.0 133.0 146.0 173.0 127.0 150.0 153.0 138.0 165.0 124.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 07:26:13 INFO - PROCESS | 10709 | Values: 161.0 159.0 160.0 159.0 159.0 160.0 160.0 162.0 162.0 162.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#3] audio-fft Cycles:10 Average:84.70 Median:72.00 stddev:19.34 (26.9%) stddev-sans-first:19.96 07:26:13 INFO - PROCESS | 10709 | Values: 72.0 72.0 97.0 103.0 71.0 72.0 72.0 128.0 88.0 72.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.00 stddev:23.10 (24.1%) stddev-sans-first:23.92 07:26:13 INFO - PROCESS | 10709 | Values: 96.0 96.0 148.0 96.0 96.0 96.0 140.0 96.0 96.0 143.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:26:13 INFO - PROCESS | 10709 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:26:13 INFO - PROCESS | 10709 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:26:13 INFO - PROCESS | 10709 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.31 (5.9%) stddev-sans-first:3.46 07:26:13 INFO - PROCESS | 10709 | Values: 58.0 56.0 56.0 55.0 56.0 55.0 56.0 65.0 53.0 54.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 07:26:13 INFO - PROCESS | 10709 | Values: 66.0 68.0 67.0 67.0 66.0 67.0 68.0 68.0 67.0 68.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 07:26:13 INFO - PROCESS | 10709 | Values: 81.0 80.0 81.0 81.0 81.0 83.0 82.0 84.0 81.0 83.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:114.50 stddev:2.27 (2.0%) stddev-sans-first:2.40 07:26:13 INFO - PROCESS | 10709 | Values: 114.0 114.0 119.0 113.0 111.0 113.0 117.0 115.0 115.0 113.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:140.00 stddev:6.04 (4.3%) stddev-sans-first:6.36 07:26:13 INFO - PROCESS | 10709 | Values: 140.0 129.0 141.0 133.0 139.0 128.0 140.0 140.0 144.0 146.0 07:26:13 INFO - PROCESS | 10709 | 07:26:13 INFO - PROCESS | 10709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 07:26:13 INFO - PROCESS | 10709 | Values: 66.0 66.0 65.0 66.0 67.0 64.0 66.0 64.0 67.0 64.0 07:26:13 INFO - PROCESS | 10709 | -------- Summary: end -------- 07:26:13 INFO - PROCESS | 10709 | 07:26:14 INFO - TEST-INFO | 10709: exit 0 07:26:14 INFO - TEST-OK | kraken | took 58433ms 07:26:14 INFO - TEST-START | v8_7 07:26:14 INFO - operating with platform_type : linux_ 07:26:14 INFO - Initialising browser for v8_7 test... 07:26:14 INFO - TEST-INFO | started process 10955 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFKvBOO/profile http://localhost:45578/getInfo.html) 07:26:18 INFO - PROCESS | 10955 | __metrics Screen width/height:1600/1200 07:26:18 INFO - PROCESS | 10955 | colorDepth:24 07:26:18 INFO - PROCESS | 10955 | Browser inner width/height: 1024/697 07:26:18 INFO - PROCESS | 10955 | __metrics 07:26:18 INFO - PROCESS | 10955 | 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:26:18 INFO - PROCESS | 10955 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:19 INFO - TEST-INFO | 10955: exit 0 07:26:19 INFO - Browser initialized. 07:26:19 INFO - Running cycle 1/1 for v8_7 test... 07:26:19 INFO - TEST-INFO | started process 11035 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFKvBOO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:30 INFO - PROCESS | 11035 | RSS: Main: 149135360 07:26:30 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | Cycle 1(1): loaded http://localhost:45578/tests/v8_7/run.html (next: http://localhost:45578/tests/v8_7/run.html) 07:26:53 INFO - PROCESS | 11035 | RSS: Main: 550776832 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | __start_tp_report 07:26:53 INFO - PROCESS | 11035 | _x_x_mozilla_page_load 07:26:53 INFO - PROCESS | 11035 | _x_x_mozilla_page_load_details 07:26:53 INFO - PROCESS | 11035 | |i|pagename|runs| 07:26:53 INFO - PROCESS | 11035 | |0;Richards;167.1402306535183 07:26:53 INFO - PROCESS | 11035 | |1;DeltaBlue;188.85741265344666 07:26:53 INFO - PROCESS | 11035 | |2;Encrypt;279.01785714285717 07:26:53 INFO - PROCESS | 11035 | |3;Decrypt;5148.717948717948 07:26:53 INFO - PROCESS | 11035 | |4;RayTrace;1934.2359767891683 07:26:53 INFO - PROCESS | 11035 | |5;Earley;793.6507936507936 07:26:53 INFO - PROCESS | 11035 | |6;Boyer;12231.707317073171 07:26:53 INFO - PROCESS | 11035 | |7;RegExp;43687.5 07:26:53 INFO - PROCESS | 11035 | |8;Splay;584.3549328663164 07:26:53 INFO - PROCESS | 11035 | |9;NavierStokes;4868.9320388349515 07:26:53 INFO - PROCESS | 11035 | __end_tp_report 07:26:53 INFO - PROCESS | 11035 | __startTimestamp1452871613523__endTimestamp 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | ------- Summary: start ------- 07:26:53 INFO - PROCESS | 11035 | Number of tests: 10 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 167.1 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 188.9 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 279.0 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 5148.7 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#4] RayTrace Cycles:1 Average:1934.24 Median:1934.24 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 1934.2 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 793.7 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 12231.7 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#7] RegExp Cycles:1 Average:43687.50 Median:43687.50 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 43687.5 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#8] Splay Cycles:1 Average:584.35 Median:584.35 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 584.4 07:26:53 INFO - PROCESS | 11035 | 07:26:53 INFO - PROCESS | 11035 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 07:26:53 INFO - PROCESS | 11035 | Values: 4868.9 07:26:53 INFO - PROCESS | 11035 | -------- Summary: end -------- 07:26:53 INFO - PROCESS | 11035 | 07:26:54 INFO - TEST-INFO | 11035: exit 0 07:26:54 INFO - TEST-OK | v8_7 | took 40277ms 07:26:54 INFO - SUITE-END | took 1210s 07:26:54 INFO - Completed test suite (00:20:10) 07:26:54 INFO - Working with test: dromaeo_css 07:26:54 INFO - Generating results file: dromaeo_css 07:26:54 INFO - Working with test: kraken 07:26:54 INFO - Generating results file: kraken 07:26:54 INFO - javascript benchmark 07:26:54 INFO - Working with test: v8_7 07:26:54 INFO - Generating results file: v8_7 07:26:54 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 07:26:54 INFO - process_Request line: dromaeo_css 6788.31 graph.html#tests=[[72,201,35]] 07:26:54 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:54 INFO - process_Request line: kraken 1482.20 graph.html#tests=[[232,201,35]] 07:26:54 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:26:54 INFO - process_Request line: v8_7 18950.87 graph.html#tests=[[230,201,35]] 07:26:54 INFO - RETURN: dromaeo_css: 6788.31 07:26:54 INFO - RETURN: kraken: 1482.20 07:26:54 INFO - RETURN: v8_7: 18950.87 07:26:54 INFO - javascript benchmark 07:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.9829456279417, 3084.6144231971, 3110.0825256549315, 3123.3597112591915, 3148.118526812493, 4987.900241995158, 5072.9746351268195, 5086.186210206359, 5092.643514953955, 5095.617828662851, 5092.949070509294, 5098.209777484496, 5166.380034395868, 5210.140326846066, 5231.947680523203, 4685.484596694352, 4692.41344831896, 4729.78715957781, 4734.4081989751285, 4791.544803243686, 4716.976415117937, 4728.787204575802, 4758.428988521365, 4761.547652972962, 4813.831515896944, 4555.0, 4600.194965880957, 4651.86044418668, 4706.435227772655, 4735.692180008288, 4616.146012987574, 4618.769061546909, 4647.117047760915, 4663.0207656392195, 4690.671652984292, 4626.514216007305, 4627.8148874045, 4633.142868569325, 4648.581627653493, 4675.812967481296, 4887.682300650446, 4958.752062396866, 4964.975175124137, 4978.178600530908, 5071.695698258116, 5470.0, 5473.0969390050595, 5476.069068258405, 5478.0, 5495.670259784426, 5471.972640136773, 5477.507024367826, 5482.17767334903, 5489.258950041733, 5490.0, 5049.570786483153, 5110.463401342842, 5118.053160165381, 5130.358705161818, 5175.249588809676, 5560.805371812048, 5561.388247292794, 5587.972060139673, 5607.943920560824, 5613.410591887793, 5364.436734142937, 5367.114426119647, 5376.086065368897, 5379.515843574097, 5384.6769193848495, 5442.047641662693, 5443.591730620219, 5476.808311709071, 5480.095784195642, 5578.553715702734, 5379.35447746273, 5380.24676545284, 5380.596455265792, 5384.219288203189, 5398.541124004425, 5316.813911513079, 5345.732713364317, 5374.973125134427, 5375.086235339923, 5429.077056900336, 4170.311898536707, 4212.4523811904255, 4257.978710106429, 4277.721948073366, 4305.138972205571, 3804.6766024888193, 3819.560750513671, 3830.4254361845387, 3859.556151042666, 3868.729188956746, 5107.821226257063, 5112.565431938327, 5112.769925353294, 5114.4629813869005, 5161.225816127536, 5350.705711185844, 5438.945610543923, 5520.0, 5547.55619550435, 5605.047141985872, 5051.393832740095, 5061.924071138936, 5081.110805609003, 5090.312807770978, 5133.383993920754, 4566.45202575693, 4710.081534100886, 4710.458297295786, 4712.246040633482, 4724.858254252378, 5547.972260138674, 5585.972070139624, 5627.465390787868, 5713.657180569179, 5739.196512488255, 5466.316710411199, 5473.0695781718, 5476.123820188751, 5488.231647569263, 5492.505674489315, 5541.0, 5675.177099320493, 5703.287089113861, 5708.372079071216, 5709.172170035405, 5315.495027972336, 5319.175527793198, 5447.4824891635235, 5473.370562385377, 5525.033119204043, 5385.27298814655, 5390.865228369165, 5392.487713667196, 5393.164059570773, 5395.487428694268, 5208.609354298367, 5278.023565640369, 5282.920756188583, 5288.524032837063, 5295.788168473218, 5242.318498595311, 5357.517823395913, 5373.9731301343245, 5393.325834270716, 5411.350637923474, 5209.53114219722, 5248.422673505835, 5251.737413129252, 5255.2379904912805, 5288.444713305047, 5342.171963345688, 5365.839024829262, 5378.220158077135, 5389.110796718497, 5431.891362172813, 5164.509371609691, 5237.607179461632, 5271.209318602087, 5312.335958005249, 5354.143337066051], "unit": "score", "name": "dojo.html", "value": 5044.9610963601845}, {"lowerIsBetter": false, "replicates": [526.6260954722147, 528.8572085536903, 534.5643300709921, 549.7608540284975, 559.3455656881448, 28509.857450712745, 28843.134705958855, 28887.711122888766, 28904.421911561756, 28913.855430722844, 27115.728842711567, 37438.0, 37450.62549374506, 37471.812640936754, 37597.812010939975, 8475.788105297355, 8646.178613031752, 8649.481031138152, 8652.783680407978, 8653.870191947126, 8285.792855178608, 8412.621432035543, 8491.830163396759, 8505.0, 8505.914940850605, 8485.0, 8535.061143274235, 8572.828543429128, 8573.314134869226, 8581.95709021454, 8446.324294056461, 8642.351823613255, 8730.38887277894, 8732.432391894507, 8737.038925718165, 8565.0, 8663.090375510543, 8672.956635216846, 8693.434926729742, 8704.869426958601, 40326.39510407346, 41232.587674123475, 41242.175156497, 41246.1750764983, 41314.586854131376, 3150.984245078783, 3197.904062878117, 3221.8066915985114, 3245.0589329094532, 3553.91605560304, 29589.0, 30025.549616755765, 30041.399172016656, 30117.849410753024, 30522.54216186759, 3831.8467261309515, 3905.6875449963936, 3922.4508568800393, 3934.449177115206, 3941.9014524637114, 274535.0, 276243.0, 276984.0, 277194.59637825564, 278270.0, 51920.48079519232, 52921.0, 59138.70430647819, 59784.0, 61005.0, 54113.72943135259, 54188.72905635447, 54259.0, 54517.454825452034, 54561.1807173494, 14722.63193420173, 14828.036177648633, 14868.851311486747, 14876.330565124596, 14883.479078232427, 10166.847497287547, 10174.745631359276, 10991.395473248887, 11148.777024459465, 11167.83248251277, 19422.2231110754, 19507.10212442242, 20203.191872324944, 20273.7698853129, 20303.28938487146, 7644.464887457936, 7654.272844079804, 7789.298963093235, 7821.452498325063, 7882.842343153105, 911.8176364726949, 972.5331840716354, 985.7732721473958, 1027.3219675014454, 1070.973225669349, 27815.30461738473, 28478.288042798682, 29159.85420072886, 29240.0, 29841.0, 1035.471909326234, 1072.1637123044038, 1148.1102145836876, 1171.0455978377595, 1176.5470293936726, 14042.648933776738, 14496.275186240646, 14496.782548261785, 15077.623059423382, 15348.693026139415, 337451.0, 344794.0, 345277.0, 345998.0, 347566.0, 52514.737426312626, 52852.20721689178, 52920.20619690708, 52991.735041324544, 53008.469915301124, 1329.8936085113362, 1347.9663008424868, 1358.1986627889592, 1360.115924648986, 1371.7050834070724, 28179.57730634083, 28824.135275941757, 29036.655332025646, 29099.0, 29420.0, 46589.0, 46883.0, 46890.76554617205, 46907.53092469032, 47006.294905575756, 250541.0, 251461.0, 251723.0, 319528.0, 323693.0, 27153.1854044379, 27487.86256068707, 30965.225869352544, 31772.68227317697, 32325.838370807996, 36259.45610815787, 37621.62378376181, 39986.600133999455, 40641.18717625572, 41037.79481102576, 33482.49776253407, 33724.15689607681, 34264.31471370609, 34554.481682774276, 35018.824905875306, 28434.57348139821, 33666.49500257449, 34869.651303487655, 35483.0, 37246.813765930994, 33380.83309583534, 34398.14004649904, 34430.65569344274, 34505.65494345125, 34644.653553464144, 29339.70660293455, 30933.381332373676, 31132.688673112978, 31442.685573144892, 31578.0, 24059.879700602087, 24117.46766589553, 24188.153414630404, 24201.0, 24339.26982190537], "unit": "score", "name": "ext.html", "value": 17919.493431740222}, {"lowerIsBetter": false, "replicates": [355.80252959607407, 362.7895820424156, 365.13280957725397, 369.7485709717392, 370.2539383142966, 13446.260455674934, 13767.449302027906, 15527.0, 16289.0, 17138.571535711628, 15305.387784488606, 15390.538283851474, 16639.251233694482, 16680.74978875318, 16683.91658041708, 5100.438951715309, 5538.584606154534, 5541.113421852504, 5543.889122217553, 5547.861303467405, 4006.599340065999, 4101.508847811641, 5396.271503347037, 5480.150576660624, 5843.678597677126, 5926.570106256414, 6028.849278768044, 6035.517158627321, 6036.667983260941, 6038.2150320458495, 5907.7636894524385, 6035.969820150871, 6043.969780151093, 6047.485963693091, 6047.697615119227, 4842.297866809328, 5026.421961474404, 5033.0, 5329.493698098674, 5355.169948657965, 15925.601859953478, 18798.718019229585, 18873.150708218163, 20006.899965500226, 20009.599808003757, 2085.3118470904565, 2103.6739305407687, 2201.438633148537, 2249.3139592424304, 2259.830512711537, 9093.681721139728, 9576.366499212772, 12509.56216532417, 12612.306323152223, 13238.139520931205, 1715.5711072231943, 1774.4144432337298, 1827.7898041725239, 1847.5196448923377, 1850.6576283387617, 57553.71223143858, 57770.133447998734, 57816.71091644557, 58422.0, 60784.69607651978, 9806.460644664612, 10074.194064474825, 10332.276740628235, 10349.0, 10353.741156470998, 13213.867861321263, 13335.666608334675, 13367.933160334136, 13369.799453008212, 13406.731865362639, 7372.631368431557, 7418.554886706707, 7726.9227307726205, 7774.183710710294, 7800.102988156321, 7437.0, 7476.738314158978, 7484.738034168887, 7523.736669216661, 7552.622368881534, 4455.487618923865, 4477.619402350771, 4482.551744825491, 4483.932741008887, 4497.055618320124, 1690.797104347486, 1726.818684038183, 1763.8500727438054, 1829.9817001830077, 1852.2961274715522, 868.3270465389373, 874.8075423406967, 894.5795476126341, 924.2513564013171, 1036.5646428500047, 15354.769678454832, 15397.307121179574, 15458.845411545966, 15557.222138893236, 16661.0, 888.9955550222207, 892.1524551675934, 898.8247291778172, 905.922996545301, 996.6710985374809, 9047.592858321392, 9251.167394934353, 9881.901180988241, 9950.402975821475, 9977.700668979942, 360920.0, 515428.0, 527588.0, 558061.0, 561752.0, 52177.98875104663, 62879.37120628827, 64956.67521662361, 66015.66992165009, 66770.66614666993, 1142.440204299887, 1144.8797876223043, 1163.5694792926672, 1172.46066809267, 1174.7944109780924, 11720.824187637021, 13782.448702052206, 14860.554183374516, 15032.173230472428, 15159.848401515843, 31580.368392632477, 34045.97862064142, 34112.0, 35125.0, 35321.0, 40251.0, 42405.0, 42845.78577107094, 43265.0, 45273.77363113163, 7009.614471204132, 7279.490435669452, 7361.374283185775, 7537.811554710956, 7575.431842611716, 9954.45250511229, 10477.895221047997, 10773.24587278883, 10780.838287425539, 11423.600173993871, 9260.583273752563, 9493.382930109521, 9695.757606059622, 9755.414675119515, 9791.706248812547, 3119.906402807919, 3328.850201740976, 8882.200601945857, 9365.050009247065, 9988.650397236062, 9379.0, 9485.193758530602, 10096.394216347042, 10111.848322275318, 10125.949370253102, 7319.487635865438, 7480.401567874448, 7482.96258518704, 7560.3573696236435, 7621.3902887769955, 9227.492487913229, 9296.349255552317, 9607.759806004906, 9644.0, 9995.250356223167], "unit": "score", "name": "jquery.html", "value": 8088.628269348637}, {"lowerIsBetter": false, "replicates": [1297.0401902592084, 1445.1618061524314, 1445.5518789175355, 1582.5568840724593, 1755.657646758881, 6707.731690732371, 7341.045664063671, 7455.850882982337, 7476.102867655875, 7484.588347640877, 7509.737159199415, 7672.271134242238, 7677.539347639132, 7690.500117492373, 7695.230476952316, 1978.2186036515568, 2008.6183625111182, 2260.3106052654016, 2325.9418514537188, 2348.9177878774244, 2320.2575175943703, 2323.9651405228933, 2340.625499920013, 2341.8126549876056, 2342.754010828864, 2239.6192647249927, 2314.780095890896, 2317.8841057947034, 2319.0375993962484, 2325.5697695926306, 2240.641497360423, 2284.314705588325, 2313.710786151731, 2314.109068008812, 2328.2084091408833, 2290.015293423827, 2307.40007598024, 2314.36355002374, 2316.2356422380576, 2323.035940084863, 7721.0, 7786.221377862225, 7798.883016754753, 7804.882926756047, 7805.492642978245, 4799.544043315879, 4887.169181239163, 4906.803727850882, 4913.410390753097, 4918.655694101414, 3050.572919791231, 3099.8450077496036, 3145.51244557094, 3149.921251968696, 3150.716435520791, 1006.8489726541004, 1021.0, 1041.2034793383068, 1058.359692386103, 1073.259450978822, 10510.737231569196, 10530.736731581695, 10530.894691053069, 10544.209184311207, 10563.841542376871, 4352.651787857028, 4427.048184640318, 4485.596296333346, 4504.25679762842, 4505.842295519707, 9119.316051296179, 9127.817443651222, 9142.0, 9144.268458523302, 9163.083691630784, 4920.286558449005, 4920.655554111249, 4940.925886111711, 4951.207806750903, 4956.826511072095, 4466.419365482467, 4510.548945105529, 4512.661550383735, 4519.706219095749, 4520.2315606347, 3457.187560923181, 3536.0982949348268, 3647.595675664888, 3669.192777588926, 3726.6832319252626, 1150.1316506037888, 1159.6636975277245, 1164.5400066973668, 1176.2060609089, 1181.7282025134268, 1006.3810756384917, 1024.8923862994427, 1025.7486915705551, 1137.5790957345835, 1304.315234501894, 7188.604626745475, 7253.274672532704, 7268.890966635505, 7271.0, 7281.672324745399, 1095.59462998691, 1097.742030622803, 1110.3615421132881, 1115.1970581181536, 1120.255030404788, 5673.631213971079, 5751.4536119068625, 5768.653880767083, 5770.653760774283, 5775.5668324875805, 9305.162535371848, 9371.203447706885, 9500.049995000445, 9646.372985755903, 9669.081437263449, 9521.428714277166, 9529.952350238205, 9531.809363812685, 9538.284628652878, 9539.427634341822, 7201.0, 7236.7467138650945, 7239.131304243525, 7306.086739157606, 7339.963300183572, 7130.286971303036, 7215.927840721525, 7229.638518074181, 7235.167955685163, 7236.529625574321, 8271.503709777433, 8281.751547453587, 8513.148685131437, 8612.698555550525, 8640.222379985831, 8636.697715579925, 8676.78308042304, 8817.074207208407, 8860.601272942604, 8872.911270887209, 6175.5677102602385, 6958.965205173941, 7146.535475194096, 7162.89255661155, 7168.856622867618, 6715.093462382516, 7148.821279468055, 7330.743423980135, 7363.263673632594, 7380.298871607189, 6841.555298905555, 7035.507514474142, 7057.258987806412, 7095.0, 7114.608696521741, 6930.8613827724175, 6940.097787287822, 7003.5797852127, 7056.047433596399, 7086.539374940612, 6627.768028118992, 6944.236134025152, 6996.755113571001, 6998.6500674967065, 7004.229534751275, 6234.0, 6274.247090349188, 6280.560360774702, 6281.96859015702, 6290.119383286252, 6366.172397588284, 6366.29970703213, 6394.6482943436695, 6410.230772307353, 6410.423061924449], "unit": "score", "name": "mootools.html", "value": 4495.163439127429}, {"lowerIsBetter": false, "replicates": [332.98834540791074, 341.4741298400463, 343.46419585446705, 344.65190157940475, 347.1635050582421, 5652.463016013472, 5782.306123265209, 5808.448197421249, 5817.418258174186, 5868.647881127135, 5572.219889215513, 5676.262085928834, 5677.772889084442, 5680.346760122577, 5688.232088668028, 4464.374987501744, 4466.8436604718845, 4470.619997300217, 4472.552744725518, 4474.798634061459, 4329.523752387235, 4411.4265145531035, 4416.668749843759, 4423.623991960671, 4466.263066594008, 4351.0862718829085, 4429.579189976947, 4429.911401771963, 4436.66724995625, 4439.689221754478, 4458.242098843204, 4463.509014008457, 4482.753448560328, 4488.05750792334, 4496.797644106006, 3975.5626881043063, 3979.263836190314, 3984.943989842694, 3985.242803867285, 3986.4618276532588, 5325.7869685212545, 5478.561715062785, 5512.779488820443, 5550.250716153349, 5565.443455654402, 5089.389273287192, 5103.209002604603, 5104.515071068243, 5107.029664363759, 5110.156824124015, 5786.971065144689, 6055.848603784896, 6057.363976782419, 6065.514758819284, 6072.666003369813, 4078.0008897819926, 4191.077962848169, 4295.506016808075, 4298.763568003758, 4310.849120280775, 6276.811695649138, 6388.680565971729, 6389.265234498046, 6390.93609063908, 6399.744010239585, 4394.231009573312, 4400.22995975703, 4402.053558484941, 4403.8238470461465, 4405.449318835145, 4291.721038132511, 4415.40392047076, 4449.377087207794, 4460.487043989918, 4462.553744625511, 5027.421846487628, 5045.8738531537, 5046.066477701637, 5050.974745126251, 5055.6713813602, 6059.939400606026, 6168.722407491674, 6173.81478555644, 6176.567640265138, 6178.289496707846, 1541.0522528644804, 1560.149718403473, 1561.7110834495654, 1562.7108984837841, 1563.9530814075597, 1050.0654417568371, 1050.3855244681795, 1053.7154968158554, 1058.3015209961388, 1082.9891701082888, 5821.0, 5845.298564172242, 5847.9415205848245, 5854.677992710442, 5858.882822343529, 6307.337729538424, 6316.905246421307, 6322.936770632235, 6330.810075697645, 6330.968345158337, 5804.88390232193, 5824.534037277008, 5837.7664893404635, 5840.8247752567495, 5843.3864444233595, 3295.47272436409, 3403.846826892796, 3408.744344174197, 3409.2329225924464, 3409.5397121388296, 6594.637294948824, 6637.933620663828, 6677.3656502632175, 6679.632620205935, 6683.532152749261, 6485.513586480938, 6495.902561461582, 6496.447801936793, 6499.057636642755, 6500.414962653384, 6465.515086368541, 6546.476281897437, 6623.205215374186, 6661.833454163685, 6667.366600172879, 6094.146819445193, 6271.871063208666, 6307.842303942438, 6317.052442133717, 6319.399657032574, 6115.84710382244, 6191.0, 6213.130161777264, 6290.8427289316305, 6307.590006649737, 6607.9669601651685, 6628.867422651617, 6633.900491492535, 6635.6350400728425, 6639.269680335063, 4251.128518653731, 4330.52364239927, 4334.06817534219, 4335.3063509838275, 4337.913241735211, 6350.460210882126, 6351.936480635134, 6360.840978975562, 6370.55406121567, 6387.68061596909, 6210.7515699373325, 6211.3478084800445, 6215.720292586935, 6217.222847144107, 6218.844528886814, 6059.272887253558, 6201.131841542097, 6203.100550420254, 6206.317305096526, 6212.658303793335, 6064.151018857276, 6091.573589848668, 6104.32852386246, 6107.236595425572, 6173.56785025044, 6201.224846894138, 6202.131701561695, 6215.782447614311, 6219.0982307566055, 6220.626762394271, 5939.524838012862, 6095.512359011357, 6102.0541816018585, 6106.45041946227, 6111.297200821962], "unit": "score", "name": "prototype.html", "value": 4645.034673547198}, {"lowerIsBetter": false, "replicates": [850.2857599616322, 850.9531975741334, 872.0973792125152, 879.7580665317037, 883.7481317824418, 15570.610734731637, 16098.919505402471, 16114.435994740186, 16115.51653450397, 16158.434454794084, 13982.230977296245, 14048.0, 14049.50826721065, 14053.859461405384, 14062.0, 663.270402557188, 801.9238172373615, 802.0736049862418, 805.7059173401725, 806.8426656801926, 669.5714742564762, 807.8868958345836, 828.5774255129897, 828.6064119543229, 829.4359835311985, 828.9544075075869, 857.8927634045745, 862.1593945902757, 862.8835107260534, 863.1842908451516, 691.7786308381345, 699.0283505926766, 833.3041910005122, 844.9366297527679, 846.6147902704316, 619.2166908860295, 624.0202881476084, 631.8420394901275, 632.9556931014831, 633.7021599848064, 14064.367103480368, 14115.858841411557, 14117.08238964464, 14120.646983825487, 14121.15273083608, 12131.696707582292, 12228.694282643006, 12332.0, 12545.623631290984, 12864.09951303409, 10349.689509314732, 10526.941421785952, 10644.201684873588, 10704.892951070467, 10799.190060745397, 3539.486774417721, 3596.730245231618, 3626.0, 3632.0, 3714.0900479382726, 50294.497055029344, 51044.489555104345, 51315.0, 51415.48584514144, 51426.74286628543, 9799.510024498746, 9801.9019809801, 9826.80346393068, 9828.21374290055, 9875.654352097643, 18110.90944545269, 18148.546286342946, 18152.09239538018, 18169.909150454427, 18174.45476635703, 7284.198738138801, 7337.19290878003, 7434.330910217998, 7527.849443011219, 7560.470767046364, 4155.91688166235, 4257.254980378421, 4327.156204540147, 4357.172137293904, 4364.388985542027, 3161.1148878314107, 3182.8885988990273, 3183.6179658441133, 3186.490161574137, 3196.744260459158, 543.8151028650278, 556.290729320112, 563.6730696196196, 565.1748447267037, 568.0967262053355, 539.8285719987637, 545.6562365709577, 554.4594020829659, 629.7386584567354, 707.2679776431472, 9368.62525498986, 9370.90629093714, 9435.622575096919, 9556.569954352071, 9635.373700709431, 640.1092242014715, 692.8267933016746, 697.9930200698029, 698.1308271202284, 703.2931903437013, 3930.7445016074435, 4379.715318504351, 4381.3208952612395, 4455.309427038814, 4500.0595639916155, 53887.19169212465, 54753.726231368586, 54773.72613136909, 54990.0, 55010.44989550133, 49789.502104978485, 49887.75056124696, 52005.47994520082, 52317.47682523202, 52848.0, 43316.133677326274, 44423.777881110385, 46330.30504542434, 46547.53452465432, 47777.0, 9016.549172541478, 9071.727848164566, 9079.319051071328, 9088.454692718458, 9167.04750928944, 32369.35261294808, 32588.185295367806, 33577.49633755544, 34406.65593344034, 34484.65515344815, 40147.79926100351, 40228.59771402366, 40798.184036319704, 42366.5763342375, 42438.36342454804, 11755.764884702428, 11777.234479758788, 11825.526978920747, 11896.583619573274, 12045.156839021185, 12301.87698123043, 12361.752764944831, 12726.0, 12953.287569183785, 12961.740765184832, 11807.173497855068, 12008.339541325311, 12050.578229761917, 12361.443735031766, 12435.378231088229, 10904.78190436171, 11215.831762523732, 11512.884871151182, 11841.763164736829, 12057.397130143634, 11011.504482298476, 11150.609728659458, 11489.368084755419, 11703.941480292544, 12067.75864482688, 9509.144177024102, 9681.661141860282, 9889.357191782512, 9991.600335986479, 10004.099631033241, 9464.191823493727, 9523.904760952579, 9685.370450920667, 10029.197664186702, 10097.0], "unit": "score", "name": "yui.html", "value": 6408.238043003731}], "name": "dromaeo_css", "value": 6788.3087784324525}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 109.0, 109.0, 99.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [154.0, 133.0, 146.0, 173.0, 127.0, 150.0, 153.0, 138.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 159.0, 160.0, 160.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 97.0, 103.0, 71.0, 72.0, 72.0, 128.0, 88.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 148.0, 96.0, 96.0, 96.0, 140.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 65.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 81.0, 81.0, 83.0, 82.0, 84.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [114.0, 114.0, 119.0, 113.0, 111.0, 113.0, 117.0, 115.0, 115.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.4}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 141.0, 133.0, 139.0, 128.0, 140.0, 140.0, 144.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 64.0, 66.0, 64.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1482.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1934.2359767891683], "unit": "score", "name": "RayTrace", "value": 382.574313}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [43687.5], "unit": "score", "name": "RegExp", "value": 20.852303290414874}, {"lowerIsBetter": false, "replicates": [584.3549328663164], "unit": "score", "name": "Splay", "value": 139.45462837162836}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 18950.872799212662}]} 07:26:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18950.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1482.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6788.31"}}} 07:26:54 INFO - Return code: 0 07:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:26:54 INFO - # TBPL SUCCESS # 07:26:54 INFO - Running post-action listener: _resource_record_post_action 07:26:54 INFO - Running post-run listener: _resource_record_post_run 07:26:55 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 24576; Write bytes: 540082176; Read time: 452; Write time: 424248 07:26:55 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 237195264; Read time: 92; Write time: 241900 07:26:56 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 302886912; Read time: 360; Write time: 182348 07:26:56 INFO - Running post-run listener: _upload_blobber_files 07:26:56 INFO - Blob upload gear active. 07:26:56 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:26:56 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 07:26:56 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'] 07:26:56 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 07:26:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:57 INFO - (blobuploader) - INFO - Done attempting. 07:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:58 INFO - (blobuploader) - INFO - Done attempting. 07:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:58 INFO - Return code: 0 07:26:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc26d4f496b8f3b4445a9031ad47bd3e665f5eb6c953a9c935590d36c4b9c994a3e29f51ad01f76f3149a5c68c6b33f33c14a07adb49dba0e14e50219b780e57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ee5ae33372eabff6b6fa83783c6c7b63e40df02af009771c229dc2d9da3f2a5aca344b68d6877da56803dad2417985b5b91dd038c91081d6219cbd86de2ee739"} 07:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:26:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:26:58 INFO - Contents: 07:26:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dc26d4f496b8f3b4445a9031ad47bd3e665f5eb6c953a9c935590d36c4b9c994a3e29f51ad01f76f3149a5c68c6b33f33c14a07adb49dba0e14e50219b780e57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ee5ae33372eabff6b6fa83783c6c7b63e40df02af009771c229dc2d9da3f2a5aca344b68d6877da56803dad2417985b5b91dd038c91081d6219cbd86de2ee739"} 07:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:58 INFO - Copying logs to upload dir... 07:26:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.525759 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 07:26:58.146215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:26:58.151192) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 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/dc26d4f496b8f3b4445a9031ad47bd3e665f5eb6c953a9c935590d36c4b9c994a3e29f51ad01f76f3149a5c68c6b33f33c14a07adb49dba0e14e50219b780e57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ee5ae33372eabff6b6fa83783c6c7b63e40df02af009771c229dc2d9da3f2a5aca344b68d6877da56803dad2417985b5b91dd038c91081d6219cbd86de2ee739"} build_url:https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/THzJx7OGSBCPF8j8WT0mmA/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/dc26d4f496b8f3b4445a9031ad47bd3e665f5eb6c953a9c935590d36c4b9c994a3e29f51ad01f76f3149a5c68c6b33f33c14a07adb49dba0e14e50219b780e57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ee5ae33372eabff6b6fa83783c6c7b63e40df02af009771c229dc2d9da3f2a5aca344b68d6877da56803dad2417985b5b91dd038c91081d6219cbd86de2ee739"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:26:58.175790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:26:58.176088) ========= 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=ed14279e38b05397cf4aa391000001a4-1452867943.872535-2116649591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:26:58.260583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:26:58.260919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:26:58.261234) ========= ========= Total master_lag: 0.23 =========