builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1452783213.41 results: success (0) buildid: 20160114043014 builduid: ed1e58ad09ca4b1682dca9a9a02510aa revision: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.407446) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.408091) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.408416) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.434648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.434954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.452186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.452591) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.504672) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.505121) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.505643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.505944) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 06:53:33-- 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% 84.0M=0s 2016-01-14 06:53:33 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158263 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.698400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.698729) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014542 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:33.751391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 06:53:33.751780) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 --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 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 --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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 06:53:33,994 truncating revision to first 12 chars 2016-01-14 06:53:33,995 Setting DEBUG logging. 2016-01-14 06:53:33,995 attempt 1/10 2016-01-14 06:53:33,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fa2ab99f52f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 06:53:35,063 unpacking tar archive at: mozilla-central-6fa2ab99f52f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.379710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 06:53:35.150639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:35.151001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:35.161909) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:35.162333) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 06:53:35.162858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-14 06:53:35.163199) ========= /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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:35 INFO - MultiFileLogger online at 20160114 06:53:35 in /builds/slave/test-pgo 06:53:35 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:53:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:53:35 INFO - {'append_to_log': False, 06:53:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:53:35 INFO - 'blob_upload_branch': 'Firefox', 06:53:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:53:35 INFO - 'branch': 'Firefox', 06:53:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:35 INFO - 'config_files': ('talos/linux_config.py',), 06:53:35 INFO - 'default_actions': ('clobber', 06:53:35 INFO - 'read-buildbot-config', 06:53:35 INFO - 'download-and-extract', 06:53:35 INFO - 'populate-webroot', 06:53:35 INFO - 'create-virtualenv', 06:53:35 INFO - 'install', 06:53:35 INFO - 'run-tests'), 06:53:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:35 INFO - 'download_minidump_stackwalk': True, 06:53:35 INFO - 'download_symbols': 'ondemand', 06:53:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:35 INFO - 'installer_path': 'installer.exe', 06:53:35 INFO - 'log_level': 'info', 06:53:35 INFO - 'log_name': 'talos', 06:53:35 INFO - 'log_to_console': True, 06:53:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:35 INFO - 'opt_config_files': (), 06:53:35 INFO - 'pip_index': False, 06:53:35 INFO - 'sps_profile': False, 06:53:35 INFO - 'sps_profile_interval': 0, 06:53:35 INFO - 'suite': 'dromaeojs-e10s', 06:53:35 INFO - 'system_bits': '32', 06:53:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:35 INFO - 'title': 'talos-linux64-ix-047', 06:53:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:35 INFO - 'use_talos_json': True, 06:53:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:53:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:35 INFO - 'work_dir': 'build'} 06:53:35 INFO - ##### 06:53:35 INFO - ##### Running clobber step. 06:53:35 INFO - ##### 06:53:35 INFO - Running pre-action listener: _resource_record_pre_action 06:53:35 INFO - Running main action method: clobber 06:53:35 INFO - rmtree: /builds/slave/test-pgo/build 06:53:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:53:35 INFO - Running post-action listener: _resource_record_post_action 06:53:35 INFO - ##### 06:53:35 INFO - ##### Running read-buildbot-config step. 06:53:35 INFO - ##### 06:53:35 INFO - Running pre-action listener: _resource_record_pre_action 06:53:35 INFO - Running main action method: read_buildbot_config 06:53:35 INFO - Using buildbot properties: 06:53:35 INFO - { 06:53:35 INFO - "project": "", 06:53:35 INFO - "product": "firefox", 06:53:35 INFO - "script_repo_revision": "production", 06:53:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:53:35 INFO - "repository": "", 06:53:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:53:35 INFO - "buildid": "20160114043014", 06:53:35 INFO - "pgo_build": "True", 06:53:35 INFO - "basedir": "/builds/slave/test-pgo", 06:53:35 INFO - "buildnumber": 299, 06:53:35 INFO - "slavename": "talos-linux64-ix-047", 06:53:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:53:35 INFO - "platform": "ubuntu64_hw", 06:53:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:53:35 INFO - "branch": "mozilla-central", 06:53:35 INFO - "repo_path": "mozilla-central", 06:53:35 INFO - "revision": "6fa2ab99f52feb1b6ead5581b8f5d398546a55a5", 06:53:35 INFO - "stage_platform": "linux64-pgo", 06:53:35 INFO - "builduid": "ed1e58ad09ca4b1682dca9a9a02510aa", 06:53:35 INFO - "slavebuilddir": "test" 06:53:35 INFO - } 06:53:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:53:35 INFO - Running post-action listener: _resource_record_post_action 06:53:35 INFO - ##### 06:53:35 INFO - ##### Running download-and-extract step. 06:53:35 INFO - ##### 06:53:35 INFO - Running pre-action listener: _resource_record_pre_action 06:53:35 INFO - Running main action method: download_and_extract 06:53:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:53: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:53:35 INFO - https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/test_packages.json 06:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/test_packages.json 06:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:53:36 INFO - Downloaded 1448 bytes. 06:53:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:53:36 INFO - Using the following test package requirements: 06:53:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:36 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:53:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'jsshell-linux-x86_64.zip'], 06:53:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:53:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:53:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:36 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:53:36 INFO - https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:39 INFO - Downloaded 24030757 bytes. 06:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:53:40 INFO - Return code: 0 06:53:40 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:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:40 INFO - https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:43 INFO - Downloaded 24030757 bytes. 06:53:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:53:44 INFO - Return code: 0 06:53:44 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:53:44 INFO - https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:46 INFO - Downloaded 11132144 bytes. 06:53:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:53:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:53:46 INFO - Return code: 0 06:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:46 INFO - https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z2UYw1vNSHuykaEY5xMedw/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:53:55 INFO - Downloaded 55872772 bytes. 06:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:55 INFO - mkdir: /builds/slave/test-pgo/properties 06:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:53:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:53:55 INFO - Contents: 06:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:55 INFO - Running post-action listener: _resource_record_post_action 06:53:55 INFO - Running post-action listener: set_extra_try_arguments 06:53:55 INFO - ##### 06:53:55 INFO - ##### Running populate-webroot step. 06:53:55 INFO - ##### 06:53:55 INFO - Running pre-action listener: _resource_record_pre_action 06:53:55 INFO - Running main action method: populate_webroot 06:53:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:53:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:53:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:53:55 INFO - '--tppagecycles', 06:53:55 INFO - '7'], 06:53:55 INFO - 'tests': ['tsvgm']}}, 06:53:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:53:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:53:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'tests': ['damp', 'tps']}, 06:53:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['damp', 'tps']}, 06:53:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:53:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:53:55 INFO - 'other': {'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'other_l64': {'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'other_nol64': {'tests': ['a11yr', 06:53:55 INFO - 'ts_paint', 06:53:55 INFO - 'tpaint', 06:53:55 INFO - 'sessionrestore', 06:53:55 INFO - 'sessionrestore_no_auto_restore']}, 06:53:55 INFO - 'svgr': {'tests': ['tsvgx', 06:53:55 INFO - 'tsvgr_opacity', 06:53:55 INFO - 'tart', 06:53:55 INFO - 'tscrollx', 06:53:55 INFO - 'cart']}, 06:53:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['tsvgx', 06:53:55 INFO - 'tsvgr_opacity', 06:53:55 INFO - 'tart', 06:53:55 INFO - 'tscrollx', 06:53:55 INFO - 'cart']}, 06:53:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'tests': ['tp5o']}, 06:53:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'talos_options': ['--e10s'], 06:53:55 INFO - 'tests': ['tp5o']}, 06:53:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'talos_options': ['--xperf_path', 06:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:55 INFO - 'tests': ['tp5n']}, 06:53:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:55 INFO - 'talos_options': ['--e10s', 06:53:55 INFO - '--xperf_path', 06:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:55 INFO - 'tests': ['tp5n']}}, 06:53:55 INFO - 'talos.zip': {'path': '', 06:53:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:53:55 INFO - Running post-action listener: _resource_record_post_action 06:53:55 INFO - ##### 06:53:55 INFO - ##### Running create-virtualenv step. 06:53:55 INFO - ##### 06:53:55 INFO - Running pre-action listener: _resource_record_pre_action 06:53:55 INFO - Running main action method: create_virtualenv 06:53:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:53:55 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:53:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:53:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:53:55 INFO - Using real prefix '/usr' 06:53:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:53:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:57 INFO - Installing pip.................done. 06:53:57 INFO - Return code: 0 06:53:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:57 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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:53:57 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:53:57 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:53:57 INFO - Using env: {'DISPLAY': ':0', 06:53:57 INFO - 'HOME': '/home/cltbld', 06:53:57 INFO - 'LANG': 'en_US.UTF-8', 06:53:57 INFO - 'LANGUAGE': 'en_US:en', 06:53:57 INFO - 'LOGNAME': 'cltbld', 06:53:57 INFO - 'MAIL': '/var/mail/cltbld', 06:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:57 INFO - 'MOZ_NO_REMOTE': '1', 06:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:57 INFO - 'NO_EM_RESTART': '1', 06:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:57 INFO - 'SHELL': '/bin/bash', 06:53:57 INFO - 'SHLVL': '1', 06:53:57 INFO - 'TERM': 'linux', 06:53:57 INFO - 'TMOUT': '86400', 06:53:57 INFO - 'USER': 'cltbld', 06:53:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:57 INFO - '_': '/tools/buildbot/bin/python'} 06:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:58 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:53:58 INFO - Cleaning up... 06:53:58 INFO - Return code: 0 06:53:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:53:58 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:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 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:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:53:58 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:53:58 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:53:58 INFO - Using env: {'DISPLAY': ':0', 06:53:58 INFO - 'HOME': '/home/cltbld', 06:53:58 INFO - 'LANG': 'en_US.UTF-8', 06:53:58 INFO - 'LANGUAGE': 'en_US:en', 06:53:58 INFO - 'LOGNAME': 'cltbld', 06:53:58 INFO - 'MAIL': '/var/mail/cltbld', 06:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:58 INFO - 'MOZ_NO_REMOTE': '1', 06:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:58 INFO - 'NO_EM_RESTART': '1', 06:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:58 INFO - 'SHELL': '/bin/bash', 06:53:58 INFO - 'SHLVL': '1', 06:53:58 INFO - 'TERM': 'linux', 06:53:58 INFO - 'TMOUT': '86400', 06:53:58 INFO - 'USER': 'cltbld', 06:53:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:58 INFO - '_': '/tools/buildbot/bin/python'} 06:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:58 INFO - Downloading/unpacking psutil>=0.7.1 06:53: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:53: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:53: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:53: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:53: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:53: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:54:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:54:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:00 INFO - Installing collected packages: psutil 06:54:00 INFO - Running setup.py install for psutil 06:54:00 INFO - building 'psutil._psutil_linux' extension 06:54:00 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:54:00 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:54:00 INFO - building 'psutil._psutil_posix' extension 06:54:00 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:54:00 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:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:00 INFO - Successfully installed psutil 06:54:00 INFO - Cleaning up... 06:54:00 INFO - Return code: 0 06:54:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:00 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:54:00 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:54:00 INFO - Using env: {'DISPLAY': ':0', 06:54:00 INFO - 'HOME': '/home/cltbld', 06:54:00 INFO - 'LANG': 'en_US.UTF-8', 06:54:00 INFO - 'LANGUAGE': 'en_US:en', 06:54:00 INFO - 'LOGNAME': 'cltbld', 06:54:00 INFO - 'MAIL': '/var/mail/cltbld', 06:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:00 INFO - 'MOZ_NO_REMOTE': '1', 06:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:00 INFO - 'NO_EM_RESTART': '1', 06:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:00 INFO - 'SHELL': '/bin/bash', 06:54:00 INFO - 'SHLVL': '1', 06:54:00 INFO - 'TERM': 'linux', 06:54:00 INFO - 'TMOUT': '86400', 06:54:00 INFO - 'USER': 'cltbld', 06:54:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:00 INFO - '_': '/tools/buildbot/bin/python'} 06:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:00 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:54:00 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:54:00 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:54:00 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:54:00 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:54:00 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:54:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:02 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:54:02 INFO - Installing collected packages: mozsystemmonitor 06:54:02 INFO - Running setup.py install for mozsystemmonitor 06:54:02 INFO - Successfully installed mozsystemmonitor 06:54:02 INFO - Cleaning up... 06:54:02 INFO - Return code: 0 06:54:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:54:02 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:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:02 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:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:02 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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:02 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:54:02 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:54:02 INFO - Using env: {'DISPLAY': ':0', 06:54:02 INFO - 'HOME': '/home/cltbld', 06:54:02 INFO - 'LANG': 'en_US.UTF-8', 06:54:02 INFO - 'LANGUAGE': 'en_US:en', 06:54:02 INFO - 'LOGNAME': 'cltbld', 06:54:02 INFO - 'MAIL': '/var/mail/cltbld', 06:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:02 INFO - 'MOZ_NO_REMOTE': '1', 06:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:02 INFO - 'NO_EM_RESTART': '1', 06:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:02 INFO - 'SHELL': '/bin/bash', 06:54:02 INFO - 'SHLVL': '1', 06:54:02 INFO - 'TERM': 'linux', 06:54:02 INFO - 'TMOUT': '86400', 06:54:02 INFO - 'USER': 'cltbld', 06:54:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:02 INFO - '_': '/tools/buildbot/bin/python'} 06:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:54:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:05 INFO - Downloading docopt-0.6.1.tar.gz 06:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:05 INFO - Running setup.py install for blobuploader 06:54:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:54:05 INFO - Running setup.py install for requests 06:54:05 INFO - Running setup.py install for docopt 06:54:05 INFO - Successfully installed blobuploader requests docopt 06:54:05 INFO - Cleaning up... 06:54:06 INFO - Return code: 0 06:54:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:06 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:54:06 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:54:06 INFO - Using env: {'DISPLAY': ':0', 06:54:06 INFO - 'HOME': '/home/cltbld', 06:54:06 INFO - 'LANG': 'en_US.UTF-8', 06:54:06 INFO - 'LANGUAGE': 'en_US:en', 06:54:06 INFO - 'LOGNAME': 'cltbld', 06:54:06 INFO - 'MAIL': '/var/mail/cltbld', 06:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:06 INFO - 'MOZ_NO_REMOTE': '1', 06:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:06 INFO - 'NO_EM_RESTART': '1', 06:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:06 INFO - 'SHELL': '/bin/bash', 06:54:06 INFO - 'SHLVL': '1', 06:54:06 INFO - 'TERM': 'linux', 06:54:06 INFO - 'TMOUT': '86400', 06:54:06 INFO - 'USER': 'cltbld', 06:54:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:06 INFO - '_': '/tools/buildbot/bin/python'} 06:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:06 INFO - Running setup.py (path:/tmp/pip-qjuzA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:06 INFO - Running setup.py (path:/tmp/pip-hA0A4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:06 INFO - Running setup.py (path:/tmp/pip-a5UTlB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:06 INFO - Running setup.py (path:/tmp/pip-9ziFdG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:06 INFO - Running setup.py (path:/tmp/pip-c39p6N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:06 INFO - Running setup.py (path:/tmp/pip-fM98JW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:06 INFO - Running setup.py (path:/tmp/pip-c789Pe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:06 INFO - Running setup.py (path:/tmp/pip-oZSh37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:06 INFO - Running setup.py (path:/tmp/pip-Esg18v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:06 INFO - Running setup.py (path:/tmp/pip-fjbCom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:06 INFO - Running setup.py (path:/tmp/pip-EmdSfc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:07 INFO - Running setup.py (path:/tmp/pip-pr6IjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:07 INFO - Running setup.py (path:/tmp/pip-RUjCVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:07 INFO - Running setup.py (path:/tmp/pip-oIMRrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:07 INFO - Running setup.py (path:/tmp/pip-pIMiTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:07 INFO - Running setup.py (path:/tmp/pip-9fKq4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:07 INFO - Running setup.py (path:/tmp/pip-2TphIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:07 INFO - Running setup.py install for manifestparser 06:54:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:54:07 INFO - Running setup.py install for mozcrash 06:54:07 INFO - Running setup.py install for mozdebug 06:54:07 INFO - Running setup.py install for mozdevice 06:54:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:54:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:54:07 INFO - Running setup.py install for mozfile 06:54:07 INFO - Running setup.py install for mozhttpd 06:54:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozinfo 06:54:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozInstall 06:54:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozleak 06:54:08 INFO - Running setup.py install for mozlog 06:54:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for moznetwork 06:54:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozprocess 06:54:08 INFO - Running setup.py install for mozprofile 06:54:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozrunner 06:54:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozscreenshot 06:54:09 INFO - Running setup.py install for moztest 06:54:09 INFO - Running setup.py install for mozversion 06:54:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:09 INFO - Cleaning up... 06:54:09 INFO - Return code: 0 06:54:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:09 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:54:09 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:54:09 INFO - Using env: {'DISPLAY': ':0', 06:54:09 INFO - 'HOME': '/home/cltbld', 06:54:09 INFO - 'LANG': 'en_US.UTF-8', 06:54:09 INFO - 'LANGUAGE': 'en_US:en', 06:54:09 INFO - 'LOGNAME': 'cltbld', 06:54:09 INFO - 'MAIL': '/var/mail/cltbld', 06:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:09 INFO - 'MOZ_NO_REMOTE': '1', 06:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:09 INFO - 'NO_EM_RESTART': '1', 06:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:09 INFO - 'SHELL': '/bin/bash', 06:54:09 INFO - 'SHLVL': '1', 06:54:09 INFO - 'TERM': 'linux', 06:54:09 INFO - 'TMOUT': '86400', 06:54:09 INFO - 'USER': 'cltbld', 06:54:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:09 INFO - '_': '/tools/buildbot/bin/python'} 06:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:09 INFO - Running setup.py (path:/tmp/pip-QBZ7Dz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:09 INFO - Running setup.py (path:/tmp/pip-LmRfZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:09 INFO - Running setup.py (path:/tmp/pip-jm0ijO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:09 INFO - Running setup.py (path:/tmp/pip-wKA9_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:09 INFO - Running setup.py (path:/tmp/pip-VdV0ki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:09 INFO - Running setup.py (path:/tmp/pip-LuL5B8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:09 INFO - Running setup.py (path:/tmp/pip-05GTK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:09 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:54:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:09 INFO - Running setup.py (path:/tmp/pip-uiNWM9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:10 INFO - Running setup.py (path:/tmp/pip-snJPsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:10 INFO - Running setup.py (path:/tmp/pip-EjpMyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:10 INFO - Running setup.py (path:/tmp/pip-OgRQH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:10 INFO - Running setup.py (path:/tmp/pip-e7KCF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:10 INFO - Running setup.py (path:/tmp/pip-w5hYy3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:10 INFO - Running setup.py (path:/tmp/pip-BjkUFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:10 INFO - Running setup.py (path:/tmp/pip-o3RGvx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:10 INFO - Running setup.py (path:/tmp/pip-zwyg2H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:10 INFO - Running setup.py (path:/tmp/pip-eNvQKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:10 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:54:10 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:54:10 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:54:10 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:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:12 INFO - Downloading blessings-1.5.1.tar.gz 06:54:12 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:54:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:12 INFO - Installing collected packages: blessings 06:54:12 INFO - Running setup.py install for blessings 06:54:12 INFO - Successfully installed blessings 06:54:12 INFO - Cleaning up... 06:54:12 INFO - Return code: 0 06:54:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:54:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:12 INFO - Reading from file tmpfile_stdout 06:54:12 INFO - Current package versions: 06:54:12 INFO - argparse == 1.2.1 06:54:12 INFO - blessings == 1.5.1 06:54:12 INFO - blobuploader == 1.2.4 06:54:12 INFO - docopt == 0.6.1 06:54:12 INFO - manifestparser == 1.1 06:54:12 INFO - mozInstall == 1.12 06:54:12 INFO - mozcrash == 0.16 06:54:12 INFO - mozdebug == 0.1 06:54:12 INFO - mozdevice == 0.48 06:54:12 INFO - mozfile == 1.2 06:54:12 INFO - mozhttpd == 0.7 06:54:12 INFO - mozinfo == 0.9 06:54:12 INFO - mozleak == 0.1 06:54:12 INFO - mozlog == 3.1 06:54:12 INFO - moznetwork == 0.27 06:54:12 INFO - mozprocess == 0.22 06:54:12 INFO - mozprofile == 0.28 06:54:12 INFO - mozrunner == 6.11 06:54:12 INFO - mozscreenshot == 0.1 06:54:12 INFO - mozsystemmonitor == 0.0 06:54:12 INFO - moztest == 0.7 06:54:12 INFO - mozversion == 1.4 06:54:12 INFO - psutil == 3.1.1 06:54:12 INFO - requests == 1.2.3 06:54:12 INFO - wsgiref == 0.1.2 06:54:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:12 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 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:12 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:54:12 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:54:12 INFO - Using env: {'DISPLAY': ':0', 06:54:12 INFO - 'HOME': '/home/cltbld', 06:54:12 INFO - 'LANG': 'en_US.UTF-8', 06:54:12 INFO - 'LANGUAGE': 'en_US:en', 06:54:12 INFO - 'LOGNAME': 'cltbld', 06:54:12 INFO - 'MAIL': '/var/mail/cltbld', 06:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:12 INFO - 'MOZ_NO_REMOTE': '1', 06:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:12 INFO - 'NO_EM_RESTART': '1', 06:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:12 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:12 INFO - 'SHELL': '/bin/bash', 06:54:12 INFO - 'SHLVL': '1', 06:54:12 INFO - 'TERM': 'linux', 06:54:12 INFO - 'TMOUT': '86400', 06:54:12 INFO - 'USER': 'cltbld', 06:54:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:12 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 INFO - Downloading/unpacking jsonschema 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:15 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:54:15 INFO - Downloading/unpacking functools32 (from jsonschema) 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:15 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:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:15 INFO - warning: no files found matching '*.txt' 06:54:15 INFO - no previously-included directories found matching 'build' 06:54:15 INFO - no previously-included directories found matching 'dist' 06:54:15 INFO - no previously-included directories found matching '.git*' 06:54:15 INFO - Installing collected packages: jsonschema, functools32 06:54:15 INFO - Running setup.py install for functools32 06:54:15 INFO - warning: no files found matching '*.txt' 06:54:15 INFO - no previously-included directories found matching 'build' 06:54:15 INFO - no previously-included directories found matching 'dist' 06:54:15 INFO - no previously-included directories found matching '.git*' 06:54:15 INFO - Successfully installed jsonschema functools32 06:54:15 INFO - Cleaning up... 06:54:15 INFO - Return code: 0 06:54:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:54: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:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d757e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, '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': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', '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:54:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:54:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:54:15 INFO - Using env: {'DISPLAY': ':0', 06:54:15 INFO - 'HOME': '/home/cltbld', 06:54:15 INFO - 'LANG': 'en_US.UTF-8', 06:54:15 INFO - 'LANGUAGE': 'en_US:en', 06:54:15 INFO - 'LOGNAME': 'cltbld', 06:54:15 INFO - 'MAIL': '/var/mail/cltbld', 06:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:15 INFO - 'MOZ_NO_REMOTE': '1', 06:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:15 INFO - 'NO_EM_RESTART': '1', 06:54:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:15 INFO - 'SHELL': '/bin/bash', 06:54:15 INFO - 'SHLVL': '1', 06:54:15 INFO - 'TERM': 'linux', 06:54:15 INFO - 'TMOUT': '86400', 06:54:15 INFO - 'USER': 'cltbld', 06:54:15 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:15 INFO - '_': '/tools/buildbot/bin/python'} 06:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:15 INFO - Downloading/unpacking flake8 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:54:17 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:54:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:54:17 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:54:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 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:54:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:54:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:18 INFO - no previously-included directories found matching 'docs/_build' 06:54:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:54:18 INFO - Running setup.py install for pep8 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:18 INFO - no previously-included directories found matching 'docs/_build' 06:54:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:54:18 INFO - Cleaning up... 06:54:18 INFO - Return code: 0 06:54:18 INFO - Running post-action listener: _resource_record_post_action 06:54:18 INFO - Running post-action listener: _start_resource_monitoring 06:54:18 INFO - Starting resource monitoring. 06:54:18 INFO - ##### 06:54:18 INFO - ##### Running install step. 06:54:18 INFO - ##### 06:54:18 INFO - Running pre-action listener: _resource_record_pre_action 06:54:18 INFO - Running main action method: install 06:54:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:18 INFO - Reading from file tmpfile_stdout 06:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:54:18 INFO - Reading from file tmpfile_stdout 06:54:18 INFO - Output received: 06:54:18 INFO - Usage: mozinstall [options] installer 06:54:18 INFO - Options: 06:54:18 INFO - -h, --help show this help message and exit 06:54:18 INFO - -d DEST, --destination=DEST 06:54:18 INFO - Directory to install application into. [default: 06:54:18 INFO - "/builds/slave/test-pgo"] 06:54:18 INFO - --app=APP Application being installed. [default: firefox] 06:54:18 INFO - mkdir: /builds/slave/test-pgo/build/application 06:54:18 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:54:18 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:54:34 INFO - Reading from file tmpfile_stdout 06:54:34 INFO - Output received: 06:54:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:54:34 INFO - Running post-action listener: _resource_record_post_action 06:54:34 INFO - ##### 06:54:34 INFO - ##### Running run-tests step. 06:54:34 INFO - ##### 06:54:34 INFO - Running pre-action listener: _resource_record_pre_action 06:54:34 INFO - Running main action method: run_tests 06:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:54:34 INFO - Python 2.7.3 06:54:34 INFO - Return code: 0 06:54:34 INFO - grabbing minidump binary from tooltool 06:54:34 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:54:34 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 0x215c840>, '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 0x20c96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:54:34 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:54:34 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:54:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:34 INFO - Return code: 0 06:54:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:54:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:54:35 INFO - Return code: 0 06:54:35 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/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:54:35 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/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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:54:35 INFO - Using env: {'DISPLAY': ':0', 06:54:35 INFO - 'HOME': '/home/cltbld', 06:54:35 INFO - 'LANG': 'en_US.UTF-8', 06:54:35 INFO - 'LANGUAGE': 'en_US:en', 06:54:35 INFO - 'LOGNAME': 'cltbld', 06:54:35 INFO - 'MAIL': '/var/mail/cltbld', 06:54:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:35 INFO - 'MOZ_NO_REMOTE': '1', 06:54:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:35 INFO - 'NO_EM_RESTART': '1', 06:54:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:35 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:54:35 INFO - 'SHELL': '/bin/bash', 06:54:35 INFO - 'SHLVL': '1', 06:54:35 INFO - 'TERM': 'linux', 06:54:35 INFO - 'TMOUT': '86400', 06:54:35 INFO - 'USER': 'cltbld', 06:54:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960', 06:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:35 INFO - '_': '/tools/buildbot/bin/python'} 06:54:35 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/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:54:35 INFO - mozversion application_buildid: 20160114043014 06:54:35 INFO - mozversion application_changeset: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 06:54:35 INFO - mozversion application_display_name: Nightly 06:54:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:35 INFO - mozversion application_name: Firefox 06:54:35 INFO - mozversion application_remotingname: firefox 06:54:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:54:35 INFO - mozversion application_vendor: Mozilla 06:54:35 INFO - mozversion application_version: 46.0a1 06:54:35 INFO - mozversion platform_buildid: 20160114043014 06:54:35 INFO - mozversion platform_changeset: 6fa2ab99f52feb1b6ead5581b8f5d398546a55a5 06:54:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:54:35 INFO - mozversion platform_version: 46.0a1 06:54:35 INFO - using testdate: 1452783275 06:54:35 INFO - actual date: 1452783275 06:54:35 INFO - starting webserver on 'localhost:49299' 06:54:35 INFO - SUITE-START | Running 3 tests 06:54:35 INFO - TEST-START | dromaeo_css 06:54:35 INFO - operating with platform_type : linux_ 06:54:35 INFO - Initialising browser for dromaeo_css test... 06:54:35 INFO - TEST-INFO | started process 23972 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpudk8MS/profile http://localhost:49299/getInfo.html) 06:54:39 INFO - PROCESS | 23972 | 06:54:39 INFO - PROCESS | 23972 | (process:24061): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:54:40 INFO - PROCESS | 23972 | __metrics Screen width/height:1600/1200 06:54:40 INFO - PROCESS | 23972 | colorDepth:24 06:54:40 INFO - PROCESS | 23972 | Browser inner width/height: 1024/697 06:54:40 INFO - PROCESS | 23972 | __metrics 06:54:40 INFO - PROCESS | 23972 | 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:54:41 INFO - TEST-INFO | 23972: exit 0 06:54:41 INFO - Browser initialized. 06:54:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:54:41 INFO - TEST-INFO | started process 24110 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpudk8MS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:42 INFO - PROCESS | 24110 | 06:54:42 INFO - PROCESS | 24110 | (process:24168): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:54:53 INFO - PROCESS | 24110 | RSS: Main: 150691840 06:54:53 INFO - PROCESS | 24110 | 06:55:42 INFO - PROCESS | 24110 | 1452783342819 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:57:51 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49299/tests/dromaeo/cssquery-ext.html) 06:57:52 INFO - PROCESS | 24110 | RSS: Main: 155787264 06:57:52 INFO - PROCESS | 24110 | 07:00:54 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-ext.html (next: http://localhost:49299/tests/dromaeo/cssquery-jquery.html) 07:00:55 INFO - PROCESS | 24110 | RSS: Main: 151429120 07:00:55 INFO - PROCESS | 24110 | 07:03:57 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49299/tests/dromaeo/cssquery-mootools.html) 07:03:57 INFO - PROCESS | 24110 | RSS: Main: 152862720 07:03:57 INFO - PROCESS | 24110 | 07:06:59 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49299/tests/dromaeo/cssquery-prototype.html) 07:07:00 INFO - PROCESS | 24110 | RSS: Main: 150515712 07:07:00 INFO - PROCESS | 24110 | 07:10:02 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49299/tests/dromaeo/cssquery-yui.html) 07:10:02 INFO - PROCESS | 24110 | RSS: Main: 150061056 07:10:02 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-yui.html (next: http://localhost:49299/tests/dromaeo/cssquery-dojo.html) 07:13:05 INFO - PROCESS | 24110 | RSS: Main: 153997312 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | __start_tp_report 07:13:05 INFO - PROCESS | 24110 | _x_x_mozilla_page_load 07:13:05 INFO - PROCESS | 24110 | _x_x_mozilla_page_load_details 07:13:05 INFO - PROCESS | 24110 | |i|pagename|runs| 07:13:05 INFO - PROCESS | 24110 | |0;dojo.html;3131.326764745579;3131.514615234638;3164.272217389999;3184.028871194285;3184.0607020928824;5243.580513558915;5306.628536002477;5307.12432448646;5323.547498462635;5334.413214546396;5185.910958698669;5201.673573238819;5320.856015956569;5386.730663466821;5417.404085550586;4908.214685650297;4944;5004.399472063357;5006.299118123466;5015.673981191229;4941.505849415048;4963.7021778693215;4970.801167953277;5008.449070602231;5026.321446604698;4816.277558366238;4847.854564363075;4866.221404575286;4933.679310844802;4974.353334066566;4856.854294371139;4862.854114376574;4891.070696567641;4897.216445368724;4897.853064408074;4860.878478038042;4865.051314993578;4865.221564549655;4875.414950205963;4888.682235654706;5094.1594636884865;5154.433012368637;5190.844274671728;5216.2958000669805;5295.285136506599;5761.279840019997;5790.305163380379;5798.1302804579655;5799.3040835100055;5818.2436283282905;5807.390224026459;5815.21494598228;5831.766729330821;5833.912491312592;5854.18041474194;5257.763400646942;5336.199570064521;5336.733163341817;5340.359156901197;5340.759665815087;5743.483086522233;5774.913376299359;5781.19063331134;5786.94213057864;5820.039693450533;5625.831225063254;5688.800891968844;5694.914576281359;5698.715064246771;5700.344460387026;5669.688167150846;5725.456081672318;5744.253247077853;5768.077107662753;5784.595078344475;5572.3870374258795;5651.2935883014625;5681.914771278434;5692.089265717465;5733.197352370671;5720.942790572124;5755.22304488897;5774.162746401748;5777.62445441045;5791.478766910998;4347.7173983690955;4366.104948485617;4413.492448368414;4494.4606647202545;4536.092781443725;3933.4099885017476;3941.3496773032703;3961.6632586230494;3987.202559488114;3993.821822562351;5337.359516857924;5359.812406565829;5372.516473517402;5373.570114390839;5403.621746477709;5644.774209031592;5721.313442386941;5746.5977381583725;5799.420057994167;5871.677057761779;5328.946710532922;5346.8395948121615;5363.141897296414;5363.678179309254;5379.139337706027;4880.585150262196;4889.315495830587;4893.314935908976;4899.2896030075435;4934.876628084255;5766.4233576642;5818.8254352369495;5987.730552125077;5997.070454079625;6014;5739.655620662774;5770.798022069207;5781.277340332458;5784.971075144597;5790.10253410722;5868.2664666916635;5892.292924849045;5952.255968003999;5970.164177015308;5976.521878249817;5597.692126933058;5647.661140331593;5675.914861277167;5718.714064296852;5768.221290125947;5798.652080875161;5806.796762113306;5812.3025236971835;5814.156947242542;5822.214001109796;5608.9158662619275;5626.212330273846;5656.2929633795775;5659.236003139524;5672.234248376416;5544.306961629796;5545.334559852843;5629.211910332639;5665.291838520185;5703.572232082527;5534.861628459321;5560.138178582326;5594.888102238014;5597.496225339739;5599.132134519156;5551.8889622208135;5640.125780504029;5713.771449141987;5737.311522617312;5741.368449470471;5419;5454.209139674805;5518.834434966958;5532.253145825423;5578.3584887738425 07:13:05 INFO - PROCESS | 24110 | |1;ext.html;529.6848375216747;537.8467136865993;558.3885645218485;560.1010378342762;568.6019786149697;36796.81601591995;37103.4434483483;37134.62865371349;37215.25569488609;37323.44014839776;39774.40338394926;40156;40182.799086004605;40196.196076078464;40232;8653.480791152535;8824.911750882506;8900.243479304267;8900.465972041666;8932.240759535447;8591.570421478933;8634.352423568225;8738.563071846382;8753.912460875374;8761.693340733076;8710.651573937035;8823.558822058903;8843.557822108902;8844.115588441136;8851.557422128868;8686.522241276727;8843.955780221058;8861.556922153899;8864.73405797827;8891.110888911122;8424.873626895602;8630.870536941951;8669.176428239307;8675.219230269306;8689.69586064491;39733.205335893406;40800.59199407998;41130.9717257068;41189.79405102985;41205.79397103025;3268.3953468608383;3308.553345298402;3334.8332583370734;3430.073880052397;3818.923621527582;29115.854420727974;29700.554491682644;29994.25014374636;30142.698573014426;30183.698163018307;3576.159602493412;3605.4591811228265;3669.1194113412857;3688.79711615861;3774.358359078963;276217;277492;277834;277900;278036.6098169516;56487.717561412755;56591;56612.716936415054;56687;56798.71600642053;58811.41188588145;59423.70288148532;65416.67291663607;65655.34344656588;66459.33540664532;14468.421263149567;14720.116792992454;14737.11577305365;14743.189124598035;14824.184669843262;10757.354558726345;10764.838527422095;10803.891961080288;10849.24055316136;10896.182786290901;19501.804981949997;19772.209111635373;19842.801571984382;19857.60284794296;20376.49058773513;7527.887081693779;7626.894100355528;7695.268949449794;7744.148143704188;7773.261540153676;913.8903331600251;934.6588495199203;951.5908159491485;1052.2686732720838;1086.8858769829053;27738.32408689315;29434.85282573616;29912.453773014327;29929.850350748107;30130;1032.4785983078648;1034.0641719244097;1038.8441733739849;1083.5124194112523;1091.5197313182334;15510.612234693997;15542.766858497132;15633.452829150925;15672.294746736425;16085.115318657587;409483;410194;413235;414030;415170;54902.725486372314;55070.44929550734;55346.44653553493;57142;57368.71315643479;1293.140061858872;1309.463120120746;1311.9409626566637;1316;1319.129374612751;30442;31222.375552489277;31415.685843141277;31615.36769264648;31884.362312754078;47653.28520072132;47773.76113119412;47829.28256076231;48773;49079.75460122676;306334;307125;309111;309291;309456;34077;45111.32333014942;45385.773071134434;45946.31080533728;47108.52891471041;44023.11953760843;44245;44632.77683611561;44986.77506612446;45057.09885802331;36540;36679.81660091683;38844.80577597094;39848.40227396534;43506;33648;34518.48222276718;34746.30507389788;34952;35155.12112197113;36117.458238125924;36482.63517364793;36534.26931461409;37222.44166337561;37398.00815934773;32832.1791955203;33867.830660846535;33952.320953581286;34541.82729086339;34786.478202826474;25871.17370516752;25896.741032589434;25904.611430828176;26025.349366265997;26195 07:13:05 INFO - PROCESS | 24110 | |2;jquery.html;360.8971443138705;363.4729642019073;365.2457674901328;365.8554870826022;367.3717942318635;15421.768673469893;16456.753148702777;16795.496135115965;17481.999999999985;17531.12344382779;10810.621628243012;10819.945900270508;10824.079953203967;12766.872331276685;14995.77506337403;4877.951220487803;5041.546260836524;5058.7976480940715;5084.745762711868;5288.788448462057;5202.947970520284;5205.453427390126;5206;5231.476852314776;5269.394019687727;5470.753816078266;5507.862303442426;5507.889842203153;5513.972430137864;5515.393306736276;5467.972660136714;5469.671819690811;5633.746481408326;5950.672713000783;5993.250843644544;5160.200168973815;5358.812441564565;5364.927014597096;5367.78528858849;5371.194320851864;12695.809562856564;12988;13020.153690010118;13050.608481745468;17177.312907483687;2083.1771450277056;2164.4588852786806;2166.2093335932427;2200.482886521666;2218.190360518415;8909.198172164537;9379.062093790566;12358.38208089601;12672.112952093357;12782.296973666445;1816.6275913437714;1827.7532533107992;1831.3590243414699;1832.6609577228255;1871.4759867237196;50768.492315077114;52238.73880630611;55359;58432.70783646097;59863;10188.388696678223;10346;10348.344264917578;10364.740881477872;10382.532786024647;12870.22778633285;13365.866341336656;13430.059895807395;13456.25990570528;13469.191848489121;7073.752418665322;7299.160596531467;7314.3782778463365;7368.705251789976;7378;6858.759943401957;6940.6529673516125;6948.652567371712;6995.510314278054;7014.719411223494;4375.890602734893;4412.867613971586;4494.775261236925;4512.842050528216;4529.501754806968;1674.5729838891248;1799.16338902411;1806.7018941874444;1858.4145994011842;1862.2923289150308;422.39808273210554;909.7543663210896;940.6848705683673;942.495764765847;948.5684013773716;10000.249981251436;10509.06401774825;10784.460776961121;10797.376801960372;10874.716309575078;789.759123467348;865.51629690495;873.3362644390309;947.3415975896824;1001.5392919257223;5871.32479764824;5925.34821169671;6107.450329470369;6132.601380910227;6155.630662160284;288595;288832;491020;596433;597157;72612;73663.63168184125;73971;74719.25280747232;76198.61900690461;496.3274762696494;505.4591587001873;505.94687557807373;507.16064912569755;509.1776780499467;10166.237532184969;10184.796304073729;10476.580936762444;10653.733656658645;14296.213708246147;30671.846640766653;31802.681973179973;31841.840790795897;32915.50626740553;34071.148221294665;37006.44490332701;37022.44466333061;37720.811395942845;38039.429408559445;38382.424263636625;6810;7194.784156475314;7290.453216008715;7435.51669141504;7740.806479838049;10128.84806727885;10452.268341216042;10883.183761218099;11031.724206894893;11051.447427628747;9164.95417522908;9281.814363712823;9368.39105458143;9450.905490945002;9621.807563848544;9494.28792840526;9518.571664275263;9590.904090959;9673.37123086997;9850.359726617748;9379.531023448664;9474.336796424184;9488.525573721425;9606.66376676813;9724.319297649097;7264.019357386685;7340.2292759261645;7381.818908974538;7430.219826918312;7436.96281518589;8668.349873759367;9210.447373157633;9350.81298374015;9363.314603371458;9415.199708024895 07:13:05 INFO - PROCESS | 24110 | |3;mootools.html;1454.8254209494862;1478.4086365453818;1624.3746157729279;1764.5235786337698;1799.9280028798848;7391.926080739191;7539.132999705035;7641.3504852087635;7701.306882380592;7712.344450721688;7725.92274077259;7740.109887362955;7832;7834.059912810457;7835;2302.3898666853256;2321.1643808229023;2331.1025255276754;2332.416895776056;2336.8013718833918;2333.195047708546;2337.929862104131;2369.052379048386;2370.0282884017556;2379.381360846175;2246.6854640350284;2302.4934514406805;2305.0318866076204;2311.0293676655847;2332.7433982261937;2320.11835502508;2333.1600623775425;2345.1440224318085;2346.378209774411;2358.3514533503253;2334.323046316566;2334.6264597664463;2349.3539276698875;2354.258408601302;2357.0218359380838;7644.617769111578;7663.961680191619;7685.154632990367;7697;7715.922840771576;4617.3304870793545;4714.457837348715;4738.2892566115015;4748.810047598092;4759.095771803346;3001.264690150905;3025.8184508929535;3102.7828052036366;3109.0361987783635;3155.8422078895965;1042.8904964978644;1045.8117538843005;1063.1760385701066;1072.4369705904385;1072.5763323487256;10365.118964887994;10506.264561480699;10518.631847885365;10549.314294570828;10558.208134389952;4086.9795651021554;4155.439015732837;4202.495700515958;4225.260579398593;4225.915481690349;8492.872606910902;8524.95737521321;8535.274501667427;8539.06070332263;8553.828923421497;4561.954380456219;4584.839530616412;4613.515580864028;4622.745748983838;4643.8374656886845;4208.978955105266;4230.598093181205;4259.87220383389;4266.274733295348;4269.4449721536;3504.982475087659;3565.858925143929;3573.1781690211396;3588.9102772430374;3602.4596310553625;1077.563586747353;1081.4646749858714;1094.2996482251365;1104.2380757277454;1112.0880877680386;1033.8397548380012;1060.3213943076437;1063.4416931111073;1190.5535424215918;1333.5932540575218;7173.5337203081635;7234.819129521804;7294.270572942663;7295.343419092307;7308.780736577911;1093.2074246171462;1117.541807858774;1125.8817824128512;1131;1148.9885101149048;5629.493345598834;5694.288213973254;5753.194552762617;5783.306003279633;5812.273465816773;9154.496502692282;9262.16640502358;9384.343095983351;9485.430874147572;9536.23710103204;9259.814803703888;9362;9373.109554592304;9386.389884657476;9417.152456278967;6883.27725588806;6925.6190909499455;7028.156621205386;7055.365017148379;7077.646117694095;6802.897956530557;6815.454763618998;6866.553674011173;6873.862522749617;6888;7811.570363630055;8009.359251259769;8116.59417029158;8128.83742325162;8213.58932053383;8015.799605009922;8262.628181731716;8287.254147126787;8346.290565301775;8415.5792210388;6426.260979987362;6497.350264973465;6688.3646053624825;6866.107406037183;6914.688839002157;7311.963440182765;7331.266873312626;7345.412367010519;7374.446916481178;7385.187629360658;6726.260111387645;6845.726170953106;6861.416779573792;6865.862682746417;6983.231844497;6857.736946807442;6964.303569642995;6974.128233970754;6999.160100787938;7120.252373500915;6683.264840867598;6780;6786.9660651698405;6812.795616131524;6824.965875170592;6249.906251406142;6252.374762523893;6256;6274.780382686767;6294.1188233648245;6433.903491447539;6447.129637499065;6607.834804129743;6614.570052946543;6615.206175259 07:13:05 INFO - PROCESS | 24110 | |4;prototype.html;340.91136304560814;348.1036331446524;351.7555299067146;353.38158223109576;353.5704119494814;6207.9689601552045;6282.623042617434;6314.652694101823;6400.5839620424695;6423.743050277989;6148.231471066117;6278.4035516625845;6286.779962701306;6301.464375528074;6326.746930122801;4838.661293709441;4845.079434907374;4845.466998630148;4853.150698627726;4856.271559266103;4846.006568653417;4851.781669824849;4860.027994401134;4866.951330486685;4868.367112275417;4730.290456431529;4814.229723244282;4826.251930950708;4831.323614693945;4850.248211527201;4773.80904763809;4791.401074865642;4810.230363141898;4825.710457372569;4826.565609095198;4213.178430206111;4214.777714462802;4225.7887105644595;4231.492220933477;4244.617984381421;5930.347661757203;5938.257717785277;5963;5982.04287314032;5991.430814072656;5581.748821303051;5596.104623260299;5600.775968961278;5636.210930469738;5636.774529018834;6642.036904648847;6646.335366463363;6661.2006559213205;6676.365745254193;6680.699368528428;4682.695624784412;4709;4713.622910167179;4715.717056976592;4720.976395118002;6902;7020.859582808315;7031.929680703179;7047.506674532785;7048.964755176191;4806.086843499724;4845.733484658307;4847.903041939141;4855.635827312895;4862.367892173995;4914.557689807934;4918.926216106761;4923.359963204761;4923.556879880828;4937.1113199624415;5551.3893471718075;5608.915866262009;5630.155476678531;5641.971790141023;5650.576206784508;6742.6291553965;6753.35843094915;6758.357955994173;6764.154480689914;6766.627835469097;1643.4576589725361;1689.3918189451788;1689.4931520543787;1692.7968643762827;1717.175755637276;1095.085603521053;1099.290957332516;1109.3233127792041;1113.0983903038564;1121.9158563107637;6268.185135932391;6286.937130628727;6322.841928951813;6329.873402531924;6336.035828893058;6777.491688123312;6821.113255276782;6834.589924604539;6861.897071543931;6877.759278425231;6108.205933228741;6236.376362363727;6288.402601752826;6290.685465726695;6301.8109456716375;3722.2555488901785;3736.439534069911;3742.7567208131386;3746.2882052409955;3751.868684596026;7129.89305160423;7133.82165445868;7135.215126336099;7137.964310178416;7141.678624461808;6973.79078627642;7032.45286037071;7033.613151276729;7045.788626341218;7058.153021637334;7408.481406301615;7417.184109747924;7419.07261592301;7423.665935032936;7426.888596670946;7095.929040709527;7098.219195888551;7111.857762844817;7112.857742845217;7117.288271172842;6857.314268573302;6958.408535274559;6982.301769823181;6986.371226589631;6987.615681137586;7347.26527347261;7368.59472729005;7385.630718464163;7386.48294619393;7387.593682347522;4735.052989402202;4755.096531658974;4760.047990401864;4772.997670489236;4779.330893674819;6900.896486552806;6956.130483689539;6996.860062798613;7084.25615310385;7104.502684812013;6793.72825086991;6852.965735171292;6863.588184708933;6869.828254293682;6895.620740859301;6796.898046529207;6845.281245469353;6852.211995620368;6862.4853136014;6870.62211578368;6610.6694665267505;6693.8326541834895;6711.295313992156;6751.426128779109;6764.154480689914;6867.381935625817;6895.34494223048;6925.203601585882;6929;6934.791956241321;6659.134312539339;6671.766488172891;6679.799606011828;6693.497987651043;6697.631630260383 07:13:05 INFO - PROCESS | 24110 | |5;yui.html;722.2777222777223;786.7600381883527;824.9092599814023;832.3632421197784;855.2431098477846;12121.57574484892;12127.575534856282;12197.329146896916;12201.206921550103;12275.44760485778;11801.232919860204;11803.291802491856;11835.171537992344;11842.526298948032;11847.111466640015;719.9460040496971;730.4156674660277;801.1187693537091;819.1399031017407;826.4586695714316;807.2008711375726;815.2214635023538;821.0065820357374;823.8475881961856;824.8680211166185;804.5856383962264;812.9552874591895;815.2906970935295;817.4645607127311;864.4726716702806;797.2904115337354;798.5448294472153;800.3277247112395;807.2049031703767;848.7029539661131;615.3907631444882;618.0420348459915;619.2507066449601;619.9473044791198;622.1414448061646;13686.247256400893;13716.245606491639;13716.519921802788;13722.794158087636;13769.586912392644;12340.074494412866;12392.876071239263;12623.305718185497;12706.496703994932;12807.359632018362;10379.740506487322;10431.582736690523;10495.842562361571;10496.317739346918;10558.52486638103;3516.841742121611;3517.929641407183;3542.415501442259;3648.9817550912076;3675.246574452231;47648;47655.76172119117;47840.52159478395;48020.519794801956;48771.512284877055;9167.358284920125;9447.811043779086;9449.90550094504;9490.478023708623;9713.854292185622;17118.914405428142;17167.227474763666;17283.13584320779;17674;17957.461276161735;7449.068866391701;7463.067116610424;7641.656125474367;7779.7666070017995;7883.526988380716;4281.486221653359;4298.247806633826;4331.761753103609;4352.129574085196;4362.716423432466;3040.619922509686;3062.372213696187;3070.171053815502;3081.768867334959;3086.768492363082;579.9884002320015;583.9328477225089;587.6738410182389;596.2963702830615;604.7399618164144;567.3220501500749;581.2676028204493;645.9806205813833;675.9121314229119;718.8382613911828;8337.207965243293;8922.68770593026;8956.820863582821;9023.097690230925;9175.77060573491;619.6839611797925;673.9284537585165;699.552286536617;701.1340993872564;709.8048036789924;3730.2166545025307;3757.5678796938155;3788.1855401088897;3801.790901500389;3878.185581028016;55919.440805591425;56095.15857262144;56617;56626.43373566212;58133.418665813646;49537;50267;50531.24203136956;51072.744636277326;51207.48792512027;45684.543154568026;46189.5381046192;46330.536694633294;46833.29750053752;46910.76544617323;7592.696292148252;7645.847083058419;8588.141185881363;8664.740057798275;8772.429792063496;31189;31802.52296215605;33332;34949.65050349464;35277.47083793694;42449;43595.78202108969;43598.56401435945;43925;44094.559054409045;10129.949350253202;10698.518566664363;10734.785304294026;10823.729406764895;10965.287256328313;10467.162626989975;10475.476226188812;10557.68326950162;10632.255742098288;11272.929071738172;10446.738831529272;10540.472976351306;10580.41807700553;10656.520456579628;10696.41169735672;10545.050945414949;10625.362478251329;10739.194560407845;11172.944135279271;11260.7747845041;10571.577136914437;10781.460926953465;10792.622258220925;11133.88866111361;11163.44182790841;8196.38527110481;8370.874436883574;8502.532360720219;8553.700620478254;8782.780430489289;8918.331125165769;8934;9058.682946096855;9102;9313.299143248381 07:13:05 INFO - PROCESS | 24110 | __end_tp_report 07:13:05 INFO - PROCESS | 24110 | __start_cc_report 07:13:05 INFO - PROCESS | 24110 | _x_x_mozilla_cycle_collect,304 07:13:05 INFO - PROCESS | 24110 | __end_cc_report 07:13:05 INFO - PROCESS | 24110 | __startTimestamp1452784385769__endTimestamp 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | ------- Summary: start ------- 07:13:05 INFO - PROCESS | 24110 | Number of tests: 6 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#0] dojo.html Cycles:165 Average:5334.45 Median:5551.89 stddev:595.03 (10.7%) stddev-sans-first:571.21 07:13:05 INFO - PROCESS | 24110 | Values: 3131.3 3131.5 3164.3 3184.0 3184.1 5243.6 5306.6 5307.1 5323.5 5334.4 5185.9 5201.7 5320.9 5386.7 5417.4 4908.2 4944.0 5004.4 5006.3 5015.7 4941.5 4963.7 4970.8 5008.4 5026.3 4816.3 4847.9 4866.2 4933.7 4974.4 4856.9 4862.9 4891.1 4897.2 4897.9 4860.9 4865.1 4865.2 4875.4 4888.7 5094.2 5154.4 5190.8 5216.3 5295.3 5761.3 5790.3 5798.1 5799.3 5818.2 5807.4 5815.2 5831.8 5833.9 5854.2 5257.8 5336.2 5336.7 5340.4 5340.8 5743.5 5774.9 5781.2 5786.9 5820.0 5625.8 5688.8 5694.9 5698.7 5700.3 5669.7 5725.5 5744.3 5768.1 5784.6 5572.4 5651.3 5681.9 5692.1 5733.2 5720.9 5755.2 5774.2 5777.6 5791.5 4347.7 4366.1 4413.5 4494.5 4536.1 3933.4 3941.3 3961.7 3987.2 3993.8 5337.4 5359.8 5372.5 5373.6 5403.6 5644.8 5721.3 5746.6 5799.4 5871.7 5328.9 5346.8 5363.1 5363.7 5379.1 4880.6 4889.3 4893.3 4899.3 4934.9 5766.4 5818.8 5987.7 5997.1 6014.0 5739.7 5770.8 5781.3 5785.0 5790.1 5868.3 5892.3 5952.3 5970.2 5976.5 5597.7 5647.7 5675.9 5718.7 5768.2 5798.7 5806.8 5812.3 5814.2 5822.2 5608.9 5626.2 5656.3 5659.2 5672.2 5544.3 5545.3 5629.2 5665.3 5703.6 5534.9 5560.1 5594.9 5597.5 5599.1 5551.9 5640.1 5713.8 5737.3 5741.4 5419.0 5454.2 5518.8 5532.3 5578.4 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#1] ext.html Cycles:180 Average:50356.66 Median:37272.94 stddev:88778.51 (238.2%) stddev-sans-first:88948.73 07:13:05 INFO - PROCESS | 24110 | Values: 529.7 537.8 558.4 560.1 568.6 36796.8 37103.4 37134.6 37215.3 37323.4 39774.4 40156.0 40182.8 40196.2 40232.0 8653.5 8824.9 8900.2 8900.5 8932.2 8591.6 8634.4 8738.6 8753.9 8761.7 8710.7 8823.6 8843.6 8844.1 8851.6 8686.5 8844.0 8861.6 8864.7 8891.1 8424.9 8630.9 8669.2 8675.2 8689.7 39733.2 40800.6 41131.0 41189.8 41205.8 3268.4 3308.6 3334.8 3430.1 3818.9 29115.9 29700.6 29994.3 30142.7 30183.7 3576.2 3605.5 3669.1 3688.8 3774.4 276217.0 277492.0 277834.0 277900.0 278036.6 56487.7 56591.0 56612.7 56687.0 56798.7 58811.4 59423.7 65416.7 65655.3 66459.3 14468.4 14720.1 14737.1 14743.2 14824.2 10757.4 10764.8 10803.9 10849.2 10896.2 19501.8 19772.2 19842.8 19857.6 20376.5 7527.9 7626.9 7695.3 7744.1 7773.3 913.9 934.7 951.6 1052.3 1086.9 27738.3 29434.9 29912.5 29929.9 30130.0 1032.5 1034.1 1038.8 1083.5 1091.5 15510.6 15542.8 15633.5 15672.3 16085.1 409483.0 410194.0 413235.0 414030.0 415170.0 54902.7 55070.4 55346.4 57142.0 57368.7 1293.1 1309.5 1311.9 1316.0 1319.1 30442.0 31222.4 31415.7 31615.4 31884.4 47653.3 47773.8 47829.3 48773.0 49079.8 306334.0 307125.0 309111.0 309291.0 309456.0 34077.0 45111.3 45385.8 45946.3 47108.5 44023.1 44245.0 44632.8 44986.8 45057.1 36540.0 36679.8 38844.8 39848.4 43506.0 33648.0 34518.5 34746.3 34952.0 35155.1 36117.5 36482.6 36534.3 37222.4 37398.0 32832.2 33867.8 33952.3 34541.8 34786.5 25871.2 25896.7 25904.6 26025.3 26195.0 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#2] jquery.html Cycles:180 Average:24281.35 Median:27926.62 stddev:77678.47 (278.2%) stddev-sans-first:77875.61 07:13:05 INFO - PROCESS | 24110 | Values: 360.9 363.5 365.2 365.9 367.4 15421.8 16456.8 16795.5 17482.0 17531.1 10810.6 10819.9 10824.1 12766.9 14995.8 4878.0 5041.5 5058.8 5084.7 5288.8 5202.9 5205.5 5206.0 5231.5 5269.4 5470.8 5507.9 5507.9 5514.0 5515.4 5468.0 5469.7 5633.7 5950.7 5993.3 5160.2 5358.8 5364.9 5367.8 5371.2 12695.8 12988.0 13020.2 13050.6 17177.3 2083.2 2164.5 2166.2 2200.5 2218.2 8909.2 9379.1 12358.4 12672.1 12782.3 1816.6 1827.8 1831.4 1832.7 1871.5 50768.5 52238.7 55359.0 58432.7 59863.0 10188.4 10346.0 10348.3 10364.7 10382.5 12870.2 13365.9 13430.1 13456.3 13469.2 7073.8 7299.2 7314.4 7368.7 7378.0 6858.8 6940.7 6948.7 6995.5 7014.7 4375.9 4412.9 4494.8 4512.8 4529.5 1674.6 1799.2 1806.7 1858.4 1862.3 422.4 909.8 940.7 942.5 948.6 10000.2 10509.1 10784.5 10797.4 10874.7 789.8 865.5 873.3 947.3 1001.5 5871.3 5925.3 6107.5 6132.6 6155.6 288595.0 288832.0 491020.0 596433.0 597157.0 72612.0 73663.6 73971.0 74719.3 76198.6 496.3 505.5 505.9 507.2 509.2 10166.2 10184.8 10476.6 10653.7 14296.2 30671.8 31802.7 31841.8 32915.5 34071.1 37006.4 37022.4 37720.8 38039.4 38382.4 6810.0 7194.8 7290.5 7435.5 7740.8 10128.8 10452.3 10883.2 11031.7 11051.4 9165.0 9281.8 9368.4 9450.9 9621.8 9494.3 9518.6 9590.9 9673.4 9850.4 9379.5 9474.3 9488.5 9606.7 9724.3 7264.0 7340.2 7381.8 7430.2 7437.0 8668.3 9210.4 9350.8 9363.3 9415.2 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#3] mootools.html Cycles:180 Average:5376.10 Median:6251.14 stddev:2738.23 (43.8%) stddev-sans-first:2730.04 07:13:05 INFO - PROCESS | 24110 | Values: 1454.8 1478.4 1624.4 1764.5 1799.9 7391.9 7539.1 7641.4 7701.3 7712.3 7725.9 7740.1 7832.0 7834.1 7835.0 2302.4 2321.2 2331.1 2332.4 2336.8 2333.2 2337.9 2369.1 2370.0 2379.4 2246.7 2302.5 2305.0 2311.0 2332.7 2320.1 2333.2 2345.1 2346.4 2358.4 2334.3 2334.6 2349.4 2354.3 2357.0 7644.6 7664.0 7685.2 7697.0 7715.9 4617.3 4714.5 4738.3 4748.8 4759.1 3001.3 3025.8 3102.8 3109.0 3155.8 1042.9 1045.8 1063.2 1072.4 1072.6 10365.1 10506.3 10518.6 10549.3 10558.2 4087.0 4155.4 4202.5 4225.3 4225.9 8492.9 8525.0 8535.3 8539.1 8553.8 4562.0 4584.8 4613.5 4622.7 4643.8 4209.0 4230.6 4259.9 4266.3 4269.4 3505.0 3565.9 3573.2 3588.9 3602.5 1077.6 1081.5 1094.3 1104.2 1112.1 1033.8 1060.3 1063.4 1190.6 1333.6 7173.5 7234.8 7294.3 7295.3 7308.8 1093.2 1117.5 1125.9 1131.0 1149.0 5629.5 5694.3 5753.2 5783.3 5812.3 9154.5 9262.2 9384.3 9485.4 9536.2 9259.8 9362.0 9373.1 9386.4 9417.2 6883.3 6925.6 7028.2 7055.4 7077.6 6802.9 6815.5 6866.6 6873.9 6888.0 7811.6 8009.4 8116.6 8128.8 8213.6 8015.8 8262.6 8287.3 8346.3 8415.6 6426.3 6497.4 6688.4 6866.1 6914.7 7312.0 7331.3 7345.4 7374.4 7385.2 6726.3 6845.7 6861.4 6865.9 6983.2 6857.7 6964.3 6974.1 6999.2 7120.3 6683.3 6780.0 6787.0 6812.8 6825.0 6249.9 6252.4 6256.0 6274.8 6294.1 6433.9 6447.1 6607.8 6614.6 6615.2 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#4] prototype.html Cycles:180 Average:5647.05 Median:6296.07 stddev:1716.33 (27.3%) stddev-sans-first:1674.30 07:13:05 INFO - PROCESS | 24110 | Values: 340.9 348.1 351.8 353.4 353.6 6208.0 6282.6 6314.7 6400.6 6423.7 6148.2 6278.4 6286.8 6301.5 6326.7 4838.7 4845.1 4845.5 4853.2 4856.3 4846.0 4851.8 4860.0 4867.0 4868.4 4730.3 4814.2 4826.3 4831.3 4850.2 4773.8 4791.4 4810.2 4825.7 4826.6 4213.2 4214.8 4225.8 4231.5 4244.6 5930.3 5938.3 5963.0 5982.0 5991.4 5581.7 5596.1 5600.8 5636.2 5636.8 6642.0 6646.3 6661.2 6676.4 6680.7 4682.7 4709.0 4713.6 4715.7 4721.0 6902.0 7020.9 7031.9 7047.5 7049.0 4806.1 4845.7 4847.9 4855.6 4862.4 4914.6 4918.9 4923.4 4923.6 4937.1 5551.4 5608.9 5630.2 5642.0 5650.6 6742.6 6753.4 6758.4 6764.2 6766.6 1643.5 1689.4 1689.5 1692.8 1717.2 1095.1 1099.3 1109.3 1113.1 1121.9 6268.2 6286.9 6322.8 6329.9 6336.0 6777.5 6821.1 6834.6 6861.9 6877.8 6108.2 6236.4 6288.4 6290.7 6301.8 3722.3 3736.4 3742.8 3746.3 3751.9 7129.9 7133.8 7135.2 7138.0 7141.7 6973.8 7032.5 7033.6 7045.8 7058.2 7408.5 7417.2 7419.1 7423.7 7426.9 7095.9 7098.2 7111.9 7112.9 7117.3 6857.3 6958.4 6982.3 6986.4 6987.6 7347.3 7368.6 7385.6 7386.5 7387.6 4735.1 4755.1 4760.0 4773.0 4779.3 6900.9 6956.1 6996.9 7084.3 7104.5 6793.7 6853.0 6863.6 6869.8 6895.6 6796.9 6845.3 6852.2 6862.5 6870.6 6610.7 6693.8 6711.3 6751.4 6764.2 6867.4 6895.3 6925.2 6929.0 6934.8 6659.1 6671.8 6679.8 6693.5 6697.6 07:13:05 INFO - PROCESS | 24110 | 07:13:05 INFO - PROCESS | 24110 | [#5] yui.html Cycles:180 Average:13428.94 Median:47651.88 stddev:15742.28 (33.0%) stddev-sans-first:15757.53 07:13:05 INFO - PROCESS | 24110 | Values: 722.3 786.8 824.9 832.4 855.2 12121.6 12127.6 12197.3 12201.2 12275.4 11801.2 11803.3 11835.2 11842.5 11847.1 719.9 730.4 801.1 819.1 826.5 807.2 815.2 821.0 823.8 824.9 804.6 813.0 815.3 817.5 864.5 797.3 798.5 800.3 807.2 848.7 615.4 618.0 619.3 619.9 622.1 13686.2 13716.2 13716.5 13722.8 13769.6 12340.1 12392.9 12623.3 12706.5 12807.4 10379.7 10431.6 10495.8 10496.3 10558.5 3516.8 3517.9 3542.4 3649.0 3675.2 47648.0 47655.8 47840.5 48020.5 48771.5 9167.4 9447.8 9449.9 9490.5 9713.9 17118.9 17167.2 17283.1 17674.0 17957.5 7449.1 7463.1 7641.7 7779.8 7883.5 4281.5 4298.2 4331.8 4352.1 4362.7 3040.6 3062.4 3070.2 3081.8 3086.8 580.0 583.9 587.7 596.3 604.7 567.3 581.3 646.0 675.9 718.8 8337.2 8922.7 8956.8 9023.1 9175.8 619.7 673.9 699.6 701.1 709.8 3730.2 3757.6 3788.2 3801.8 3878.2 55919.4 56095.2 56617.0 56626.4 58133.4 49537.0 50267.0 50531.2 51072.7 51207.5 45684.5 46189.5 46330.5 46833.3 46910.8 7592.7 7645.8 8588.1 8664.7 8772.4 31189.0 31802.5 33332.0 34949.7 35277.5 42449.0 43595.8 43598.6 43925.0 44094.6 10129.9 10698.5 10734.8 10823.7 10965.3 10467.2 10475.5 10557.7 10632.3 11272.9 10446.7 10540.5 10580.4 10656.5 10696.4 10545.1 10625.4 10739.2 11172.9 11260.8 10571.6 10781.5 10792.6 11133.9 11163.4 8196.4 8370.9 8502.5 8553.7 8782.8 8918.3 8934.0 9058.7 9102.0 9313.3 07:13:05 INFO - PROCESS | 24110 | -------- Summary: end -------- 07:13:05 INFO - PROCESS | 24110 | 07:13:06 INFO - TEST-INFO | 24110: exit 0 07:13:06 INFO - TEST-OK | dromaeo_css | took 1110513ms 07:13:06 INFO - TEST-START | kraken 07:13:06 INFO - operating with platform_type : linux_ 07:13:06 INFO - Initialising browser for kraken test... 07:13:06 INFO - TEST-INFO | started process 24352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpltRqgX/profile http://localhost:49299/getInfo.html) 07:13:10 INFO - PROCESS | 24352 | 07:13:10 INFO - PROCESS | 24352 | (process:24422): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:10 INFO - PROCESS | 24352 | __metrics Screen width/height:1600/1200 07:13:10 INFO - PROCESS | 24352 | colorDepth:24 07:13:10 INFO - PROCESS | 24352 | Browser inner width/height: 1024/697 07:13:10 INFO - PROCESS | 24352 | __metrics 07:13:10 INFO - PROCESS | 24352 | 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:13:11 INFO - TEST-INFO | 24352: exit 0 07:13:11 INFO - Browser initialized. 07:13:11 INFO - Running cycle 1/1 for kraken test... 07:13:11 INFO - TEST-INFO | started process 24471 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpltRqgX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:13 INFO - PROCESS | 24471 | 07:13:13 INFO - PROCESS | 24471 | (process:24529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:13:23 INFO - PROCESS | 24471 | RSS: Main: 150605824 07:13:23 INFO - PROCESS | 24471 | 07:13:26 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:26 INFO - PROCESS | 24471 | RSS: Main: 151162880 07:13:26 INFO - PROCESS | 24471 | 07:13:29 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-dft) 07:13:30 INFO - PROCESS | 24471 | RSS: Main: 154484736 07:13:30 INFO - PROCESS | 24471 | 07:13:32 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-fft) 07:13:33 INFO - PROCESS | 24471 | RSS: Main: 148086784 07:13:33 INFO - PROCESS | 24471 | 07:13:35 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator) 07:13:36 INFO - PROCESS | 24471 | RSS: Main: 148107264 07:13:36 INFO - PROCESS | 24471 | 07:13:38 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:38 INFO - PROCESS | 24471 | RSS: Main: 148983808 07:13:38 INFO - PROCESS | 24471 | 07:13:41 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:42 INFO - PROCESS | 24471 | RSS: Main: 149794816 07:13:42 INFO - PROCESS | 24471 | 07:13:45 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:46 INFO - PROCESS | 24471 | RSS: Main: 149893120 07:13:46 INFO - PROCESS | 24471 | 07:13:49 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial) 07:13:49 INFO - PROCESS | 24471 | RSS: Main: 150110208 07:13:49 INFO - PROCESS | 24471 | 07:13:51 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:13:52 INFO - PROCESS | 24471 | RSS: Main: 149639168 07:13:52 INFO - PROCESS | 24471 | 07:13:53 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:54 INFO - PROCESS | 24471 | RSS: Main: 148992000 07:13:54 INFO - PROCESS | 24471 | 07:13:56 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:13:57 INFO - PROCESS | 24471 | RSS: Main: 149217280 07:13:57 INFO - PROCESS | 24471 | 07:13:59 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:00 INFO - PROCESS | 24471 | RSS: Main: 149921792 07:14:00 INFO - PROCESS | 24471 | 07:14:02 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:03 INFO - PROCESS | 24471 | RSS: Main: 150339584 07:14:03 INFO - PROCESS | 24471 | 07:14:04 INFO - PROCESS | 24471 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49299/tests/kraken/driver.html?testName=ai-astar) 07:14:05 INFO - PROCESS | 24471 | RSS: Main: 149544960 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | __start_tp_report 07:14:05 INFO - PROCESS | 24471 | _x_x_mozilla_page_load 07:14:05 INFO - PROCESS | 24471 | _x_x_mozilla_page_load_details 07:14:05 INFO - PROCESS | 24471 | |i|pagename|runs| 07:14:05 INFO - PROCESS | 24471 | |0;ai-astar;111;106;111;110;110;122;111;111;111;109 07:14:05 INFO - PROCESS | 24471 | |1;audio-beat-detection;148;128;146;171;126;160;154;130;163;127 07:14:05 INFO - PROCESS | 24471 | |2;audio-dft;162;162;163;163;162;162;162;166;172;163 07:14:05 INFO - PROCESS | 24471 | |3;audio-fft;72;76;71;71;72;77;147;73;75;71 07:14:05 INFO - PROCESS | 24471 | |4;audio-oscillator;95;95;150;96;96;97;141;97;95;140 07:14:05 INFO - PROCESS | 24471 | |5;imaging-gaussian-blur;110;110;110;109;110;110;113;110;109;109 07:14:05 INFO - PROCESS | 24471 | |6;imaging-darkroom;147;146;146;147;147;148;146;147;147;146 07:14:05 INFO - PROCESS | 24471 | |7;imaging-desaturate;97;98;96;97;97;96;96;96;97;96 07:14:05 INFO - PROCESS | 24471 | |8;json-parse-financial;58;59;58;59;58;57;60;58;57;58 07:14:05 INFO - PROCESS | 24471 | |9;json-stringify-tinderbox;67;72;67;67;67;67;67;67;67;67 07:14:05 INFO - PROCESS | 24471 | |10;stanford-crypto-aes;83;83;84;85;83;84;82;82;83;86 07:14:05 INFO - PROCESS | 24471 | |11;stanford-crypto-ccm;127;129;121;118;116;117;121;119;116;118 07:14:05 INFO - PROCESS | 24471 | |12;stanford-crypto-pbkdf2;136;142;154;132;143;131;147;138;140;132 07:14:05 INFO - PROCESS | 24471 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;66;68;65;67;67 07:14:05 INFO - PROCESS | 24471 | __end_tp_report 07:14:05 INFO - PROCESS | 24471 | __start_cc_report 07:14:05 INFO - PROCESS | 24471 | _x_x_mozilla_cycle_collect,753 07:14:05 INFO - PROCESS | 24471 | __end_cc_report 07:14:05 INFO - PROCESS | 24471 | __startTimestamp1452784445133__endTimestamp 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | ------- Summary: start ------- 07:14:05 INFO - PROCESS | 24471 | Number of tests: 14 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.10 (3.7%) stddev-sans-first:4.35 07:14:05 INFO - PROCESS | 24471 | Values: 111.0 106.0 111.0 110.0 110.0 122.0 111.0 111.0 111.0 109.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:151.00 stddev:16.71 (11.1%) stddev-sans-first:17.70 07:14:05 INFO - PROCESS | 24471 | Values: 148.0 128.0 146.0 171.0 126.0 160.0 154.0 130.0 163.0 127.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.16 (1.9%) stddev-sans-first:3.30 07:14:05 INFO - PROCESS | 24471 | Values: 162.0 162.0 163.0 163.0 162.0 162.0 162.0 166.0 172.0 163.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#3] audio-fft Cycles:10 Average:80.50 Median:72.50 stddev:23.47 (32.4%) stddev-sans-first:24.69 07:14:05 INFO - PROCESS | 24471 | Values: 72.0 76.0 71.0 71.0 72.0 77.0 147.0 73.0 75.0 71.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.50 stddev:23.25 (24.3%) stddev-sans-first:24.00 07:14:05 INFO - PROCESS | 24471 | Values: 95.0 95.0 150.0 96.0 96.0 97.0 141.0 97.0 95.0 140.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 07:14:05 INFO - PROCESS | 24471 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 113.0 110.0 109.0 109.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:14:05 INFO - PROCESS | 24471 | Values: 147.0 146.0 146.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:14:05 INFO - PROCESS | 24471 | Values: 97.0 98.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 07:14:05 INFO - PROCESS | 24471 | Values: 58.0 59.0 58.0 59.0 58.0 57.0 60.0 58.0 57.0 58.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 07:14:05 INFO - PROCESS | 24471 | Values: 67.0 72.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 07:14:05 INFO - PROCESS | 24471 | Values: 83.0 83.0 84.0 85.0 83.0 84.0 82.0 82.0 83.0 86.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.00 stddev:4.49 (3.7%) stddev-sans-first:4.03 07:14:05 INFO - PROCESS | 24471 | Values: 127.0 129.0 121.0 118.0 116.0 117.0 121.0 119.0 116.0 118.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:141.00 stddev:7.34 (5.2%) stddev-sans-first:7.67 07:14:05 INFO - PROCESS | 24471 | Values: 136.0 142.0 154.0 132.0 143.0 131.0 147.0 138.0 140.0 132.0 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - PROCESS | 24471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 07:14:05 INFO - PROCESS | 24471 | Values: 66.0 66.0 65.0 66.0 67.0 66.0 68.0 65.0 67.0 67.0 07:14:05 INFO - PROCESS | 24471 | -------- Summary: end -------- 07:14:05 INFO - PROCESS | 24471 | 07:14:05 INFO - TEST-INFO | 24471: exit 0 07:14:06 INFO - TEST-OK | kraken | took 59600ms 07:14:06 INFO - TEST-START | v8_7 07:14:06 INFO - operating with platform_type : linux_ 07:14:06 INFO - Initialising browser for v8_7 test... 07:14:06 INFO - TEST-INFO | started process 24757 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4RDlnU/profile http://localhost:49299/getInfo.html) 07:14:09 INFO - PROCESS | 24757 | 07:14:09 INFO - PROCESS | 24757 | (process:24830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:14:10 INFO - PROCESS | 24757 | __metrics Screen width/height:1600/1200 07:14:10 INFO - PROCESS | 24757 | colorDepth:24 07:14:10 INFO - PROCESS | 24757 | Browser inner width/height: 1024/697 07:14:10 INFO - PROCESS | 24757 | __metrics 07:14:10 INFO - PROCESS | 24757 | 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:14:11 INFO - TEST-INFO | 24757: exit 0 07:14:11 INFO - Browser initialized. 07:14:11 INFO - Running cycle 1/1 for v8_7 test... 07:14:11 INFO - TEST-INFO | started process 24879 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4RDlnU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:12 INFO - PROCESS | 24879 | 07:14:12 INFO - PROCESS | 24879 | (process:24940): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:14:23 INFO - PROCESS | 24879 | RSS: Main: 150798336 07:14:23 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | Cycle 1(1): loaded http://localhost:49299/tests/v8_7/run.html (next: http://localhost:49299/tests/v8_7/run.html) 07:14:45 INFO - PROCESS | 24879 | RSS: Main: 146128896 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | __start_tp_report 07:14:45 INFO - PROCESS | 24879 | _x_x_mozilla_page_load 07:14:45 INFO - PROCESS | 24879 | _x_x_mozilla_page_load_details 07:14:45 INFO - PROCESS | 24879 | |i|pagename|runs| 07:14:45 INFO - PROCESS | 24879 | |0;Richards;167.39203213927016 07:14:45 INFO - PROCESS | 24879 | |1;DeltaBlue;188.28845791752966 07:14:45 INFO - PROCESS | 24879 | |2;Encrypt;278.6291446085261 07:14:45 INFO - PROCESS | 24879 | |3;Decrypt;5186.5284974093265 07:14:45 INFO - PROCESS | 24879 | |4;RayTrace;1094.0919037199126 07:14:45 INFO - PROCESS | 24879 | |5;Earley;704.2253521126761 07:14:45 INFO - PROCESS | 24879 | |6;Boyer;12256.09756097561 07:14:45 INFO - PROCESS | 24879 | |7;RegExp;41120 07:14:45 INFO - PROCESS | 24879 | |8;Splay;589.622641509434 07:14:45 INFO - PROCESS | 24879 | |9;NavierStokes;4854.368932038835 07:14:45 INFO - PROCESS | 24879 | __end_tp_report 07:14:45 INFO - PROCESS | 24879 | __startTimestamp1452784485782__endTimestamp 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | ------- Summary: start ------- 07:14:45 INFO - PROCESS | 24879 | Number of tests: 10 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#0] Richards Cycles:1 Average:167.39 Median:167.39 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 167.4 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#1] DeltaBlue Cycles:1 Average:188.29 Median:188.29 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 188.3 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 278.6 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 5186.5 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 1094.1 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#5] Earley Cycles:1 Average:704.23 Median:704.23 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 704.2 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 12256.1 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#7] RegExp Cycles:1 Average:41120.00 Median:41120.00 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 41120.0 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#8] Splay Cycles:1 Average:589.62 Median:589.62 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 589.6 07:14:45 INFO - PROCESS | 24879 | 07:14:45 INFO - PROCESS | 24879 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 07:14:45 INFO - PROCESS | 24879 | Values: 4854.4 07:14:45 INFO - PROCESS | 24879 | -------- Summary: end -------- 07:14:45 INFO - PROCESS | 24879 | 07:14:46 INFO - TEST-INFO | 24879: exit 0 07:14:46 INFO - TEST-OK | v8_7 | took 40632ms 07:14:46 INFO - SUITE-END | took 1210s 07:14:46 INFO - Completed test suite (00:20:10) 07:14:46 INFO - Working with test: dromaeo_css 07:14:46 INFO - Generating results file: dromaeo_css 07:14:46 INFO - Working with test: kraken 07:14:46 INFO - Generating results file: kraken 07:14:46 INFO - javascript benchmark 07:14:46 INFO - Working with test: v8_7 07:14:46 INFO - Generating results file: v8_7 07:14:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:14:46 INFO - process_Request line: dromaeo_css 6860.55 graph.html#tests=[[72,1,43]] 07:14:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - process_Request line: kraken 1499.40 graph.html#tests=[[232,1,43]] 07:14:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - process_Request line: v8_7 20401.36 graph.html#tests=[[230,1,43]] 07:14:46 INFO - RETURN: dromaeo_css: 6860.55 07:14:46 INFO - RETURN: kraken: 1499.40 07:14:46 INFO - RETURN: v8_7: 20401.36 07:14:46 INFO - javascript benchmark 07:14:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3131.326764745579, 3131.514615234638, 3164.272217389999, 3184.028871194285, 3184.0607020928824, 5243.580513558915, 5306.628536002477, 5307.12432448646, 5323.547498462635, 5334.413214546396, 5185.910958698669, 5201.673573238819, 5320.856015956569, 5386.730663466821, 5417.404085550586, 4908.214685650297, 4944.0, 5004.399472063357, 5006.299118123466, 5015.673981191229, 4941.505849415048, 4963.7021778693215, 4970.801167953277, 5008.449070602231, 5026.321446604698, 4816.277558366238, 4847.854564363075, 4866.221404575286, 4933.679310844802, 4974.353334066566, 4856.854294371139, 4862.854114376574, 4891.070696567641, 4897.216445368724, 4897.853064408074, 4860.878478038042, 4865.051314993578, 4865.221564549655, 4875.414950205963, 4888.682235654706, 5094.1594636884865, 5154.433012368637, 5190.844274671728, 5216.2958000669805, 5295.285136506599, 5761.279840019997, 5790.305163380379, 5798.1302804579655, 5799.3040835100055, 5818.2436283282905, 5807.390224026459, 5815.21494598228, 5831.766729330821, 5833.912491312592, 5854.18041474194, 5257.763400646942, 5336.199570064521, 5336.733163341817, 5340.359156901197, 5340.759665815087, 5743.483086522233, 5774.913376299359, 5781.19063331134, 5786.94213057864, 5820.039693450533, 5625.831225063254, 5688.800891968844, 5694.914576281359, 5698.715064246771, 5700.344460387026, 5669.688167150846, 5725.456081672318, 5744.253247077853, 5768.077107662753, 5784.595078344475, 5572.3870374258795, 5651.2935883014625, 5681.914771278434, 5692.089265717465, 5733.197352370671, 5720.942790572124, 5755.22304488897, 5774.162746401748, 5777.62445441045, 5791.478766910998, 4347.7173983690955, 4366.104948485617, 4413.492448368414, 4494.4606647202545, 4536.092781443725, 3933.4099885017476, 3941.3496773032703, 3961.6632586230494, 3987.202559488114, 3993.821822562351, 5337.359516857924, 5359.812406565829, 5372.516473517402, 5373.570114390839, 5403.621746477709, 5644.774209031592, 5721.313442386941, 5746.5977381583725, 5799.420057994167, 5871.677057761779, 5328.946710532922, 5346.8395948121615, 5363.141897296414, 5363.678179309254, 5379.139337706027, 4880.585150262196, 4889.315495830587, 4893.314935908976, 4899.2896030075435, 4934.876628084255, 5766.4233576642, 5818.8254352369495, 5987.730552125077, 5997.070454079625, 6014.0, 5739.655620662774, 5770.798022069207, 5781.277340332458, 5784.971075144597, 5790.10253410722, 5868.2664666916635, 5892.292924849045, 5952.255968003999, 5970.164177015308, 5976.521878249817, 5597.692126933058, 5647.661140331593, 5675.914861277167, 5718.714064296852, 5768.221290125947, 5798.652080875161, 5806.796762113306, 5812.3025236971835, 5814.156947242542, 5822.214001109796, 5608.9158662619275, 5626.212330273846, 5656.2929633795775, 5659.236003139524, 5672.234248376416, 5544.306961629796, 5545.334559852843, 5629.211910332639, 5665.291838520185, 5703.572232082527, 5534.861628459321, 5560.138178582326, 5594.888102238014, 5597.496225339739, 5599.132134519156, 5551.8889622208135, 5640.125780504029, 5713.771449141987, 5737.311522617312, 5741.368449470471, 5419.0, 5454.209139674805, 5518.834434966958, 5532.253145825423, 5578.3584887738425], "unit": "score", "name": "dojo.html", "value": 5295.337983816108}, {"lowerIsBetter": false, "replicates": [529.6848375216747, 537.8467136865993, 558.3885645218485, 560.1010378342762, 568.6019786149697, 36796.81601591995, 37103.4434483483, 37134.62865371349, 37215.25569488609, 37323.44014839776, 39774.40338394926, 40156.0, 40182.799086004605, 40196.196076078464, 40232.0, 8653.480791152535, 8824.911750882506, 8900.243479304267, 8900.465972041666, 8932.240759535447, 8591.570421478933, 8634.352423568225, 8738.563071846382, 8753.912460875374, 8761.693340733076, 8710.651573937035, 8823.558822058903, 8843.557822108902, 8844.115588441136, 8851.557422128868, 8686.522241276727, 8843.955780221058, 8861.556922153899, 8864.73405797827, 8891.110888911122, 8424.873626895602, 8630.870536941951, 8669.176428239307, 8675.219230269306, 8689.69586064491, 39733.205335893406, 40800.59199407998, 41130.9717257068, 41189.79405102985, 41205.79397103025, 3268.3953468608383, 3308.553345298402, 3334.8332583370734, 3430.073880052397, 3818.923621527582, 29115.854420727974, 29700.554491682644, 29994.25014374636, 30142.698573014426, 30183.698163018307, 3576.159602493412, 3605.4591811228265, 3669.1194113412857, 3688.79711615861, 3774.358359078963, 276217.0, 277492.0, 277834.0, 277900.0, 278036.6098169516, 56487.717561412755, 56591.0, 56612.716936415054, 56687.0, 56798.71600642053, 58811.41188588145, 59423.70288148532, 65416.67291663607, 65655.34344656588, 66459.33540664532, 14468.421263149567, 14720.116792992454, 14737.11577305365, 14743.189124598035, 14824.184669843262, 10757.354558726345, 10764.838527422095, 10803.891961080288, 10849.24055316136, 10896.182786290901, 19501.804981949997, 19772.209111635373, 19842.801571984382, 19857.60284794296, 20376.49058773513, 7527.887081693779, 7626.894100355528, 7695.268949449794, 7744.148143704188, 7773.261540153676, 913.8903331600251, 934.6588495199203, 951.5908159491485, 1052.2686732720838, 1086.8858769829053, 27738.32408689315, 29434.85282573616, 29912.453773014327, 29929.850350748107, 30130.0, 1032.4785983078648, 1034.0641719244097, 1038.8441733739849, 1083.5124194112523, 1091.5197313182334, 15510.612234693997, 15542.766858497132, 15633.452829150925, 15672.294746736425, 16085.115318657587, 409483.0, 410194.0, 413235.0, 414030.0, 415170.0, 54902.725486372314, 55070.44929550734, 55346.44653553493, 57142.0, 57368.71315643479, 1293.140061858872, 1309.463120120746, 1311.9409626566637, 1316.0, 1319.129374612751, 30442.0, 31222.375552489277, 31415.685843141277, 31615.36769264648, 31884.362312754078, 47653.28520072132, 47773.76113119412, 47829.28256076231, 48773.0, 49079.75460122676, 306334.0, 307125.0, 309111.0, 309291.0, 309456.0, 34077.0, 45111.32333014942, 45385.773071134434, 45946.31080533728, 47108.52891471041, 44023.11953760843, 44245.0, 44632.77683611561, 44986.77506612446, 45057.09885802331, 36540.0, 36679.81660091683, 38844.80577597094, 39848.40227396534, 43506.0, 33648.0, 34518.48222276718, 34746.30507389788, 34952.0, 35155.12112197113, 36117.458238125924, 36482.63517364793, 36534.26931461409, 37222.44166337561, 37398.00815934773, 32832.1791955203, 33867.830660846535, 33952.320953581286, 34541.82729086339, 34786.478202826474, 25871.17370516752, 25896.741032589434, 25904.611430828176, 26025.349366265997, 26195.0], "unit": "score", "name": "ext.html", "value": 18903.992721862636}, {"lowerIsBetter": false, "replicates": [360.8971443138705, 363.4729642019073, 365.2457674901328, 365.8554870826022, 367.3717942318635, 15421.768673469893, 16456.753148702777, 16795.496135115965, 17481.999999999985, 17531.12344382779, 10810.621628243012, 10819.945900270508, 10824.079953203967, 12766.872331276685, 14995.77506337403, 4877.951220487803, 5041.546260836524, 5058.7976480940715, 5084.745762711868, 5288.788448462057, 5202.947970520284, 5205.453427390126, 5206.0, 5231.476852314776, 5269.394019687727, 5470.753816078266, 5507.862303442426, 5507.889842203153, 5513.972430137864, 5515.393306736276, 5467.972660136714, 5469.671819690811, 5633.746481408326, 5950.672713000783, 5993.250843644544, 5160.200168973815, 5358.812441564565, 5364.927014597096, 5367.78528858849, 5371.194320851864, 12695.809562856564, 12988.0, 13020.153690010118, 13050.608481745468, 17177.312907483687, 2083.1771450277056, 2164.4588852786806, 2166.2093335932427, 2200.482886521666, 2218.190360518415, 8909.198172164537, 9379.062093790566, 12358.38208089601, 12672.112952093357, 12782.296973666445, 1816.6275913437714, 1827.7532533107992, 1831.3590243414699, 1832.6609577228255, 1871.4759867237196, 50768.492315077114, 52238.73880630611, 55359.0, 58432.70783646097, 59863.0, 10188.388696678223, 10346.0, 10348.344264917578, 10364.740881477872, 10382.532786024647, 12870.22778633285, 13365.866341336656, 13430.059895807395, 13456.25990570528, 13469.191848489121, 7073.752418665322, 7299.160596531467, 7314.3782778463365, 7368.705251789976, 7378.0, 6858.759943401957, 6940.6529673516125, 6948.652567371712, 6995.510314278054, 7014.719411223494, 4375.890602734893, 4412.867613971586, 4494.775261236925, 4512.842050528216, 4529.501754806968, 1674.5729838891248, 1799.16338902411, 1806.7018941874444, 1858.4145994011842, 1862.2923289150308, 422.39808273210554, 909.7543663210896, 940.6848705683673, 942.495764765847, 948.5684013773716, 10000.249981251436, 10509.06401774825, 10784.460776961121, 10797.376801960372, 10874.716309575078, 789.759123467348, 865.51629690495, 873.3362644390309, 947.3415975896824, 1001.5392919257223, 5871.32479764824, 5925.34821169671, 6107.450329470369, 6132.601380910227, 6155.630662160284, 288595.0, 288832.0, 491020.0, 596433.0, 597157.0, 72612.0, 73663.63168184125, 73971.0, 74719.25280747232, 76198.61900690461, 496.3274762696494, 505.4591587001873, 505.94687557807373, 507.16064912569755, 509.1776780499467, 10166.237532184969, 10184.796304073729, 10476.580936762444, 10653.733656658645, 14296.213708246147, 30671.846640766653, 31802.681973179973, 31841.840790795897, 32915.50626740553, 34071.148221294665, 37006.44490332701, 37022.44466333061, 37720.811395942845, 38039.429408559445, 38382.424263636625, 6810.0, 7194.784156475314, 7290.453216008715, 7435.51669141504, 7740.806479838049, 10128.84806727885, 10452.268341216042, 10883.183761218099, 11031.724206894893, 11051.447427628747, 9164.95417522908, 9281.814363712823, 9368.39105458143, 9450.905490945002, 9621.807563848544, 9494.28792840526, 9518.571664275263, 9590.904090959, 9673.37123086997, 9850.359726617748, 9379.531023448664, 9474.336796424184, 9488.525573721425, 9606.66376676813, 9724.319297649097, 7264.019357386685, 7340.2292759261645, 7381.818908974538, 7430.219826918312, 7436.96281518589, 8668.349873759367, 9210.447373157633, 9350.81298374015, 9363.314603371458, 9415.199708024895], "unit": "score", "name": "jquery.html", "value": 7496.031044635616}, {"lowerIsBetter": false, "replicates": [1454.8254209494862, 1478.4086365453818, 1624.3746157729279, 1764.5235786337698, 1799.9280028798848, 7391.926080739191, 7539.132999705035, 7641.3504852087635, 7701.306882380592, 7712.344450721688, 7725.92274077259, 7740.109887362955, 7832.0, 7834.059912810457, 7835.0, 2302.3898666853256, 2321.1643808229023, 2331.1025255276754, 2332.416895776056, 2336.8013718833918, 2333.195047708546, 2337.929862104131, 2369.052379048386, 2370.0282884017556, 2379.381360846175, 2246.6854640350284, 2302.4934514406805, 2305.0318866076204, 2311.0293676655847, 2332.7433982261937, 2320.11835502508, 2333.1600623775425, 2345.1440224318085, 2346.378209774411, 2358.3514533503253, 2334.323046316566, 2334.6264597664463, 2349.3539276698875, 2354.258408601302, 2357.0218359380838, 7644.617769111578, 7663.961680191619, 7685.154632990367, 7697.0, 7715.922840771576, 4617.3304870793545, 4714.457837348715, 4738.2892566115015, 4748.810047598092, 4759.095771803346, 3001.264690150905, 3025.8184508929535, 3102.7828052036366, 3109.0361987783635, 3155.8422078895965, 1042.8904964978644, 1045.8117538843005, 1063.1760385701066, 1072.4369705904385, 1072.5763323487256, 10365.118964887994, 10506.264561480699, 10518.631847885365, 10549.314294570828, 10558.208134389952, 4086.9795651021554, 4155.439015732837, 4202.495700515958, 4225.260579398593, 4225.915481690349, 8492.872606910902, 8524.95737521321, 8535.274501667427, 8539.06070332263, 8553.828923421497, 4561.954380456219, 4584.839530616412, 4613.515580864028, 4622.745748983838, 4643.8374656886845, 4208.978955105266, 4230.598093181205, 4259.87220383389, 4266.274733295348, 4269.4449721536, 3504.982475087659, 3565.858925143929, 3573.1781690211396, 3588.9102772430374, 3602.4596310553625, 1077.563586747353, 1081.4646749858714, 1094.2996482251365, 1104.2380757277454, 1112.0880877680386, 1033.8397548380012, 1060.3213943076437, 1063.4416931111073, 1190.5535424215918, 1333.5932540575218, 7173.5337203081635, 7234.819129521804, 7294.270572942663, 7295.343419092307, 7308.780736577911, 1093.2074246171462, 1117.541807858774, 1125.8817824128512, 1131.0, 1148.9885101149048, 5629.493345598834, 5694.288213973254, 5753.194552762617, 5783.306003279633, 5812.273465816773, 9154.496502692282, 9262.16640502358, 9384.343095983351, 9485.430874147572, 9536.23710103204, 9259.814803703888, 9362.0, 9373.109554592304, 9386.389884657476, 9417.152456278967, 6883.27725588806, 6925.6190909499455, 7028.156621205386, 7055.365017148379, 7077.646117694095, 6802.897956530557, 6815.454763618998, 6866.553674011173, 6873.862522749617, 6888.0, 7811.570363630055, 8009.359251259769, 8116.59417029158, 8128.83742325162, 8213.58932053383, 8015.799605009922, 8262.628181731716, 8287.254147126787, 8346.290565301775, 8415.5792210388, 6426.260979987362, 6497.350264973465, 6688.3646053624825, 6866.107406037183, 6914.688839002157, 7311.963440182765, 7331.266873312626, 7345.412367010519, 7374.446916481178, 7385.187629360658, 6726.260111387645, 6845.726170953106, 6861.416779573792, 6865.862682746417, 6983.231844497, 6857.736946807442, 6964.303569642995, 6974.128233970754, 6999.160100787938, 7120.252373500915, 6683.264840867598, 6780.0, 6786.9660651698405, 6812.795616131524, 6824.965875170592, 6249.906251406142, 6252.374762523893, 6256.0, 6274.780382686767, 6294.1188233648245, 6433.903491447539, 6447.129637499065, 6607.834804129743, 6614.570052946543, 6615.206175259], "unit": "score", "name": "mootools.html", "value": 4449.61860167734}, {"lowerIsBetter": false, "replicates": [340.91136304560814, 348.1036331446524, 351.7555299067146, 353.38158223109576, 353.5704119494814, 6207.9689601552045, 6282.623042617434, 6314.652694101823, 6400.5839620424695, 6423.743050277989, 6148.231471066117, 6278.4035516625845, 6286.779962701306, 6301.464375528074, 6326.746930122801, 4838.661293709441, 4845.079434907374, 4845.466998630148, 4853.150698627726, 4856.271559266103, 4846.006568653417, 4851.781669824849, 4860.027994401134, 4866.951330486685, 4868.367112275417, 4730.290456431529, 4814.229723244282, 4826.251930950708, 4831.323614693945, 4850.248211527201, 4773.80904763809, 4791.401074865642, 4810.230363141898, 4825.710457372569, 4826.565609095198, 4213.178430206111, 4214.777714462802, 4225.7887105644595, 4231.492220933477, 4244.617984381421, 5930.347661757203, 5938.257717785277, 5963.0, 5982.04287314032, 5991.430814072656, 5581.748821303051, 5596.104623260299, 5600.775968961278, 5636.210930469738, 5636.774529018834, 6642.036904648847, 6646.335366463363, 6661.2006559213205, 6676.365745254193, 6680.699368528428, 4682.695624784412, 4709.0, 4713.622910167179, 4715.717056976592, 4720.976395118002, 6902.0, 7020.859582808315, 7031.929680703179, 7047.506674532785, 7048.964755176191, 4806.086843499724, 4845.733484658307, 4847.903041939141, 4855.635827312895, 4862.367892173995, 4914.557689807934, 4918.926216106761, 4923.359963204761, 4923.556879880828, 4937.1113199624415, 5551.3893471718075, 5608.915866262009, 5630.155476678531, 5641.971790141023, 5650.576206784508, 6742.6291553965, 6753.35843094915, 6758.357955994173, 6764.154480689914, 6766.627835469097, 1643.4576589725361, 1689.3918189451788, 1689.4931520543787, 1692.7968643762827, 1717.175755637276, 1095.085603521053, 1099.290957332516, 1109.3233127792041, 1113.0983903038564, 1121.9158563107637, 6268.185135932391, 6286.937130628727, 6322.841928951813, 6329.873402531924, 6336.035828893058, 6777.491688123312, 6821.113255276782, 6834.589924604539, 6861.897071543931, 6877.759278425231, 6108.205933228741, 6236.376362363727, 6288.402601752826, 6290.685465726695, 6301.8109456716375, 3722.2555488901785, 3736.439534069911, 3742.7567208131386, 3746.2882052409955, 3751.868684596026, 7129.89305160423, 7133.82165445868, 7135.215126336099, 7137.964310178416, 7141.678624461808, 6973.79078627642, 7032.45286037071, 7033.613151276729, 7045.788626341218, 7058.153021637334, 7408.481406301615, 7417.184109747924, 7419.07261592301, 7423.665935032936, 7426.888596670946, 7095.929040709527, 7098.219195888551, 7111.857762844817, 7112.857742845217, 7117.288271172842, 6857.314268573302, 6958.408535274559, 6982.301769823181, 6986.371226589631, 6987.615681137586, 7347.26527347261, 7368.59472729005, 7385.630718464163, 7386.48294619393, 7387.593682347522, 4735.052989402202, 4755.096531658974, 4760.047990401864, 4772.997670489236, 4779.330893674819, 6900.896486552806, 6956.130483689539, 6996.860062798613, 7084.25615310385, 7104.502684812013, 6793.72825086991, 6852.965735171292, 6863.588184708933, 6869.828254293682, 6895.620740859301, 6796.898046529207, 6845.281245469353, 6852.211995620368, 6862.4853136014, 6870.62211578368, 6610.6694665267505, 6693.8326541834895, 6711.295313992156, 6751.426128779109, 6764.154480689914, 6867.381935625817, 6895.34494223048, 6925.203601585882, 6929.0, 6934.791956241321, 6659.134312539339, 6671.766488172891, 6679.799606011828, 6693.497987651043, 6697.631630260383], "unit": "score", "name": "prototype.html", "value": 5083.0367175650545}, {"lowerIsBetter": false, "replicates": [722.2777222777223, 786.7600381883527, 824.9092599814023, 832.3632421197784, 855.2431098477846, 12121.57574484892, 12127.575534856282, 12197.329146896916, 12201.206921550103, 12275.44760485778, 11801.232919860204, 11803.291802491856, 11835.171537992344, 11842.526298948032, 11847.111466640015, 719.9460040496971, 730.4156674660277, 801.1187693537091, 819.1399031017407, 826.4586695714316, 807.2008711375726, 815.2214635023538, 821.0065820357374, 823.8475881961856, 824.8680211166185, 804.5856383962264, 812.9552874591895, 815.2906970935295, 817.4645607127311, 864.4726716702806, 797.2904115337354, 798.5448294472153, 800.3277247112395, 807.2049031703767, 848.7029539661131, 615.3907631444882, 618.0420348459915, 619.2507066449601, 619.9473044791198, 622.1414448061646, 13686.247256400893, 13716.245606491639, 13716.519921802788, 13722.794158087636, 13769.586912392644, 12340.074494412866, 12392.876071239263, 12623.305718185497, 12706.496703994932, 12807.359632018362, 10379.740506487322, 10431.582736690523, 10495.842562361571, 10496.317739346918, 10558.52486638103, 3516.841742121611, 3517.929641407183, 3542.415501442259, 3648.9817550912076, 3675.246574452231, 47648.0, 47655.76172119117, 47840.52159478395, 48020.519794801956, 48771.512284877055, 9167.358284920125, 9447.811043779086, 9449.90550094504, 9490.478023708623, 9713.854292185622, 17118.914405428142, 17167.227474763666, 17283.13584320779, 17674.0, 17957.461276161735, 7449.068866391701, 7463.067116610424, 7641.656125474367, 7779.7666070017995, 7883.526988380716, 4281.486221653359, 4298.247806633826, 4331.761753103609, 4352.129574085196, 4362.716423432466, 3040.619922509686, 3062.372213696187, 3070.171053815502, 3081.768867334959, 3086.768492363082, 579.9884002320015, 583.9328477225089, 587.6738410182389, 596.2963702830615, 604.7399618164144, 567.3220501500749, 581.2676028204493, 645.9806205813833, 675.9121314229119, 718.8382613911828, 8337.207965243293, 8922.68770593026, 8956.820863582821, 9023.097690230925, 9175.77060573491, 619.6839611797925, 673.9284537585165, 699.552286536617, 701.1340993872564, 709.8048036789924, 3730.2166545025307, 3757.5678796938155, 3788.1855401088897, 3801.790901500389, 3878.185581028016, 55919.440805591425, 56095.15857262144, 56617.0, 56626.43373566212, 58133.418665813646, 49537.0, 50267.0, 50531.24203136956, 51072.744636277326, 51207.48792512027, 45684.543154568026, 46189.5381046192, 46330.536694633294, 46833.29750053752, 46910.76544617323, 7592.696292148252, 7645.847083058419, 8588.141185881363, 8664.740057798275, 8772.429792063496, 31189.0, 31802.52296215605, 33332.0, 34949.65050349464, 35277.47083793694, 42449.0, 43595.78202108969, 43598.56401435945, 43925.0, 44094.559054409045, 10129.949350253202, 10698.518566664363, 10734.785304294026, 10823.729406764895, 10965.287256328313, 10467.162626989975, 10475.476226188812, 10557.68326950162, 10632.255742098288, 11272.929071738172, 10446.738831529272, 10540.472976351306, 10580.41807700553, 10656.520456579628, 10696.41169735672, 10545.050945414949, 10625.362478251329, 10739.194560407845, 11172.944135279271, 11260.7747845041, 10571.577136914437, 10781.460926953465, 10792.622258220925, 11133.88866111361, 11163.44182790841, 8196.38527110481, 8370.874436883574, 8502.532360720219, 8553.700620478254, 8782.780430489289, 8918.331125165769, 8934.0, 9058.682946096855, 9102.0, 9313.299143248381], "unit": "score", "name": "yui.html", "value": 6143.181955280951}], "name": "dromaeo_css", "value": 6860.553283043902}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 110.0, 122.0, 111.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [148.0, 128.0, 146.0, 171.0, 126.0, 160.0, 154.0, 130.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 166.0, 172.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 71.0, 71.0, 72.0, 77.0, 147.0, 73.0, 75.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 150.0, 96.0, 96.0, 97.0, 141.0, 97.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 113.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 57.0, 60.0, 58.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 85.0, 83.0, 84.0, 82.0, 82.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 121.0, 118.0, 116.0, 117.0, 121.0, 119.0, 116.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [136.0, 142.0, 154.0, 132.0, 143.0, 131.0, 147.0, 138.0, 140.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 66.0, 68.0, 65.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1499.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.39203213927016], "unit": "score", "name": "Richards", "value": 210.89414799999994}, {"lowerIsBetter": false, "replicates": [188.28845791752966], "unit": "score", "name": "DeltaBlue", "value": 351.152698}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [704.2253521126761], "unit": "score", "name": "Earley", "value": 946.3774600000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [41120.0], "unit": "score", "name": "RegExp", "value": 22.154304474708184}, {"lowerIsBetter": false, "replicates": [589.622641509434], "unit": "score", "name": "Splay", "value": 138.208736}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20401.364395457345}]} 07:14:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20401.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6860.55"}}} 07:14:47 INFO - Return code: 0 07:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:14:47 INFO - # TBPL SUCCESS # 07:14:47 INFO - Running post-action listener: _resource_record_post_action 07:14:47 INFO - Running post-run listener: _resource_record_post_run 07:14:48 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 479199232; Read time: 156; Write time: 330552 07:14:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98308096; Read time: 156; Write time: 112456 07:14:48 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 314339328; Read time: 0; Write time: 198556 07:14:48 INFO - Running post-run listener: _upload_blobber_files 07:14:48 INFO - Blob upload gear active. 07:14:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:14:48 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:14:48 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:14:48 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:14:48 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:14:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:49 INFO - (blobuploader) - INFO - Done attempting. 07:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:50 INFO - (blobuploader) - INFO - Done attempting. 07:14:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:50 INFO - Return code: 0 07:14:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:14:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fb7ab27ee6afe86c5fa6e02ea26c8d03d1e6bebbcf48cfacd03e8733a2d1085f0e11173578049a9ee08566c8ae8aa10c3d496077c76d8c8529a41a2017d043", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bcf46cf267e4d10ae9671ba9575f82ff326290e3c72f1532a1a65da17faed4db3cb64a18ca26cb9e5c3666bbba1473a9f04167f83718347a8026552fad44590"} 07:14:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:14:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:14:50 INFO - Contents: 07:14:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fb7ab27ee6afe86c5fa6e02ea26c8d03d1e6bebbcf48cfacd03e8733a2d1085f0e11173578049a9ee08566c8ae8aa10c3d496077c76d8c8529a41a2017d043", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bcf46cf267e4d10ae9671ba9575f82ff326290e3c72f1532a1a65da17faed4db3cb64a18ca26cb9e5c3666bbba1473a9f04167f83718347a8026552fad44590"} 07:14:50 INFO - Copying logs to upload dir... 07:14:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.017856 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-14 07:14:50.211385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 07:14:50.215020) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 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/a1fb7ab27ee6afe86c5fa6e02ea26c8d03d1e6bebbcf48cfacd03e8733a2d1085f0e11173578049a9ee08566c8ae8aa10c3d496077c76d8c8529a41a2017d043", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bcf46cf267e4d10ae9671ba9575f82ff326290e3c72f1532a1a65da17faed4db3cb64a18ca26cb9e5c3666bbba1473a9f04167f83718347a8026552fad44590"} build_url:https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011558 build_url: 'https://queue.taskcluster.net/v1/task/Z2UYw1vNSHuykaEY5xMedw/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/a1fb7ab27ee6afe86c5fa6e02ea26c8d03d1e6bebbcf48cfacd03e8733a2d1085f0e11173578049a9ee08566c8ae8aa10c3d496077c76d8c8529a41a2017d043", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bcf46cf267e4d10ae9671ba9575f82ff326290e3c72f1532a1a65da17faed4db3cb64a18ca26cb9e5c3666bbba1473a9f04167f83718347a8026552fad44590"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 07:14:50.240170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:14:50.240559) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452780037.339693-1486785960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 07:14:50.324826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 07:14:50.325194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 07:14:50.325524) ========= ========= Total master_lag: 0.28 =========