builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1452794728.8 results: success (0) buildid: 20160114073313 builduid: 97a0187206d44849a89ebfcfb7225eed revision: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.803217) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.803674) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.803989) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006405 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.827491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.827829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.843259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.843791) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.893587) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.893883) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.894227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:28.894493) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 10:05:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.5M=0s 2016-01-14 10:05:29 (60.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.010811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.011130) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022357 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.061463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.062052) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 --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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 10:05:29,435 truncating revision to first 12 chars 2016-01-14 10:05:29,435 Setting DEBUG logging. 2016-01-14 10:05:29,435 attempt 1/10 2016-01-14 10:05:29,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27eb5e90eeee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 10:05:29,694 unpacking tar archive at: mozilla-central-27eb5e90eeee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.637432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.637741) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.758593) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.758887) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 10:05:29.759483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 10:05:29.759795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:30 INFO - MultiFileLogger online at 20160114 10:05:30 in /builds/slave/test-pgo 10:05:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:05:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:05:30 INFO - {'append_to_log': False, 10:05:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:05:30 INFO - 'blob_upload_branch': 'Firefox', 10:05:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:05:30 INFO - 'branch': 'Firefox', 10:05:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:30 INFO - 'config_files': ('talos/linux_config.py',), 10:05:30 INFO - 'default_actions': ('clobber', 10:05:30 INFO - 'read-buildbot-config', 10:05:30 INFO - 'download-and-extract', 10:05:30 INFO - 'populate-webroot', 10:05:30 INFO - 'create-virtualenv', 10:05:30 INFO - 'install', 10:05:30 INFO - 'run-tests'), 10:05:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:30 INFO - 'download_minidump_stackwalk': True, 10:05:30 INFO - 'download_symbols': 'ondemand', 10:05:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:30 INFO - 'installer_path': 'installer.exe', 10:05:30 INFO - 'log_level': 'info', 10:05:30 INFO - 'log_name': 'talos', 10:05:30 INFO - 'log_to_console': True, 10:05:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:30 INFO - 'opt_config_files': (), 10:05:30 INFO - 'pip_index': False, 10:05:30 INFO - 'sps_profile': False, 10:05:30 INFO - 'sps_profile_interval': 0, 10:05:30 INFO - 'suite': 'dromaeojs', 10:05:30 INFO - 'system_bits': '32', 10:05:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:30 INFO - 'title': 'talos-linux64-ix-033', 10:05:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:30 INFO - 'use_talos_json': True, 10:05:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:05:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:30 INFO - 'work_dir': 'build'} 10:05:30 INFO - ##### 10:05:30 INFO - ##### Running clobber step. 10:05:30 INFO - ##### 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: clobber 10:05:30 INFO - rmtree: /builds/slave/test-pgo/build 10:05:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - ##### 10:05:30 INFO - ##### Running read-buildbot-config step. 10:05:30 INFO - ##### 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: read_buildbot_config 10:05:30 INFO - Using buildbot properties: 10:05:30 INFO - { 10:05:30 INFO - "project": "", 10:05:30 INFO - "product": "firefox", 10:05:30 INFO - "script_repo_revision": "production", 10:05:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:05:30 INFO - "repository": "", 10:05:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:05:30 INFO - "buildid": "20160114073313", 10:05:30 INFO - "pgo_build": "True", 10:05:30 INFO - "basedir": "/builds/slave/test-pgo", 10:05:30 INFO - "buildnumber": 304, 10:05:30 INFO - "slavename": "talos-linux64-ix-033", 10:05:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:05:30 INFO - "platform": "ubuntu64_hw", 10:05:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:05:30 INFO - "branch": "mozilla-central", 10:05:30 INFO - "repo_path": "mozilla-central", 10:05:30 INFO - "revision": "27eb5e90eeee2e6a1ffe61c368c294d3de51b797", 10:05:30 INFO - "stage_platform": "linux64-pgo", 10:05:30 INFO - "builduid": "97a0187206d44849a89ebfcfb7225eed", 10:05:30 INFO - "slavebuilddir": "test" 10:05:30 INFO - } 10:05:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:05:30 INFO - Running post-action listener: _resource_record_post_action 10:05:30 INFO - ##### 10:05:30 INFO - ##### Running download-and-extract step. 10:05:30 INFO - ##### 10:05:30 INFO - Running pre-action listener: _resource_record_pre_action 10:05:30 INFO - Running main action method: download_and_extract 10:05:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:05:30 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')]} 10:05:30 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json 10:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json 10:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:05:31 INFO - Downloaded 1448 bytes. 10:05:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:05:31 INFO - Using the following test package requirements: 10:05:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:31 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:05:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'jsshell-linux-x86_64.zip'], 10:05:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:05:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:05:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:05:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:05:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:31 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')]} 10:05:31 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:33 INFO - Downloaded 24030232 bytes. 10:05:33 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'] 10:05:33 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 10:05:35 INFO - Return code: 0 10:05:35 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 10:05:35 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')]} 10:05:35 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:39 INFO - Downloaded 24030232 bytes. 10:05:39 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'] 10:05:39 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 10:05:40 INFO - Return code: 0 10:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:40 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:43 INFO - Downloaded 11132144 bytes. 10:05:43 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'] 10:05:43 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 10:05:43 INFO - Return code: 0 10:05:43 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')]} 10:05:43 INFO - https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDJfC_xASsCOcFlHgpeziw/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 10:05:46 INFO - Downloaded 55844893 bytes. 10:05:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:46 INFO - mkdir: /builds/slave/test-pgo/properties 10:05:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:05:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:05:46 INFO - Contents: 10:05:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:05:46 INFO - Running post-action listener: _resource_record_post_action 10:05:46 INFO - Running post-action listener: set_extra_try_arguments 10:05:46 INFO - ##### 10:05:46 INFO - ##### Running populate-webroot step. 10:05:46 INFO - ##### 10:05:46 INFO - Running pre-action listener: _resource_record_pre_action 10:05:46 INFO - Running main action method: populate_webroot 10:05:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:46 INFO - '--tppagecycles', 10:05:46 INFO - '7'], 10:05:46 INFO - 'tests': ['tsvgm']}}, 10:05:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:05:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'tests': ['damp', 'tps']}, 10:05:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['damp', 'tps']}, 10:05:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:05:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:46 INFO - 'other': {'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'other_l64': {'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'other_nol64': {'tests': ['a11yr', 10:05:46 INFO - 'ts_paint', 10:05:46 INFO - 'tpaint', 10:05:46 INFO - 'sessionrestore', 10:05:46 INFO - 'sessionrestore_no_auto_restore']}, 10:05:46 INFO - 'svgr': {'tests': ['tsvgx', 10:05:46 INFO - 'tsvgr_opacity', 10:05:46 INFO - 'tart', 10:05:46 INFO - 'tscrollx', 10:05:46 INFO - 'cart']}, 10:05:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['tsvgx', 10:05:46 INFO - 'tsvgr_opacity', 10:05:46 INFO - 'tart', 10:05:46 INFO - 'tscrollx', 10:05:46 INFO - 'cart']}, 10:05:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'tests': ['tp5o']}, 10:05:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'talos_options': ['--e10s'], 10:05:46 INFO - 'tests': ['tp5o']}, 10:05:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'talos_options': ['--xperf_path', 10:05:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:46 INFO - 'tests': ['tp5n']}, 10:05:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:46 INFO - 'talos_options': ['--e10s', 10:05:46 INFO - '--xperf_path', 10:05:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:46 INFO - 'tests': ['tp5n']}}, 10:05:46 INFO - 'talos.zip': {'path': '', 10:05:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:46 INFO - Running post-action listener: _resource_record_post_action 10:05:46 INFO - ##### 10:05:46 INFO - ##### Running create-virtualenv step. 10:05:46 INFO - ##### 10:05:46 INFO - Running pre-action listener: _resource_record_pre_action 10:05:46 INFO - Running main action method: create_virtualenv 10:05:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:05:46 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 10:05:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:05:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:46 INFO - Using real prefix '/usr' 10:05:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:48 INFO - Installing pip.................done. 10:05:48 INFO - Return code: 0 10:05:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:05:48 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')]} 10:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 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')]} 10:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:05:48 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 10:05:48 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 10:05:48 INFO - Using env: {'DISPLAY': ':0', 10:05:48 INFO - 'HOME': '/home/cltbld', 10:05:48 INFO - 'LANG': 'en_US.UTF-8', 10:05:48 INFO - 'LANGUAGE': 'en_US:en', 10:05:48 INFO - 'LOGNAME': 'cltbld', 10:05:48 INFO - 'MAIL': '/var/mail/cltbld', 10:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:48 INFO - 'MOZ_NO_REMOTE': '1', 10:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:48 INFO - 'NO_EM_RESTART': '1', 10:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:48 INFO - 'SHELL': '/bin/bash', 10:05:48 INFO - 'SHLVL': '1', 10:05:48 INFO - 'TERM': 'linux', 10:05:48 INFO - 'TMOUT': '86400', 10:05:48 INFO - 'USER': 'cltbld', 10:05:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:48 INFO - '_': '/tools/buildbot/bin/python'} 10:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:48 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 10:05:48 INFO - Cleaning up... 10:05:48 INFO - Return code: 0 10:05:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:05:48 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')]} 10:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 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')]} 10:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:05:48 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 10:05:48 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 10:05:48 INFO - Using env: {'DISPLAY': ':0', 10:05:48 INFO - 'HOME': '/home/cltbld', 10:05:48 INFO - 'LANG': 'en_US.UTF-8', 10:05:48 INFO - 'LANGUAGE': 'en_US:en', 10:05:48 INFO - 'LOGNAME': 'cltbld', 10:05:48 INFO - 'MAIL': '/var/mail/cltbld', 10:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:48 INFO - 'MOZ_NO_REMOTE': '1', 10:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:48 INFO - 'NO_EM_RESTART': '1', 10:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:48 INFO - 'SHELL': '/bin/bash', 10:05:48 INFO - 'SHLVL': '1', 10:05:48 INFO - 'TERM': 'linux', 10:05:48 INFO - 'TMOUT': '86400', 10:05:48 INFO - 'USER': 'cltbld', 10:05:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:48 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 INFO - Downloading/unpacking psutil>=0.7.1 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:05:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:05:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:51 INFO - Installing collected packages: psutil 10:05:51 INFO - Running setup.py install for psutil 10:05:51 INFO - building 'psutil._psutil_linux' extension 10:05:51 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 10:05:51 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 10:05:51 INFO - building 'psutil._psutil_posix' extension 10:05:51 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 10:05:51 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 10:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:51 INFO - Successfully installed psutil 10:05:51 INFO - Cleaning up... 10:05:51 INFO - Return code: 0 10:05:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:05:51 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')]} 10:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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')]} 10:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:51 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:05:51 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 10:05:51 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 10:05:51 INFO - Using env: {'DISPLAY': ':0', 10:05:51 INFO - 'HOME': '/home/cltbld', 10:05:51 INFO - 'LANG': 'en_US.UTF-8', 10:05:51 INFO - 'LANGUAGE': 'en_US:en', 10:05:51 INFO - 'LOGNAME': 'cltbld', 10:05:51 INFO - 'MAIL': '/var/mail/cltbld', 10:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:51 INFO - 'MOZ_NO_REMOTE': '1', 10:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:51 INFO - 'NO_EM_RESTART': '1', 10:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:51 INFO - 'SHELL': '/bin/bash', 10:05:51 INFO - 'SHLVL': '1', 10:05:51 INFO - 'TERM': 'linux', 10:05:51 INFO - 'TMOUT': '86400', 10:05:51 INFO - 'USER': 'cltbld', 10:05:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:51 INFO - '_': '/tools/buildbot/bin/python'} 10:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:51 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 10:05:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:05:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:53 INFO - Installing collected packages: mozsystemmonitor 10:05:53 INFO - Running setup.py install for mozsystemmonitor 10:05:53 INFO - Successfully installed mozsystemmonitor 10:05:53 INFO - Cleaning up... 10:05:53 INFO - Return code: 0 10:05:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10: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')]} 10:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10: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')]} 10:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:05:53 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 10:05:53 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 10:05:53 INFO - Using env: {'DISPLAY': ':0', 10:05:53 INFO - 'HOME': '/home/cltbld', 10:05:53 INFO - 'LANG': 'en_US.UTF-8', 10:05:53 INFO - 'LANGUAGE': 'en_US:en', 10:05:53 INFO - 'LOGNAME': 'cltbld', 10:05:53 INFO - 'MAIL': '/var/mail/cltbld', 10:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:53 INFO - 'MOZ_NO_REMOTE': '1', 10:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:53 INFO - 'NO_EM_RESTART': '1', 10:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:53 INFO - 'SHELL': '/bin/bash', 10:05:53 INFO - 'SHLVL': '1', 10:05:53 INFO - 'TERM': 'linux', 10:05:53 INFO - 'TMOUT': '86400', 10:05:53 INFO - 'USER': 'cltbld', 10:05:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:53 INFO - '_': '/tools/buildbot/bin/python'} 10:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:53 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:05:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 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 10:05:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:05:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:05:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 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 10:05:56 INFO - Downloading docopt-0.6.1.tar.gz 10:05:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:05:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:56 INFO - Running setup.py install for blobuploader 10:05:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:05:56 INFO - Running setup.py install for requests 10:05:56 INFO - Running setup.py install for docopt 10:05:56 INFO - Successfully installed blobuploader requests docopt 10:05:56 INFO - Cleaning up... 10:05:56 INFO - Return code: 0 10:05:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:05:56 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')]} 10:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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')]} 10:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:56 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:05:56 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 10:05:56 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 10:05:56 INFO - Using env: {'DISPLAY': ':0', 10:05:56 INFO - 'HOME': '/home/cltbld', 10:05:56 INFO - 'LANG': 'en_US.UTF-8', 10:05:56 INFO - 'LANGUAGE': 'en_US:en', 10:05:56 INFO - 'LOGNAME': 'cltbld', 10:05:56 INFO - 'MAIL': '/var/mail/cltbld', 10:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:56 INFO - 'MOZ_NO_REMOTE': '1', 10:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:56 INFO - 'NO_EM_RESTART': '1', 10:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:56 INFO - 'SHELL': '/bin/bash', 10:05:56 INFO - 'SHLVL': '1', 10:05:56 INFO - 'TERM': 'linux', 10:05:56 INFO - 'TMOUT': '86400', 10:05:56 INFO - 'USER': 'cltbld', 10:05:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:56 INFO - '_': '/tools/buildbot/bin/python'} 10:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:57 INFO - Running setup.py (path:/tmp/pip-AOBAFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:57 INFO - Running setup.py (path:/tmp/pip-YIo2oi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:57 INFO - Running setup.py (path:/tmp/pip-fcdjcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:57 INFO - Running setup.py (path:/tmp/pip-iJAlyN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:57 INFO - Running setup.py (path:/tmp/pip-5edNht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:57 INFO - Running setup.py (path:/tmp/pip-Y53CIe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:57 INFO - Running setup.py (path:/tmp/pip-Uxe7P3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:57 INFO - Running setup.py (path:/tmp/pip-mNbT2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:57 INFO - Running setup.py (path:/tmp/pip-uipnMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:57 INFO - Running setup.py (path:/tmp/pip-_oyV4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:57 INFO - Running setup.py (path:/tmp/pip-dA0m7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:05:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:57 INFO - Running setup.py (path:/tmp/pip-1CZmhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:58 INFO - Running setup.py (path:/tmp/pip-Z5PNmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:58 INFO - Running setup.py (path:/tmp/pip-q_p8i5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:58 INFO - Running setup.py (path:/tmp/pip-8QcxYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:58 INFO - Running setup.py (path:/tmp/pip-PyxsH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:05:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:58 INFO - Running setup.py (path:/tmp/pip-yIdXpe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:05:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:58 INFO - Running setup.py install for manifestparser 10:05:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:05:58 INFO - Running setup.py install for mozcrash 10:05:58 INFO - Running setup.py install for mozdebug 10:05:58 INFO - Running setup.py install for mozdevice 10:05:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:05:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:05:58 INFO - Running setup.py install for mozfile 10:05:58 INFO - Running setup.py install for mozhttpd 10:05:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozinfo 10:05:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozInstall 10:05:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozleak 10:05:59 INFO - Running setup.py install for mozlog 10:05:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for moznetwork 10:05:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozprocess 10:05:59 INFO - Running setup.py install for mozprofile 10:05:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozrunner 10:05:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:05:59 INFO - Running setup.py install for mozscreenshot 10:05:59 INFO - Running setup.py install for moztest 10:06:00 INFO - Running setup.py install for mozversion 10:06:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:06:00 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 10:06:00 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 10:06:00 INFO - Using env: {'DISPLAY': ':0', 10:06:00 INFO - 'HOME': '/home/cltbld', 10:06:00 INFO - 'LANG': 'en_US.UTF-8', 10:06:00 INFO - 'LANGUAGE': 'en_US:en', 10:06:00 INFO - 'LOGNAME': 'cltbld', 10:06:00 INFO - 'MAIL': '/var/mail/cltbld', 10:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:00 INFO - 'MOZ_NO_REMOTE': '1', 10:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:00 INFO - 'NO_EM_RESTART': '1', 10:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:00 INFO - 'SHELL': '/bin/bash', 10:06:00 INFO - 'SHLVL': '1', 10:06:00 INFO - 'TERM': 'linux', 10:06:00 INFO - 'TMOUT': '86400', 10:06:00 INFO - 'USER': 'cltbld', 10:06:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:00 INFO - '_': '/tools/buildbot/bin/python'} 10:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:06:00 INFO - Running setup.py (path:/tmp/pip-7kZClj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:06:00 INFO - Running setup.py (path:/tmp/pip-c4E5ig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:06:00 INFO - Running setup.py (path:/tmp/pip-AbzKqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:06:00 INFO - Running setup.py (path:/tmp/pip-t8kMWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:06:00 INFO - Running setup.py (path:/tmp/pip-cO7khw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:06:00 INFO - Running setup.py (path:/tmp/pip-Ac3z9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:06:00 INFO - Running setup.py (path:/tmp/pip-AX3wBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:06:00 INFO - Running setup.py (path:/tmp/pip-1w9FrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:06:00 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)) 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:06:00 INFO - Running setup.py (path:/tmp/pip-FGPaUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:01 INFO - Running setup.py (path:/tmp/pip-m8YUpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:01 INFO - Running setup.py (path:/tmp/pip-nfAvgS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:01 INFO - Running setup.py (path:/tmp/pip-JDHOc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:01 INFO - Running setup.py (path:/tmp/pip-jLZ44x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:01 INFO - Running setup.py (path:/tmp/pip-i3AWnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:01 INFO - Running setup.py (path:/tmp/pip-qlBoA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:01 INFO - Running setup.py (path:/tmp/pip-oQ0vVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:01 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)) 10:06:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:01 INFO - Running setup.py (path:/tmp/pip-9HsTSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:01 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 10:06:03 INFO - Downloading blessings-1.5.1.tar.gz 10:06:03 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 10:06:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:03 INFO - Installing collected packages: blessings 10:06:03 INFO - Running setup.py install for blessings 10:06:03 INFO - Successfully installed blessings 10:06:03 INFO - Cleaning up... 10:06:03 INFO - Return code: 0 10:06:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:06:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:06:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:06:03 INFO - Reading from file tmpfile_stdout 10:06:03 INFO - Current package versions: 10:06:03 INFO - argparse == 1.2.1 10:06:03 INFO - blessings == 1.5.1 10:06:03 INFO - blobuploader == 1.2.4 10:06:03 INFO - docopt == 0.6.1 10:06:03 INFO - manifestparser == 1.1 10:06:03 INFO - mozInstall == 1.12 10:06:03 INFO - mozcrash == 0.16 10:06:03 INFO - mozdebug == 0.1 10:06:03 INFO - mozdevice == 0.48 10:06:03 INFO - mozfile == 1.2 10:06:03 INFO - mozhttpd == 0.7 10:06:03 INFO - mozinfo == 0.9 10:06:03 INFO - mozleak == 0.1 10:06:03 INFO - mozlog == 3.1 10:06:03 INFO - moznetwork == 0.27 10:06:03 INFO - mozprocess == 0.22 10:06:03 INFO - mozprofile == 0.28 10:06:03 INFO - mozrunner == 6.11 10:06:03 INFO - mozscreenshot == 0.1 10:06:03 INFO - mozsystemmonitor == 0.0 10:06:03 INFO - moztest == 0.7 10:06:03 INFO - mozversion == 1.4 10:06:03 INFO - psutil == 3.1.1 10:06:03 INFO - requests == 1.2.3 10:06:03 INFO - wsgiref == 0.1.2 10:06:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:06:03 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')]} 10:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 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')]} 10:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:03 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:06:03 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 10:06:03 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 10:06:03 INFO - Using env: {'DISPLAY': ':0', 10:06:03 INFO - 'HOME': '/home/cltbld', 10:06:03 INFO - 'LANG': 'en_US.UTF-8', 10:06:03 INFO - 'LANGUAGE': 'en_US:en', 10:06:03 INFO - 'LOGNAME': 'cltbld', 10:06:03 INFO - 'MAIL': '/var/mail/cltbld', 10:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:03 INFO - 'MOZ_NO_REMOTE': '1', 10:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:03 INFO - 'NO_EM_RESTART': '1', 10:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:03 INFO - 'SHELL': '/bin/bash', 10:06:03 INFO - 'SHLVL': '1', 10:06:03 INFO - 'TERM': 'linux', 10:06:03 INFO - 'TMOUT': '86400', 10:06:03 INFO - 'USER': 'cltbld', 10:06:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:03 INFO - '_': '/tools/buildbot/bin/python'} 10:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 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)) 10:06:04 INFO - Cleaning up... 10:06:04 INFO - Return code: 0 10:06:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:04 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:06:04 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 10:06:04 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 10:06:04 INFO - Using env: {'DISPLAY': ':0', 10:06:04 INFO - 'HOME': '/home/cltbld', 10:06:04 INFO - 'LANG': 'en_US.UTF-8', 10:06:04 INFO - 'LANGUAGE': 'en_US:en', 10:06:04 INFO - 'LOGNAME': 'cltbld', 10:06:04 INFO - 'MAIL': '/var/mail/cltbld', 10:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:04 INFO - 'MOZ_NO_REMOTE': '1', 10:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:04 INFO - 'NO_EM_RESTART': '1', 10:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:04 INFO - 'SHELL': '/bin/bash', 10:06:04 INFO - 'SHLVL': '1', 10:06:04 INFO - 'TERM': 'linux', 10:06:04 INFO - 'TMOUT': '86400', 10:06:04 INFO - 'USER': 'cltbld', 10:06:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:04 INFO - '_': '/tools/buildbot/bin/python'} 10:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:04 INFO - Downloading/unpacking jsonschema 10:06:04 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 10:06:04 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 10:06:04 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 10:06:04 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 10:06:04 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 10:06:04 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 10:06:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:05 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 10:06:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10: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 10: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 10: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 10: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 10: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 10: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 10:06:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:06:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:06 INFO - warning: no files found matching '*.txt' 10:06:06 INFO - no previously-included directories found matching 'build' 10:06:06 INFO - no previously-included directories found matching 'dist' 10:06:06 INFO - no previously-included directories found matching '.git*' 10:06:06 INFO - Installing collected packages: jsonschema, functools32 10:06:06 INFO - Running setup.py install for functools32 10:06:06 INFO - warning: no files found matching '*.txt' 10:06:06 INFO - no previously-included directories found matching 'build' 10:06:06 INFO - no previously-included directories found matching 'dist' 10:06:06 INFO - no previously-included directories found matching '.git*' 10:06:06 INFO - Successfully installed jsonschema functools32 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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 0x7f22f65b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2256630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', '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 10:06:06 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 10:06:06 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 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Downloading/unpacking flake8 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:06:08 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 10:06:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10: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 10: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 10: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 10: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 10: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 10: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 10:06:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:06:08 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 10:06:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10: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 10: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 10: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 10: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 10: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 10: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 10:06:08 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 10:06:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10: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 10: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 10: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 10: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 10: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 10: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 10:06:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:06:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:09 INFO - no previously-included directories found matching 'docs/_build' 10:06:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:06:09 INFO - Running setup.py install for pep8 10:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:09 INFO - no previously-included directories found matching 'docs/_build' 10:06:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:06:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:06:09 INFO - Cleaning up... 10:06:09 INFO - Return code: 0 10:06:09 INFO - Running post-action listener: _resource_record_post_action 10:06:09 INFO - Running post-action listener: _start_resource_monitoring 10:06:09 INFO - Starting resource monitoring. 10:06:09 INFO - ##### 10:06:09 INFO - ##### Running install step. 10:06:09 INFO - ##### 10:06:09 INFO - Running pre-action listener: _resource_record_pre_action 10:06:09 INFO - Running main action method: install 10:06:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:06:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:06:09 INFO - Reading from file tmpfile_stdout 10:06:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:06:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:06:09 INFO - Reading from file tmpfile_stdout 10:06:09 INFO - Output received: 10:06:09 INFO - Usage: mozinstall [options] installer 10:06:09 INFO - Options: 10:06:09 INFO - -h, --help show this help message and exit 10:06:09 INFO - -d DEST, --destination=DEST 10:06:09 INFO - Directory to install application into. [default: 10:06:09 INFO - "/builds/slave/test-pgo"] 10:06:09 INFO - --app=APP Application being installed. [default: firefox] 10:06:09 INFO - mkdir: /builds/slave/test-pgo/build/application 10:06:09 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'] 10:06:09 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 10:06:25 INFO - Reading from file tmpfile_stdout 10:06:25 INFO - Output received: 10:06:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:06:25 INFO - Running post-action listener: _resource_record_post_action 10:06:25 INFO - ##### 10:06:25 INFO - ##### Running run-tests step. 10:06:25 INFO - ##### 10:06:25 INFO - Running pre-action listener: _resource_record_pre_action 10:06:25 INFO - Running main action method: run_tests 10:06:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:06:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:06:25 INFO - Python 2.7.3 10:06:25 INFO - Return code: 0 10:06:25 INFO - grabbing minidump binary from tooltool 10:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:25 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 0x22e7840>, '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 0x22546b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2254b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:06:25 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 10:06:25 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 10:06:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:25 INFO - Return code: 0 10:06:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:06:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:06:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:06:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:06:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:06:26 INFO - Return code: 0 10:06:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:06:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 10:06:26 INFO - Using env: {'DISPLAY': ':0', 10:06:26 INFO - 'HOME': '/home/cltbld', 10:06:26 INFO - 'LANG': 'en_US.UTF-8', 10:06:26 INFO - 'LANGUAGE': 'en_US:en', 10:06:26 INFO - 'LOGNAME': 'cltbld', 10:06:26 INFO - 'MAIL': '/var/mail/cltbld', 10:06:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:26 INFO - 'MOZ_NO_REMOTE': '1', 10:06:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:26 INFO - 'NO_EM_RESTART': '1', 10:06:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:26 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:06:26 INFO - 'SHELL': '/bin/bash', 10:06:26 INFO - 'SHLVL': '1', 10:06:26 INFO - 'TERM': 'linux', 10:06:26 INFO - 'TMOUT': '86400', 10:06:26 INFO - 'USER': 'cltbld', 10:06:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956', 10:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:26 INFO - '_': '/tools/buildbot/bin/python'} 10:06:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 10:06:27 INFO - mozversion application_buildid: 20160114073313 10:06:27 INFO - mozversion application_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 10:06:27 INFO - mozversion application_display_name: Nightly 10:06:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:27 INFO - mozversion application_name: Firefox 10:06:27 INFO - mozversion application_remotingname: firefox 10:06:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:27 INFO - mozversion application_vendor: Mozilla 10:06:27 INFO - mozversion application_version: 46.0a1 10:06:27 INFO - mozversion platform_buildid: 20160114073313 10:06:27 INFO - mozversion platform_changeset: 27eb5e90eeee2e6a1ffe61c368c294d3de51b797 10:06:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:27 INFO - mozversion platform_version: 46.0a1 10:06:27 INFO - using testdate: 1452794787 10:06:27 INFO - actual date: 1452794787 10:06:27 INFO - starting webserver on 'localhost:35563' 10:06:27 INFO - SUITE-START | Running 3 tests 10:06:27 INFO - TEST-START | dromaeo_css 10:06:27 INFO - operating with platform_type : linux_ 10:06:27 INFO - Initialising browser for dromaeo_css test... 10:06:27 INFO - TEST-INFO | started process 32182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3x0Hh1/profile http://localhost:35563/getInfo.html) 10:06:32 INFO - PROCESS | 32182 | __metrics Screen width/height:1600/1200 10:06:32 INFO - PROCESS | 32182 | colorDepth:24 10:06:32 INFO - PROCESS | 32182 | Browser inner width/height: 1024/697 10:06:32 INFO - PROCESS | 32182 | __metrics 10:06:32 INFO - PROCESS | 32182 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:06:32 INFO - PROCESS | 32182 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:33 INFO - TEST-INFO | 32182: exit 0 10:06:33 INFO - Browser initialized. 10:06:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:33 INFO - TEST-INFO | started process 32275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3x0Hh1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:45 INFO - PROCESS | 32275 | RSS: Main: 150507520 10:06:45 INFO - PROCESS | 32275 | 10:07:36 INFO - PROCESS | 32275 | 1452794856739 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] 10:09:44 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35563/tests/dromaeo/cssquery-ext.html) 10:09:46 INFO - PROCESS | 32275 | RSS: Main: 319557632 10:09:46 INFO - PROCESS | 32275 | 10:12:48 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-ext.html (next: http://localhost:35563/tests/dromaeo/cssquery-jquery.html) 10:12:49 INFO - PROCESS | 32275 | RSS: Main: 235065344 10:12:49 INFO - PROCESS | 32275 | 10:15:51 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35563/tests/dromaeo/cssquery-mootools.html) 10:15:51 INFO - PROCESS | 32275 | RSS: Main: 225361920 10:15:51 INFO - PROCESS | 32275 | 10:18:53 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35563/tests/dromaeo/cssquery-prototype.html) 10:18:54 INFO - PROCESS | 32275 | RSS: Main: 206200832 10:18:54 INFO - PROCESS | 32275 | 10:21:56 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35563/tests/dromaeo/cssquery-yui.html) 10:21:57 INFO - PROCESS | 32275 | RSS: Main: 211296256 10:21:57 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | Cycle 1(1): loaded http://localhost:35563/tests/dromaeo/cssquery-yui.html (next: http://localhost:35563/tests/dromaeo/cssquery-dojo.html) 10:25:00 INFO - PROCESS | 32275 | RSS: Main: 273080320 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | __start_tp_report 10:25:00 INFO - PROCESS | 32275 | _x_x_mozilla_page_load 10:25:00 INFO - PROCESS | 32275 | _x_x_mozilla_page_load_details 10:25:00 INFO - PROCESS | 32275 | |i|pagename|runs| 10:25:00 INFO - PROCESS | 32275 | |0;dojo.html;3030.7120823521764;3064.1420402287367;3065.1111177758453;3081.9845900770506;3091.5208142737874;4819.614430845532;4911.2633105034265;4970.179920313149;4972.055309491198;5011.874703132424;4938.234573641092;4998.150314446544;5016.297718319438;5032.421271553772;5089.491050894909;4536.25151849946;4541.273396256592;4545.47727011393;4605.700629459091;4608.493065762764;4573.908521829561;4592.058627981272;4625.62994960404;4653.441587009546;4671;4460.063386688783;4481.551844815525;4556.794944227501;4564.566366195206;4593.724376537385;4561.429821272341;4571.839985600488;4573.474050484204;4583.381243532114;4593.47175074864;4525.275955847049;4538.432695913011;4548.613367863735;4555.316702494619;4582.908341833178;4712.0811441768865;4740.336352910561;4772.284157376386;4792.808287668489;4826.517348265181;5200.193969934666;5257.237700533401;5261.710605916673;5263.421023687391;5264.341957255343;5265.341832270966;5271.710055946922;5272.604554658377;5275.973620131875;5279;4975.303457515951;4979.253112033188;5014.147594908874;5101.36232970875;5109.310243117206;5400;5458.426865179178;5463.153211252262;5463.808766693226;5508.118701007819;5233.1365324721755;5280.419153893069;5280.9207861882105;5281.419043905167;5291.761870715827;5162.432132465426;5238.68567885928;5262.184361423985;5357.544608708304;5363.865903352369;5228.215767634885;5239.607029472805;5240.135377662643;5244.449332820075;5272.288241087481;5282.577393808486;5298.549623282064;5303.761330740126;5309.814156504581;5347.224652425377;4076.775777332216;4137.606927341898;4150.979245103816;4186.518550366686;4224.324108142744;3713.6472035156617;3715.071232191952;3727.6458736419995;3731.1418373774186;3735.402335626287;4836.274558816206;4840.1287768201355;4841.564259216688;4853.757312134379;4891.144049791344;5138.948610513922;5202.401723801736;5208.192730126836;5211.530962213419;5218.6868787872845;4907.60739140875;4922.606191504671;4922.606191504743;4954.5788607968725;5000.1249781288125;4502.144592527409;4504.09918016398;4512.52618475062;4545.818167273272;4557.430321209848;5380.435054319319;5401.3518377794135;5419.945800541944;5470.64440811346;5473.452654734574;5213.218017297436;5300.5494532963585;5311.176767601028;5323.201519772065;5364.114921037985;5482.451754824486;5515.917261241005;5534.972325138509;5537.584681148849;5541.3904470509015;5112.846614601568;5177.611679124006;5185.403678576861;5267.473252674855;5268.6575372600655;5133;5202.115640341075;5204.947950520598;5204.973975130251;5209.947900521098;5088.389393272831;5090.796368145381;5092.439831618593;5093.337866077386;5100.7449627517735;5080.415752188398;5148.3564554430695;5157.484251574812;5183.896322073613;5195.584353251656;4958.429780575136;5036.6726162799305;5037.118504261666;5037.672551284155;5078.365204349457;5122.846314610568;5130.102232109441;5133.666311689728;5181.35233095863;5226.790928362823;5032.421271553818;5095.388553373619;5149.742512874416;5153.330067091254;5193.896122077613 10:25:00 INFO - PROCESS | 32275 | |1;ext.html;537.8490031332946;582.7872826418356;598.8562744941213;600.0848705723771;608.5466327585947;27487;28051.29871753207;28055.212546306244;28070.719292807065;38656;42721.35917961233;43270.78364608181;43303.35044974328;43371.3494297585;43477.34783978235;8569.742907712778;8780.560971951378;8783.64865405383;8814.911850881474;8815.118488151165;8520.829583408358;8600.440971336875;8633.611487483047;8656.61045252965;8670.739877803677;8420;8545.27365173961;8545.487270763773;8549.059603443617;8552.14478552143;8572.785680358009;8648.913510864937;8657;8658.783530411727;8663.003754568212;8595.269402100828;8689.7827554311;8721.433106848035;8721.996970348364;8735.43219690718;39958.60041399578;40373.19253614941;40411.39382909259;40435.595644043475;40509.59490405088;3165.6517783043846;3522.5068490411363;3838;3949.131191137974;3957.544882338539;28264.434711305657;30069.248268793453;30822;30878.382432351453;30993.535096973563;3707.7219208559195;3711.1464363196346;3828.8085595720104;3871.4192871069286;3874.4382064600477;266358;267448;268295;268791;269810;50944.23583646248;52025.47974520282;59840;59888.70055649694;61009;53389.46610533923;53625.1956220657;53826.19260711093;53850.73074634602;53907.73046134823;14377.78433323501;14726.116433014053;14730.92634536842;14738.336774845158;14758.92620536912;9463.574139163755;9750.75623109428;11236.494357753922;11481.540738370539;11498.540058397737;19468.123934422983;19482.610347792965;19666.803331966785;19694.31069912546;19713.40859774209;7391.704331826774;7579.810504737316;7693.961530192425;7727.459077864608;7791.844163116706;891.1222445890793;941.6468824190929;1028.639976008406;1046.4715318764127;1101.1741194104422;28280.434391312057;29033.56449653257;29046.854765726457;29298.414031719247;29325;1068.5405275731355;1087.9510422031028;1115.6987613344513;1127.4362818590705;1144.0618692671928;15114.697706045818;15128.697426051418;15439.691206176038;15494.380224790882;15736.291866866019;329413;334019;335361;335549;335760;52288.47711522836;52325;52393.47606523886;52451;52518.73740631272;1296.2611311552514;1348.514534767483;1352.952646657382;1355.9186448813102;1357.463801798284;28490.85754571214;29298.707012929597;29344.11967640974;29602.407951841273;29845.85077074601;42352.78823605862;46910.29634555416;47329.76335118302;47374.52625473839;47460.7626961863;190607;404992;414788;416317;417460;30825;31582.210444739067;31657;31674;31700.36599268048;42020.36969445522;44140.11719765651;44205.55794442014;44868;45219.547804521535;36819.63180368162;37228.813855930544;37992.430113547765;38415;38912.80543597377;36557;36839;37544.81227593844;37691.81154094212;38062.429063564625;36288.09279768027;36479.27041459103;36697.26605467822;37033.62966370302;37070.25859482849;32347.19132021718;33927.24425990689;33977;34191;34549.827250863586;25455.109071182418;25587.175468892256;25623;25691.3577160565;25801.87099064568 10:25:00 INFO - PROCESS | 32275 | |2;jquery.html;360.1518424111217;360.4089293558563;361.4181168319006;361.62571738250915;368.8911771027547;13152.6711832204;13557.322133893314;15479.845201547982;16067.357305707772;17142.571435714097;14356.712865742678;15184.164870932122;15504.224788760574;15555.68888622227;16352.75470867938;5180.948190518094;5348.973255133719;5352.785888564453;5355.303810504629;5358.223057656637;3894.7663140211534;4036.1725846201607;4653.767311634421;5320.308359913206;5595.804146854861;5680.517156041741;5698.145278208261;5744.712764361786;5746.281714785652;5750.137479378085;5039.193729003342;5140.871478213037;5171.741412929376;5180.611454140936;5181.766820493087;4775.426948766136;4912;4915.827946021908;4917.778699958475;4950.405951285833;11205.271657342246;11398.031167350786;15773.526794196192;18408.815911840844;18596.3491277806;2073.668213085899;2077.989610051955;2086.384516567601;2101.81083702466;2108.3147976907567;9423.811523769486;9699.854502182472;9873.901260987443;12519.624411267676;12614.180078294974;1814.3831097426805;1880.9059547022594;1883.8210370014826;1961.2351183038627;2007;55240;59011;59347;61097.69451152716;62576.68711656458;14440.711185776436;14653.340599672827;14750.63123421923;14800.111993280438;14833.777493337608;22615;22894.198703045313;22913.885430573075;22948.131483564553;23000.424989375064;8429.241368276884;8664.220220180214;8705.042445331008;8718.258947989365;8797.252233560219;7395.889061664079;7405.333519983227;7407.148177959496;7474.626268686544;7477.027986361738;7459.922015806523;7489.138749043821;7490.962545187239;7506.849863002819;7659.770206893691;2534.379077126079;2901.202169403389;2951.468735627565;2961.348503329264;2966.881324746986;423.60393032514696;423.8029316367904;444.4244703109481;817.8609636361714;874.1433395272542;10014.599416023424;10120.595176193017;10587.84118238227;10682.092022178202;10888.564457421615;437.9890502737457;451.178854484841;454.4138061900112;455.6650861616709;467.6329081670872;5794.710264486759;5906.940930590725;5985.880282394328;6047.697615119227;6065.5754097212775;355591;469800;474283;495788;503169;42814.57185428168;43529.129417411474;43597.910052248946;58194.7090264546;66054.66972665106;1073.624231518962;1117.0839911272678;1120.7422292872684;1122.1023181454802;1156.3408856951457;11619.709507262387;13576.93211533936;13762.449502019806;14077.648058798612;15070.472533461276;30084.548731768602;30560.08319750411;30905.381892361576;31209.99999999909;31330.530042049842;37810;39408.256215659465;39884.601153988086;40873;42408.78795606002;7280.817979550554;7561.281678240558;7583.544987300559;7590.8102297443;7642.08295004603;7741.845163096819;10432.426216557858;11168.776624467302;11269.380184089954;11489.425528723697;8878.911210888067;9159.313051521296;9172.08279172104;9285.117913798178;9462.57418416159;9448.716538503855;9520.761980950532;9638;9850.704478865646;9955.502224888582;3170.571972783737;3178.666240044762;9882.240134240232;9897.65358212459;9981.800363992825;7434.442416818652;7658.693652253847;7706.460547761603;7739.651715672696;7741.225877412214;8888.688895888612;9807.803843922939;9915.65295214664;9944.801103977736;10090.747731306776 10:25:00 INFO - PROCESS | 32275 | |3;mootools.html;1271.446920589544;1468.3172324868933;1477.9778303325452;1616.4504068616668;1775.7513948047276;6996.965015174924;7494.4004479641635;7703.114141873679;7704.807379815507;7721.150673425933;7717.421193410502;7923.6830526779;7924.564148971805;7936.166702496242;7944.285014348708;2004.3085135628257;2050.5693804301113;2238.1718764057323;2304.8617082975034;2333.2533589251448;2315.6410756332793;2324.430514523944;2326.9767302327014;2327.359976006595;2330.5222429402015;2148.3662319615673;2262.5474905018978;2266.3654176830514;2266.8866556672183;2270.3416009357265;2280.498290376123;2297.9885100574475;2341.66045923341;2349.6005679034433;2358.233574088428;2274.886255687209;2278.2481781012225;2295.494991101955;2296.9310920672237;2298.6322188449935;8073.838523229502;8172.7956801080445;8174.141715119887;8179.059408168017;8187.549684767336;4633.86098417048;4748.002919386933;4770.141374552579;4771.093492236464;4785.564330700776;3044.3911217756536;3046.0866385317304;3099.6590375058727;3104.8602812873473;3115.7818952673324;981.4111533080167;1012.8784545854545;1018.1651046142166;1065.0095411267519;1066.1577353890418;11319.20765546412;11337.943310283561;11344.092472602255;11347.375894325809;11360.943195284053;4241.363795430649;4297.076128632297;4355.346697995326;4357.54245804186;4364.432623758891;9587.760305992266;9634.759131021781;9670.419774813534;9670.661526846527;9697.903020969841;4796.496367881392;4796.760161991887;4818.156822556109;4857.8299759508245;4857.927131093036;4373.234683930299;4376.693631445768;4420.425344705168;4425.977870110629;4431.135928493977;3458.75788694794;3535.575730912307;3650.2699460108083;3671.5043469131324;3789.981050094787;1200.1418985425462;1203.253982530819;1205.7046023724245;1209.7157168065498;1213.0962432987305;1291.3607764156802;1293.4502836294537;1308.941097650608;1323.1399590266403;1342.5636668082716;7150.96424517874;7180.856382872418;7181.712731490787;7182.209956904736;7314.158871729713;1092.2845536173818;1103.3104309806372;1109.8224284114665;1114.4093630375914;1122.8484154639182;5771.68255745938;5893.233879595625;5894.204282421904;5897.439743224387;5910.822675319747;9053.68312109073;9165.90834091664;9175.908240917639;9321.906780932239;9332.813343733087;9219.262459003263;9230.35387522867;9237.261019118454;9248.797656304772;9255.49094799779;7228.855422891513;7261.818454538678;7385.778426647209;7477.513961592479;7490.812729681802;6718.328167183243;6742.9662851685425;6748;6754.729810807513;6762.6280554568;8095.109537950939;8244.670213191404;8253.83492330162;8381.078081411162;8389.244967952913;8550.315974722133;8725.258353040063;8740.300775937783;8939.150780675825;8953.194212520644;7071.328223818729;7297.671604777692;7304.013958115586;7320.707171713072;7325.706971721284;6790.253072162157;6903.482238832007;7268.854622907618;7552.509086909334;7563.205863384265;7019.719211231493;7198.280171982759;7225.494215404871;7235.167955684953;7286.672099755418;6936.930630693831;6948.791536253921;6994.895076573754;7015.36861682451;7021.5787052777;6873.175218973555;6889.104416426033;6929.861402772017;6945.791626251221;7034.261402552658;6412.807615771534;6426.228852537725;6448.258450278278;6461.224653041665;6463.127477790438;6539.411452969255;6588;6595.901061483985;6601.537892347682;6603.867922641616 10:25:00 INFO - PROCESS | 32275 | |4;prototype.html;345.54733299377835;346.1432953440235;348.3329424152746;349.18639569802355;355.71542765787365;5654.858628534289;5771.624844385117;5787.363390027093;5826.679532625709;5827.271591051113;5581.330240371161;5684.857878553038;5695.800646977356;5700.629459085157;5708.885822283562;4484.461864576256;4499.0776890737325;4502.189605870958;4532.320151977214;4532.7280363178315;4339.370791235269;4403.141387429452;4432.290833466646;4510.684252102355;4537.478190008158;4461.152381047591;4469.910601787962;4480.103979204156;4491.9775401123115;4501.909961800779;4490.3488994096;4491.371208030879;4496.078303947699;4501.189785838547;4506.324051392285;3987.6809855211513;3990.38149086892;3990.5809889961715;3994.3409337459284;3996.460477835484;5375.973120134374;5530;5542.974549708317;5562.833115006556;5568.749406276727;5123.974380128076;5142.820001299937;5158.9484105158845;5169.974150129263;5176.0683077046115;5899.262592175978;6145.877082458371;6152.84617884552;6173.536984726119;6174.166487524217;4200.85297014603;4216.198922204802;4287.249731297042;4294.677899157545;4302.806373713191;6255.12428260044;6356.96821515894;6357.5867568608355;6358.491320694333;6362.331955144736;4357.7385356878685;4385.693001489865;4393.055493069006;4393.51671316155;4398.208322501916;4316.374125751749;4445.355423463579;4447.221736196153;4452.5992660660695;4481.327800829901;5147.1507201312115;5148.3564554430695;5148.742562871841;5151.2530683050745;5164.586833053347;6163.8150855474405;6165.445109940127;6171.228596425447;6173.59871608344;6183.752649893954;1550.99224503879;1569.6154442161744;1571.08091766318;1572.6225705830518;1574.3545146489885;1046.1630695443614;1053.146950969717;1054.1724746074294;1066.9519871605796;1078.9676309710721;5820;5829.766809327664;5832.679202643811;5835.416458354131;5840.036393995028;6282;6285.371462853678;6287.339829317947;6295.370462953668;6316.526260530479;5821.708914554255;5824.563157763185;5826.0678291474005;5834.066549352084;5836.241288632451;3288.062902072898;3392.3215356928713;3393.01602535262;3395.286989732184;3395.7453191010277;6573.441257493071;6578.671066446658;6582;6582.473402127818;6596.175478065242;6443.259025212161;6466.612003279724;6470.22357317125;6474.870502590016;6476.611403315722;6364.427201551883;6533.216014078341;6540.182477190351;6568.113304703804;6589.4728421725185;6111.5110791137495;6204.968975155095;6280.717367718372;6288.968555157195;6350.174477317919;6151.384861513813;6282.1519094921605;6296.905546416716;6301;6311.652859092794;6579.868402632016;6631.568948018364;6632.038354438676;6634.104395906491;6635.568688035262;4290.442242508454;4368.9126217476105;4371.388005679144;4374.934375984427;4376.978115109404;6353.8729225416155;6355.87288254223;6358.554901156875;6361.586496877688;6362.363763623601;6192.566520343533;6193.38066193377;6198.039303907902;6199.783007594712;6201.875962480815;6036.788712395045;6184.319724830355;6185.536084793568;6190.50475961913;6191.226096737908;6078.331383547717;6079.3312735598165;6084.026555751058;6084.756609735561;6085.817425477243;6163.784267550794;6183.536234782499;6189.82393345263;6200.627962322275;6204.410580994799;5914.935311643773;6061.39386061408;6069.5751297410525;6070.484008859296;6073.969630151998 10:25:00 INFO - PROCESS | 32275 | |5;yui.html;831.7587899509143;833.1002517281337;841.1840514700738;846.6740304982582;848.6647774129219;12539.811902821453;13628.523001694943;13836.308184590767;13857.653558661039;13875.375608097635;12285.570005049804;12337.198082124656;12363.629091127257;12363.690907727312;12368.938155309212;647.2912161183497;793.6230290611942;806.4838503357855;806.7136166660839;806.9112397636255;665.7703092433103;670.9496787740915;672.1262358933392;784.4116912315764;807.7738233294687;828.8300898315831;835.3150416658343;835.5780330932901;835.8662613981764;837.417994493827;832.883396324515;833.8832563441123;835.5905606252923;837.4431003382743;838.995805020974;505.58541995563655;511.12342332899254;608.2822269721727;617.2068891474479;618.1562167641182;12960.351982400842;12962.80555791664;12966.481340746359;12981.740365192738;12993.48026078965;11780.116491263103;11923.879118526942;12056.819147712791;12080.111359346889;12350;10014.699559013241;10068.899311006942;10183;10224;10295.742606434824;3554.3424466473525;3562.7327950403824;3578.58846232684;3655.6344365563496;3728.6271372862766;44282.77858610686;44575.55424445747;44659.55340446586;44874;44905.55094449046;9286.860697089549;9597.9040209597;9599.712008639752;9769.16962058233;10161.136303414145;17693.646127077387;17788.822111778976;17850.821491784915;17898.91050544739;17912.910435448;7529.623518824037;7634.6946122155605;7674.386049116169;7875.448718589759;7989.680412783539;4289.056407590325;4327.3725309830525;4329.069250111178;4378.124375124988;4385.912281754347;2994.4909365407934;3009.2627306309655;3009.2627306310096;3011.9247018824267;3021.5165573508134;547.2748608094291;549.6976662835505;552.5220684108217;556.057482567045;565.9886802263932;567.5459632294148;635.5201822623982;670.2560158224367;689.2452764223168;699.1164083516015;8656.8701469478;8674.86987695185;8754.168354006359;8811;8871.157240062184;520.8723862653674;550.5623029691405;589.0251633546487;660.7621256347711;666.3736088077192;3900.980495097563;4060.878173654795;4124.546299907008;4203.726757760735;4268.679849011337;52963.73518132462;53182.46817531853;54049.459505405226;54274.72862635661;54364.45635543673;47845;48494.75752621285;48753.756231219326;49065.754671226416;49334.75332623314;41857.37213941793;43635;44392.55607443949;44632.330515042304;44708;8244.83510329802;8337.708180213906;8394.874076888973;8463.703770368007;8471.152884711479;32360.514592281605;32972.845950392584;33091.66908330886;33851.492227616116;33893.83053084719;39110.6088939107;43648.34527482027;44844.77577612222;45008.549914500436;46594.301085484425;10622.024389390952;10629.415382154055;10654.60234576657;10905.618303359344;11001.119910406987;11592.508754811066;11756.94121529387;11950.701232469259;11957.402129893297;12064.577739779066;10091.344062635904;10189.439580823126;10227.795444091225;10422.374657520573;10616.363018218932;10964.835527466936;11188.328700278009;11452.713682158013;11643.53425862956;11710.12174086964;10488.528016239135;10610.151187904794;10908.672739817817;11356.886431135914;11806.881931180922;9605.519724013911;9710.70867873965;9889.802203955736;9989.60041598328;10262.332948358333;9127.908720912972;9379.202767764817;9787.657431989846;9916.305858589829;9941.502924853872 10:25:00 INFO - PROCESS | 32275 | __end_tp_report 10:25:00 INFO - PROCESS | 32275 | __start_cc_report 10:25:00 INFO - PROCESS | 32275 | _x_x_mozilla_cycle_collect,1363 10:25:00 INFO - PROCESS | 32275 | __end_cc_report 10:25:00 INFO - PROCESS | 32275 | __startTimestamp1452795900374__endTimestamp 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | ------- Summary: start ------- 10:25:00 INFO - PROCESS | 32275 | Number of tests: 6 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#0] dojo.html Cycles:165 Average:4919.95 Median:5092.44 stddev:510.49 (10.0%) stddev-sans-first:490.07 10:25:00 INFO - PROCESS | 32275 | Values: 3030.7 3064.1 3065.1 3082.0 3091.5 4819.6 4911.3 4970.2 4972.1 5011.9 4938.2 4998.2 5016.3 5032.4 5089.5 4536.3 4541.3 4545.5 4605.7 4608.5 4573.9 4592.1 4625.6 4653.4 4671.0 4460.1 4481.6 4556.8 4564.6 4593.7 4561.4 4571.8 4573.5 4583.4 4593.5 4525.3 4538.4 4548.6 4555.3 4582.9 4712.1 4740.3 4772.3 4792.8 4826.5 5200.2 5257.2 5261.7 5263.4 5264.3 5265.3 5271.7 5272.6 5276.0 5279.0 4975.3 4979.3 5014.1 5101.4 5109.3 5400.0 5458.4 5463.2 5463.8 5508.1 5233.1 5280.4 5280.9 5281.4 5291.8 5162.4 5238.7 5262.2 5357.5 5363.9 5228.2 5239.6 5240.1 5244.4 5272.3 5282.6 5298.5 5303.8 5309.8 5347.2 4076.8 4137.6 4151.0 4186.5 4224.3 3713.6 3715.1 3727.6 3731.1 3735.4 4836.3 4840.1 4841.6 4853.8 4891.1 5138.9 5202.4 5208.2 5211.5 5218.7 4907.6 4922.6 4922.6 4954.6 5000.1 4502.1 4504.1 4512.5 4545.8 4557.4 5380.4 5401.4 5419.9 5470.6 5473.5 5213.2 5300.5 5311.2 5323.2 5364.1 5482.5 5515.9 5535.0 5537.6 5541.4 5112.8 5177.6 5185.4 5267.5 5268.7 5133.0 5202.1 5204.9 5205.0 5209.9 5088.4 5090.8 5092.4 5093.3 5100.7 5080.4 5148.4 5157.5 5183.9 5195.6 4958.4 5036.7 5037.1 5037.7 5078.4 5122.8 5130.1 5133.7 5181.4 5226.8 5032.4 5095.4 5149.7 5153.3 5193.9 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#1] ext.html Cycles:180 Average:48665.16 Median:37842.12 stddev:86939.51 (229.7%) stddev-sans-first:87108.30 10:25:00 INFO - PROCESS | 32275 | Values: 537.8 582.8 598.9 600.1 608.5 27487.0 28051.3 28055.2 28070.7 38656.0 42721.4 43270.8 43303.4 43371.3 43477.3 8569.7 8780.6 8783.6 8814.9 8815.1 8520.8 8600.4 8633.6 8656.6 8670.7 8420.0 8545.3 8545.5 8549.1 8552.1 8572.8 8648.9 8657.0 8658.8 8663.0 8595.3 8689.8 8721.4 8722.0 8735.4 39958.6 40373.2 40411.4 40435.6 40509.6 3165.7 3522.5 3838.0 3949.1 3957.5 28264.4 30069.2 30822.0 30878.4 30993.5 3707.7 3711.1 3828.8 3871.4 3874.4 266358.0 267448.0 268295.0 268791.0 269810.0 50944.2 52025.5 59840.0 59888.7 61009.0 53389.5 53625.2 53826.2 53850.7 53907.7 14377.8 14726.1 14730.9 14738.3 14758.9 9463.6 9750.8 11236.5 11481.5 11498.5 19468.1 19482.6 19666.8 19694.3 19713.4 7391.7 7579.8 7694.0 7727.5 7791.8 891.1 941.6 1028.6 1046.5 1101.2 28280.4 29033.6 29046.9 29298.4 29325.0 1068.5 1088.0 1115.7 1127.4 1144.1 15114.7 15128.7 15439.7 15494.4 15736.3 329413.0 334019.0 335361.0 335549.0 335760.0 52288.5 52325.0 52393.5 52451.0 52518.7 1296.3 1348.5 1353.0 1355.9 1357.5 28490.9 29298.7 29344.1 29602.4 29845.9 42352.8 46910.3 47329.8 47374.5 47460.8 190607.0 404992.0 414788.0 416317.0 417460.0 30825.0 31582.2 31657.0 31674.0 31700.4 42020.4 44140.1 44205.6 44868.0 45219.5 36819.6 37228.8 37992.4 38415.0 38912.8 36557.0 36839.0 37544.8 37691.8 38062.4 36288.1 36479.3 36697.3 37033.6 37070.3 32347.2 33927.2 33977.0 34191.0 34549.8 25455.1 25587.2 25623.0 25691.4 25801.9 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#2] jquery.html Cycles:180 Average:24586.70 Median:455.04 stddev:75492.14 (16590.2%) stddev-sans-first:75681.99 10:25:00 INFO - PROCESS | 32275 | Values: 360.2 360.4 361.4 361.6 368.9 13152.7 13557.3 15479.8 16067.4 17142.6 14356.7 15184.2 15504.2 15555.7 16352.8 5180.9 5349.0 5352.8 5355.3 5358.2 3894.8 4036.2 4653.8 5320.3 5595.8 5680.5 5698.1 5744.7 5746.3 5750.1 5039.2 5140.9 5171.7 5180.6 5181.8 4775.4 4912.0 4915.8 4917.8 4950.4 11205.3 11398.0 15773.5 18408.8 18596.3 2073.7 2078.0 2086.4 2101.8 2108.3 9423.8 9699.9 9873.9 12519.6 12614.2 1814.4 1880.9 1883.8 1961.2 2007.0 55240.0 59011.0 59347.0 61097.7 62576.7 14440.7 14653.3 14750.6 14800.1 14833.8 22615.0 22894.2 22913.9 22948.1 23000.4 8429.2 8664.2 8705.0 8718.3 8797.3 7395.9 7405.3 7407.1 7474.6 7477.0 7459.9 7489.1 7491.0 7506.8 7659.8 2534.4 2901.2 2951.5 2961.3 2966.9 423.6 423.8 444.4 817.9 874.1 10014.6 10120.6 10587.8 10682.1 10888.6 438.0 451.2 454.4 455.7 467.6 5794.7 5906.9 5985.9 6047.7 6065.6 355591.0 469800.0 474283.0 495788.0 503169.0 42814.6 43529.1 43597.9 58194.7 66054.7 1073.6 1117.1 1120.7 1122.1 1156.3 11619.7 13576.9 13762.4 14077.6 15070.5 30084.5 30560.1 30905.4 31210.0 31330.5 37810.0 39408.3 39884.6 40873.0 42408.8 7280.8 7561.3 7583.5 7590.8 7642.1 7741.8 10432.4 11168.8 11269.4 11489.4 8878.9 9159.3 9172.1 9285.1 9462.6 9448.7 9520.8 9638.0 9850.7 9955.5 3170.6 3178.7 9882.2 9897.7 9981.8 7434.4 7658.7 7706.5 7739.7 7741.2 8888.7 9807.8 9915.7 9944.8 10090.7 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#3] mootools.html Cycles:180 Average:5511.70 Median:6437.24 stddev:2866.82 (44.5%) stddev-sans-first:2857.14 10:25:00 INFO - PROCESS | 32275 | Values: 1271.4 1468.3 1478.0 1616.5 1775.8 6997.0 7494.4 7703.1 7704.8 7721.2 7717.4 7923.7 7924.6 7936.2 7944.3 2004.3 2050.6 2238.2 2304.9 2333.3 2315.6 2324.4 2327.0 2327.4 2330.5 2148.4 2262.5 2266.4 2266.9 2270.3 2280.5 2298.0 2341.7 2349.6 2358.2 2274.9 2278.2 2295.5 2296.9 2298.6 8073.8 8172.8 8174.1 8179.1 8187.5 4633.9 4748.0 4770.1 4771.1 4785.6 3044.4 3046.1 3099.7 3104.9 3115.8 981.4 1012.9 1018.2 1065.0 1066.2 11319.2 11337.9 11344.1 11347.4 11360.9 4241.4 4297.1 4355.3 4357.5 4364.4 9587.8 9634.8 9670.4 9670.7 9697.9 4796.5 4796.8 4818.2 4857.8 4857.9 4373.2 4376.7 4420.4 4426.0 4431.1 3458.8 3535.6 3650.3 3671.5 3790.0 1200.1 1203.3 1205.7 1209.7 1213.1 1291.4 1293.5 1308.9 1323.1 1342.6 7151.0 7180.9 7181.7 7182.2 7314.2 1092.3 1103.3 1109.8 1114.4 1122.8 5771.7 5893.2 5894.2 5897.4 5910.8 9053.7 9165.9 9175.9 9321.9 9332.8 9219.3 9230.4 9237.3 9248.8 9255.5 7228.9 7261.8 7385.8 7477.5 7490.8 6718.3 6743.0 6748.0 6754.7 6762.6 8095.1 8244.7 8253.8 8381.1 8389.2 8550.3 8725.3 8740.3 8939.2 8953.2 7071.3 7297.7 7304.0 7320.7 7325.7 6790.3 6903.5 7268.9 7552.5 7563.2 7019.7 7198.3 7225.5 7235.2 7286.7 6936.9 6948.8 6994.9 7015.4 7021.6 6873.2 6889.1 6929.9 6945.8 7034.3 6412.8 6426.2 6448.3 6461.2 6463.1 6539.4 6588.0 6595.9 6601.5 6603.9 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#4] prototype.html Cycles:180 Average:5146.57 Median:5825.32 stddev:1536.14 (26.4%) stddev-sans-first:1497.59 10:25:00 INFO - PROCESS | 32275 | Values: 345.5 346.1 348.3 349.2 355.7 5654.9 5771.6 5787.4 5826.7 5827.3 5581.3 5684.9 5695.8 5700.6 5708.9 4484.5 4499.1 4502.2 4532.3 4532.7 4339.4 4403.1 4432.3 4510.7 4537.5 4461.2 4469.9 4480.1 4492.0 4501.9 4490.3 4491.4 4496.1 4501.2 4506.3 3987.7 3990.4 3990.6 3994.3 3996.5 5376.0 5530.0 5543.0 5562.8 5568.7 5124.0 5142.8 5158.9 5170.0 5176.1 5899.3 6145.9 6152.8 6173.5 6174.2 4200.9 4216.2 4287.2 4294.7 4302.8 6255.1 6357.0 6357.6 6358.5 6362.3 4357.7 4385.7 4393.1 4393.5 4398.2 4316.4 4445.4 4447.2 4452.6 4481.3 5147.2 5148.4 5148.7 5151.3 5164.6 6163.8 6165.4 6171.2 6173.6 6183.8 1551.0 1569.6 1571.1 1572.6 1574.4 1046.2 1053.1 1054.2 1067.0 1079.0 5820.0 5829.8 5832.7 5835.4 5840.0 6282.0 6285.4 6287.3 6295.4 6316.5 5821.7 5824.6 5826.1 5834.1 5836.2 3288.1 3392.3 3393.0 3395.3 3395.7 6573.4 6578.7 6582.0 6582.5 6596.2 6443.3 6466.6 6470.2 6474.9 6476.6 6364.4 6533.2 6540.2 6568.1 6589.5 6111.5 6205.0 6280.7 6289.0 6350.2 6151.4 6282.2 6296.9 6301.0 6311.7 6579.9 6631.6 6632.0 6634.1 6635.6 4290.4 4368.9 4371.4 4374.9 4377.0 6353.9 6355.9 6358.6 6361.6 6362.4 6192.6 6193.4 6198.0 6199.8 6201.9 6036.8 6184.3 6185.5 6190.5 6191.2 6078.3 6079.3 6084.0 6084.8 6085.8 6163.8 6183.5 6189.8 6200.6 6204.4 5914.9 6061.4 6069.6 6070.5 6074.0 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - PROCESS | 32275 | [#5] yui.html Cycles:180 Average:13273.26 Median:44683.78 stddev:15052.35 (33.7%) stddev-sans-first:15065.57 10:25:00 INFO - PROCESS | 32275 | Values: 831.8 833.1 841.2 846.7 848.7 12539.8 13628.5 13836.3 13857.7 13875.4 12285.6 12337.2 12363.6 12363.7 12368.9 647.3 793.6 806.5 806.7 806.9 665.8 670.9 672.1 784.4 807.8 828.8 835.3 835.6 835.9 837.4 832.9 833.9 835.6 837.4 839.0 505.6 511.1 608.3 617.2 618.2 12960.4 12962.8 12966.5 12981.7 12993.5 11780.1 11923.9 12056.8 12080.1 12350.0 10014.7 10068.9 10183.0 10224.0 10295.7 3554.3 3562.7 3578.6 3655.6 3728.6 44282.8 44575.6 44659.6 44874.0 44905.6 9286.9 9597.9 9599.7 9769.2 10161.1 17693.6 17788.8 17850.8 17898.9 17912.9 7529.6 7634.7 7674.4 7875.4 7989.7 4289.1 4327.4 4329.1 4378.1 4385.9 2994.5 3009.3 3009.3 3011.9 3021.5 547.3 549.7 552.5 556.1 566.0 567.5 635.5 670.3 689.2 699.1 8656.9 8674.9 8754.2 8811.0 8871.2 520.9 550.6 589.0 660.8 666.4 3901.0 4060.9 4124.5 4203.7 4268.7 52963.7 53182.5 54049.5 54274.7 54364.5 47845.0 48494.8 48753.8 49065.8 49334.8 41857.4 43635.0 44392.6 44632.3 44708.0 8244.8 8337.7 8394.9 8463.7 8471.2 32360.5 32972.8 33091.7 33851.5 33893.8 39110.6 43648.3 44844.8 45008.5 46594.3 10622.0 10629.4 10654.6 10905.6 11001.1 11592.5 11756.9 11950.7 11957.4 12064.6 10091.3 10189.4 10227.8 10422.4 10616.4 10964.8 11188.3 11452.7 11643.5 11710.1 10488.5 10610.2 10908.7 11356.9 11806.9 9605.5 9710.7 9889.8 9989.6 10262.3 9127.9 9379.2 9787.7 9916.3 9941.5 10:25:00 INFO - PROCESS | 32275 | -------- Summary: end -------- 10:25:00 INFO - PROCESS | 32275 | 10:25:00 INFO - TEST-INFO | 32275: exit 0 10:25:01 INFO - TEST-OK | dromaeo_css | took 1113924ms 10:25:01 INFO - TEST-START | kraken 10:25:01 INFO - operating with platform_type : linux_ 10:25:01 INFO - Initialising browser for kraken test... 10:25:01 INFO - TEST-INFO | started process 32479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp2VvlI/profile http://localhost:35563/getInfo.html) 10:25:05 INFO - PROCESS | 32479 | __metrics Screen width/height:1600/1200 10:25:05 INFO - PROCESS | 32479 | colorDepth:24 10:25:05 INFO - PROCESS | 32479 | Browser inner width/height: 1024/697 10:25:05 INFO - PROCESS | 32479 | __metrics 10:25:06 INFO - PROCESS | 32479 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:25:06 INFO - PROCESS | 32479 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:07 INFO - TEST-INFO | 32479: exit 0 10:25:07 INFO - Browser initialized. 10:25:07 INFO - Running cycle 1/1 for kraken test... 10:25:07 INFO - TEST-INFO | started process 32562 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp2VvlI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:18 INFO - PROCESS | 32562 | RSS: Main: 150421504 10:25:18 INFO - PROCESS | 32562 | 10:25:21 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35563/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:21 INFO - PROCESS | 32562 | RSS: Main: 186654720 10:25:21 INFO - PROCESS | 32562 | 10:25:24 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35563/tests/kraken/driver.html?testName=audio-dft) 10:25:25 INFO - PROCESS | 32562 | RSS: Main: 178483200 10:25:25 INFO - PROCESS | 32562 | 10:25:28 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35563/tests/kraken/driver.html?testName=audio-fft) 10:25:28 INFO - PROCESS | 32562 | RSS: Main: 161857536 10:25:28 INFO - PROCESS | 32562 | 10:25:30 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35563/tests/kraken/driver.html?testName=audio-oscillator) 10:25:31 INFO - PROCESS | 32562 | RSS: Main: 164495360 10:25:31 INFO - PROCESS | 32562 | 10:25:33 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:34 INFO - PROCESS | 32562 | RSS: Main: 165117952 10:25:34 INFO - PROCESS | 32562 | 10:25:36 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35563/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:37 INFO - PROCESS | 32562 | RSS: Main: 165064704 10:25:37 INFO - PROCESS | 32562 | 10:25:40 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35563/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:41 INFO - PROCESS | 32562 | RSS: Main: 166522880 10:25:41 INFO - PROCESS | 32562 | 10:25:44 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35563/tests/kraken/driver.html?testName=json-parse-financial) 10:25:44 INFO - PROCESS | 32562 | RSS: Main: 165744640 10:25:44 INFO - PROCESS | 32562 | 10:25:46 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:46 INFO - PROCESS | 32562 | RSS: Main: 176435200 10:25:46 INFO - PROCESS | 32562 | 10:25:48 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:49 INFO - PROCESS | 32562 | RSS: Main: 174702592 10:25:49 INFO - PROCESS | 32562 | 10:25:51 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:51 INFO - PROCESS | 32562 | RSS: Main: 183836672 10:25:51 INFO - PROCESS | 32562 | 10:25:54 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:54 INFO - PROCESS | 32562 | RSS: Main: 189284352 10:25:54 INFO - PROCESS | 32562 | 10:25:57 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:57 INFO - PROCESS | 32562 | RSS: Main: 186613760 10:25:57 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | Cycle 1(1): loaded http://localhost:35563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35563/tests/kraken/driver.html?testName=ai-astar) 10:25:59 INFO - PROCESS | 32562 | RSS: Main: 245538816 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | __start_tp_report 10:25:59 INFO - PROCESS | 32562 | _x_x_mozilla_page_load 10:25:59 INFO - PROCESS | 32562 | _x_x_mozilla_page_load_details 10:25:59 INFO - PROCESS | 32562 | |i|pagename|runs| 10:25:59 INFO - PROCESS | 32562 | |0;ai-astar;110;110;106;110;114;110;99;110;112;110 10:25:59 INFO - PROCESS | 32562 | |1;audio-beat-detection;155;131;150;162;131;149;149;132;166;126 10:25:59 INFO - PROCESS | 32562 | |2;audio-dft;162;161;163;162;162;161;161;163;162;162 10:25:59 INFO - PROCESS | 32562 | |3;audio-fft;72;72;103;109;72;75;72;116;97;73 10:25:59 INFO - PROCESS | 32562 | |4;audio-oscillator;101;96;149;94;95;96;140;96;96;153 10:25:59 INFO - PROCESS | 32562 | |5;imaging-gaussian-blur;109;109;109;110;109;110;109;109;109;109 10:25:59 INFO - PROCESS | 32562 | |6;imaging-darkroom;146;145;147;146;146;146;146;145;145;145 10:25:59 INFO - PROCESS | 32562 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;95;96 10:25:59 INFO - PROCESS | 32562 | |8;json-parse-financial;57;56;58;56;57;56;55;66;53;54 10:25:59 INFO - PROCESS | 32562 | |9;json-stringify-tinderbox;68;68;68;68;68;68;69;68;68;68 10:25:59 INFO - PROCESS | 32562 | |10;stanford-crypto-aes;80;81;81;82;81;80;80;82;81;88 10:25:59 INFO - PROCESS | 32562 | |11;stanford-crypto-ccm;121;130;115;114;119;123;118;123;114;115 10:25:59 INFO - PROCESS | 32562 | |12;stanford-crypto-pbkdf2;140;139;144;140;129;128;143;138;138;132 10:25:59 INFO - PROCESS | 32562 | |13;stanford-crypto-sha256-iterative;65;66;67;69;67;68;65;67;65;68 10:25:59 INFO - PROCESS | 32562 | __end_tp_report 10:25:59 INFO - PROCESS | 32562 | __start_cc_report 10:25:59 INFO - PROCESS | 32562 | _x_x_mozilla_cycle_collect,946 10:25:59 INFO - PROCESS | 32562 | __end_cc_report 10:25:59 INFO - PROCESS | 32562 | __startTimestamp1452795959877__endTimestamp 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | ------- Summary: start ------- 10:25:59 INFO - PROCESS | 32562 | Number of tests: 14 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:4.07 (3.7%) stddev-sans-first:4.30 10:25:59 INFO - PROCESS | 32562 | Values: 110.0 110.0 106.0 110.0 114.0 110.0 99.0 110.0 112.0 110.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:149.50 stddev:14.18 (9.5%) stddev-sans-first:14.58 10:25:59 INFO - PROCESS | 32562 | Values: 155.0 131.0 150.0 162.0 131.0 149.0 149.0 132.0 166.0 126.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:25:59 INFO - PROCESS | 32562 | Values: 162.0 161.0 163.0 162.0 162.0 161.0 161.0 163.0 162.0 162.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#3] audio-fft Cycles:10 Average:86.10 Median:72.00 stddev:17.99 (25.0%) stddev-sans-first:18.34 10:25:59 INFO - PROCESS | 32562 | Values: 72.0 72.0 103.0 109.0 72.0 75.0 72.0 116.0 97.0 73.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:95.50 stddev:24.92 (26.1%) stddev-sans-first:26.14 10:25:59 INFO - PROCESS | 32562 | Values: 101.0 96.0 149.0 94.0 95.0 96.0 140.0 96.0 96.0 153.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:25:59 INFO - PROCESS | 32562 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:25:59 INFO - PROCESS | 32562 | Values: 146.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:25:59 INFO - PROCESS | 32562 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.55 (6.3%) stddev-sans-first:3.77 10:25:59 INFO - PROCESS | 32562 | Values: 57.0 56.0 58.0 56.0 57.0 56.0 55.0 66.0 53.0 54.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:25:59 INFO - PROCESS | 32562 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:2.37 (2.9%) stddev-sans-first:2.44 10:25:59 INFO - PROCESS | 32562 | Values: 80.0 81.0 81.0 82.0 81.0 80.0 80.0 82.0 81.0 88.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:5.16 (4.3%) stddev-sans-first:5.43 10:25:59 INFO - PROCESS | 32562 | Values: 121.0 130.0 115.0 114.0 119.0 123.0 118.0 123.0 114.0 115.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:139.50 stddev:5.57 (4.0%) stddev-sans-first:5.80 10:25:59 INFO - PROCESS | 32562 | Values: 140.0 139.0 144.0 140.0 129.0 128.0 143.0 138.0 138.0 132.0 10:25:59 INFO - PROCESS | 32562 | 10:25:59 INFO - PROCESS | 32562 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 10:25:59 INFO - PROCESS | 32562 | Values: 65.0 66.0 67.0 69.0 67.0 68.0 65.0 67.0 65.0 68.0 10:25:59 INFO - PROCESS | 32562 | -------- Summary: end -------- 10:25:59 INFO - PROCESS | 32562 | 10:26:01 INFO - TEST-INFO | 32562: exit 0 10:26:01 INFO - TEST-OK | kraken | took 60194ms 10:26:01 INFO - TEST-START | v8_7 10:26:01 INFO - operating with platform_type : linux_ 10:26:01 INFO - Initialising browser for v8_7 test... 10:26:01 INFO - TEST-INFO | started process 343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSQMWta/profile http://localhost:35563/getInfo.html) 10:26:06 INFO - PROCESS | 343 | __metrics Screen width/height:1600/1200 10:26:06 INFO - PROCESS | 343 | colorDepth:24 10:26:06 INFO - PROCESS | 343 | Browser inner width/height: 1024/697 10:26:06 INFO - PROCESS | 343 | __metrics 10:26:06 INFO - PROCESS | 343 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:26:06 INFO - PROCESS | 343 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:07 INFO - TEST-INFO | 343: exit 0 10:26:07 INFO - Browser initialized. 10:26:07 INFO - Running cycle 1/1 for v8_7 test... 10:26:07 INFO - TEST-INFO | started process 428 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSQMWta/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:19 INFO - PROCESS | 428 | RSS: Main: 149458944 10:26:19 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | Cycle 1(1): loaded http://localhost:35563/tests/v8_7/run.html (next: http://localhost:35563/tests/v8_7/run.html) 10:26:41 INFO - PROCESS | 428 | RSS: Main: 550510592 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | __start_tp_report 10:26:41 INFO - PROCESS | 428 | _x_x_mozilla_page_load 10:26:41 INFO - PROCESS | 428 | _x_x_mozilla_page_load_details 10:26:41 INFO - PROCESS | 428 | |i|pagename|runs| 10:26:41 INFO - PROCESS | 428 | |0;Richards;166.27868307283006 10:26:41 INFO - PROCESS | 428 | |1;DeltaBlue;188.5014137606032 10:26:41 INFO - PROCESS | 428 | |2;Encrypt;280.3476310625175 10:26:41 INFO - PROCESS | 428 | |3;Decrypt;5306.878306878307 10:26:41 INFO - PROCESS | 428 | |4;RayTrace;1974.3589743589744 10:26:41 INFO - PROCESS | 428 | |5;Earley;789.8894154818325 10:26:41 INFO - PROCESS | 428 | |6;Boyer;12219.512195121952 10:26:41 INFO - PROCESS | 428 | |7;RegExp;42437.5 10:26:41 INFO - PROCESS | 428 | |8;Splay;598.0861244019138 10:26:41 INFO - PROCESS | 428 | |9;NavierStokes;4835.748792270531 10:26:41 INFO - PROCESS | 428 | __end_tp_report 10:26:41 INFO - PROCESS | 428 | __startTimestamp1452796001974__endTimestamp 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | ------- Summary: start ------- 10:26:41 INFO - PROCESS | 428 | Number of tests: 10 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 166.3 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 188.5 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 280.3 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 5306.9 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 1974.4 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 789.9 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 12219.5 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#7] RegExp Cycles:1 Average:42437.50 Median:42437.50 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 42437.5 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#8] Splay Cycles:1 Average:598.09 Median:598.09 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 598.1 10:26:41 INFO - PROCESS | 428 | 10:26:41 INFO - PROCESS | 428 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:26:41 INFO - PROCESS | 428 | Values: 4835.7 10:26:41 INFO - PROCESS | 428 | -------- Summary: end -------- 10:26:41 INFO - PROCESS | 428 | 10:26:42 INFO - TEST-INFO | 428: exit 0 10:26:42 INFO - TEST-OK | v8_7 | took 41706ms 10:26:42 INFO - SUITE-END | took 1215s 10:26:43 INFO - Completed test suite (00:20:15) 10:26:43 INFO - Working with test: dromaeo_css 10:26:43 INFO - Generating results file: dromaeo_css 10:26:43 INFO - Working with test: kraken 10:26:43 INFO - Generating results file: kraken 10:26:43 INFO - javascript benchmark 10:26:43 INFO - Working with test: v8_7 10:26:43 INFO - Generating results file: v8_7 10:26:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 10:26:43 INFO - process_Request line: dromaeo_css 6719.86 graph.html#tests=[[72,1,35]] 10:26:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:43 INFO - process_Request line: kraken 1493.90 graph.html#tests=[[232,1,35]] 10:26:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:43 INFO - process_Request line: v8_7 18892.53 graph.html#tests=[[230,1,35]] 10:26:43 INFO - RETURN: dromaeo_css: 6719.86 10:26:43 INFO - RETURN: kraken: 1493.90 10:26:43 INFO - RETURN: v8_7: 18892.53 10:26:43 INFO - javascript benchmark 10:26:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3030.7120823521764, 3064.1420402287367, 3065.1111177758453, 3081.9845900770506, 3091.5208142737874, 4819.614430845532, 4911.2633105034265, 4970.179920313149, 4972.055309491198, 5011.874703132424, 4938.234573641092, 4998.150314446544, 5016.297718319438, 5032.421271553772, 5089.491050894909, 4536.25151849946, 4541.273396256592, 4545.47727011393, 4605.700629459091, 4608.493065762764, 4573.908521829561, 4592.058627981272, 4625.62994960404, 4653.441587009546, 4671.0, 4460.063386688783, 4481.551844815525, 4556.794944227501, 4564.566366195206, 4593.724376537385, 4561.429821272341, 4571.839985600488, 4573.474050484204, 4583.381243532114, 4593.47175074864, 4525.275955847049, 4538.432695913011, 4548.613367863735, 4555.316702494619, 4582.908341833178, 4712.0811441768865, 4740.336352910561, 4772.284157376386, 4792.808287668489, 4826.517348265181, 5200.193969934666, 5257.237700533401, 5261.710605916673, 5263.421023687391, 5264.341957255343, 5265.341832270966, 5271.710055946922, 5272.604554658377, 5275.973620131875, 5279.0, 4975.303457515951, 4979.253112033188, 5014.147594908874, 5101.36232970875, 5109.310243117206, 5400.0, 5458.426865179178, 5463.153211252262, 5463.808766693226, 5508.118701007819, 5233.1365324721755, 5280.419153893069, 5280.9207861882105, 5281.419043905167, 5291.761870715827, 5162.432132465426, 5238.68567885928, 5262.184361423985, 5357.544608708304, 5363.865903352369, 5228.215767634885, 5239.607029472805, 5240.135377662643, 5244.449332820075, 5272.288241087481, 5282.577393808486, 5298.549623282064, 5303.761330740126, 5309.814156504581, 5347.224652425377, 4076.775777332216, 4137.606927341898, 4150.979245103816, 4186.518550366686, 4224.324108142744, 3713.6472035156617, 3715.071232191952, 3727.6458736419995, 3731.1418373774186, 3735.402335626287, 4836.274558816206, 4840.1287768201355, 4841.564259216688, 4853.757312134379, 4891.144049791344, 5138.948610513922, 5202.401723801736, 5208.192730126836, 5211.530962213419, 5218.6868787872845, 4907.60739140875, 4922.606191504671, 4922.606191504743, 4954.5788607968725, 5000.1249781288125, 4502.144592527409, 4504.09918016398, 4512.52618475062, 4545.818167273272, 4557.430321209848, 5380.435054319319, 5401.3518377794135, 5419.945800541944, 5470.64440811346, 5473.452654734574, 5213.218017297436, 5300.5494532963585, 5311.176767601028, 5323.201519772065, 5364.114921037985, 5482.451754824486, 5515.917261241005, 5534.972325138509, 5537.584681148849, 5541.3904470509015, 5112.846614601568, 5177.611679124006, 5185.403678576861, 5267.473252674855, 5268.6575372600655, 5133.0, 5202.115640341075, 5204.947950520598, 5204.973975130251, 5209.947900521098, 5088.389393272831, 5090.796368145381, 5092.439831618593, 5093.337866077386, 5100.7449627517735, 5080.415752188398, 5148.3564554430695, 5157.484251574812, 5183.896322073613, 5195.584353251656, 4958.429780575136, 5036.6726162799305, 5037.118504261666, 5037.672551284155, 5078.365204349457, 5122.846314610568, 5130.102232109441, 5133.666311689728, 5181.35233095863, 5226.790928362823, 5032.421271553818, 5095.388553373619, 5149.742512874416, 5153.330067091254, 5193.896122077613], "unit": "score", "name": "dojo.html", "value": 4889.298156181327}, {"lowerIsBetter": false, "replicates": [537.8490031332946, 582.7872826418356, 598.8562744941213, 600.0848705723771, 608.5466327585947, 27487.0, 28051.29871753207, 28055.212546306244, 28070.719292807065, 38656.0, 42721.35917961233, 43270.78364608181, 43303.35044974328, 43371.3494297585, 43477.34783978235, 8569.742907712778, 8780.560971951378, 8783.64865405383, 8814.911850881474, 8815.118488151165, 8520.829583408358, 8600.440971336875, 8633.611487483047, 8656.61045252965, 8670.739877803677, 8420.0, 8545.27365173961, 8545.487270763773, 8549.059603443617, 8552.14478552143, 8572.785680358009, 8648.913510864937, 8657.0, 8658.783530411727, 8663.003754568212, 8595.269402100828, 8689.7827554311, 8721.433106848035, 8721.996970348364, 8735.43219690718, 39958.60041399578, 40373.19253614941, 40411.39382909259, 40435.595644043475, 40509.59490405088, 3165.6517783043846, 3522.5068490411363, 3838.0, 3949.131191137974, 3957.544882338539, 28264.434711305657, 30069.248268793453, 30822.0, 30878.382432351453, 30993.535096973563, 3707.7219208559195, 3711.1464363196346, 3828.8085595720104, 3871.4192871069286, 3874.4382064600477, 266358.0, 267448.0, 268295.0, 268791.0, 269810.0, 50944.23583646248, 52025.47974520282, 59840.0, 59888.70055649694, 61009.0, 53389.46610533923, 53625.1956220657, 53826.19260711093, 53850.73074634602, 53907.73046134823, 14377.78433323501, 14726.116433014053, 14730.92634536842, 14738.336774845158, 14758.92620536912, 9463.574139163755, 9750.75623109428, 11236.494357753922, 11481.540738370539, 11498.540058397737, 19468.123934422983, 19482.610347792965, 19666.803331966785, 19694.31069912546, 19713.40859774209, 7391.704331826774, 7579.810504737316, 7693.961530192425, 7727.459077864608, 7791.844163116706, 891.1222445890793, 941.6468824190929, 1028.639976008406, 1046.4715318764127, 1101.1741194104422, 28280.434391312057, 29033.56449653257, 29046.854765726457, 29298.414031719247, 29325.0, 1068.5405275731355, 1087.9510422031028, 1115.6987613344513, 1127.4362818590705, 1144.0618692671928, 15114.697706045818, 15128.697426051418, 15439.691206176038, 15494.380224790882, 15736.291866866019, 329413.0, 334019.0, 335361.0, 335549.0, 335760.0, 52288.47711522836, 52325.0, 52393.47606523886, 52451.0, 52518.73740631272, 1296.2611311552514, 1348.514534767483, 1352.952646657382, 1355.9186448813102, 1357.463801798284, 28490.85754571214, 29298.707012929597, 29344.11967640974, 29602.407951841273, 29845.85077074601, 42352.78823605862, 46910.29634555416, 47329.76335118302, 47374.52625473839, 47460.7626961863, 190607.0, 404992.0, 414788.0, 416317.0, 417460.0, 30825.0, 31582.210444739067, 31657.0, 31674.0, 31700.36599268048, 42020.36969445522, 44140.11719765651, 44205.55794442014, 44868.0, 45219.547804521535, 36819.63180368162, 37228.813855930544, 37992.430113547765, 38415.0, 38912.80543597377, 36557.0, 36839.0, 37544.81227593844, 37691.81154094212, 38062.429063564625, 36288.09279768027, 36479.27041459103, 36697.26605467822, 37033.62966370302, 37070.25859482849, 32347.19132021718, 33927.24425990689, 33977.0, 34191.0, 34549.827250863586, 25455.109071182418, 25587.175468892256, 25623.0, 25691.3577160565, 25801.87099064568], "unit": "score", "name": "ext.html", "value": 18529.05920823444}, {"lowerIsBetter": false, "replicates": [360.1518424111217, 360.4089293558563, 361.4181168319006, 361.62571738250915, 368.8911771027547, 13152.6711832204, 13557.322133893314, 15479.845201547982, 16067.357305707772, 17142.571435714097, 14356.712865742678, 15184.164870932122, 15504.224788760574, 15555.68888622227, 16352.75470867938, 5180.948190518094, 5348.973255133719, 5352.785888564453, 5355.303810504629, 5358.223057656637, 3894.7663140211534, 4036.1725846201607, 4653.767311634421, 5320.308359913206, 5595.804146854861, 5680.517156041741, 5698.145278208261, 5744.712764361786, 5746.281714785652, 5750.137479378085, 5039.193729003342, 5140.871478213037, 5171.741412929376, 5180.611454140936, 5181.766820493087, 4775.426948766136, 4912.0, 4915.827946021908, 4917.778699958475, 4950.405951285833, 11205.271657342246, 11398.031167350786, 15773.526794196192, 18408.815911840844, 18596.3491277806, 2073.668213085899, 2077.989610051955, 2086.384516567601, 2101.81083702466, 2108.3147976907567, 9423.811523769486, 9699.854502182472, 9873.901260987443, 12519.624411267676, 12614.180078294974, 1814.3831097426805, 1880.9059547022594, 1883.8210370014826, 1961.2351183038627, 2007.0, 55240.0, 59011.0, 59347.0, 61097.69451152716, 62576.68711656458, 14440.711185776436, 14653.340599672827, 14750.63123421923, 14800.111993280438, 14833.777493337608, 22615.0, 22894.198703045313, 22913.885430573075, 22948.131483564553, 23000.424989375064, 8429.241368276884, 8664.220220180214, 8705.042445331008, 8718.258947989365, 8797.252233560219, 7395.889061664079, 7405.333519983227, 7407.148177959496, 7474.626268686544, 7477.027986361738, 7459.922015806523, 7489.138749043821, 7490.962545187239, 7506.849863002819, 7659.770206893691, 2534.379077126079, 2901.202169403389, 2951.468735627565, 2961.348503329264, 2966.881324746986, 423.60393032514696, 423.8029316367904, 444.4244703109481, 817.8609636361714, 874.1433395272542, 10014.599416023424, 10120.595176193017, 10587.84118238227, 10682.092022178202, 10888.564457421615, 437.9890502737457, 451.178854484841, 454.4138061900112, 455.6650861616709, 467.6329081670872, 5794.710264486759, 5906.940930590725, 5985.880282394328, 6047.697615119227, 6065.5754097212775, 355591.0, 469800.0, 474283.0, 495788.0, 503169.0, 42814.57185428168, 43529.129417411474, 43597.910052248946, 58194.7090264546, 66054.66972665106, 1073.624231518962, 1117.0839911272678, 1120.7422292872684, 1122.1023181454802, 1156.3408856951457, 11619.709507262387, 13576.93211533936, 13762.449502019806, 14077.648058798612, 15070.472533461276, 30084.548731768602, 30560.08319750411, 30905.381892361576, 31209.99999999909, 31330.530042049842, 37810.0, 39408.256215659465, 39884.601153988086, 40873.0, 42408.78795606002, 7280.817979550554, 7561.281678240558, 7583.544987300559, 7590.8102297443, 7642.08295004603, 7741.845163096819, 10432.426216557858, 11168.776624467302, 11269.380184089954, 11489.425528723697, 8878.911210888067, 9159.313051521296, 9172.08279172104, 9285.117913798178, 9462.57418416159, 9448.716538503855, 9520.761980950532, 9638.0, 9850.704478865646, 9955.502224888582, 3170.571972783737, 3178.666240044762, 9882.240134240232, 9897.65358212459, 9981.800363992825, 7434.442416818652, 7658.693652253847, 7706.460547761603, 7739.651715672696, 7741.225877412214, 8888.688895888612, 9807.803843922939, 9915.65295214664, 9944.801103977736, 10090.747731306776], "unit": "score", "name": "jquery.html", "value": 7835.316516077357}, {"lowerIsBetter": false, "replicates": [1271.446920589544, 1468.3172324868933, 1477.9778303325452, 1616.4504068616668, 1775.7513948047276, 6996.965015174924, 7494.4004479641635, 7703.114141873679, 7704.807379815507, 7721.150673425933, 7717.421193410502, 7923.6830526779, 7924.564148971805, 7936.166702496242, 7944.285014348708, 2004.3085135628257, 2050.5693804301113, 2238.1718764057323, 2304.8617082975034, 2333.2533589251448, 2315.6410756332793, 2324.430514523944, 2326.9767302327014, 2327.359976006595, 2330.5222429402015, 2148.3662319615673, 2262.5474905018978, 2266.3654176830514, 2266.8866556672183, 2270.3416009357265, 2280.498290376123, 2297.9885100574475, 2341.66045923341, 2349.6005679034433, 2358.233574088428, 2274.886255687209, 2278.2481781012225, 2295.494991101955, 2296.9310920672237, 2298.6322188449935, 8073.838523229502, 8172.7956801080445, 8174.141715119887, 8179.059408168017, 8187.549684767336, 4633.86098417048, 4748.002919386933, 4770.141374552579, 4771.093492236464, 4785.564330700776, 3044.3911217756536, 3046.0866385317304, 3099.6590375058727, 3104.8602812873473, 3115.7818952673324, 981.4111533080167, 1012.8784545854545, 1018.1651046142166, 1065.0095411267519, 1066.1577353890418, 11319.20765546412, 11337.943310283561, 11344.092472602255, 11347.375894325809, 11360.943195284053, 4241.363795430649, 4297.076128632297, 4355.346697995326, 4357.54245804186, 4364.432623758891, 9587.760305992266, 9634.759131021781, 9670.419774813534, 9670.661526846527, 9697.903020969841, 4796.496367881392, 4796.760161991887, 4818.156822556109, 4857.8299759508245, 4857.927131093036, 4373.234683930299, 4376.693631445768, 4420.425344705168, 4425.977870110629, 4431.135928493977, 3458.75788694794, 3535.575730912307, 3650.2699460108083, 3671.5043469131324, 3789.981050094787, 1200.1418985425462, 1203.253982530819, 1205.7046023724245, 1209.7157168065498, 1213.0962432987305, 1291.3607764156802, 1293.4502836294537, 1308.941097650608, 1323.1399590266403, 1342.5636668082716, 7150.96424517874, 7180.856382872418, 7181.712731490787, 7182.209956904736, 7314.158871729713, 1092.2845536173818, 1103.3104309806372, 1109.8224284114665, 1114.4093630375914, 1122.8484154639182, 5771.68255745938, 5893.233879595625, 5894.204282421904, 5897.439743224387, 5910.822675319747, 9053.68312109073, 9165.90834091664, 9175.908240917639, 9321.906780932239, 9332.813343733087, 9219.262459003263, 9230.35387522867, 9237.261019118454, 9248.797656304772, 9255.49094799779, 7228.855422891513, 7261.818454538678, 7385.778426647209, 7477.513961592479, 7490.812729681802, 6718.328167183243, 6742.9662851685425, 6748.0, 6754.729810807513, 6762.6280554568, 8095.109537950939, 8244.670213191404, 8253.83492330162, 8381.078081411162, 8389.244967952913, 8550.315974722133, 8725.258353040063, 8740.300775937783, 8939.150780675825, 8953.194212520644, 7071.328223818729, 7297.671604777692, 7304.013958115586, 7320.707171713072, 7325.706971721284, 6790.253072162157, 6903.482238832007, 7268.854622907618, 7552.509086909334, 7563.205863384265, 7019.719211231493, 7198.280171982759, 7225.494215404871, 7235.167955684953, 7286.672099755418, 6936.930630693831, 6948.791536253921, 6994.895076573754, 7015.36861682451, 7021.5787052777, 6873.175218973555, 6889.104416426033, 6929.861402772017, 6945.791626251221, 7034.261402552658, 6412.807615771534, 6426.228852537725, 6448.258450278278, 6461.224653041665, 6463.127477790438, 6539.411452969255, 6588.0, 6595.901061483985, 6601.537892347682, 6603.867922641616], "unit": "score", "name": "mootools.html", "value": 4535.140168938246}, {"lowerIsBetter": false, "replicates": [345.54733299377835, 346.1432953440235, 348.3329424152746, 349.18639569802355, 355.71542765787365, 5654.858628534289, 5771.624844385117, 5787.363390027093, 5826.679532625709, 5827.271591051113, 5581.330240371161, 5684.857878553038, 5695.800646977356, 5700.629459085157, 5708.885822283562, 4484.461864576256, 4499.0776890737325, 4502.189605870958, 4532.320151977214, 4532.7280363178315, 4339.370791235269, 4403.141387429452, 4432.290833466646, 4510.684252102355, 4537.478190008158, 4461.152381047591, 4469.910601787962, 4480.103979204156, 4491.9775401123115, 4501.909961800779, 4490.3488994096, 4491.371208030879, 4496.078303947699, 4501.189785838547, 4506.324051392285, 3987.6809855211513, 3990.38149086892, 3990.5809889961715, 3994.3409337459284, 3996.460477835484, 5375.973120134374, 5530.0, 5542.974549708317, 5562.833115006556, 5568.749406276727, 5123.974380128076, 5142.820001299937, 5158.9484105158845, 5169.974150129263, 5176.0683077046115, 5899.262592175978, 6145.877082458371, 6152.84617884552, 6173.536984726119, 6174.166487524217, 4200.85297014603, 4216.198922204802, 4287.249731297042, 4294.677899157545, 4302.806373713191, 6255.12428260044, 6356.96821515894, 6357.5867568608355, 6358.491320694333, 6362.331955144736, 4357.7385356878685, 4385.693001489865, 4393.055493069006, 4393.51671316155, 4398.208322501916, 4316.374125751749, 4445.355423463579, 4447.221736196153, 4452.5992660660695, 4481.327800829901, 5147.1507201312115, 5148.3564554430695, 5148.742562871841, 5151.2530683050745, 5164.586833053347, 6163.8150855474405, 6165.445109940127, 6171.228596425447, 6173.59871608344, 6183.752649893954, 1550.99224503879, 1569.6154442161744, 1571.08091766318, 1572.6225705830518, 1574.3545146489885, 1046.1630695443614, 1053.146950969717, 1054.1724746074294, 1066.9519871605796, 1078.9676309710721, 5820.0, 5829.766809327664, 5832.679202643811, 5835.416458354131, 5840.036393995028, 6282.0, 6285.371462853678, 6287.339829317947, 6295.370462953668, 6316.526260530479, 5821.708914554255, 5824.563157763185, 5826.0678291474005, 5834.066549352084, 5836.241288632451, 3288.062902072898, 3392.3215356928713, 3393.01602535262, 3395.286989732184, 3395.7453191010277, 6573.441257493071, 6578.671066446658, 6582.0, 6582.473402127818, 6596.175478065242, 6443.259025212161, 6466.612003279724, 6470.22357317125, 6474.870502590016, 6476.611403315722, 6364.427201551883, 6533.216014078341, 6540.182477190351, 6568.113304703804, 6589.4728421725185, 6111.5110791137495, 6204.968975155095, 6280.717367718372, 6288.968555157195, 6350.174477317919, 6151.384861513813, 6282.1519094921605, 6296.905546416716, 6301.0, 6311.652859092794, 6579.868402632016, 6631.568948018364, 6632.038354438676, 6634.104395906491, 6635.568688035262, 4290.442242508454, 4368.9126217476105, 4371.388005679144, 4374.934375984427, 4376.978115109404, 6353.8729225416155, 6355.87288254223, 6358.554901156875, 6361.586496877688, 6362.363763623601, 6192.566520343533, 6193.38066193377, 6198.039303907902, 6199.783007594712, 6201.875962480815, 6036.788712395045, 6184.319724830355, 6185.536084793568, 6190.50475961913, 6191.226096737908, 6078.331383547717, 6079.3312735598165, 6084.026555751058, 6084.756609735561, 6085.817425477243, 6163.784267550794, 6183.536234782499, 6189.82393345263, 6200.627962322275, 6204.410580994799, 5914.935311643773, 6061.39386061408, 6069.5751297410525, 6070.484008859296, 6073.969630151998], "unit": "score", "name": "prototype.html", "value": 4655.063955313294}, {"lowerIsBetter": false, "replicates": [831.7587899509143, 833.1002517281337, 841.1840514700738, 846.6740304982582, 848.6647774129219, 12539.811902821453, 13628.523001694943, 13836.308184590767, 13857.653558661039, 13875.375608097635, 12285.570005049804, 12337.198082124656, 12363.629091127257, 12363.690907727312, 12368.938155309212, 647.2912161183497, 793.6230290611942, 806.4838503357855, 806.7136166660839, 806.9112397636255, 665.7703092433103, 670.9496787740915, 672.1262358933392, 784.4116912315764, 807.7738233294687, 828.8300898315831, 835.3150416658343, 835.5780330932901, 835.8662613981764, 837.417994493827, 832.883396324515, 833.8832563441123, 835.5905606252923, 837.4431003382743, 838.995805020974, 505.58541995563655, 511.12342332899254, 608.2822269721727, 617.2068891474479, 618.1562167641182, 12960.351982400842, 12962.80555791664, 12966.481340746359, 12981.740365192738, 12993.48026078965, 11780.116491263103, 11923.879118526942, 12056.819147712791, 12080.111359346889, 12350.0, 10014.699559013241, 10068.899311006942, 10183.0, 10224.0, 10295.742606434824, 3554.3424466473525, 3562.7327950403824, 3578.58846232684, 3655.6344365563496, 3728.6271372862766, 44282.77858610686, 44575.55424445747, 44659.55340446586, 44874.0, 44905.55094449046, 9286.860697089549, 9597.9040209597, 9599.712008639752, 9769.16962058233, 10161.136303414145, 17693.646127077387, 17788.822111778976, 17850.821491784915, 17898.91050544739, 17912.910435448, 7529.623518824037, 7634.6946122155605, 7674.386049116169, 7875.448718589759, 7989.680412783539, 4289.056407590325, 4327.3725309830525, 4329.069250111178, 4378.124375124988, 4385.912281754347, 2994.4909365407934, 3009.2627306309655, 3009.2627306310096, 3011.9247018824267, 3021.5165573508134, 547.2748608094291, 549.6976662835505, 552.5220684108217, 556.057482567045, 565.9886802263932, 567.5459632294148, 635.5201822623982, 670.2560158224367, 689.2452764223168, 699.1164083516015, 8656.8701469478, 8674.86987695185, 8754.168354006359, 8811.0, 8871.157240062184, 520.8723862653674, 550.5623029691405, 589.0251633546487, 660.7621256347711, 666.3736088077192, 3900.980495097563, 4060.878173654795, 4124.546299907008, 4203.726757760735, 4268.679849011337, 52963.73518132462, 53182.46817531853, 54049.459505405226, 54274.72862635661, 54364.45635543673, 47845.0, 48494.75752621285, 48753.756231219326, 49065.754671226416, 49334.75332623314, 41857.37213941793, 43635.0, 44392.55607443949, 44632.330515042304, 44708.0, 8244.83510329802, 8337.708180213906, 8394.874076888973, 8463.703770368007, 8471.152884711479, 32360.514592281605, 32972.845950392584, 33091.66908330886, 33851.492227616116, 33893.83053084719, 39110.6088939107, 43648.34527482027, 44844.77577612222, 45008.549914500436, 46594.301085484425, 10622.024389390952, 10629.415382154055, 10654.60234576657, 10905.618303359344, 11001.119910406987, 11592.508754811066, 11756.94121529387, 11950.701232469259, 11957.402129893297, 12064.577739779066, 10091.344062635904, 10189.439580823126, 10227.795444091225, 10422.374657520573, 10616.363018218932, 10964.835527466936, 11188.328700278009, 11452.713682158013, 11643.53425862956, 11710.12174086964, 10488.528016239135, 10610.151187904794, 10908.672739817817, 11356.886431135914, 11806.881931180922, 9605.519724013911, 9710.70867873965, 9889.802203955736, 9989.60041598328, 10262.332948358333, 9127.908720912972, 9379.202767764817, 9787.657431989846, 9916.305858589829, 9941.502924853872], "unit": "score", "name": "yui.html", "value": 6143.935170372735}], "name": "dromaeo_css", "value": 6719.854145272424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 110.0, 114.0, 110.0, 99.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [155.0, 131.0, 150.0, 162.0, 131.0, 149.0, 149.0, 132.0, 166.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 103.0, 109.0, 72.0, 75.0, 72.0, 116.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 149.0, 94.0, 95.0, 96.0, 140.0, 96.0, 96.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 56.0, 57.0, 56.0, 55.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 81.0, 82.0, 81.0, 80.0, 80.0, 82.0, 81.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 115.0, 114.0, 119.0, 123.0, 118.0, 123.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [140.0, 139.0, 144.0, 140.0, 129.0, 128.0, 143.0, 138.0, 138.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 69.0, 67.0, 68.0, 65.0, 67.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1493.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42437.5], "unit": "score", "name": "RegExp", "value": 21.466509572901316}, {"lowerIsBetter": false, "replicates": [598.0861244019138], "unit": "score", "name": "Splay", "value": 136.25295200000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18892.526173252812}]} 10:26:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18892.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6719.86"}}} 10:26:43 INFO - Return code: 0 10:26:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:43 INFO - # TBPL SUCCESS # 10:26:43 INFO - Running post-action listener: _resource_record_post_action 10:26:43 INFO - Running post-run listener: _resource_record_post_run 10:26:44 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 550981632; Read time: 1156; Write time: 1275448 10:26:44 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 8192; Write bytes: 239345664; Read time: 712; Write time: 624388 10:26:44 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311635968; Read time: 444; Write time: 651060 10:26:44 INFO - Running post-run listener: _upload_blobber_files 10:26:44 INFO - Blob upload gear active. 10:26:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:26:44 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 10:26:44 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:26:44 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:26:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:45 INFO - (blobuploader) - INFO - Done attempting. 10:26:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:46 INFO - (blobuploader) - INFO - Done attempting. 10:26:46 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:46 INFO - Return code: 0 10:26:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:26:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4311e30b70fe38f734769357abfd2bc3c3403ac0f4d2e1e3a9ce2b24ba05c389dea11207e9e4a8319798e1188cdc3e3845d7fedffa4983bfb3b003f5bb3a990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ad78e40a8633dba943f056b9e6611233a7f28c25a422908e698ddac651336ec5a25baa11ffbc3214ed4e861dd037220a6b8977776c7b7862e9bc5579901757"} 10:26:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:26:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:26:46 INFO - Contents: 10:26:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4311e30b70fe38f734769357abfd2bc3c3403ac0f4d2e1e3a9ce2b24ba05c389dea11207e9e4a8319798e1188cdc3e3845d7fedffa4983bfb3b003f5bb3a990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ad78e40a8633dba943f056b9e6611233a7f28c25a422908e698ddac651336ec5a25baa11ffbc3214ed4e861dd037220a6b8977776c7b7862e9bc5579901757"} 10:26:46 INFO - Copying logs to upload dir... 10:26:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.469379 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 10:26:46.253063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:46.256982) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4311e30b70fe38f734769357abfd2bc3c3403ac0f4d2e1e3a9ce2b24ba05c389dea11207e9e4a8319798e1188cdc3e3845d7fedffa4983bfb3b003f5bb3a990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ad78e40a8633dba943f056b9e6611233a7f28c25a422908e698ddac651336ec5a25baa11ffbc3214ed4e861dd037220a6b8977776c7b7862e9bc5579901757"} build_url:https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/PDJfC_xASsCOcFlHgpeziw/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/Firefox/sha512/b4311e30b70fe38f734769357abfd2bc3c3403ac0f4d2e1e3a9ce2b24ba05c389dea11207e9e4a8319798e1188cdc3e3845d7fedffa4983bfb3b003f5bb3a990", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ad78e40a8633dba943f056b9e6611233a7f28c25a422908e698ddac651336ec5a25baa11ffbc3214ed4e861dd037220a6b8977776c7b7862e9bc5579901757"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:46.281866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:46.282192) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452793346.173234-1802918956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 10:26:46.364814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:26:46.365171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 10:26:46.365516) ========= ========= Total master_lag: 0.24 =========