builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1452264626.41 results: success (0) buildid: 20160108043006 builduid: df896889f67f4889800f7f9fa90f7a5f revision: 1424cdfc075d1b7e277be914488ac73e20d1c982 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.410667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.411125) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.411408) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005898 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.433879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.434179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.447520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.448023) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.497962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.498269) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.498627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.498981) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 06:50:26-- 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% 222M=0s 2016-01-08 06:50:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.683901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.684263) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.733670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:26.734037) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1424cdfc075d1b7e277be914488ac73e20d1c982 --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 1424cdfc075d1b7e277be914488ac73e20d1c982 --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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 06:50:26,970 truncating revision to first 12 chars 2016-01-08 06:50:26,970 Setting DEBUG logging. 2016-01-08 06:50:26,970 attempt 1/10 2016-01-08 06:50:26,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1424cdfc075d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 06:50:27,563 unpacking tar archive at: mozilla-central-1424cdfc075d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:27.634162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:27.634502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:27.893586) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:27.893968) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 06:50:27.894412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-08 06:50:27.894717) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:50:28 INFO - MultiFileLogger online at 20160108 06:50:28 in /builds/slave/test-pgo 06:50:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:50:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:50:28 INFO - {'append_to_log': False, 06:50:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:50:28 INFO - 'blob_upload_branch': 'Firefox', 06:50:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:50:28 INFO - 'branch': 'Firefox', 06:50:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:28 INFO - 'config_files': ('talos/linux_config.py',), 06:50:28 INFO - 'default_actions': ('clobber', 06:50:28 INFO - 'read-buildbot-config', 06:50:28 INFO - 'download-and-extract', 06:50:28 INFO - 'populate-webroot', 06:50:28 INFO - 'create-virtualenv', 06:50:28 INFO - 'install', 06:50:28 INFO - 'run-tests'), 06:50:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:28 INFO - 'download_minidump_stackwalk': True, 06:50:28 INFO - 'download_symbols': 'ondemand', 06:50:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:28 INFO - 'installer_path': 'installer.exe', 06:50:28 INFO - 'log_level': 'info', 06:50:28 INFO - 'log_name': 'talos', 06:50:28 INFO - 'log_to_console': True, 06:50:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:50:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:50:28 INFO - 'opt_config_files': (), 06:50:28 INFO - 'pip_index': False, 06:50:28 INFO - 'sps_profile': False, 06:50:28 INFO - 'sps_profile_interval': 0, 06:50:28 INFO - 'suite': 'dromaeojs-e10s', 06:50:28 INFO - 'system_bits': '32', 06:50:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:28 INFO - 'title': 'talos-linux64-ix-023', 06:50:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:28 INFO - 'use_talos_json': True, 06:50:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:50:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:28 INFO - 'work_dir': 'build'} 06:50:28 INFO - ##### 06:50:28 INFO - ##### Running clobber step. 06:50:28 INFO - ##### 06:50:28 INFO - Running pre-action listener: _resource_record_pre_action 06:50:28 INFO - Running main action method: clobber 06:50:28 INFO - rmtree: /builds/slave/test-pgo/build 06:50:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:50:28 INFO - Running post-action listener: _resource_record_post_action 06:50:28 INFO - ##### 06:50:28 INFO - ##### Running read-buildbot-config step. 06:50:28 INFO - ##### 06:50:28 INFO - Running pre-action listener: _resource_record_pre_action 06:50:28 INFO - Running main action method: read_buildbot_config 06:50:28 INFO - Using buildbot properties: 06:50:28 INFO - { 06:50:28 INFO - "project": "", 06:50:28 INFO - "product": "firefox", 06:50:28 INFO - "script_repo_revision": "production", 06:50:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:50:28 INFO - "repository": "", 06:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:50:28 INFO - "buildid": "20160108043006", 06:50:28 INFO - "pgo_build": "True", 06:50:28 INFO - "basedir": "/builds/slave/test-pgo", 06:50:28 INFO - "buildnumber": 606, 06:50:28 INFO - "slavename": "talos-linux64-ix-023", 06:50:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:50:28 INFO - "platform": "ubuntu64_hw", 06:50:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:50:28 INFO - "branch": "mozilla-central", 06:50:28 INFO - "repo_path": "mozilla-central", 06:50:28 INFO - "revision": "1424cdfc075d1b7e277be914488ac73e20d1c982", 06:50:28 INFO - "stage_platform": "linux64-pgo", 06:50:28 INFO - "builduid": "df896889f67f4889800f7f9fa90f7a5f", 06:50:28 INFO - "slavebuilddir": "test" 06:50:28 INFO - } 06:50:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:50:28 INFO - Running post-action listener: _resource_record_post_action 06:50:28 INFO - ##### 06:50:28 INFO - ##### Running download-and-extract step. 06:50:28 INFO - ##### 06:50:28 INFO - Running pre-action listener: _resource_record_pre_action 06:50:28 INFO - Running main action method: download_and_extract 06:50:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:50:28 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')]} 06:50:28 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:50:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json 06:50:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json 06:50:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:50:29 INFO - Downloaded 1302 bytes. 06:50:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:50:29 INFO - Using the following test package requirements: 06:50:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:50:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'jsshell-linux-x86_64.zip'], 06:50:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:50:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:50:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:50:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:50:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:50:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:50:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:50:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:29 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:30 INFO - Downloaded 24028185 bytes. 06:50:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:50:31 INFO - Return code: 0 06:50:31 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 06:50: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')]} 06:50:31 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:32 INFO - Downloaded 24028185 bytes. 06:50:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:50:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:50:33 INFO - Return code: 0 06:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:33 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:50:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:34 INFO - Downloaded 11132285 bytes. 06:50:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:50:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:50:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:50:35 INFO - Return code: 0 06:50: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')]} 06:50:35 INFO - https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/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 06:50:36 INFO - Downloaded 55916804 bytes. 06:50:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:36 INFO - mkdir: /builds/slave/test-pgo/properties 06:50:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:50:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:50:36 INFO - Contents: 06:50:36 INFO - build_url:https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:50:36 INFO - Running post-action listener: _resource_record_post_action 06:50:36 INFO - Running post-action listener: set_extra_try_arguments 06:50:36 INFO - ##### 06:50:36 INFO - ##### Running populate-webroot step. 06:50:36 INFO - ##### 06:50:36 INFO - Running pre-action listener: _resource_record_pre_action 06:50:36 INFO - Running main action method: populate_webroot 06:50:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:36 INFO - '--tppagecycles', 06:50:36 INFO - '7'], 06:50:36 INFO - 'tests': ['tsvgm']}}, 06:50:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:50:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:50:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'tests': ['damp', 'tps']}, 06:50:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['damp', 'tps']}, 06:50:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:50:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:36 INFO - 'other': {'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'other_l64': {'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'other_nol64': {'tests': ['a11yr', 06:50:36 INFO - 'ts_paint', 06:50:36 INFO - 'tpaint', 06:50:36 INFO - 'sessionrestore', 06:50:36 INFO - 'sessionrestore_no_auto_restore']}, 06:50:36 INFO - 'svgr': {'tests': ['tsvgx', 06:50:36 INFO - 'tsvgr_opacity', 06:50:36 INFO - 'tart', 06:50:36 INFO - 'tscrollx', 06:50:36 INFO - 'cart']}, 06:50:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['tsvgx', 06:50:36 INFO - 'tsvgr_opacity', 06:50:36 INFO - 'tart', 06:50:36 INFO - 'tscrollx', 06:50:36 INFO - 'cart']}, 06:50:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'tests': ['tp5o']}, 06:50:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'talos_options': ['--e10s'], 06:50:36 INFO - 'tests': ['tp5o']}, 06:50:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'talos_options': ['--xperf_path', 06:50:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:36 INFO - 'tests': ['tp5n']}, 06:50:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:36 INFO - 'talos_options': ['--e10s', 06:50:36 INFO - '--xperf_path', 06:50:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:36 INFO - 'tests': ['tp5n']}}, 06:50:36 INFO - 'talos.zip': {'path': '', 06:50:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:36 INFO - Running post-action listener: _resource_record_post_action 06:50:36 INFO - ##### 06:50:36 INFO - ##### Running create-virtualenv step. 06:50:36 INFO - ##### 06:50:36 INFO - Running pre-action listener: _resource_record_pre_action 06:50:36 INFO - Running main action method: create_virtualenv 06:50:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:50:36 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 06:50:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:50:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:36 INFO - Using real prefix '/usr' 06:50:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:50:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:38 INFO - Installing pip.................done. 06:50:38 INFO - Return code: 0 06:50:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:50:38 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')]} 06:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:38 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')]} 06:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:38 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:38 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 06:50:38 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 06:50:38 INFO - Using env: {'DISPLAY': ':0', 06:50:38 INFO - 'HOME': '/home/cltbld', 06:50:38 INFO - 'LANG': 'en_US.UTF-8', 06:50:38 INFO - 'LANGUAGE': 'en_US:en', 06:50:38 INFO - 'LOGNAME': 'cltbld', 06:50:38 INFO - 'MAIL': '/var/mail/cltbld', 06:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:38 INFO - 'MOZ_NO_REMOTE': '1', 06:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:38 INFO - 'NO_EM_RESTART': '1', 06:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:38 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:38 INFO - 'SHELL': '/bin/bash', 06:50:38 INFO - 'SHLVL': '1', 06:50:38 INFO - 'TERM': 'linux', 06:50:38 INFO - 'TMOUT': '86400', 06:50:38 INFO - 'USER': 'cltbld', 06:50:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:38 INFO - '_': '/tools/buildbot/bin/python'} 06:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:39 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 06:50:39 INFO - Cleaning up... 06:50:39 INFO - Return code: 0 06:50:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:39 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 06:50:39 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 06:50:39 INFO - Using env: {'DISPLAY': ':0', 06:50:39 INFO - 'HOME': '/home/cltbld', 06:50:39 INFO - 'LANG': 'en_US.UTF-8', 06:50:39 INFO - 'LANGUAGE': 'en_US:en', 06:50:39 INFO - 'LOGNAME': 'cltbld', 06:50:39 INFO - 'MAIL': '/var/mail/cltbld', 06:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:39 INFO - 'MOZ_NO_REMOTE': '1', 06:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:39 INFO - 'NO_EM_RESTART': '1', 06:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:39 INFO - 'SHELL': '/bin/bash', 06:50:39 INFO - 'SHLVL': '1', 06:50:39 INFO - 'TERM': 'linux', 06:50:39 INFO - 'TMOUT': '86400', 06:50:39 INFO - 'USER': 'cltbld', 06:50:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:39 INFO - '_': '/tools/buildbot/bin/python'} 06:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:39 INFO - Downloading/unpacking psutil>=0.7.1 06:50:39 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 06:50:39 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 06:50:39 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 06:50:39 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 06:50:39 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 06:50:39 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 06:50:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:50:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:50:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:41 INFO - Installing collected packages: psutil 06:50:41 INFO - Running setup.py install for psutil 06:50:41 INFO - building 'psutil._psutil_linux' extension 06:50:41 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 06:50:41 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 06:50:41 INFO - building 'psutil._psutil_posix' extension 06:50:41 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 06:50:41 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 06:50:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:41 INFO - Successfully installed psutil 06:50:41 INFO - Cleaning up... 06:50:41 INFO - Return code: 0 06:50:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:50:41 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')]} 06:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:41 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')]} 06:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:41 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:41 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 06:50:41 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 06:50:41 INFO - Using env: {'DISPLAY': ':0', 06:50:41 INFO - 'HOME': '/home/cltbld', 06:50:41 INFO - 'LANG': 'en_US.UTF-8', 06:50:41 INFO - 'LANGUAGE': 'en_US:en', 06:50:41 INFO - 'LOGNAME': 'cltbld', 06:50:41 INFO - 'MAIL': '/var/mail/cltbld', 06:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:41 INFO - 'MOZ_NO_REMOTE': '1', 06:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:41 INFO - 'NO_EM_RESTART': '1', 06:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:41 INFO - 'SHELL': '/bin/bash', 06:50:41 INFO - 'SHLVL': '1', 06:50:41 INFO - 'TERM': 'linux', 06:50:41 INFO - 'TMOUT': '86400', 06:50:41 INFO - 'USER': 'cltbld', 06:50:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:41 INFO - '_': '/tools/buildbot/bin/python'} 06:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:41 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 06:50:41 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 06:50:41 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 06:50:41 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 06:50:41 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 06:50:41 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 06:50:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:50:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:43 INFO - Installing collected packages: mozsystemmonitor 06:50:43 INFO - Running setup.py install for mozsystemmonitor 06:50:43 INFO - Successfully installed mozsystemmonitor 06:50:43 INFO - Cleaning up... 06:50:43 INFO - Return code: 0 06:50:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:43 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:43 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 06:50:43 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 06:50:43 INFO - Using env: {'DISPLAY': ':0', 06:50:43 INFO - 'HOME': '/home/cltbld', 06:50:43 INFO - 'LANG': 'en_US.UTF-8', 06:50:43 INFO - 'LANGUAGE': 'en_US:en', 06:50:43 INFO - 'LOGNAME': 'cltbld', 06:50:43 INFO - 'MAIL': '/var/mail/cltbld', 06:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:43 INFO - 'MOZ_NO_REMOTE': '1', 06:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:43 INFO - 'NO_EM_RESTART': '1', 06:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:43 INFO - 'SHELL': '/bin/bash', 06:50:43 INFO - 'SHLVL': '1', 06:50:43 INFO - 'TERM': 'linux', 06:50:43 INFO - 'TMOUT': '86400', 06:50:43 INFO - 'USER': 'cltbld', 06:50:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:43 INFO - '_': '/tools/buildbot/bin/python'} 06:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:50:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:45 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 06:50:45 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 06:50:45 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 06:50:45 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 06:50:45 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 06:50:45 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 06:50:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:50:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:50:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:46 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 06:50:46 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 06:50:46 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 06:50:46 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 06:50:46 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 06:50:46 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 06:50:46 INFO - Downloading docopt-0.6.1.tar.gz 06:50:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:50:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:46 INFO - Running setup.py install for blobuploader 06:50:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:50:46 INFO - Running setup.py install for requests 06:50:46 INFO - Running setup.py install for docopt 06:50:46 INFO - Successfully installed blobuploader requests docopt 06:50:46 INFO - Cleaning up... 06:50:47 INFO - Return code: 0 06:50:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:47 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:47 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 06:50:47 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 06:50:47 INFO - Using env: {'DISPLAY': ':0', 06:50:47 INFO - 'HOME': '/home/cltbld', 06:50:47 INFO - 'LANG': 'en_US.UTF-8', 06:50:47 INFO - 'LANGUAGE': 'en_US:en', 06:50:47 INFO - 'LOGNAME': 'cltbld', 06:50:47 INFO - 'MAIL': '/var/mail/cltbld', 06:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:47 INFO - 'MOZ_NO_REMOTE': '1', 06:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:47 INFO - 'NO_EM_RESTART': '1', 06:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:47 INFO - 'SHELL': '/bin/bash', 06:50:47 INFO - 'SHLVL': '1', 06:50:47 INFO - 'TERM': 'linux', 06:50:47 INFO - 'TMOUT': '86400', 06:50:47 INFO - 'USER': 'cltbld', 06:50:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:47 INFO - '_': '/tools/buildbot/bin/python'} 06:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:47 INFO - Running setup.py (path:/tmp/pip-O36LCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:47 INFO - Running setup.py (path:/tmp/pip-NGFuex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:47 INFO - Running setup.py (path:/tmp/pip-CLOJK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:47 INFO - Running setup.py (path:/tmp/pip-bVniip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:47 INFO - Running setup.py (path:/tmp/pip-3wVilg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:47 INFO - Running setup.py (path:/tmp/pip-bBy0Ub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:47 INFO - Running setup.py (path:/tmp/pip-5Np6vh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:47 INFO - Running setup.py (path:/tmp/pip-VbwGiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:47 INFO - Running setup.py (path:/tmp/pip-yBYwbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:47 INFO - Running setup.py (path:/tmp/pip-dnylFr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:47 INFO - Running setup.py (path:/tmp/pip-Um9_fA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:48 INFO - Running setup.py (path:/tmp/pip-CeSoWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:48 INFO - Running setup.py (path:/tmp/pip-Zt6ifS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:48 INFO - Running setup.py (path:/tmp/pip-CU_diO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:48 INFO - Running setup.py (path:/tmp/pip-WqH6Pt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:48 INFO - Running setup.py (path:/tmp/pip-aPXhfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:48 INFO - Running setup.py (path:/tmp/pip-X6SDwP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:48 INFO - Running setup.py install for manifestparser 06:50:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:50:48 INFO - Running setup.py install for mozcrash 06:50:48 INFO - Running setup.py install for mozdebug 06:50:48 INFO - Running setup.py install for mozdevice 06:50:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:50:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:50:48 INFO - Running setup.py install for mozfile 06:50:48 INFO - Running setup.py install for mozhttpd 06:50:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozinfo 06:50:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozInstall 06:50:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozleak 06:50:49 INFO - Running setup.py install for mozlog 06:50:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for moznetwork 06:50:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozprocess 06:50:49 INFO - Running setup.py install for mozprofile 06:50:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozrunner 06:50:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:50:49 INFO - Running setup.py install for mozscreenshot 06:50:50 INFO - Running setup.py install for moztest 06:50:50 INFO - Running setup.py install for mozversion 06:50:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:50:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:50 INFO - Cleaning up... 06:50:50 INFO - Return code: 0 06:50:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50:50 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')]} 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:50 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')]} 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:50 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:50 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 06:50:50 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 06:50:50 INFO - Using env: {'DISPLAY': ':0', 06:50:50 INFO - 'HOME': '/home/cltbld', 06:50:50 INFO - 'LANG': 'en_US.UTF-8', 06:50:50 INFO - 'LANGUAGE': 'en_US:en', 06:50:50 INFO - 'LOGNAME': 'cltbld', 06:50:50 INFO - 'MAIL': '/var/mail/cltbld', 06:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:50 INFO - 'MOZ_NO_REMOTE': '1', 06:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:50 INFO - 'NO_EM_RESTART': '1', 06:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:50 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:50 INFO - 'SHELL': '/bin/bash', 06:50:50 INFO - 'SHLVL': '1', 06:50:50 INFO - 'TERM': 'linux', 06:50:50 INFO - 'TMOUT': '86400', 06:50:50 INFO - 'USER': 'cltbld', 06:50:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:50 INFO - '_': '/tools/buildbot/bin/python'} 06:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:50 INFO - Running setup.py (path:/tmp/pip-gdVFMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:50 INFO - Running setup.py (path:/tmp/pip-J6cXyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:50 INFO - Running setup.py (path:/tmp/pip-X_eR0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:50 INFO - Running setup.py (path:/tmp/pip-1ihNq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:50 INFO - Running setup.py (path:/tmp/pip-jlsIMl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:50 INFO - Running setup.py (path:/tmp/pip-7u_dIE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:50 INFO - Running setup.py (path:/tmp/pip-EA5wgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:50:50 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)) 06:50:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:50 INFO - Running setup.py (path:/tmp/pip-aCdEQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:51 INFO - Running setup.py (path:/tmp/pip-wr_QH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:51 INFO - Running setup.py (path:/tmp/pip-JP7iB0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:51 INFO - Running setup.py (path:/tmp/pip-5ohrMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:51 INFO - Running setup.py (path:/tmp/pip-IdOC8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:51 INFO - Running setup.py (path:/tmp/pip-589LbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:51 INFO - Running setup.py (path:/tmp/pip-CNph4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:51 INFO - Running setup.py (path:/tmp/pip-VfiD35-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:51 INFO - Running setup.py (path:/tmp/pip-mxchOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:51 INFO - Running setup.py (path:/tmp/pip-OjLpk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:50:51 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)) 06:50:51 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)) 06:50:51 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)) 06:50:51 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)) 06:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:53 INFO - Downloading blessings-1.5.1.tar.gz 06:50:53 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 06:50:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:53 INFO - Installing collected packages: blessings 06:50:53 INFO - Running setup.py install for blessings 06:50:53 INFO - Successfully installed blessings 06:50:53 INFO - Cleaning up... 06:50:53 INFO - Return code: 0 06:50:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:50:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:53 INFO - Reading from file tmpfile_stdout 06:50:53 INFO - Current package versions: 06:50:53 INFO - argparse == 1.2.1 06:50:53 INFO - blessings == 1.5.1 06:50:53 INFO - blobuploader == 1.2.4 06:50:53 INFO - docopt == 0.6.1 06:50:53 INFO - manifestparser == 1.1 06:50:53 INFO - mozInstall == 1.12 06:50:53 INFO - mozcrash == 0.16 06:50:53 INFO - mozdebug == 0.1 06:50:53 INFO - mozdevice == 0.47 06:50:53 INFO - mozfile == 1.2 06:50:53 INFO - mozhttpd == 0.7 06:50:53 INFO - mozinfo == 0.9 06:50:53 INFO - mozleak == 0.1 06:50:53 INFO - mozlog == 3.1 06:50:53 INFO - moznetwork == 0.27 06:50:53 INFO - mozprocess == 0.22 06:50:53 INFO - mozprofile == 0.28 06:50:53 INFO - mozrunner == 6.11 06:50:53 INFO - mozscreenshot == 0.1 06:50:53 INFO - mozsystemmonitor == 0.0 06:50:53 INFO - moztest == 0.7 06:50:53 INFO - mozversion == 1.4 06:50:53 INFO - psutil == 3.1.1 06:50:53 INFO - requests == 1.2.3 06:50:53 INFO - wsgiref == 0.1.2 06:50:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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', '-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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:53 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 06:50:53 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 06:50:53 INFO - Using env: {'DISPLAY': ':0', 06:50:53 INFO - 'HOME': '/home/cltbld', 06:50:53 INFO - 'LANG': 'en_US.UTF-8', 06:50:53 INFO - 'LANGUAGE': 'en_US:en', 06:50:53 INFO - 'LOGNAME': 'cltbld', 06:50:53 INFO - 'MAIL': '/var/mail/cltbld', 06:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:53 INFO - 'MOZ_NO_REMOTE': '1', 06:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:53 INFO - 'NO_EM_RESTART': '1', 06:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:53 INFO - 'SHELL': '/bin/bash', 06:50:53 INFO - 'SHLVL': '1', 06:50:53 INFO - 'TERM': 'linux', 06:50:53 INFO - 'TMOUT': '86400', 06:50:53 INFO - 'USER': 'cltbld', 06:50:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:53 INFO - '_': '/tools/buildbot/bin/python'} 06:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 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)) 06:50:54 INFO - Cleaning up... 06:50:54 INFO - Return code: 0 06:50:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:50:54 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')]} 06:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 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')]} 06:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:54 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:54 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 06:50:54 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 06:50:54 INFO - Using env: {'DISPLAY': ':0', 06:50:54 INFO - 'HOME': '/home/cltbld', 06:50:54 INFO - 'LANG': 'en_US.UTF-8', 06:50:54 INFO - 'LANGUAGE': 'en_US:en', 06:50:54 INFO - 'LOGNAME': 'cltbld', 06:50:54 INFO - 'MAIL': '/var/mail/cltbld', 06:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:54 INFO - 'MOZ_NO_REMOTE': '1', 06:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:54 INFO - 'NO_EM_RESTART': '1', 06:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:54 INFO - 'SHELL': '/bin/bash', 06:50:54 INFO - 'SHLVL': '1', 06:50:54 INFO - 'TERM': 'linux', 06:50:54 INFO - 'TMOUT': '86400', 06:50:54 INFO - 'USER': 'cltbld', 06:50:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:54 INFO - '_': '/tools/buildbot/bin/python'} 06:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:54 INFO - Downloading/unpacking jsonschema 06:50:54 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 06:50:54 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 06:50:54 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 06:50:54 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 06:50:54 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 06:50:54 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 06:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:55 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 06:50:55 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:56 INFO - warning: no files found matching '*.txt' 06:50:56 INFO - no previously-included directories found matching 'build' 06:50:56 INFO - no previously-included directories found matching 'dist' 06:50:56 INFO - no previously-included directories found matching '.git*' 06:50:56 INFO - Installing collected packages: jsonschema, functools32 06:50:56 INFO - Running setup.py install for functools32 06:50:56 INFO - warning: no files found matching '*.txt' 06:50:56 INFO - no previously-included directories found matching 'build' 06:50:56 INFO - no previously-included directories found matching 'dist' 06:50:56 INFO - no previously-included directories found matching '.git*' 06:50:56 INFO - Successfully installed jsonschema functools32 06:50:56 INFO - Cleaning up... 06:50:56 INFO - Return code: 0 06:50:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:50: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')]} 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:56 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 0x7feec8448f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', '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 06:50:56 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 06:50:56 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 06:50:56 INFO - Using env: {'DISPLAY': ':0', 06:50:56 INFO - 'HOME': '/home/cltbld', 06:50:56 INFO - 'LANG': 'en_US.UTF-8', 06:50:56 INFO - 'LANGUAGE': 'en_US:en', 06:50:56 INFO - 'LOGNAME': 'cltbld', 06:50:56 INFO - 'MAIL': '/var/mail/cltbld', 06:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:56 INFO - 'MOZ_NO_REMOTE': '1', 06:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:56 INFO - 'NO_EM_RESTART': '1', 06:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:56 INFO - 'SHELL': '/bin/bash', 06:50:56 INFO - 'SHLVL': '1', 06:50:56 INFO - 'TERM': 'linux', 06:50:56 INFO - 'TMOUT': '86400', 06:50:56 INFO - 'USER': 'cltbld', 06:50:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:56 INFO - '_': '/tools/buildbot/bin/python'} 06:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:56 INFO - Downloading/unpacking flake8 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:58 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 06:50:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:58 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 06:50:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:50:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:59 INFO - no previously-included directories found matching 'docs/_build' 06:50:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:59 INFO - Running setup.py install for pep8 06:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:59 INFO - no previously-included directories found matching 'docs/_build' 06:50:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:59 INFO - Cleaning up... 06:50:59 INFO - Return code: 0 06:50:59 INFO - Running post-action listener: _resource_record_post_action 06:50:59 INFO - Running post-action listener: _start_resource_monitoring 06:50:59 INFO - Starting resource monitoring. 06:50:59 INFO - ##### 06:50:59 INFO - ##### Running install step. 06:50:59 INFO - ##### 06:50:59 INFO - Running pre-action listener: _resource_record_pre_action 06:50:59 INFO - Running main action method: install 06:50:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:59 INFO - Reading from file tmpfile_stdout 06:50:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:59 INFO - Reading from file tmpfile_stdout 06:50:59 INFO - Output received: 06:50:59 INFO - Usage: mozinstall [options] installer 06:50:59 INFO - Options: 06:50:59 INFO - -h, --help show this help message and exit 06:50:59 INFO - -d DEST, --destination=DEST 06:50:59 INFO - Directory to install application into. [default: 06:50:59 INFO - "/builds/slave/test-pgo"] 06:50:59 INFO - --app=APP Application being installed. [default: firefox] 06:50:59 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:59 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'] 06:50:59 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 06:51:15 INFO - Reading from file tmpfile_stdout 06:51:15 INFO - Output received: 06:51:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:51:15 INFO - Running post-action listener: _resource_record_post_action 06:51:15 INFO - ##### 06:51:15 INFO - ##### Running run-tests step. 06:51:15 INFO - ##### 06:51:15 INFO - Running pre-action listener: _resource_record_pre_action 06:51:15 INFO - Running main action method: run_tests 06:51:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:51:15 INFO - Python 2.7.3 06:51:15 INFO - Return code: 0 06:51:15 INFO - grabbing minidump binary from tooltool 06:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:15 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 0x14cf840>, '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 0x143c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:51:15 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 06:51:15 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 06:51:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:15 INFO - Return code: 0 06:51:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:51:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:51:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:51:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:51:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:51:16 INFO - Return code: 0 06:51:16 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 06:51:16 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:51:16 INFO - Using env: {'DISPLAY': ':0', 06:51:16 INFO - 'HOME': '/home/cltbld', 06:51:16 INFO - 'LANG': 'en_US.UTF-8', 06:51:16 INFO - 'LANGUAGE': 'en_US:en', 06:51:16 INFO - 'LOGNAME': 'cltbld', 06:51:16 INFO - 'MAIL': '/var/mail/cltbld', 06:51:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:16 INFO - 'MOZ_NO_REMOTE': '1', 06:51:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:16 INFO - 'NO_EM_RESTART': '1', 06:51:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:51:16 INFO - 'SHELL': '/bin/bash', 06:51:16 INFO - 'SHLVL': '1', 06:51:16 INFO - 'TERM': 'linux', 06:51:16 INFO - 'TMOUT': '86400', 06:51:16 INFO - 'USER': 'cltbld', 06:51:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551', 06:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:16 INFO - '_': '/tools/buildbot/bin/python'} 06:51:16 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:51:16 INFO - mozversion application_buildid: 20160108043006 06:51:16 INFO - mozversion application_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:51:16 INFO - mozversion application_display_name: Nightly 06:51:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:16 INFO - mozversion application_name: Firefox 06:51:16 INFO - mozversion application_remotingname: firefox 06:51:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:51:16 INFO - mozversion application_vendor: Mozilla 06:51:16 INFO - mozversion application_version: 46.0a1 06:51:16 INFO - mozversion platform_buildid: 20160108043006 06:51:16 INFO - mozversion platform_changeset: 1424cdfc075d1b7e277be914488ac73e20d1c982 06:51:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:51:16 INFO - mozversion platform_version: 46.0a1 06:51:16 INFO - using testdate: 1452264676 06:51:16 INFO - actual date: 1452264676 06:51:16 INFO - starting webserver on 'localhost:33689' 06:51:16 INFO - SUITE-START | Running 3 tests 06:51:16 INFO - TEST-START | dromaeo_css 06:51:16 INFO - operating with platform_type : linux_ 06:51:16 INFO - Initialising browser for dromaeo_css test... 06:51:16 INFO - TEST-INFO | started process 29228 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfew1dH/profile http://localhost:33689/getInfo.html) 06:51:20 INFO - PROCESS | 29228 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 06:51:21 INFO - PROCESS | 29228 | __metrics Screen width/height:1600/1200 06:51:21 INFO - PROCESS | 29228 | colorDepth:24 06:51:21 INFO - PROCESS | 29228 | Browser inner width/height: 1024/697 06:51:21 INFO - PROCESS | 29228 | __metrics 06:51:21 INFO - PROCESS | 29228 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:51:22 INFO - TEST-INFO | 29228: exit 0 06:51:22 INFO - Browser initialized. 06:51:22 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:22 INFO - TEST-INFO | started process 29360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfew1dH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:33 INFO - PROCESS | 29360 | RSS: Main: 150470656 06:51:33 INFO - PROCESS | 29360 | 06:52:23 INFO - PROCESS | 29360 | 1452264743547 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] 06:54:32 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33689/tests/dromaeo/cssquery-ext.html) 06:54:33 INFO - PROCESS | 29360 | RSS: Main: 156594176 06:54:33 INFO - PROCESS | 29360 | 06:57:35 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-ext.html (next: http://localhost:33689/tests/dromaeo/cssquery-jquery.html) 06:57:36 INFO - PROCESS | 29360 | RSS: Main: 153407488 06:57:36 INFO - PROCESS | 29360 | 07:00:37 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33689/tests/dromaeo/cssquery-mootools.html) 07:00:38 INFO - PROCESS | 29360 | RSS: Main: 153649152 07:00:38 INFO - PROCESS | 29360 | 07:03:40 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33689/tests/dromaeo/cssquery-prototype.html) 07:03:40 INFO - PROCESS | 29360 | RSS: Main: 152379392 07:03:40 INFO - PROCESS | 29360 | 07:06:43 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33689/tests/dromaeo/cssquery-yui.html) 07:06:43 INFO - PROCESS | 29360 | RSS: Main: 153677824 07:06:43 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | Cycle 1(1): loaded http://localhost:33689/tests/dromaeo/cssquery-yui.html (next: http://localhost:33689/tests/dromaeo/cssquery-dojo.html) 07:09:46 INFO - PROCESS | 29360 | RSS: Main: 155815936 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | __start_tp_report 07:09:46 INFO - PROCESS | 29360 | _x_x_mozilla_page_load 07:09:46 INFO - PROCESS | 29360 | _x_x_mozilla_page_load_details 07:09:46 INFO - PROCESS | 29360 | |i|pagename|runs| 07:09:46 INFO - PROCESS | 29360 | |0;dojo.html;3155.8106513609187;3192.2019495126206;3205.6794320567933;3218.533312669663;3236.773425860189;5101.38783345999;5209.895802083961;5218.0868348039085;5237.711925844077;5317.229001794737;5190.273361729352;5191.714455704935;5204.817831375903;5215.556677682402;5223.242629818674;4781.760911954397;4881.951180488185;4916.508349165073;4960.553550180483;4970.478099799505;4892.804287828482;4914.434839993393;4947.529984651453;4948.925766113493;4984.451710311862;4597.747123908183;4726.409198850144;4820.156472617278;4920.212765957447;4936.284238785374;4794.089123066607;4830.686005409637;4834.854954351375;4842.12841688496;4885.2427873679635;4787.736674482902;4807.6394270429855;4827.710337379734;4877.6829506081995;4884.487128851455;5077;5143.588512918957;5148.974255128738;5149.613778966593;5184.7148406837605;5604.075327570946;5610.915836262459;5650.830475085754;5715.257016587859;5763.106718458645;5775.1337299405;5776.8844623107725;5778.393268706767;5783.768649254025;5795.072788353886;5351.117065684158;5355.303810504648;5375;5376.059189641797;5386.245925570423;5734.598578099576;5838.241028666246;5842.5618078644275;5867.765289388377;5980.0132978059;5552.694601796859;5613.7193140342815;5619.438056194348;5620.437956204347;5631.127175287755;5654.3497497788285;5681.886362272814;5708.857278567986;5714.485696287271;5716.599838011382;5604.831855044274;5679.659220446786;5687.744051517691;5746.741396637161;5756.33802112754;5615.298087739033;5627.212190293362;5643.125315576092;5664.660120392789;5673.943260567342;4353;4422.314541246112;4426.690131690815;4428.335749637516;4448.332750087448;3936.842526298973;3967.8809635710977;3992.8003599819895;4023.3562629979065;4024.2353952748886;5339.225812257201;5347.41178470368;5356.812511562077;5358.089124848785;5358.169483730028;5668.801591944262;5717.656940583578;5727.198192253088;5739.339975902742;5774.538036957033;5258.027264955919;5281.392639846466;5290.232916227125;5346.4386239445075;5355.892882142413;4852.636052296092;4858.125537403302;4862.586680132228;4875.902481950341;4908.460069392364;5866.1494083357675;5866.266716660418;5930.792422265286;5932.080527518156;5946.494547963472;5612.298462692163;5615.522680572034;5630.042892708331;5730.22641943349;5735.369109398046;5887.381824908323;5914.4381283777975;5914.940850591439;5915.615484993462;5945.583809133319;5618.101103823368;5648.293963254593;5648.830535083954;5664.235328230636;5669.262995810518;5673.943260567342;5678.68767217807;5736.6558006519745;5777.537796976316;5816.47651711348;5554.389017208185;5571.832845014656;5587.860303492445;5591.580631452576;5595.328560572757;5489.066858633962;5523.447655234444;5553.111502159635;5561.555075593862;5571.415001424792;5369.624126311121;5466.125419932791;5551.333839939233;5554.75003624846;5597.908407860591;5592.496675299242;5594.804181853616;5602.52378547828;5610.242617246619;5626.634268772516;5415.2147938547905;5510.476504732204;5519.724013799214;5538.418466061005;5586.888262234814 07:09:46 INFO - PROCESS | 29360 | |1;ext.html;521.9086659834529;523.1968927695988;535.4083737470093;539.9983031476611;562.1371195215345;33925.66074339256;35157.29685406294;35250.11874703134;35258.82370588147;35292;38643.80678096613;38834.22331553367;39035.21929561407;39243.21513569727;39261.60738392615;8239.217274358927;8445.1977062179;8492.830143397128;8521.616527256288;8541.359398045171;8343.54110523921;8417.915820841805;8440;8478.915210847905;8482.236598706115;8615.61229744663;8651;8728.956355218246;8737.7815554611;8796.120387961184;8553.743387698349;8635.309175266026;8644.092370301154;8658.264047555966;8680.869786953137;8537.786555336166;8597.699080532151;8663.610137543825;8687.435316704394;8692.869606955837;38175;38266;38337;38411.42382864231;38546;2601.355888365535;3205.6153261608524;3282.983585082083;3479.5128681984543;4060.39094135882;26137.869310653514;26367.73632263672;27099.864500677566;27203.047893323837;27276.31809204766;3759.0978165240417;3762.209935913434;3857.633524815138;3870.9806450967844;4040.5151381834075;216052;217740;218024;218574.90712546493;219909;54496;55578;55640.88718225613;55727.721361392934;55759;65716;65849.67075164593;66459;66690;66818;13118.934405327913;13322.800157997637;13352.399142038632;13540.119892206974;13569.253691047088;9781.462019588991;9913.702588922344;9943.105120539187;9946.20430365569;10009.799804003878;20047.198112075355;20059.59880802376;20214.898925505277;20782.376528704164;20954.895225523775;8389;8567.186117318844;8676.783080422914;8689.826203476021;8730.519821409884;943.2029934705163;949.9952500237455;1029.917606591471;1069.8819733378639;1087.4617064553097;28279.71720282812;28356.43287134246;28498.28754281118;28613.427731445256;28679;964.3056998960737;1002.5839276700234;1033.2405681823852;1098.5770478365887;1174.7591743692522;14059.71880562383;14391.208483533297;14458.20479873596;14593.416263349347;14617;361728;362014;362787;364166;364385;51741;51776.22335664968;52215.47784522106;52303.73848130735;52306.47693523092;1290.1227165527343;1292.1213574769058;1295.812107244463;1335.8063080853221;1336.4453751692938;26398;26973.904107196824;27193.32016699598;27219.727802721718;27705.584416234175;42808.57191428046;43626.34560481659;43700.78149609231;43722.56277437185;43816;289718;289913;291617;291786;293445;32122;42788.979529014476;42869.571304287805;43255.539556836;43539.78230108829;41399.58600413957;41885;42184.78907605565;42471.57528424676;42643.3603495954;36018.639813602575;36029.45955810718;36181.638183617826;36320.636793631726;36632;36151;36277;36641.81679091587;36908.81545592255;36972.630273696916;34962.82518587391;35761.82119089492;35929.28141437104;36059.63940360563;36176.63823361838;29829.5525567121;32576.674233257363;33175.33649327048;33208.83395583103;33285.50071748877;23769.16807911715;24236.272911812674;24418.145364912143;24446.75553244516;24510.87744561266 07:09:46 INFO - PROCESS | 29360 | |2;jquery.html;359.9532060832091;363.2444515407952;363.59096016980897;363.7308391790076;368.2524475315111;15790.526284211477;16515.91742041288;16666.41667541635;17201.7419738704;17766.111694415275;13076.803847942288;13157.01322400819;13196.604101876936;13329.400176992034;13511.662208444794;4761.476237613877;4780.665353425253;4848.733319667417;4866.31871537985;4873.512648735134;4798.448178459487;4880.194767863299;4887.095887260851;4891.755412229374;4892.633052521075;4641.118187544355;4792.448868380128;4979.576735977446;5199.818006369778;5209.86975325618;5105.285260063612;5112.36095488064;5127.102757017526;5313.57491400687;5927.496162826165;5270.736463176864;5312.6281160318795;5315.867103322409;5322.7338633068575;5323.627346085776;14015.509457169052;18983.71524427135;19682.606347873105;19716.309929152412;19740.11169497376;1959.4317647882096;2069.513664288891;2109.4620871677625;2157.072458842697;2179.967300490494;9544.284178686627;9953.054459826304;11757.529698812037;12154.635360939097;12617.242965422012;1810.1944634637591;1838.6782313095289;1855.4804654696572;1869.12151288894;1915.329634627883;51335.48664513382;52235.73882130603;54604.72697636526;54680.17979730347;54737.452625473634;10163.237757168094;10187.032231937954;10200.897991019994;10206.336588121749;10265.948670256601;13089.738205236032;13189.934050329686;13209.735805284034;13232.272225027524;13268;6847.349501797321;6987.091678081817;7000.299970002959;7015.3686168244085;7065.540739851893;6531.673416329165;6556.98366753154;6576;6597.967010164918;6598.10925525048;4308.202982448257;4356.302991521405;4369.366441865912;4422.29243321067;4465.37484752135;1709.2991873332123;1772.4020238915023;1781.5457058450013;1823.2615790604825;1832.954176145607;906.6554709210458;907.1654078248027;930.8417569013284;1034.2191645307744;1047.177965297238;14523.854761452461;15197.924010379877;15973.920130399274;16111.033337999757;16456.753148702777;890.8129292848574;913.9680111196076;923.0584803500392;998.9250806189419;1017.013496907998;9080.31897607682;9449.527523623792;9493.335466517416;9499.905000949902;9606.327557070937;477575;487814;494312;495475.7940733841;516212;39972.60027399747;51124.48875511272;54994.450055499736;68304.65847670729;73203.26796731964;1102.1733699725205;1110.650145204258;1117.0728295514702;1118.972025699364;1121.6186496591035;13762.24307663088;14622;14734.336954837272;14749.557513274618;14849.40602375893;30095.849520752257;32521.349573007934;32908.01275961725;32932.83533582317;33225.66774332226;39966.80016599898;40018.799906000284;40824.79587602162;41301.38047929223;42208.15583688371;7174.641267936687;7385.48301618903;7394.223606521237;7429.8142546436775;7512.774616761506;10594.576216951236;10775.407352595683;11245.044171245536;11338.263012904135;11357.54569817198;7479.326860582573;8523.360747943805;9289.953550232205;9685;9707.66023189185;9690.75773105678;9801;9966.950165249418;10199.330569016276;10228.335158214692;9704.175145112744;10081.495925203857;10189.165950129049;10198.592056317664;10385.428801415994;7441.8139546511775;7588.165301816685;7605.505642133244;7608.163102058658;7628.427867909818;8722.91277087221;10203.438810865473;10257.435841028517;10402.427866467115;10509.264351495322 07:09:46 INFO - PROCESS | 29360 | |3;mootools.html;1435.856414358564;1464.5313499680103;1591.8089829220487;1711.537884771111;1739.4433781190023;7663.540187588742;7757.418193635472;7819.2571705688015;7915.089764677064;8003.319717823977;8001.3998950078685;8026.398020148483;8051.275385215329;8088.757337279876;8102.432829701923;2279.920202792907;2290.919817806377;2294.5869743446174;2295.621222498294;2296.80566105625;2307.861528308307;2337.824663150262;2338.251759436981;2354.905803767856;2360.716713994323;2193.7696541863115;2212.889355532225;2257.0858802185057;2259.378670865517;2299.735530414007;2261.208576998054;2290;2314.456102815837;2319.3273950554317;2326.9883650581723;2333.9183128590416;2343.4610039690965;2349.2247558305717;2355.211004313557;2361.1263832381956;7825.686972521093;7871;7883;7890.250426209501;7898.763037108896;4476.9552304476865;4580.3358513015755;4587.8623641290815;4598.0344127733215;4599.195140850338;3138.764592655537;3145.748340132784;3186.8406579670923;3224.9677503224902;3227.160938156073;951.70497145885;971.7667759737683;983.2576404814391;997.9251556133319;1032.7005168501125;10770.892291077067;10826.891731082667;10884.891151088466;10897.291676041112;10900.727481812939;4021.4772079630047;4097.836086556505;4137.689673274516;4154.252234597741;4206.831726730897;8815.735527934172;8822.691205807765;8893.777655558533;8904.376693631513;8920;4355.62977146946;4391.923978625257;4417.403650507141;4430.490493593278;4442.355858400579;3965.3457179565626;3975.6819454443576;4011.5186177658866;4015.1166743316426;4016;3392.796432214075;3395.286989732184;3400.6599340065795;3412.7099196568074;3412.897613071612;1017.2523195451338;1029.7539976628213;1039.594558122333;1041.1202533858877;1044.2481413382352;1106.363840791548;1112.5438570186184;1127.3292391027326;1256.3529782162193;1341.03445519226;7250.2024777274455;7279.308465695751;7280.381167600707;7392.889106663404;7412.85174296511;1094.414488248783;1109.6116359274351;1117.0895719988184;1124.668222874254;1128.8871112888646;5686.3744988051285;5818.156367326714;5821.88356232873;5826.504747096459;5844.415558444121;9331.860022099674;9353.766155846022;9557.808843823084;9655.420674759536;9769.951150244204;9448.622055117856;9492.572834222477;9543.761405964906;9600.279979001603;9617.759556011015;7098.29017098286;7190.137183537904;7249.746258880914;7249.891251631229;7258.818529536698;7119.323664251888;7127.607981561064;7151.749688761077;7159.463040271896;7176.031235783103;8080.63637136342;8173.591320433836;8232.34141268685;8257.710980115668;8259.669613215645;8566.571671416528;8703.47779133254;8741.825163496567;8743.868841967249;8824.3381746368;6591;6858.245592984668;6909.481788865754;6910.032595436543;6914.654267286716;7642.388608911385;7691.692332306869;7695.307422332017;7697.499662521918;7698.384129269533;7108.822279443055;7250.564966102051;7253.637318134178;7331.963340183265;7462.925370746223;7140.85718285621;7206.927930720835;7217.989481472703;7266.346028857217;7268.927310726825;7174.390176835028;7304.707811687473;7305.2329505403295;7322.194558598443;7324.937884006896;6294.213223347082;6632.403083722488;6637.767678131436;6670.966645166744;6689.933100668931;6528.477721782151;6539.476841852736;6583;6592.736290548324;6621.337866213533 07:09:46 INFO - PROCESS | 29360 | |4;prototype.html;340.0749960108505;343.7370411635098;344.8517137630821;347.80870521213325;347.9895603131906;6052.576319657625;6113.449789518942;6167.229096362955;6192.566520343572;6196.225471816023;5942.049272116451;6101.908471372933;6110.297315808683;6167.167432396636;6208.844778880519;4735.786889589959;4745.525447455261;4748.857534273978;4750.809967601292;4767.928481072787;4721.527847215269;4749.216379297412;4755.2153894607345;4758.476567577581;4766.261229509431;4517.209488339544;4626.282926146453;4632;4639.744814035227;4711.175544279755;4606.124836281113;4619.353290539327;4626.884327891796;4629.560191781792;4659.510751371091;4012;4085.2646523625735;4087.816048277805;4096.242195193869;4107.158032603339;5878.177055212273;5917.142014407887;5928.40715928408;5943;5946.197263369433;5319.893602127936;5453.072977593819;5461.5357694596005;5463.3717122530625;5470.042742520043;6507.056476810836;6529.510286728514;6545.298222462194;6552.574082684658;6557.114789503404;4476.597106260419;4500.797464114123;4503.829004458831;4506.233940230136;4519.231730605805;6588.505862060365;6809.659517024179;6832;6839.794806155774;6904.13698287714;4574.519675434031;4600.470945841204;4611.400517932647;4612.146752850734;4614.953850461452;4674.789634466457;4675.0883577702025;4677.859664210011;4679.883002924886;4683.367745354333;5428.864278393072;5445.455454454523;5446.210299506629;5448.509634132868;5452.863678407992;6533.085368048477;6627.1716035495565;6647.567908085959;6657.966710166418;6659.300773418819;1611.1621956582512;1611.3312975115196;1624.5207663739225;1626.5039163055146;1638.475687779899;1096.2928910852456;1097.2757979733337;1098.220263612828;1102.250469680625;1111.8992197724194;6155.753769849245;6166.475849552839;6172.598781079216;6182.505399568024;6196.349383314777;6654.268030516736;6666.500012499082;6678.09845670838;6712.697928593225;6713.160854893138;6015.54883383748;6133.172021777093;6135.294441139237;6143.293521245114;6165;3636.745427820027;3637.7635453695425;3647.7993710345654;3648.1426864686778;3652.196516766307;7034.472414568825;7039.92960070403;7047.54190977595;7052.33002864727;7066.081409416845;6676.83307917306;6810.284920083419;6818.897716534157;6832.555883867532;6849;6994.475414344046;7022.92977070233;7025.683844227022;7026.824329391704;7043.929560704328;6680.432163266177;6681.76613818514;6685.164354455693;6720.193576770624;6733.192016957996;6622.403983641495;6662.700178492077;6664.933350666432;6666.666666666551;6669.566478178903;7008.579485230903;7026.086608741035;7029.26192749754;7033.894491582528;7039.648017598997;4609.400777898852;4619.076184762994;4621.838235661736;4624.884377890445;4628.421447319085;6460.547761656639;6546.967265163644;6723.2940541244425;6724.831879203059;6728.764493242713;6686.13080299558;6703.229128650072;6727.26000139994;6741.966290168518;6747.831304217434;6651.201855777338;6666.133402657818;6669.433098186514;6677.998300255001;6681.432078273401;6451.645159516272;6532.869342613216;6562.278149403657;6563.803085907431;6568.540202185801;6616.305287944889;6661.3338666132995;6711.731530738716;6714.362135597111;6726.932730672631;6489.156409666713;6541.2477565078725;6543.80368588924;6551.377619126175;6557.245916719447 07:09:46 INFO - PROCESS | 29360 | |5;yui.html;807.4993504027502;822.8107535266888;844.3878188313473;854.7521218846534;883.1345281624004;11804.7639047219;12108.939455302721;12113.27320360778;12122.45448954797;12140.15018948674;12253.264804111759;12434.626961191156;12487.43806528706;12533.2480051197;12533.68665783356;770.6955752477768;776.6194564663302;778.1518145221708;778.7391223939959;780.169119887321;773.2576726342718;776.2896949291392;777.7316825695126;781.3866115099648;785.1520358013361;805.0580820440099;809.2918696140877;809.7854068671807;811.0429692962302;811.4968719393984;800.8478389106081;800.9599520024004;805.2028491793142;806.9757907262791;807.0476837331976;597.4175179200288;597.9910301345483;598.530153829242;599.4934280532987;599.9130126131687;12031.639050828402;12049.518019279218;12139.210951288138;12142.332171730552;12159.878401216052;9459.432434053979;9516.666916657883;9573.712788616353;9678.467684277362;9786.510674466248;11417.372044537547;11434.256773309708;11452.541898324058;11689.590864319707;12105.87894121065;4180.93529291894;4229.217594744951;4290.506591741927;4304.397384366192;4314.503832059322;43991;44395.77802111001;44525.332120018225;44645.33032004523;44707.329390059174;9069;9781.90218097824;9794.706158815246;9824.361416507903;10104.938981406847;16810.495685129466;16854.241559129867;16858.578535536464;16898.915505422396;16907.32370705158;7314.27201821576;7359.852802944019;7437.776866694008;7492.662830172655;7551.509151905108;4328.718633288826;4373.650107991353;4383.408239887574;4396.208682437128;4411.338299255138;2865.9283517912218;2866.913992580226;2868.641419822522;2879.265787224286;2879.640044994376;518.9455107213688;519.9766010529535;531.0255680825728;532.6404676843115;538.8087229033715;564.9745761440745;658.2068607328158;668.669008840627;685.3112621815044;685.5715178013742;8372.41393102477;8413.200745929127;8494.447860889146;8560.828783424296;8623.870641940375;639.8400399900025;640.9359064093553;641.4066988036049;650.1061041068531;653.0726368556661;3868.4390763339156;3943.4479172915817;3951.8221680024467;3999.1201935574127;4051.959480405217;52576.21135682968;54912.45087549153;54971.175432368545;55232.72383638137;55797;48427.75786121047;48891;48932.7553362238;52428;54070;44652.77673611611;44793.32810007853;44796.10407791891;45000.54999449963;45428.54571454309;8810.427322224035;8860.246879015098;8866.601002954754;9020.413673111227;9503.857442138235;32330.191745206557;32768.50847237246;33228.1692957678;35268.64731352653;35334.823325883204;37684;38393.80803095967;38604.80697596494;41637;41765;10524.158067354747;10560;11215.60745373908;11232.4383780809;11391.658250252505;11995.040396768412;12005.519779208735;12052.51789928393;12492.625221243377;12671.239725616493;11102.333859968428;11288.492017859051;11389.658310250707;11626.941865290619;12070.577529786766;11241.775164496828;11450.312981221154;11574.6527604172;11677.824832627688;11749.118816088998;10907.127429805756;11022.669319920415;11153.330800152016;11582.073434125417;11591.304521728724;9024.643875352569;9152.908470915472;9258.120478554527;9534.570944307661;9583.520823958914;8606.268467180109;8743;9195.908040919772;9216.631334746804;9218 07:09:46 INFO - PROCESS | 29360 | __end_tp_report 07:09:46 INFO - PROCESS | 29360 | __start_cc_report 07:09:46 INFO - PROCESS | 29360 | _x_x_mozilla_cycle_collect,332 07:09:46 INFO - PROCESS | 29360 | __end_cc_report 07:09:46 INFO - PROCESS | 29360 | __startTimestamp1452265786412__endTimestamp 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | ------- Summary: start ------- 07:09:46 INFO - PROCESS | 29360 | Number of tests: 6 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#0] dojo.html Cycles:165 Average:5293.22 Median:5538.42 stddev:580.83 (10.5%) stddev-sans-first:557.88 07:09:46 INFO - PROCESS | 29360 | Values: 3155.8 3192.2 3205.7 3218.5 3236.8 5101.4 5209.9 5218.1 5237.7 5317.2 5190.3 5191.7 5204.8 5215.6 5223.2 4781.8 4882.0 4916.5 4960.6 4970.5 4892.8 4914.4 4947.5 4948.9 4984.5 4597.7 4726.4 4820.2 4920.2 4936.3 4794.1 4830.7 4834.9 4842.1 4885.2 4787.7 4807.6 4827.7 4877.7 4884.5 5077.0 5143.6 5149.0 5149.6 5184.7 5604.1 5610.9 5650.8 5715.3 5763.1 5775.1 5776.9 5778.4 5783.8 5795.1 5351.1 5355.3 5375.0 5376.1 5386.2 5734.6 5838.2 5842.6 5867.8 5980.0 5552.7 5613.7 5619.4 5620.4 5631.1 5654.3 5681.9 5708.9 5714.5 5716.6 5604.8 5679.7 5687.7 5746.7 5756.3 5615.3 5627.2 5643.1 5664.7 5673.9 4353.0 4422.3 4426.7 4428.3 4448.3 3936.8 3967.9 3992.8 4023.4 4024.2 5339.2 5347.4 5356.8 5358.1 5358.2 5668.8 5717.7 5727.2 5739.3 5774.5 5258.0 5281.4 5290.2 5346.4 5355.9 4852.6 4858.1 4862.6 4875.9 4908.5 5866.1 5866.3 5930.8 5932.1 5946.5 5612.3 5615.5 5630.0 5730.2 5735.4 5887.4 5914.4 5914.9 5915.6 5945.6 5618.1 5648.3 5648.8 5664.2 5669.3 5673.9 5678.7 5736.7 5777.5 5816.5 5554.4 5571.8 5587.9 5591.6 5595.3 5489.1 5523.4 5553.1 5561.6 5571.4 5369.6 5466.1 5551.3 5554.8 5597.9 5592.5 5594.8 5602.5 5610.2 5626.6 5415.2 5510.5 5519.7 5538.4 5586.9 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#1] ext.html Cycles:180 Average:45930.07 Median:36775.32 stddev:77894.44 (211.8%) stddev-sans-first:78038.34 07:09:46 INFO - PROCESS | 29360 | Values: 521.9 523.2 535.4 540.0 562.1 33925.7 35157.3 35250.1 35258.8 35292.0 38643.8 38834.2 39035.2 39243.2 39261.6 8239.2 8445.2 8492.8 8521.6 8541.4 8343.5 8417.9 8440.0 8478.9 8482.2 8615.6 8651.0 8729.0 8737.8 8796.1 8553.7 8635.3 8644.1 8658.3 8680.9 8537.8 8597.7 8663.6 8687.4 8692.9 38175.0 38266.0 38337.0 38411.4 38546.0 2601.4 3205.6 3283.0 3479.5 4060.4 26137.9 26367.7 27099.9 27203.0 27276.3 3759.1 3762.2 3857.6 3871.0 4040.5 216052.0 217740.0 218024.0 218574.9 219909.0 54496.0 55578.0 55640.9 55727.7 55759.0 65716.0 65849.7 66459.0 66690.0 66818.0 13118.9 13322.8 13352.4 13540.1 13569.3 9781.5 9913.7 9943.1 9946.2 10009.8 20047.2 20059.6 20214.9 20782.4 20954.9 8389.0 8567.2 8676.8 8689.8 8730.5 943.2 950.0 1029.9 1069.9 1087.5 28279.7 28356.4 28498.3 28613.4 28679.0 964.3 1002.6 1033.2 1098.6 1174.8 14059.7 14391.2 14458.2 14593.4 14617.0 361728.0 362014.0 362787.0 364166.0 364385.0 51741.0 51776.2 52215.5 52303.7 52306.5 1290.1 1292.1 1295.8 1335.8 1336.4 26398.0 26973.9 27193.3 27219.7 27705.6 42808.6 43626.3 43700.8 43722.6 43816.0 289718.0 289913.0 291617.0 291786.0 293445.0 32122.0 42789.0 42869.6 43255.5 43539.8 41399.6 41885.0 42184.8 42471.6 42643.4 36018.6 36029.5 36181.6 36320.6 36632.0 36151.0 36277.0 36641.8 36908.8 36972.6 34962.8 35761.8 35929.3 36059.6 36176.6 29829.6 32576.7 33175.3 33208.8 33285.5 23769.2 24236.3 24418.1 24446.8 24510.9 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#2] jquery.html Cycles:180 Average:25517.60 Median:41754.77 stddev:80621.02 (193.1%) stddev-sans-first:80825.05 07:09:46 INFO - PROCESS | 29360 | Values: 360.0 363.2 363.6 363.7 368.3 15790.5 16515.9 16666.4 17201.7 17766.1 13076.8 13157.0 13196.6 13329.4 13511.7 4761.5 4780.7 4848.7 4866.3 4873.5 4798.4 4880.2 4887.1 4891.8 4892.6 4641.1 4792.4 4979.6 5199.8 5209.9 5105.3 5112.4 5127.1 5313.6 5927.5 5270.7 5312.6 5315.9 5322.7 5323.6 14015.5 18983.7 19682.6 19716.3 19740.1 1959.4 2069.5 2109.5 2157.1 2180.0 9544.3 9953.1 11757.5 12154.6 12617.2 1810.2 1838.7 1855.5 1869.1 1915.3 51335.5 52235.7 54604.7 54680.2 54737.5 10163.2 10187.0 10200.9 10206.3 10265.9 13089.7 13189.9 13209.7 13232.3 13268.0 6847.3 6987.1 7000.3 7015.4 7065.5 6531.7 6557.0 6576.0 6598.0 6598.1 4308.2 4356.3 4369.4 4422.3 4465.4 1709.3 1772.4 1781.5 1823.3 1833.0 906.7 907.2 930.8 1034.2 1047.2 14523.9 15197.9 15973.9 16111.0 16456.8 890.8 914.0 923.1 998.9 1017.0 9080.3 9449.5 9493.3 9499.9 9606.3 477575.0 487814.0 494312.0 495475.8 516212.0 39972.6 51124.5 54994.5 68304.7 73203.3 1102.2 1110.7 1117.1 1119.0 1121.6 13762.2 14622.0 14734.3 14749.6 14849.4 30095.8 32521.3 32908.0 32932.8 33225.7 39966.8 40018.8 40824.8 41301.4 42208.2 7174.6 7385.5 7394.2 7429.8 7512.8 10594.6 10775.4 11245.0 11338.3 11357.5 7479.3 8523.4 9290.0 9685.0 9707.7 9690.8 9801.0 9967.0 10199.3 10228.3 9704.2 10081.5 10189.2 10198.6 10385.4 7441.8 7588.2 7605.5 7608.2 7628.4 8722.9 10203.4 10257.4 10402.4 10509.3 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#3] mootools.html Cycles:180 Average:5487.50 Median:6591.87 stddev:2874.16 (43.6%) stddev-sans-first:2866.09 07:09:46 INFO - PROCESS | 29360 | Values: 1435.9 1464.5 1591.8 1711.5 1739.4 7663.5 7757.4 7819.3 7915.1 8003.3 8001.4 8026.4 8051.3 8088.8 8102.4 2279.9 2290.9 2294.6 2295.6 2296.8 2307.9 2337.8 2338.3 2354.9 2360.7 2193.8 2212.9 2257.1 2259.4 2299.7 2261.2 2290.0 2314.5 2319.3 2327.0 2333.9 2343.5 2349.2 2355.2 2361.1 7825.7 7871.0 7883.0 7890.3 7898.8 4477.0 4580.3 4587.9 4598.0 4599.2 3138.8 3145.7 3186.8 3225.0 3227.2 951.7 971.8 983.3 997.9 1032.7 10770.9 10826.9 10884.9 10897.3 10900.7 4021.5 4097.8 4137.7 4154.3 4206.8 8815.7 8822.7 8893.8 8904.4 8920.0 4355.6 4391.9 4417.4 4430.5 4442.4 3965.3 3975.7 4011.5 4015.1 4016.0 3392.8 3395.3 3400.7 3412.7 3412.9 1017.3 1029.8 1039.6 1041.1 1044.2 1106.4 1112.5 1127.3 1256.4 1341.0 7250.2 7279.3 7280.4 7392.9 7412.9 1094.4 1109.6 1117.1 1124.7 1128.9 5686.4 5818.2 5821.9 5826.5 5844.4 9331.9 9353.8 9557.8 9655.4 9770.0 9448.6 9492.6 9543.8 9600.3 9617.8 7098.3 7190.1 7249.7 7249.9 7258.8 7119.3 7127.6 7151.7 7159.5 7176.0 8080.6 8173.6 8232.3 8257.7 8259.7 8566.6 8703.5 8741.8 8743.9 8824.3 6591.0 6858.2 6909.5 6910.0 6914.7 7642.4 7691.7 7695.3 7697.5 7698.4 7108.8 7250.6 7253.6 7332.0 7462.9 7140.9 7206.9 7218.0 7266.3 7268.9 7174.4 7304.7 7305.2 7322.2 7324.9 6294.2 6632.4 6637.8 6671.0 6689.9 6528.5 6539.5 6583.0 6592.7 6621.3 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#4] prototype.html Cycles:180 Average:5471.49 Median:6165.74 stddev:1661.32 (26.9%) stddev-sans-first:1620.72 07:09:46 INFO - PROCESS | 29360 | Values: 340.1 343.7 344.9 347.8 348.0 6052.6 6113.4 6167.2 6192.6 6196.2 5942.0 6101.9 6110.3 6167.2 6208.8 4735.8 4745.5 4748.9 4750.8 4767.9 4721.5 4749.2 4755.2 4758.5 4766.3 4517.2 4626.3 4632.0 4639.7 4711.2 4606.1 4619.4 4626.9 4629.6 4659.5 4012.0 4085.3 4087.8 4096.2 4107.2 5878.2 5917.1 5928.4 5943.0 5946.2 5319.9 5453.1 5461.5 5463.4 5470.0 6507.1 6529.5 6545.3 6552.6 6557.1 4476.6 4500.8 4503.8 4506.2 4519.2 6588.5 6809.7 6832.0 6839.8 6904.1 4574.5 4600.5 4611.4 4612.1 4615.0 4674.8 4675.1 4677.9 4679.9 4683.4 5428.9 5445.5 5446.2 5448.5 5452.9 6533.1 6627.2 6647.6 6658.0 6659.3 1611.2 1611.3 1624.5 1626.5 1638.5 1096.3 1097.3 1098.2 1102.3 1111.9 6155.8 6166.5 6172.6 6182.5 6196.3 6654.3 6666.5 6678.1 6712.7 6713.2 6015.5 6133.2 6135.3 6143.3 6165.0 3636.7 3637.8 3647.8 3648.1 3652.2 7034.5 7039.9 7047.5 7052.3 7066.1 6676.8 6810.3 6818.9 6832.6 6849.0 6994.5 7022.9 7025.7 7026.8 7043.9 6680.4 6681.8 6685.2 6720.2 6733.2 6622.4 6662.7 6664.9 6666.7 6669.6 7008.6 7026.1 7029.3 7033.9 7039.6 4609.4 4619.1 4621.8 4624.9 4628.4 6460.5 6547.0 6723.3 6724.8 6728.8 6686.1 6703.2 6727.3 6742.0 6747.8 6651.2 6666.1 6669.4 6678.0 6681.4 6451.6 6532.9 6562.3 6563.8 6568.5 6616.3 6661.3 6711.7 6714.4 6726.9 6489.2 6541.2 6543.8 6551.4 6557.2 07:09:46 INFO - PROCESS | 29360 | 07:09:46 INFO - PROCESS | 29360 | [#5] yui.html Cycles:180 Average:13197.88 Median:46928.15 stddev:15090.32 (32.2%) stddev-sans-first:15103.96 07:09:46 INFO - PROCESS | 29360 | Values: 807.5 822.8 844.4 854.8 883.1 11804.8 12108.9 12113.3 12122.5 12140.2 12253.3 12434.6 12487.4 12533.2 12533.7 770.7 776.6 778.2 778.7 780.2 773.3 776.3 777.7 781.4 785.2 805.1 809.3 809.8 811.0 811.5 800.8 801.0 805.2 807.0 807.0 597.4 598.0 598.5 599.5 599.9 12031.6 12049.5 12139.2 12142.3 12159.9 9459.4 9516.7 9573.7 9678.5 9786.5 11417.4 11434.3 11452.5 11689.6 12105.9 4180.9 4229.2 4290.5 4304.4 4314.5 43991.0 44395.8 44525.3 44645.3 44707.3 9069.0 9781.9 9794.7 9824.4 10104.9 16810.5 16854.2 16858.6 16898.9 16907.3 7314.3 7359.9 7437.8 7492.7 7551.5 4328.7 4373.7 4383.4 4396.2 4411.3 2865.9 2866.9 2868.6 2879.3 2879.6 518.9 520.0 531.0 532.6 538.8 565.0 658.2 668.7 685.3 685.6 8372.4 8413.2 8494.4 8560.8 8623.9 639.8 640.9 641.4 650.1 653.1 3868.4 3943.4 3951.8 3999.1 4052.0 52576.2 54912.5 54971.2 55232.7 55797.0 48427.8 48891.0 48932.8 52428.0 54070.0 44652.8 44793.3 44796.1 45000.5 45428.5 8810.4 8860.2 8866.6 9020.4 9503.9 32330.2 32768.5 33228.2 35268.6 35334.8 37684.0 38393.8 38604.8 41637.0 41765.0 10524.2 10560.0 11215.6 11232.4 11391.7 11995.0 12005.5 12052.5 12492.6 12671.2 11102.3 11288.5 11389.7 11626.9 12070.6 11241.8 11450.3 11574.7 11677.8 11749.1 10907.1 11022.7 11153.3 11582.1 11591.3 9024.6 9152.9 9258.1 9534.6 9583.5 8606.3 8743.0 9195.9 9216.6 9218.0 07:09:46 INFO - PROCESS | 29360 | -------- Summary: end -------- 07:09:46 INFO - PROCESS | 29360 | 07:09:47 INFO - TEST-INFO | 29360: exit 0 07:09:47 INFO - TEST-OK | dromaeo_css | took 1110195ms 07:09:47 INFO - TEST-START | kraken 07:09:47 INFO - operating with platform_type : linux_ 07:09:47 INFO - Initialising browser for kraken test... 07:09:47 INFO - TEST-INFO | started process 29600 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAq1o0R/profile http://localhost:33689/getInfo.html) 07:09:50 INFO - PROCESS | 29600 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 07:09:51 INFO - PROCESS | 29600 | __metrics Screen width/height:1600/1200 07:09:51 INFO - PROCESS | 29600 | colorDepth:24 07:09:51 INFO - PROCESS | 29600 | Browser inner width/height: 1024/697 07:09:51 INFO - PROCESS | 29600 | __metrics 07:09:51 INFO - PROCESS | 29600 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:09:52 INFO - TEST-INFO | 29600: exit 0 07:09:52 INFO - Browser initialized. 07:09:52 INFO - Running cycle 1/1 for kraken test... 07:09:52 INFO - TEST-INFO | started process 29722 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAq1o0R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:04 INFO - PROCESS | 29722 | RSS: Main: 150560768 07:10:04 INFO - PROCESS | 29722 | 07:10:06 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33689/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:07 INFO - PROCESS | 29722 | RSS: Main: 151207936 07:10:07 INFO - PROCESS | 29722 | 07:10:10 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33689/tests/kraken/driver.html?testName=audio-dft) 07:10:10 INFO - PROCESS | 29722 | RSS: Main: 152342528 07:10:10 INFO - PROCESS | 29722 | 07:10:13 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33689/tests/kraken/driver.html?testName=audio-fft) 07:10:14 INFO - PROCESS | 29722 | RSS: Main: 146706432 07:10:14 INFO - PROCESS | 29722 | 07:10:16 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33689/tests/kraken/driver.html?testName=audio-oscillator) 07:10:16 INFO - PROCESS | 29722 | RSS: Main: 146411520 07:10:16 INFO - PROCESS | 29722 | 07:10:19 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:19 INFO - PROCESS | 29722 | RSS: Main: 147345408 07:10:19 INFO - PROCESS | 29722 | 07:10:22 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33689/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:23 INFO - PROCESS | 29722 | RSS: Main: 147722240 07:10:23 INFO - PROCESS | 29722 | 07:10:26 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33689/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:27 INFO - PROCESS | 29722 | RSS: Main: 149237760 07:10:27 INFO - PROCESS | 29722 | 07:10:30 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33689/tests/kraken/driver.html?testName=json-parse-financial) 07:10:30 INFO - PROCESS | 29722 | RSS: Main: 149667840 07:10:30 INFO - PROCESS | 29722 | 07:10:32 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:32 INFO - PROCESS | 29722 | RSS: Main: 148987904 07:10:32 INFO - PROCESS | 29722 | 07:10:34 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:35 INFO - PROCESS | 29722 | RSS: Main: 149454848 07:10:35 INFO - PROCESS | 29722 | 07:10:37 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:37 INFO - PROCESS | 29722 | RSS: Main: 149807104 07:10:37 INFO - PROCESS | 29722 | 07:10:40 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:41 INFO - PROCESS | 29722 | RSS: Main: 149803008 07:10:41 INFO - PROCESS | 29722 | 07:10:43 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:44 INFO - PROCESS | 29722 | RSS: Main: 148926464 07:10:44 INFO - PROCESS | 29722 | 07:10:45 INFO - PROCESS | 29722 | Cycle 1(1): loaded http://localhost:33689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33689/tests/kraken/driver.html?testName=ai-astar) 07:10:46 INFO - PROCESS | 29722 | RSS: Main: 149381120 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | __start_tp_report 07:10:46 INFO - PROCESS | 29722 | _x_x_mozilla_page_load 07:10:46 INFO - PROCESS | 29722 | _x_x_mozilla_page_load_details 07:10:46 INFO - PROCESS | 29722 | |i|pagename|runs| 07:10:46 INFO - PROCESS | 29722 | |0;ai-astar;113;109;111;110;112;124;111;112;110;111 07:10:46 INFO - PROCESS | 29722 | |1;audio-beat-detection;157;129;153;174;125;158;156;131;171;138 07:10:46 INFO - PROCESS | 29722 | |2;audio-dft;163;164;163;161;160;163;163;165;169;162 07:10:46 INFO - PROCESS | 29722 | |3;audio-fft;74;72;73;73;72;71;138;75;71;71 07:10:46 INFO - PROCESS | 29722 | |4;audio-oscillator;96;95;139;97;97;95;151;95;96;135 07:10:46 INFO - PROCESS | 29722 | |5;imaging-gaussian-blur;110;110;109;110;110;110;110;110;109;112 07:10:46 INFO - PROCESS | 29722 | |6;imaging-darkroom;147;147;147;146;147;146;146;146;148;146 07:10:46 INFO - PROCESS | 29722 | |7;imaging-desaturate;96;97;96;96;97;96;96;96;96;96 07:10:46 INFO - PROCESS | 29722 | |8;json-parse-financial;58;58;59;57;60;57;60;60;55;55 07:10:46 INFO - PROCESS | 29722 | |9;json-stringify-tinderbox;66;67;66;68;67;67;67;68;68;67 07:10:46 INFO - PROCESS | 29722 | |10;stanford-crypto-aes;87;85;87;85;88;86;85;93;88;87 07:10:46 INFO - PROCESS | 29722 | |11;stanford-crypto-ccm;128;117;122;123;135;124;117;122;120;116 07:10:46 INFO - PROCESS | 29722 | |12;stanford-crypto-pbkdf2;148;150;151;153;150;149;151;157;146;149 07:10:46 INFO - PROCESS | 29722 | |13;stanford-crypto-sha256-iterative;77;68;70;69;71;68;67;68;72;70 07:10:46 INFO - PROCESS | 29722 | __end_tp_report 07:10:46 INFO - PROCESS | 29722 | __start_cc_report 07:10:46 INFO - PROCESS | 29722 | _x_x_mozilla_cycle_collect,770 07:10:46 INFO - PROCESS | 29722 | __end_cc_report 07:10:46 INFO - PROCESS | 29722 | __startTimestamp1452265846154__endTimestamp 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | ------- Summary: start ------- 07:10:46 INFO - PROCESS | 29722 | Number of tests: 14 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.50 stddev:4.27 (3.8%) stddev-sans-first:4.52 07:10:46 INFO - PROCESS | 29722 | Values: 113.0 109.0 111.0 110.0 112.0 124.0 111.0 112.0 110.0 111.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:156.50 stddev:17.45 (11.1%) stddev-sans-first:18.28 07:10:46 INFO - PROCESS | 29722 | Values: 157.0 129.0 153.0 174.0 125.0 158.0 156.0 131.0 171.0 138.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.45 (1.5%) stddev-sans-first:2.60 07:10:46 INFO - PROCESS | 29722 | Values: 163.0 164.0 163.0 161.0 160.0 163.0 163.0 165.0 169.0 162.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.50 stddev:20.77 (28.7%) stddev-sans-first:21.96 07:10:46 INFO - PROCESS | 29722 | Values: 74.0 72.0 73.0 73.0 72.0 71.0 138.0 75.0 71.0 71.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.50 stddev:22.49 (23.5%) stddev-sans-first:23.30 07:10:46 INFO - PROCESS | 29722 | Values: 96.0 95.0 139.0 97.0 97.0 95.0 151.0 95.0 96.0 135.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:10:46 INFO - PROCESS | 29722 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 112.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:10:46 INFO - PROCESS | 29722 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:10:46 INFO - PROCESS | 29722 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.91 (3.3%) stddev-sans-first:2.03 07:10:46 INFO - PROCESS | 29722 | Values: 58.0 58.0 59.0 57.0 60.0 57.0 60.0 60.0 55.0 55.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 07:10:46 INFO - PROCESS | 29722 | Values: 66.0 67.0 66.0 68.0 67.0 67.0 67.0 68.0 68.0 67.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.38 (2.7%) stddev-sans-first:2.52 07:10:46 INFO - PROCESS | 29722 | Values: 87.0 85.0 87.0 85.0 88.0 86.0 85.0 93.0 88.0 87.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.50 stddev:5.76 (4.7%) stddev-sans-first:5.74 07:10:46 INFO - PROCESS | 29722 | Values: 128.0 117.0 122.0 123.0 135.0 124.0 117.0 122.0 120.0 116.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:150.50 stddev:2.99 (2.0%) stddev-sans-first:3.04 07:10:46 INFO - PROCESS | 29722 | Values: 148.0 150.0 151.0 153.0 150.0 149.0 151.0 157.0 146.0 149.0 07:10:46 INFO - PROCESS | 29722 | 07:10:46 INFO - PROCESS | 29722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:2.91 (4.2%) stddev-sans-first:1.64 07:10:46 INFO - PROCESS | 29722 | Values: 77.0 68.0 70.0 69.0 71.0 68.0 67.0 68.0 72.0 70.0 07:10:46 INFO - PROCESS | 29722 | -------- Summary: end -------- 07:10:46 INFO - PROCESS | 29722 | 07:10:47 INFO - TEST-INFO | 29722: exit 0 07:10:47 INFO - TEST-OK | kraken | took 59947ms 07:10:47 INFO - TEST-START | v8_7 07:10:47 INFO - operating with platform_type : linux_ 07:10:47 INFO - Initialising browser for v8_7 test... 07:10:47 INFO - TEST-INFO | started process 30008 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptYZQmA/profile http://localhost:33689/getInfo.html) 07:10:50 INFO - PROCESS | 30008 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 07:10:51 INFO - PROCESS | 30008 | __metrics Screen width/height:1600/1200 07:10:51 INFO - PROCESS | 30008 | colorDepth:24 07:10:51 INFO - PROCESS | 30008 | Browser inner width/height: 1024/697 07:10:51 INFO - PROCESS | 30008 | __metrics 07:10:51 INFO - PROCESS | 30008 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:10:52 INFO - TEST-INFO | 30008: exit 0 07:10:52 INFO - Browser initialized. 07:10:52 INFO - Running cycle 1/1 for v8_7 test... 07:10:52 INFO - TEST-INFO | started process 30129 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptYZQmA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:04 INFO - PROCESS | 30129 | RSS: Main: 150425600 07:11:04 INFO - PROCESS | 30129 | 07:11:26 INFO - PROCESS | 30129 | Cycle 1(1): loaded http://localhost:33689/tests/v8_7/run.html (next: http://localhost:33689/tests/v8_7/run.html) 07:11:27 INFO - PROCESS | 30129 | RSS: Main: 146141184 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | __start_tp_report 07:11:27 INFO - PROCESS | 30129 | _x_x_mozilla_page_load 07:11:27 INFO - PROCESS | 30129 | _x_x_mozilla_page_load_details 07:11:27 INFO - PROCESS | 30129 | |i|pagename|runs| 07:11:27 INFO - PROCESS | 30129 | |0;Richards;166.63889351774705 07:11:27 INFO - PROCESS | 30129 | |1;DeltaBlue;188.39487565938205 07:11:27 INFO - PROCESS | 30129 | |2;Encrypt;282.80542986425337 07:11:27 INFO - PROCESS | 30129 | |3;Decrypt;5251.308900523561 07:11:27 INFO - PROCESS | 30129 | |4;RayTrace;1049.3179433368311 07:11:27 INFO - PROCESS | 30129 | |5;Earley;726.2164124909223 07:11:27 INFO - PROCESS | 30129 | |6;Boyer;12268.292682926829 07:11:27 INFO - PROCESS | 30129 | |7;RegExp;41265.30612244898 07:11:27 INFO - PROCESS | 30129 | |8;Splay;1726.3339070567986 07:11:27 INFO - PROCESS | 30129 | |9;NavierStokes;4826.923076923077 07:11:27 INFO - PROCESS | 30129 | __end_tp_report 07:11:27 INFO - PROCESS | 30129 | __startTimestamp1452265887123__endTimestamp 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | ------- Summary: start ------- 07:11:27 INFO - PROCESS | 30129 | Number of tests: 10 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#0] Richards Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 166.6 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 188.4 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 282.8 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 5251.3 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#4] RayTrace Cycles:1 Average:1049.32 Median:1049.32 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 1049.3 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#5] Earley Cycles:1 Average:726.22 Median:726.22 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 726.2 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 12268.3 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#7] RegExp Cycles:1 Average:41265.31 Median:41265.31 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 41265.3 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#8] Splay Cycles:1 Average:1726.33 Median:1726.33 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 1726.3 07:11:27 INFO - PROCESS | 30129 | 07:11:27 INFO - PROCESS | 30129 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:11:27 INFO - PROCESS | 30129 | Values: 4826.9 07:11:27 INFO - PROCESS | 30129 | -------- Summary: end -------- 07:11:27 INFO - PROCESS | 30129 | 07:11:28 INFO - TEST-INFO | 30129: exit 0 07:11:28 INFO - TEST-OK | v8_7 | took 40933ms 07:11:28 INFO - SUITE-END | took 1211s 07:11:28 INFO - Completed test suite (00:20:11) 07:11:28 INFO - Working with test: dromaeo_css 07:11:28 INFO - Generating results file: dromaeo_css 07:11:28 INFO - Working with test: kraken 07:11:28 INFO - Generating results file: kraken 07:11:28 INFO - javascript benchmark 07:11:28 INFO - Working with test: v8_7 07:11:28 INFO - Generating results file: v8_7 07:11:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:11:28 INFO - process_Request line: dromaeo_css 6843.69 graph.html#tests=[[72,1,43]] 07:11:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:28 INFO - process_Request line: kraken 1521.10 graph.html#tests=[[232,1,43]] 07:11:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:28 INFO - process_Request line: v8_7 18318.57 graph.html#tests=[[230,1,43]] 07:11:28 INFO - RETURN: dromaeo_css: 6843.69 07:11:28 INFO - RETURN: kraken: 1521.10 07:11:28 INFO - RETURN: v8_7: 18318.57 07:11:28 INFO - javascript benchmark 07:11:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.8106513609187, 3192.2019495126206, 3205.6794320567933, 3218.533312669663, 3236.773425860189, 5101.38783345999, 5209.895802083961, 5218.0868348039085, 5237.711925844077, 5317.229001794737, 5190.273361729352, 5191.714455704935, 5204.817831375903, 5215.556677682402, 5223.242629818674, 4781.760911954397, 4881.951180488185, 4916.508349165073, 4960.553550180483, 4970.478099799505, 4892.804287828482, 4914.434839993393, 4947.529984651453, 4948.925766113493, 4984.451710311862, 4597.747123908183, 4726.409198850144, 4820.156472617278, 4920.212765957447, 4936.284238785374, 4794.089123066607, 4830.686005409637, 4834.854954351375, 4842.12841688496, 4885.2427873679635, 4787.736674482902, 4807.6394270429855, 4827.710337379734, 4877.6829506081995, 4884.487128851455, 5077.0, 5143.588512918957, 5148.974255128738, 5149.613778966593, 5184.7148406837605, 5604.075327570946, 5610.915836262459, 5650.830475085754, 5715.257016587859, 5763.106718458645, 5775.1337299405, 5776.8844623107725, 5778.393268706767, 5783.768649254025, 5795.072788353886, 5351.117065684158, 5355.303810504648, 5375.0, 5376.059189641797, 5386.245925570423, 5734.598578099576, 5838.241028666246, 5842.5618078644275, 5867.765289388377, 5980.0132978059, 5552.694601796859, 5613.7193140342815, 5619.438056194348, 5620.437956204347, 5631.127175287755, 5654.3497497788285, 5681.886362272814, 5708.857278567986, 5714.485696287271, 5716.599838011382, 5604.831855044274, 5679.659220446786, 5687.744051517691, 5746.741396637161, 5756.33802112754, 5615.298087739033, 5627.212190293362, 5643.125315576092, 5664.660120392789, 5673.943260567342, 4353.0, 4422.314541246112, 4426.690131690815, 4428.335749637516, 4448.332750087448, 3936.842526298973, 3967.8809635710977, 3992.8003599819895, 4023.3562629979065, 4024.2353952748886, 5339.225812257201, 5347.41178470368, 5356.812511562077, 5358.089124848785, 5358.169483730028, 5668.801591944262, 5717.656940583578, 5727.198192253088, 5739.339975902742, 5774.538036957033, 5258.027264955919, 5281.392639846466, 5290.232916227125, 5346.4386239445075, 5355.892882142413, 4852.636052296092, 4858.125537403302, 4862.586680132228, 4875.902481950341, 4908.460069392364, 5866.1494083357675, 5866.266716660418, 5930.792422265286, 5932.080527518156, 5946.494547963472, 5612.298462692163, 5615.522680572034, 5630.042892708331, 5730.22641943349, 5735.369109398046, 5887.381824908323, 5914.4381283777975, 5914.940850591439, 5915.615484993462, 5945.583809133319, 5618.101103823368, 5648.293963254593, 5648.830535083954, 5664.235328230636, 5669.262995810518, 5673.943260567342, 5678.68767217807, 5736.6558006519745, 5777.537796976316, 5816.47651711348, 5554.389017208185, 5571.832845014656, 5587.860303492445, 5591.580631452576, 5595.328560572757, 5489.066858633962, 5523.447655234444, 5553.111502159635, 5561.555075593862, 5571.415001424792, 5369.624126311121, 5466.125419932791, 5551.333839939233, 5554.75003624846, 5597.908407860591, 5592.496675299242, 5594.804181853616, 5602.52378547828, 5610.242617246619, 5626.634268772516, 5415.2147938547905, 5510.476504732204, 5519.724013799214, 5538.418466061005, 5586.888262234814], "unit": "score", "name": "dojo.html", "value": 5256.1596757729585}, {"lowerIsBetter": false, "replicates": [521.9086659834529, 523.1968927695988, 535.4083737470093, 539.9983031476611, 562.1371195215345, 33925.66074339256, 35157.29685406294, 35250.11874703134, 35258.82370588147, 35292.0, 38643.80678096613, 38834.22331553367, 39035.21929561407, 39243.21513569727, 39261.60738392615, 8239.217274358927, 8445.1977062179, 8492.830143397128, 8521.616527256288, 8541.359398045171, 8343.54110523921, 8417.915820841805, 8440.0, 8478.915210847905, 8482.236598706115, 8615.61229744663, 8651.0, 8728.956355218246, 8737.7815554611, 8796.120387961184, 8553.743387698349, 8635.309175266026, 8644.092370301154, 8658.264047555966, 8680.869786953137, 8537.786555336166, 8597.699080532151, 8663.610137543825, 8687.435316704394, 8692.869606955837, 38175.0, 38266.0, 38337.0, 38411.42382864231, 38546.0, 2601.355888365535, 3205.6153261608524, 3282.983585082083, 3479.5128681984543, 4060.39094135882, 26137.869310653514, 26367.73632263672, 27099.864500677566, 27203.047893323837, 27276.31809204766, 3759.0978165240417, 3762.209935913434, 3857.633524815138, 3870.9806450967844, 4040.5151381834075, 216052.0, 217740.0, 218024.0, 218574.90712546493, 219909.0, 54496.0, 55578.0, 55640.88718225613, 55727.721361392934, 55759.0, 65716.0, 65849.67075164593, 66459.0, 66690.0, 66818.0, 13118.934405327913, 13322.800157997637, 13352.399142038632, 13540.119892206974, 13569.253691047088, 9781.462019588991, 9913.702588922344, 9943.105120539187, 9946.20430365569, 10009.799804003878, 20047.198112075355, 20059.59880802376, 20214.898925505277, 20782.376528704164, 20954.895225523775, 8389.0, 8567.186117318844, 8676.783080422914, 8689.826203476021, 8730.519821409884, 943.2029934705163, 949.9952500237455, 1029.917606591471, 1069.8819733378639, 1087.4617064553097, 28279.71720282812, 28356.43287134246, 28498.28754281118, 28613.427731445256, 28679.0, 964.3056998960737, 1002.5839276700234, 1033.2405681823852, 1098.5770478365887, 1174.7591743692522, 14059.71880562383, 14391.208483533297, 14458.20479873596, 14593.416263349347, 14617.0, 361728.0, 362014.0, 362787.0, 364166.0, 364385.0, 51741.0, 51776.22335664968, 52215.47784522106, 52303.73848130735, 52306.47693523092, 1290.1227165527343, 1292.1213574769058, 1295.812107244463, 1335.8063080853221, 1336.4453751692938, 26398.0, 26973.904107196824, 27193.32016699598, 27219.727802721718, 27705.584416234175, 42808.57191428046, 43626.34560481659, 43700.78149609231, 43722.56277437185, 43816.0, 289718.0, 289913.0, 291617.0, 291786.0, 293445.0, 32122.0, 42788.979529014476, 42869.571304287805, 43255.539556836, 43539.78230108829, 41399.58600413957, 41885.0, 42184.78907605565, 42471.57528424676, 42643.3603495954, 36018.639813602575, 36029.45955810718, 36181.638183617826, 36320.636793631726, 36632.0, 36151.0, 36277.0, 36641.81679091587, 36908.81545592255, 36972.630273696916, 34962.82518587391, 35761.82119089492, 35929.28141437104, 36059.63940360563, 36176.63823361838, 29829.5525567121, 32576.674233257363, 33175.33649327048, 33208.83395583103, 33285.50071748877, 23769.16807911715, 24236.272911812674, 24418.145364912143, 24446.75553244516, 24510.87744561266], "unit": "score", "name": "ext.html", "value": 18134.105573037847}, {"lowerIsBetter": false, "replicates": [359.9532060832091, 363.2444515407952, 363.59096016980897, 363.7308391790076, 368.2524475315111, 15790.526284211477, 16515.91742041288, 16666.41667541635, 17201.7419738704, 17766.111694415275, 13076.803847942288, 13157.01322400819, 13196.604101876936, 13329.400176992034, 13511.662208444794, 4761.476237613877, 4780.665353425253, 4848.733319667417, 4866.31871537985, 4873.512648735134, 4798.448178459487, 4880.194767863299, 4887.095887260851, 4891.755412229374, 4892.633052521075, 4641.118187544355, 4792.448868380128, 4979.576735977446, 5199.818006369778, 5209.86975325618, 5105.285260063612, 5112.36095488064, 5127.102757017526, 5313.57491400687, 5927.496162826165, 5270.736463176864, 5312.6281160318795, 5315.867103322409, 5322.7338633068575, 5323.627346085776, 14015.509457169052, 18983.71524427135, 19682.606347873105, 19716.309929152412, 19740.11169497376, 1959.4317647882096, 2069.513664288891, 2109.4620871677625, 2157.072458842697, 2179.967300490494, 9544.284178686627, 9953.054459826304, 11757.529698812037, 12154.635360939097, 12617.242965422012, 1810.1944634637591, 1838.6782313095289, 1855.4804654696572, 1869.12151288894, 1915.329634627883, 51335.48664513382, 52235.73882130603, 54604.72697636526, 54680.17979730347, 54737.452625473634, 10163.237757168094, 10187.032231937954, 10200.897991019994, 10206.336588121749, 10265.948670256601, 13089.738205236032, 13189.934050329686, 13209.735805284034, 13232.272225027524, 13268.0, 6847.349501797321, 6987.091678081817, 7000.299970002959, 7015.3686168244085, 7065.540739851893, 6531.673416329165, 6556.98366753154, 6576.0, 6597.967010164918, 6598.10925525048, 4308.202982448257, 4356.302991521405, 4369.366441865912, 4422.29243321067, 4465.37484752135, 1709.2991873332123, 1772.4020238915023, 1781.5457058450013, 1823.2615790604825, 1832.954176145607, 906.6554709210458, 907.1654078248027, 930.8417569013284, 1034.2191645307744, 1047.177965297238, 14523.854761452461, 15197.924010379877, 15973.920130399274, 16111.033337999757, 16456.753148702777, 890.8129292848574, 913.9680111196076, 923.0584803500392, 998.9250806189419, 1017.013496907998, 9080.31897607682, 9449.527523623792, 9493.335466517416, 9499.905000949902, 9606.327557070937, 477575.0, 487814.0, 494312.0, 495475.7940733841, 516212.0, 39972.60027399747, 51124.48875511272, 54994.450055499736, 68304.65847670729, 73203.26796731964, 1102.1733699725205, 1110.650145204258, 1117.0728295514702, 1118.972025699364, 1121.6186496591035, 13762.24307663088, 14622.0, 14734.336954837272, 14749.557513274618, 14849.40602375893, 30095.849520752257, 32521.349573007934, 32908.01275961725, 32932.83533582317, 33225.66774332226, 39966.80016599898, 40018.799906000284, 40824.79587602162, 41301.38047929223, 42208.15583688371, 7174.641267936687, 7385.48301618903, 7394.223606521237, 7429.8142546436775, 7512.774616761506, 10594.576216951236, 10775.407352595683, 11245.044171245536, 11338.263012904135, 11357.54569817198, 7479.326860582573, 8523.360747943805, 9289.953550232205, 9685.0, 9707.66023189185, 9690.75773105678, 9801.0, 9966.950165249418, 10199.330569016276, 10228.335158214692, 9704.175145112744, 10081.495925203857, 10189.165950129049, 10198.592056317664, 10385.428801415994, 7441.8139546511775, 7588.165301816685, 7605.505642133244, 7608.163102058658, 7628.427867909818, 8722.91277087221, 10203.438810865473, 10257.435841028517, 10402.427866467115, 10509.264351495322], "unit": "score", "name": "jquery.html", "value": 7947.615334793699}, {"lowerIsBetter": false, "replicates": [1435.856414358564, 1464.5313499680103, 1591.8089829220487, 1711.537884771111, 1739.4433781190023, 7663.540187588742, 7757.418193635472, 7819.2571705688015, 7915.089764677064, 8003.319717823977, 8001.3998950078685, 8026.398020148483, 8051.275385215329, 8088.757337279876, 8102.432829701923, 2279.920202792907, 2290.919817806377, 2294.5869743446174, 2295.621222498294, 2296.80566105625, 2307.861528308307, 2337.824663150262, 2338.251759436981, 2354.905803767856, 2360.716713994323, 2193.7696541863115, 2212.889355532225, 2257.0858802185057, 2259.378670865517, 2299.735530414007, 2261.208576998054, 2290.0, 2314.456102815837, 2319.3273950554317, 2326.9883650581723, 2333.9183128590416, 2343.4610039690965, 2349.2247558305717, 2355.211004313557, 2361.1263832381956, 7825.686972521093, 7871.0, 7883.0, 7890.250426209501, 7898.763037108896, 4476.9552304476865, 4580.3358513015755, 4587.8623641290815, 4598.0344127733215, 4599.195140850338, 3138.764592655537, 3145.748340132784, 3186.8406579670923, 3224.9677503224902, 3227.160938156073, 951.70497145885, 971.7667759737683, 983.2576404814391, 997.9251556133319, 1032.7005168501125, 10770.892291077067, 10826.891731082667, 10884.891151088466, 10897.291676041112, 10900.727481812939, 4021.4772079630047, 4097.836086556505, 4137.689673274516, 4154.252234597741, 4206.831726730897, 8815.735527934172, 8822.691205807765, 8893.777655558533, 8904.376693631513, 8920.0, 4355.62977146946, 4391.923978625257, 4417.403650507141, 4430.490493593278, 4442.355858400579, 3965.3457179565626, 3975.6819454443576, 4011.5186177658866, 4015.1166743316426, 4016.0, 3392.796432214075, 3395.286989732184, 3400.6599340065795, 3412.7099196568074, 3412.897613071612, 1017.2523195451338, 1029.7539976628213, 1039.594558122333, 1041.1202533858877, 1044.2481413382352, 1106.363840791548, 1112.5438570186184, 1127.3292391027326, 1256.3529782162193, 1341.03445519226, 7250.2024777274455, 7279.308465695751, 7280.381167600707, 7392.889106663404, 7412.85174296511, 1094.414488248783, 1109.6116359274351, 1117.0895719988184, 1124.668222874254, 1128.8871112888646, 5686.3744988051285, 5818.156367326714, 5821.88356232873, 5826.504747096459, 5844.415558444121, 9331.860022099674, 9353.766155846022, 9557.808843823084, 9655.420674759536, 9769.951150244204, 9448.622055117856, 9492.572834222477, 9543.761405964906, 9600.279979001603, 9617.759556011015, 7098.29017098286, 7190.137183537904, 7249.746258880914, 7249.891251631229, 7258.818529536698, 7119.323664251888, 7127.607981561064, 7151.749688761077, 7159.463040271896, 7176.031235783103, 8080.63637136342, 8173.591320433836, 8232.34141268685, 8257.710980115668, 8259.669613215645, 8566.571671416528, 8703.47779133254, 8741.825163496567, 8743.868841967249, 8824.3381746368, 6591.0, 6858.245592984668, 6909.481788865754, 6910.032595436543, 6914.654267286716, 7642.388608911385, 7691.692332306869, 7695.307422332017, 7697.499662521918, 7698.384129269533, 7108.822279443055, 7250.564966102051, 7253.637318134178, 7331.963340183265, 7462.925370746223, 7140.85718285621, 7206.927930720835, 7217.989481472703, 7266.346028857217, 7268.927310726825, 7174.390176835028, 7304.707811687473, 7305.2329505403295, 7322.194558598443, 7324.937884006896, 6294.213223347082, 6632.403083722488, 6637.767678131436, 6670.966645166744, 6689.933100668931, 6528.477721782151, 6539.476841852736, 6583.0, 6592.736290548324, 6621.337866213533], "unit": "score", "name": "mootools.html", "value": 4488.590911312612}, {"lowerIsBetter": false, "replicates": [340.0749960108505, 343.7370411635098, 344.8517137630821, 347.80870521213325, 347.9895603131906, 6052.576319657625, 6113.449789518942, 6167.229096362955, 6192.566520343572, 6196.225471816023, 5942.049272116451, 6101.908471372933, 6110.297315808683, 6167.167432396636, 6208.844778880519, 4735.786889589959, 4745.525447455261, 4748.857534273978, 4750.809967601292, 4767.928481072787, 4721.527847215269, 4749.216379297412, 4755.2153894607345, 4758.476567577581, 4766.261229509431, 4517.209488339544, 4626.282926146453, 4632.0, 4639.744814035227, 4711.175544279755, 4606.124836281113, 4619.353290539327, 4626.884327891796, 4629.560191781792, 4659.510751371091, 4012.0, 4085.2646523625735, 4087.816048277805, 4096.242195193869, 4107.158032603339, 5878.177055212273, 5917.142014407887, 5928.40715928408, 5943.0, 5946.197263369433, 5319.893602127936, 5453.072977593819, 5461.5357694596005, 5463.3717122530625, 5470.042742520043, 6507.056476810836, 6529.510286728514, 6545.298222462194, 6552.574082684658, 6557.114789503404, 4476.597106260419, 4500.797464114123, 4503.829004458831, 4506.233940230136, 4519.231730605805, 6588.505862060365, 6809.659517024179, 6832.0, 6839.794806155774, 6904.13698287714, 4574.519675434031, 4600.470945841204, 4611.400517932647, 4612.146752850734, 4614.953850461452, 4674.789634466457, 4675.0883577702025, 4677.859664210011, 4679.883002924886, 4683.367745354333, 5428.864278393072, 5445.455454454523, 5446.210299506629, 5448.509634132868, 5452.863678407992, 6533.085368048477, 6627.1716035495565, 6647.567908085959, 6657.966710166418, 6659.300773418819, 1611.1621956582512, 1611.3312975115196, 1624.5207663739225, 1626.5039163055146, 1638.475687779899, 1096.2928910852456, 1097.2757979733337, 1098.220263612828, 1102.250469680625, 1111.8992197724194, 6155.753769849245, 6166.475849552839, 6172.598781079216, 6182.505399568024, 6196.349383314777, 6654.268030516736, 6666.500012499082, 6678.09845670838, 6712.697928593225, 6713.160854893138, 6015.54883383748, 6133.172021777093, 6135.294441139237, 6143.293521245114, 6165.0, 3636.745427820027, 3637.7635453695425, 3647.7993710345654, 3648.1426864686778, 3652.196516766307, 7034.472414568825, 7039.92960070403, 7047.54190977595, 7052.33002864727, 7066.081409416845, 6676.83307917306, 6810.284920083419, 6818.897716534157, 6832.555883867532, 6849.0, 6994.475414344046, 7022.92977070233, 7025.683844227022, 7026.824329391704, 7043.929560704328, 6680.432163266177, 6681.76613818514, 6685.164354455693, 6720.193576770624, 6733.192016957996, 6622.403983641495, 6662.700178492077, 6664.933350666432, 6666.666666666551, 6669.566478178903, 7008.579485230903, 7026.086608741035, 7029.26192749754, 7033.894491582528, 7039.648017598997, 4609.400777898852, 4619.076184762994, 4621.838235661736, 4624.884377890445, 4628.421447319085, 6460.547761656639, 6546.967265163644, 6723.2940541244425, 6724.831879203059, 6728.764493242713, 6686.13080299558, 6703.229128650072, 6727.26000139994, 6741.966290168518, 6747.831304217434, 6651.201855777338, 6666.133402657818, 6669.433098186514, 6677.998300255001, 6681.432078273401, 6451.645159516272, 6532.869342613216, 6562.278149403657, 6563.803085907431, 6568.540202185801, 6616.305287944889, 6661.3338666132995, 6711.731530738716, 6714.362135597111, 6726.932730672631, 6489.156409666713, 6541.2477565078725, 6543.80368588924, 6551.377619126175, 6557.245916719447], "unit": "score", "name": "prototype.html", "value": 4929.061775137208}, {"lowerIsBetter": false, "replicates": [807.4993504027502, 822.8107535266888, 844.3878188313473, 854.7521218846534, 883.1345281624004, 11804.7639047219, 12108.939455302721, 12113.27320360778, 12122.45448954797, 12140.15018948674, 12253.264804111759, 12434.626961191156, 12487.43806528706, 12533.2480051197, 12533.68665783356, 770.6955752477768, 776.6194564663302, 778.1518145221708, 778.7391223939959, 780.169119887321, 773.2576726342718, 776.2896949291392, 777.7316825695126, 781.3866115099648, 785.1520358013361, 805.0580820440099, 809.2918696140877, 809.7854068671807, 811.0429692962302, 811.4968719393984, 800.8478389106081, 800.9599520024004, 805.2028491793142, 806.9757907262791, 807.0476837331976, 597.4175179200288, 597.9910301345483, 598.530153829242, 599.4934280532987, 599.9130126131687, 12031.639050828402, 12049.518019279218, 12139.210951288138, 12142.332171730552, 12159.878401216052, 9459.432434053979, 9516.666916657883, 9573.712788616353, 9678.467684277362, 9786.510674466248, 11417.372044537547, 11434.256773309708, 11452.541898324058, 11689.590864319707, 12105.87894121065, 4180.93529291894, 4229.217594744951, 4290.506591741927, 4304.397384366192, 4314.503832059322, 43991.0, 44395.77802111001, 44525.332120018225, 44645.33032004523, 44707.329390059174, 9069.0, 9781.90218097824, 9794.706158815246, 9824.361416507903, 10104.938981406847, 16810.495685129466, 16854.241559129867, 16858.578535536464, 16898.915505422396, 16907.32370705158, 7314.27201821576, 7359.852802944019, 7437.776866694008, 7492.662830172655, 7551.509151905108, 4328.718633288826, 4373.650107991353, 4383.408239887574, 4396.208682437128, 4411.338299255138, 2865.9283517912218, 2866.913992580226, 2868.641419822522, 2879.265787224286, 2879.640044994376, 518.9455107213688, 519.9766010529535, 531.0255680825728, 532.6404676843115, 538.8087229033715, 564.9745761440745, 658.2068607328158, 668.669008840627, 685.3112621815044, 685.5715178013742, 8372.41393102477, 8413.200745929127, 8494.447860889146, 8560.828783424296, 8623.870641940375, 639.8400399900025, 640.9359064093553, 641.4066988036049, 650.1061041068531, 653.0726368556661, 3868.4390763339156, 3943.4479172915817, 3951.8221680024467, 3999.1201935574127, 4051.959480405217, 52576.21135682968, 54912.45087549153, 54971.175432368545, 55232.72383638137, 55797.0, 48427.75786121047, 48891.0, 48932.7553362238, 52428.0, 54070.0, 44652.77673611611, 44793.32810007853, 44796.10407791891, 45000.54999449963, 45428.54571454309, 8810.427322224035, 8860.246879015098, 8866.601002954754, 9020.413673111227, 9503.857442138235, 32330.191745206557, 32768.50847237246, 33228.1692957678, 35268.64731352653, 35334.823325883204, 37684.0, 38393.80803095967, 38604.80697596494, 41637.0, 41765.0, 10524.158067354747, 10560.0, 11215.60745373908, 11232.4383780809, 11391.658250252505, 11995.040396768412, 12005.519779208735, 12052.51789928393, 12492.625221243377, 12671.239725616493, 11102.333859968428, 11288.492017859051, 11389.658310250707, 11626.941865290619, 12070.577529786766, 11241.775164496828, 11450.312981221154, 11574.6527604172, 11677.824832627688, 11749.118816088998, 10907.127429805756, 11022.669319920415, 11153.330800152016, 11582.073434125417, 11591.304521728724, 9024.643875352569, 9152.908470915472, 9258.120478554527, 9534.570944307661, 9583.520823958914, 8606.268467180109, 8743.0, 9195.908040919772, 9216.631334746804, 9218.0], "unit": "score", "name": "yui.html", "value": 6129.572417619257}], "name": "dromaeo_css", "value": 6843.690509330256}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 110.0, 112.0, 124.0, 111.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 153.0, 174.0, 125.0, 158.0, 156.0, 131.0, 171.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 161.0, 160.0, 163.0, 163.0, 165.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 73.0, 72.0, 71.0, 138.0, 75.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 139.0, 97.0, 97.0, 95.0, 151.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 57.0, 60.0, 57.0, 60.0, 60.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 85.0, 88.0, 86.0, 85.0, 93.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [128.0, 117.0, 122.0, 123.0, 135.0, 124.0, 117.0, 122.0, 120.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 151.0, 153.0, 150.0, 149.0, 151.0, 157.0, 146.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [77.0, 68.0, 70.0, 69.0, 71.0, 68.0, 67.0, 68.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1521.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "Richards", "value": 211.84730199999996}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1049.3179433368311], "unit": "score", "name": "RayTrace", "value": 705.2095169999998}, {"lowerIsBetter": false, "replicates": [726.2164124909223], "unit": "score", "name": "Earley", "value": 917.719551}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [41265.30612244898], "unit": "score", "name": "RegExp", "value": 22.076293273986163}, {"lowerIsBetter": false, "replicates": [1726.3339070567986], "unit": "score", "name": "Splay", "value": 47.204657028913246}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18318.56575374201}]} 07:11:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "18318.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1521.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6843.69"}}} 07:11:28 INFO - Return code: 0 07:11:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:28 INFO - # TBPL SUCCESS # 07:11:28 INFO - Running post-action listener: _resource_record_post_action 07:11:28 INFO - Running post-run listener: _resource_record_post_run 07:11:29 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562929664; Read time: 20; Write time: 467704 07:11:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239575040; Read time: 0; Write time: 250992 07:11:29 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323354624; Read time: 20; Write time: 216712 07:11:29 INFO - Running post-run listener: _upload_blobber_files 07:11:29 INFO - Blob upload gear active. 07:11:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:11:29 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:11:29 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'] 07:11:29 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 07:11:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:31 INFO - (blobuploader) - INFO - Done attempting. 07:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:11:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:32 INFO - (blobuploader) - INFO - Done attempting. 07:11:32 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:32 INFO - Return code: 0 07:11:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:11:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4150f497bcd1cdf9f464b6aa243a50e4dffa0af3406985a1123b4a9c4c84c65c4b47a3a069a2f563a631fa10d4517f24431f4766b172a36d041268dd5c05a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afca70024a3b48ce890380548a9dbc81596afdae05fc179b7fc30d439f651a1603909cc6cbc810e34e8ad495405a18f3321f6842b7b7920c4c47fca2b5dc40d8"} 07:11:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:11:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:11:32 INFO - Contents: 07:11:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4150f497bcd1cdf9f464b6aa243a50e4dffa0af3406985a1123b4a9c4c84c65c4b47a3a069a2f563a631fa10d4517f24431f4766b172a36d041268dd5c05a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afca70024a3b48ce890380548a9dbc81596afdae05fc179b7fc30d439f651a1603909cc6cbc810e34e8ad495405a18f3321f6842b7b7920c4c47fca2b5dc40d8"} 07:11:32 INFO - Copying logs to upload dir... 07:11:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.972982 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-08 07:11:31.889952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:31.897214) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4150f497bcd1cdf9f464b6aa243a50e4dffa0af3406985a1123b4a9c4c84c65c4b47a3a069a2f563a631fa10d4517f24431f4766b172a36d041268dd5c05a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afca70024a3b48ce890380548a9dbc81596afdae05fc179b7fc30d439f651a1603909cc6cbc810e34e8ad495405a18f3321f6842b7b7920c4c47fca2b5dc40d8"} build_url:https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/XyQ7y7Q6Rw2k_eA7Xqma4A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4150f497bcd1cdf9f464b6aa243a50e4dffa0af3406985a1123b4a9c4c84c65c4b47a3a069a2f563a631fa10d4517f24431f4766b172a36d041268dd5c05a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afca70024a3b48ce890380548a9dbc81596afdae05fc179b7fc30d439f651a1603909cc6cbc810e34e8ad495405a18f3321f6842b7b7920c4c47fca2b5dc40d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:31.922286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:31.922603) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452264625.960497-1923159551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 07:11:31.974296) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 07:11:31.974605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 07:11:31.975465) ========= ========= Total master_lag: 0.20 =========