builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1450464637.65 results: success (0) buildid: 20151218083105 builduid: 63f2ebf6e9be46459b75620663a90ea4 revision: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.648550) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.648970) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.649281) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.688157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.688449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.739801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.740341) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.796081) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.796350) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.796671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.796933) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 10:50:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.8M=0s 2015-12-18 10:50:38 (60.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.921551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.921824) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021015 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.982248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:37.982560) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 --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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 10:50:38,406 truncating revision to first 12 chars 2015-12-18 10:50:38,406 Setting DEBUG logging. 2015-12-18 10:50:38,406 attempt 1/10 2015-12-18 10:50:38,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2a25cd6b592f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 10:50:38,637 unpacking tar archive at: fx-team-2a25cd6b592f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.513051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.513370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.564582) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.564885) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 10:50:38.565291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-18 10:50:38.565562) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:39 INFO - MultiFileLogger online at 20151218 10:50:39 in /builds/slave/test-pgo 10:50:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:50:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:50:39 INFO - {'append_to_log': False, 10:50:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:50:39 INFO - 'blob_upload_branch': 'Fx-Team', 10:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:50:39 INFO - 'branch': 'Fx-Team', 10:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:39 INFO - 'config_files': ('talos/linux_config.py',), 10:50:39 INFO - 'default_actions': ('clobber', 10:50:39 INFO - 'read-buildbot-config', 10:50:39 INFO - 'download-and-extract', 10:50:39 INFO - 'populate-webroot', 10:50:39 INFO - 'create-virtualenv', 10:50:39 INFO - 'install', 10:50:39 INFO - 'run-tests'), 10:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:39 INFO - 'download_minidump_stackwalk': True, 10:50:39 INFO - 'download_symbols': 'ondemand', 10:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:39 INFO - 'installer_path': 'installer.exe', 10:50:39 INFO - 'log_level': 'info', 10:50:39 INFO - 'log_name': 'talos', 10:50:39 INFO - 'log_to_console': True, 10:50:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:39 INFO - 'opt_config_files': (), 10:50:39 INFO - 'pip_index': False, 10:50:39 INFO - 'sps_profile': False, 10:50:39 INFO - 'sps_profile_interval': 0, 10:50:39 INFO - 'suite': 'dromaeojs', 10:50:39 INFO - 'system_bits': '64', 10:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:39 INFO - 'title': 'talos-linux64-ix-036', 10:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:39 INFO - 'use_talos_json': True, 10:50:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:39 INFO - 'work_dir': 'build'} 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running clobber step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: clobber 10:50:39 INFO - rmtree: /builds/slave/test-pgo/build 10:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:50:39 INFO - Running post-action listener: _resource_record_post_action 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running read-buildbot-config step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: read_buildbot_config 10:50:39 INFO - Using buildbot properties: 10:50:39 INFO - { 10:50:39 INFO - "project": "", 10:50:39 INFO - "product": "firefox", 10:50:39 INFO - "script_repo_revision": "production", 10:50:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:50:39 INFO - "repository": "", 10:50:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:50:39 INFO - "buildid": "20151218083105", 10:50:39 INFO - "pgo_build": "True", 10:50:39 INFO - "basedir": "/builds/slave/test-pgo", 10:50:39 INFO - "buildnumber": 843, 10:50:39 INFO - "slavename": "talos-linux64-ix-036", 10:50:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:50:39 INFO - "platform": "ubuntu64_hw", 10:50:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:50:39 INFO - "branch": "fx-team", 10:50:39 INFO - "repo_path": "integration/fx-team", 10:50:39 INFO - "revision": "2a25cd6b592f4f3b942d3fb8476ce10a0e071d65", 10:50:39 INFO - "stage_platform": "linux64-pgo", 10:50:39 INFO - "builduid": "63f2ebf6e9be46459b75620663a90ea4", 10:50:39 INFO - "slavebuilddir": "test" 10:50:39 INFO - } 10:50:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:50:39 INFO - Running post-action listener: _resource_record_post_action 10:50:39 INFO - ##### 10:50:39 INFO - ##### Running download-and-extract step. 10:50:39 INFO - ##### 10:50:39 INFO - Running pre-action listener: _resource_record_pre_action 10:50:39 INFO - Running main action method: download_and_extract 10:50:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:39 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json 10:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json 10:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:50:50 INFO - Downloaded 1302 bytes. 10:50:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:50:50 INFO - Using the following test package requirements: 10:50:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'jsshell-linux-x86_64.zip'], 10:50:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:50 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:56 INFO - Downloaded 23120938 bytes. 10:50:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:50:57 INFO - Return code: 0 10:50:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:50: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')]} 10:50:57 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:59 INFO - Downloaded 23120938 bytes. 10:50:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:50:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:50:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:51:01 INFO - Return code: 0 10:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:01 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:51:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:51:02 INFO - Downloaded 11132039 bytes. 10:51:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:51:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:51:02 INFO - Return code: 0 10:51: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')]} 10:51:02 INFO - https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:51:04 INFO - Downloaded 54647542 bytes. 10:51:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:51:04 INFO - mkdir: /builds/slave/test-pgo/properties 10:51:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:51:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:51:04 INFO - Contents: 10:51:04 INFO - build_url:https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:51:04 INFO - Running post-action listener: _resource_record_post_action 10:51:04 INFO - Running post-action listener: set_extra_try_arguments 10:51:04 INFO - ##### 10:51:04 INFO - ##### Running populate-webroot step. 10:51:04 INFO - ##### 10:51:04 INFO - Running pre-action listener: _resource_record_pre_action 10:51:04 INFO - Running main action method: populate_webroot 10:51:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:04 INFO - '--tppagecycles', 10:51:04 INFO - '7'], 10:51:04 INFO - 'tests': ['tsvgm']}}, 10:51:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:51:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:51:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:51:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'tests': ['damp', 'tps']}, 10:51:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['damp', 'tps']}, 10:51:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:51:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:04 INFO - 'other': {'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'other_l64': {'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'other_nol64': {'tests': ['a11yr', 10:51:04 INFO - 'ts_paint', 10:51:04 INFO - 'tpaint', 10:51:04 INFO - 'sessionrestore', 10:51:04 INFO - 'sessionrestore_no_auto_restore']}, 10:51:04 INFO - 'svgr': {'tests': ['tsvgx', 10:51:04 INFO - 'tsvgr_opacity', 10:51:04 INFO - 'tart', 10:51:04 INFO - 'tscrollx', 10:51:04 INFO - 'cart']}, 10:51:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['tsvgx', 10:51:04 INFO - 'tsvgr_opacity', 10:51:04 INFO - 'tart', 10:51:04 INFO - 'tscrollx', 10:51:04 INFO - 'cart']}, 10:51:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'tests': ['tp5o']}, 10:51:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'talos_options': ['--e10s'], 10:51:04 INFO - 'tests': ['tp5o']}, 10:51:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'talos_options': ['--xperf_path', 10:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:04 INFO - 'tests': ['tp5n']}, 10:51:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:04 INFO - 'talos_options': ['--e10s', 10:51:04 INFO - '--xperf_path', 10:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:04 INFO - 'tests': ['tp5n']}}, 10:51:04 INFO - 'talos.zip': {'path': '', 10:51:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:04 INFO - Running post-action listener: _resource_record_post_action 10:51:04 INFO - ##### 10:51:04 INFO - ##### Running create-virtualenv step. 10:51:04 INFO - ##### 10:51:04 INFO - Running pre-action listener: _resource_record_pre_action 10:51:04 INFO - Running main action method: create_virtualenv 10:51:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:51:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:51:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:51:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:04 INFO - Using real prefix '/usr' 10:51:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:06 INFO - Installing pip.................done. 10:51:06 INFO - Return code: 0 10:51:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:06 INFO - Using env: {'DISPLAY': ':0', 10:51:06 INFO - 'HOME': '/home/cltbld', 10:51:06 INFO - 'LANG': 'en_US.UTF-8', 10:51:06 INFO - 'LANGUAGE': 'en_US:en', 10:51:06 INFO - 'LOGNAME': 'cltbld', 10:51:06 INFO - 'MAIL': '/var/mail/cltbld', 10:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:06 INFO - 'MOZ_NO_REMOTE': '1', 10:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:06 INFO - 'NO_EM_RESTART': '1', 10:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:06 INFO - 'SHELL': '/bin/bash', 10:51:06 INFO - 'SHLVL': '1', 10:51:06 INFO - 'TERM': 'linux', 10:51:06 INFO - 'TMOUT': '86400', 10:51:06 INFO - 'USER': 'cltbld', 10:51:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:06 INFO - '_': '/tools/buildbot/bin/python'} 10:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:51:07 INFO - Cleaning up... 10:51:07 INFO - Return code: 0 10:51:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:07 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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:51:07 INFO - Using env: {'DISPLAY': ':0', 10:51:07 INFO - 'HOME': '/home/cltbld', 10:51:07 INFO - 'LANG': 'en_US.UTF-8', 10:51:07 INFO - 'LANGUAGE': 'en_US:en', 10:51:07 INFO - 'LOGNAME': 'cltbld', 10:51:07 INFO - 'MAIL': '/var/mail/cltbld', 10:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:07 INFO - 'MOZ_NO_REMOTE': '1', 10:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:07 INFO - 'NO_EM_RESTART': '1', 10:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:07 INFO - 'SHELL': '/bin/bash', 10:51:07 INFO - 'SHLVL': '1', 10:51:07 INFO - 'TERM': 'linux', 10:51:07 INFO - 'TMOUT': '86400', 10:51:07 INFO - 'USER': 'cltbld', 10:51:07 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:07 INFO - '_': '/tools/buildbot/bin/python'} 10:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:07 INFO - Downloading/unpacking psutil>=0.7.1 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:51:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:09 INFO - Installing collected packages: psutil 10:51:09 INFO - Running setup.py install for psutil 10:51:09 INFO - building 'psutil._psutil_linux' extension 10:51:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:51:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:51:09 INFO - building 'psutil._psutil_posix' extension 10:51:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:51:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:09 INFO - Successfully installed psutil 10:51:09 INFO - Cleaning up... 10:51:09 INFO - Return code: 0 10:51:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:51: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')]} 10:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '--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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:51:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:51:09 INFO - Using env: {'DISPLAY': ':0', 10:51:09 INFO - 'HOME': '/home/cltbld', 10:51:09 INFO - 'LANG': 'en_US.UTF-8', 10:51:09 INFO - 'LANGUAGE': 'en_US:en', 10:51:09 INFO - 'LOGNAME': 'cltbld', 10:51:09 INFO - 'MAIL': '/var/mail/cltbld', 10:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:09 INFO - 'MOZ_NO_REMOTE': '1', 10:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:09 INFO - 'NO_EM_RESTART': '1', 10:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:09 INFO - 'SHELL': '/bin/bash', 10:51:09 INFO - 'SHLVL': '1', 10:51:09 INFO - 'TERM': 'linux', 10:51:09 INFO - 'TMOUT': '86400', 10:51:09 INFO - 'USER': 'cltbld', 10:51:09 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:09 INFO - '_': '/tools/buildbot/bin/python'} 10:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:51:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:51:11 INFO - Installing collected packages: mozsystemmonitor 10:51:11 INFO - Running setup.py install for mozsystemmonitor 10:51:11 INFO - Successfully installed mozsystemmonitor 10:51:11 INFO - Cleaning up... 10:51:11 INFO - Return code: 0 10:51:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:51:11 INFO - Using env: {'DISPLAY': ':0', 10:51:11 INFO - 'HOME': '/home/cltbld', 10:51:11 INFO - 'LANG': 'en_US.UTF-8', 10:51:11 INFO - 'LANGUAGE': 'en_US:en', 10:51:11 INFO - 'LOGNAME': 'cltbld', 10:51:11 INFO - 'MAIL': '/var/mail/cltbld', 10:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:11 INFO - 'MOZ_NO_REMOTE': '1', 10:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:11 INFO - 'NO_EM_RESTART': '1', 10:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:11 INFO - 'SHELL': '/bin/bash', 10:51:11 INFO - 'SHLVL': '1', 10:51:11 INFO - 'TERM': 'linux', 10:51:11 INFO - 'TMOUT': '86400', 10:51:11 INFO - 'USER': 'cltbld', 10:51:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:11 INFO - '_': '/tools/buildbot/bin/python'} 10:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:51:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:51:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:14 INFO - Downloading docopt-0.6.1.tar.gz 10:51:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:51:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:14 INFO - Running setup.py install for blobuploader 10:51:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:51:14 INFO - Running setup.py install for requests 10:51:14 INFO - Running setup.py install for docopt 10:51:14 INFO - Successfully installed blobuploader requests docopt 10:51:14 INFO - Cleaning up... 10:51:15 INFO - Return code: 0 10:51:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:15 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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:51:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:15 INFO - Using env: {'DISPLAY': ':0', 10:51:15 INFO - 'HOME': '/home/cltbld', 10:51:15 INFO - 'LANG': 'en_US.UTF-8', 10:51:15 INFO - 'LANGUAGE': 'en_US:en', 10:51:15 INFO - 'LOGNAME': 'cltbld', 10:51:15 INFO - 'MAIL': '/var/mail/cltbld', 10:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:15 INFO - 'MOZ_NO_REMOTE': '1', 10:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:15 INFO - 'NO_EM_RESTART': '1', 10:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:15 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:15 INFO - 'SHELL': '/bin/bash', 10:51:15 INFO - 'SHLVL': '1', 10:51:15 INFO - 'TERM': 'linux', 10:51:15 INFO - 'TMOUT': '86400', 10:51:15 INFO - 'USER': 'cltbld', 10:51:15 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:15 INFO - '_': '/tools/buildbot/bin/python'} 10:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:15 INFO - Running setup.py (path:/tmp/pip-wQWgac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:15 INFO - Running setup.py (path:/tmp/pip-5vpj4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:15 INFO - Running setup.py (path:/tmp/pip-2PncBp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:15 INFO - Running setup.py (path:/tmp/pip-qo999d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:15 INFO - Running setup.py (path:/tmp/pip-TDQIoX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:15 INFO - Running setup.py (path:/tmp/pip-yZoN3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:15 INFO - Running setup.py (path:/tmp/pip-tf8MTa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:15 INFO - Running setup.py (path:/tmp/pip-YpipwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:15 INFO - Running setup.py (path:/tmp/pip-F_3Rfy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:15 INFO - Running setup.py (path:/tmp/pip-3jWqeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:15 INFO - Running setup.py (path:/tmp/pip-P1VOgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:16 INFO - Running setup.py (path:/tmp/pip-zYCRY2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:16 INFO - Running setup.py (path:/tmp/pip-YvPnl_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:16 INFO - Running setup.py (path:/tmp/pip-lblJiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:16 INFO - Running setup.py (path:/tmp/pip-hUYp0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:16 INFO - Running setup.py (path:/tmp/pip-gooNxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:16 INFO - Running setup.py (path:/tmp/pip-k0UqI4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:16 INFO - Running setup.py install for manifestparser 10:51:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:51:16 INFO - Running setup.py install for mozcrash 10:51:16 INFO - Running setup.py install for mozdebug 10:51:16 INFO - Running setup.py install for mozdevice 10:51:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:51:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:51:16 INFO - Running setup.py install for mozfile 10:51:17 INFO - Running setup.py install for mozhttpd 10:51:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozinfo 10:51:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozInstall 10:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozleak 10:51:17 INFO - Running setup.py install for mozlog 10:51:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for moznetwork 10:51:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozprocess 10:51:17 INFO - Running setup.py install for mozprofile 10:51:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozrunner 10:51:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:51:17 INFO - Running setup.py install for mozscreenshot 10:51:18 INFO - Running setup.py install for moztest 10:51:18 INFO - Running setup.py install for mozversion 10:51:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:18 INFO - Cleaning up... 10:51:18 INFO - Return code: 0 10:51:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:18 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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:51:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:18 INFO - Using env: {'DISPLAY': ':0', 10:51:18 INFO - 'HOME': '/home/cltbld', 10:51:18 INFO - 'LANG': 'en_US.UTF-8', 10:51:18 INFO - 'LANGUAGE': 'en_US:en', 10:51:18 INFO - 'LOGNAME': 'cltbld', 10:51:18 INFO - 'MAIL': '/var/mail/cltbld', 10:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:18 INFO - 'MOZ_NO_REMOTE': '1', 10:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:18 INFO - 'NO_EM_RESTART': '1', 10:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:18 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:18 INFO - 'SHELL': '/bin/bash', 10:51:18 INFO - 'SHLVL': '1', 10:51:18 INFO - 'TERM': 'linux', 10:51:18 INFO - 'TMOUT': '86400', 10:51:18 INFO - 'USER': 'cltbld', 10:51:18 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:18 INFO - '_': '/tools/buildbot/bin/python'} 10:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:18 INFO - Running setup.py (path:/tmp/pip-vnGwQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:18 INFO - Running setup.py (path:/tmp/pip-kPprqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:18 INFO - Running setup.py (path:/tmp/pip-Dn57Wn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:18 INFO - Running setup.py (path:/tmp/pip-UVjmag-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:18 INFO - Running setup.py (path:/tmp/pip-P3wILl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:18 INFO - Running setup.py (path:/tmp/pip-dnGdOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:51:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:18 INFO - Running setup.py (path:/tmp/pip-Vetadi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:19 INFO - Running setup.py (path:/tmp/pip-aU3mc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:19 INFO - Running setup.py (path:/tmp/pip-7NaURh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:19 INFO - Running setup.py (path:/tmp/pip-RlmCF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:19 INFO - Running setup.py (path:/tmp/pip-MJC0x4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:19 INFO - Running setup.py (path:/tmp/pip-tYXQeY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:19 INFO - Running setup.py (path:/tmp/pip-RBxWb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:19 INFO - Running setup.py (path:/tmp/pip-7TvsyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:19 INFO - Running setup.py (path:/tmp/pip-6lkkq8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:19 INFO - Running setup.py (path:/tmp/pip-vO1Cen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:51:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:19 INFO - Running setup.py (path:/tmp/pip-r_wXHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:51:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:21 INFO - Downloading blessings-1.5.1.tar.gz 10:51:21 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:51:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:21 INFO - Installing collected packages: blessings 10:51:21 INFO - Running setup.py install for blessings 10:51:21 INFO - Successfully installed blessings 10:51:21 INFO - Cleaning up... 10:51:21 INFO - Return code: 0 10:51:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:51:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:21 INFO - Reading from file tmpfile_stdout 10:51:21 INFO - Current package versions: 10:51:21 INFO - argparse == 1.2.1 10:51:21 INFO - blessings == 1.5.1 10:51:21 INFO - blobuploader == 1.2.4 10:51:21 INFO - docopt == 0.6.1 10:51:21 INFO - manifestparser == 1.1 10:51:21 INFO - mozInstall == 1.12 10:51:21 INFO - mozcrash == 0.16 10:51:21 INFO - mozdebug == 0.1 10:51:21 INFO - mozdevice == 0.47 10:51:21 INFO - mozfile == 1.2 10:51:21 INFO - mozhttpd == 0.7 10:51:21 INFO - mozinfo == 0.9 10:51:21 INFO - mozleak == 0.1 10:51:21 INFO - mozlog == 3.1 10:51:21 INFO - moznetwork == 0.27 10:51:21 INFO - mozprocess == 0.22 10:51:21 INFO - mozprofile == 0.27 10:51:21 INFO - mozrunner == 6.11 10:51:21 INFO - mozscreenshot == 0.1 10:51:21 INFO - mozsystemmonitor == 0.0 10:51:21 INFO - moztest == 0.7 10:51:21 INFO - mozversion == 1.4 10:51:21 INFO - psutil == 3.1.1 10:51:21 INFO - requests == 1.2.3 10:51:21 INFO - wsgiref == 0.1.2 10:51:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:51:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:51:21 INFO - Using env: {'DISPLAY': ':0', 10:51:21 INFO - 'HOME': '/home/cltbld', 10:51:21 INFO - 'LANG': 'en_US.UTF-8', 10:51:21 INFO - 'LANGUAGE': 'en_US:en', 10:51:21 INFO - 'LOGNAME': 'cltbld', 10:51:21 INFO - 'MAIL': '/var/mail/cltbld', 10:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:21 INFO - 'MOZ_NO_REMOTE': '1', 10:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:21 INFO - 'NO_EM_RESTART': '1', 10:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:21 INFO - 'SHELL': '/bin/bash', 10:51:21 INFO - 'SHLVL': '1', 10:51:21 INFO - 'TERM': 'linux', 10:51:21 INFO - 'TMOUT': '86400', 10:51:21 INFO - 'USER': 'cltbld', 10:51:21 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:21 INFO - '_': '/tools/buildbot/bin/python'} 10:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:22 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 1)) 10:51:22 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 2)) 10:51:22 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 3)) 10:51:22 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 4)) 10:51:22 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 5)) 10:51:22 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 6)) 10:51:22 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 7)) 10:51:22 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 8)) 10:51:22 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:51:22 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 3)) 10:51:22 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:51:22 INFO - Cleaning up... 10:51:22 INFO - Return code: 0 10:51:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:51:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:51:22 INFO - Using env: {'DISPLAY': ':0', 10:51:22 INFO - 'HOME': '/home/cltbld', 10:51:22 INFO - 'LANG': 'en_US.UTF-8', 10:51:22 INFO - 'LANGUAGE': 'en_US:en', 10:51:22 INFO - 'LOGNAME': 'cltbld', 10:51:22 INFO - 'MAIL': '/var/mail/cltbld', 10:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:22 INFO - 'MOZ_NO_REMOTE': '1', 10:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:22 INFO - 'NO_EM_RESTART': '1', 10:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:22 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:22 INFO - 'SHELL': '/bin/bash', 10:51:22 INFO - 'SHLVL': '1', 10:51:22 INFO - 'TERM': 'linux', 10:51:22 INFO - 'TMOUT': '86400', 10:51:22 INFO - 'USER': 'cltbld', 10:51:22 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:22 INFO - '_': '/tools/buildbot/bin/python'} 10:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:22 INFO - Downloading/unpacking jsonschema 10:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:51:24 INFO - Downloading/unpacking functools32 (from jsonschema) 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:51:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:24 INFO - warning: no files found matching '*.txt' 10:51:24 INFO - no previously-included directories found matching 'build' 10:51:24 INFO - no previously-included directories found matching 'dist' 10:51:24 INFO - no previously-included directories found matching '.git*' 10:51:24 INFO - Installing collected packages: jsonschema, functools32 10:51:24 INFO - Running setup.py install for functools32 10:51:24 INFO - warning: no files found matching '*.txt' 10:51:24 INFO - no previously-included directories found matching 'build' 10:51:24 INFO - no previously-included directories found matching 'dist' 10:51:24 INFO - no previously-included directories found matching '.git*' 10:51:24 INFO - Successfully installed jsonschema functools32 10:51:24 INFO - Cleaning up... 10:51:24 INFO - Return code: 0 10:51:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:24 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 0x7f369389ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee3600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:51:24 INFO - Using env: {'DISPLAY': ':0', 10:51:24 INFO - 'HOME': '/home/cltbld', 10:51:24 INFO - 'LANG': 'en_US.UTF-8', 10:51:24 INFO - 'LANGUAGE': 'en_US:en', 10:51:24 INFO - 'LOGNAME': 'cltbld', 10:51:24 INFO - 'MAIL': '/var/mail/cltbld', 10:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:24 INFO - 'MOZ_NO_REMOTE': '1', 10:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:24 INFO - 'NO_EM_RESTART': '1', 10:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:24 INFO - 'SHELL': '/bin/bash', 10:51:24 INFO - 'SHLVL': '1', 10:51:24 INFO - 'TERM': 'linux', 10:51:24 INFO - 'TMOUT': '86400', 10:51:24 INFO - 'USER': 'cltbld', 10:51:24 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:24 INFO - '_': '/tools/buildbot/bin/python'} 10:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:24 INFO - Downloading/unpacking flake8 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:51:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:51:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:51:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:51:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:27 INFO - no previously-included directories found matching 'docs/_build' 10:51:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:51:27 INFO - Running setup.py install for pep8 10:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:27 INFO - no previously-included directories found matching 'docs/_build' 10:51:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:51:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:51:27 INFO - Cleaning up... 10:51:27 INFO - Return code: 0 10:51:27 INFO - Running post-action listener: _resource_record_post_action 10:51:27 INFO - Running post-action listener: _start_resource_monitoring 10:51:27 INFO - Starting resource monitoring. 10:51:27 INFO - ##### 10:51:27 INFO - ##### Running install step. 10:51:27 INFO - ##### 10:51:27 INFO - Running pre-action listener: _resource_record_pre_action 10:51:27 INFO - Running main action method: install 10:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:51:27 INFO - Reading from file tmpfile_stdout 10:51:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:51:27 INFO - Reading from file tmpfile_stdout 10:51:27 INFO - Output received: 10:51:27 INFO - Usage: mozinstall [options] installer 10:51:27 INFO - Options: 10:51:27 INFO - -h, --help show this help message and exit 10:51:27 INFO - -d DEST, --destination=DEST 10:51:27 INFO - Directory to install application into. [default: 10:51:27 INFO - "/builds/slave/test-pgo"] 10:51:27 INFO - --app=APP Application being installed. [default: firefox] 10:51:27 INFO - mkdir: /builds/slave/test-pgo/build/application 10:51:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:51:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:51:43 INFO - Reading from file tmpfile_stdout 10:51:43 INFO - Output received: 10:51:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:51:43 INFO - Running post-action listener: _resource_record_post_action 10:51:43 INFO - ##### 10:51:43 INFO - ##### Running run-tests step. 10:51:43 INFO - ##### 10:51:43 INFO - Running pre-action listener: _resource_record_pre_action 10:51:43 INFO - Running main action method: run_tests 10:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:51:43 INFO - Python 2.7.3 10:51:43 INFO - Return code: 0 10:51:43 INFO - grabbing minidump binary from tooltool 10:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:43 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 0xf72350>, '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 0xf73250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf736e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:51:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:51:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:51:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:43 INFO - Return code: 0 10:51:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:51:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:51:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:51:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:51:44 INFO - Return code: 0 10:51:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:51:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 10:51:44 INFO - Using env: {'DISPLAY': ':0', 10:51:44 INFO - 'HOME': '/home/cltbld', 10:51:44 INFO - 'LANG': 'en_US.UTF-8', 10:51:44 INFO - 'LANGUAGE': 'en_US:en', 10:51:44 INFO - 'LOGNAME': 'cltbld', 10:51:44 INFO - 'MAIL': '/var/mail/cltbld', 10:51:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:44 INFO - 'MOZ_NO_REMOTE': '1', 10:51:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:44 INFO - 'NO_EM_RESTART': '1', 10:51:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:51:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:51:44 INFO - 'SHELL': '/bin/bash', 10:51:44 INFO - 'SHLVL': '1', 10:51:44 INFO - 'TERM': 'linux', 10:51:44 INFO - 'TMOUT': '86400', 10:51:44 INFO - 'USER': 'cltbld', 10:51:44 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153', 10:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:44 INFO - '_': '/tools/buildbot/bin/python'} 10:51:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 10:51:44 INFO - mozversion INFO | application_buildid: 20151218083105 10:51:44 INFO - mozversion INFO | application_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 10:51:44 INFO - mozversion INFO | application_display_name: Nightly 10:51:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:44 INFO - mozversion INFO | application_name: Firefox 10:51:44 INFO - mozversion INFO | application_remotingname: firefox 10:51:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:51:44 INFO - mozversion INFO | application_vendor: Mozilla 10:51:44 INFO - mozversion INFO | application_version: 46.0a1 10:51:44 INFO - mozversion INFO | platform_buildid: 20151218083105 10:51:44 INFO - mozversion INFO | platform_changeset: 2a25cd6b592f4f3b942d3fb8476ce10a0e071d65 10:51:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:51:44 INFO - mozversion INFO | platform_version: 46.0a1 10:51:44 INFO - 2015-12-18 10:51:44,562 DEBUG : using testdate: 1450464704 10:51:44 INFO - 2015-12-18 10:51:44,562 DEBUG : actual date: 1450464704 10:51:44 INFO - 2015-12-18 10:51:44,570 INFO : starting webserver on 'localhost:47238' 10:51:44 INFO - 2015-12-18 10:51:44,571 INFO : Starting test suite talos-linux64-ix-036 10:51:44 INFO - 2015-12-18 10:51:44,571 INFO : Starting test dromaeo_css 10:51:44 INFO - 2015-12-18 10:51:44,571 DEBUG : operating with platform_type : linux_ 10:51:44 INFO - 2015-12-18 10:51:44,572 INFO : Initialising browser for dromaeo_css test... 10:51:44 INFO - 2015-12-18 10:51:44,589 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkc4C5C/profile http://localhost:47238/getInfo.html 10:51:48 INFO - 2015-12-18 10:51:48,928 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:51:48 INFO - 2015-12-18 10:51:48,928 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:51:48 INFO - 2015-12-18 10:51:48,928 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:51:48 INFO - 2015-12-18 10:51:48,928 DEBUG : BROWSER_OUTPUT: __metrics 10:51:49 INFO - 2015-12-18 10:51:49,037 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:51:49 INFO - 2015-12-18 10:51:49,093 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:50 INFO - 2015-12-18 10:51:50,360 INFO : Browser initialized. 10:51:50 INFO - 2015-12-18 10:51:50,360 INFO : Running cycle 1/1 for dromaeo_css test... 10:51:50 INFO - 2015-12-18 10:51:50,360 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkc4C5C/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:52:02 INFO - 2015-12-18 10:52:02,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 149667840 10:52:02 INFO - 2015-12-18 10:52:02,142 DEBUG : BROWSER_OUTPUT: 10:52:52 INFO - 2015-12-18 10:52:52,823 DEBUG : BROWSER_OUTPUT: 1450464772816 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:55:01 INFO - 2015-12-18 10:55:01,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47238/tests/dromaeo/cssquery-ext.html) 10:55:02 INFO - 2015-12-18 10:55:02,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 317698048 10:55:02 INFO - 2015-12-18 10:55:02,801 DEBUG : BROWSER_OUTPUT: 10:58:05 INFO - 2015-12-18 10:58:05,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-ext.html (next: http://localhost:47238/tests/dromaeo/cssquery-jquery.html) 10:58:05 INFO - 2015-12-18 10:58:05,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 236314624 10:58:05 INFO - 2015-12-18 10:58:05,754 DEBUG : BROWSER_OUTPUT: 11:01:07 INFO - 2015-12-18 11:01:07,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47238/tests/dromaeo/cssquery-mootools.html) 11:01:08 INFO - 2015-12-18 11:01:08,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 231702528 11:01:08 INFO - 2015-12-18 11:01:08,225 DEBUG : BROWSER_OUTPUT: 11:04:10 INFO - 2015-12-18 11:04:10,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47238/tests/dromaeo/cssquery-prototype.html) 11:04:10 INFO - 2015-12-18 11:04:10,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 213495808 11:04:10 INFO - 2015-12-18 11:04:10,689 DEBUG : BROWSER_OUTPUT: 11:07:13 INFO - 2015-12-18 11:07:13,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47238/tests/dromaeo/cssquery-yui.html) 11:07:13 INFO - 2015-12-18 11:07:13,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 216178688 11:07:13 INFO - 2015-12-18 11:07:13,665 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/dromaeo/cssquery-yui.html (next: http://localhost:47238/tests/dromaeo/cssquery-dojo.html) 11:10:16 INFO - 2015-12-18 11:10:16,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 263323648 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:10:16 INFO - 2015-12-18 11:10:16,497 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3111.6421611514675;3154.574132492116;3176.8411579421036;3178.4914413693814;3192.2817366092627;5056.443791182976;5208.895822083556;5265.655359809796;5285.550728188099;5294.814681486148;5177.326947496829;5180.533751962323;5277.076511610472;5279.604029697769;5312.893742125155;4794.976025119879;4874.829380971667;4941.629377796662;5003.924941125886;5067.239914012909;276.65431175584035;4673.299005149221;4863.586595139417;4867.148249056401;5003.074431230234;4832.637552183583;4850.151223535885;4931.284963680247;4933.654644174909;4983.576396006344;4868.245421959602;4884.853454396374;4886;4895;4937.876553086202;4701.694389864648;4803.135435621587;4824.541668541518;4869.391326084239;4923.827666031708;5171.663841850305;5172.586193104543;5175.042617115846;5179.637425380225;5183.896322073575;5696.2594862668;5709.743061562198;5712.428757124296;5714.028615135437;5722.427757224286;5441.1838224266285;5517.586181036439;5529.889402211933;5560.6941618210985;5715.742791574389;5270.4729527047375;5388.892222155574;5409.377921538995;5412.025835349675;5412.945870541323;5849.561282903799;5899.439553242435;5908.645481271137;5914.172015917775;5963.4334738199805;5386.976474469838;5435.10320797064;5501.642393244426;5585.301837270341;5663.405342439067;5674.517665998436;5676.489115979499;5682;5683.7442315095095;5718.971405143031;5636.887262254814;5639.6334238274385;5640.576956728261;5643.407442218508;5647.040003199466;5437.4562543745305;5565.888682226333;5567.331920169525;5633;5731.254936858182;4352.542982986804;4391.978040109843;4394.802233899482;4423.557644235615;4428.579284967923;3918.9804050979565;3919.9020024499046;3923.7841918694176;3951.4863067801575;3959.465472161279;5242.18746094356;5304.893902122013;5331.546818520469;5336.119540275811;5347.465253474621;5784.797532086357;5805.796797112081;5808.651480911159;5811.4479124483105;5851.093080572518;5379.327584051994;5439.456054394608;5440.047991601454;5445.646033007842;5449.782008719686;4786.760661966958;4863.829765958245;4883.121038213156;5014.448410674823;5022.171341728647;5978.133170690226;6006.309274433409;6007.459328660441;6013.218281623361;6023.397660233942;5825.7378417971295;5844.912326315024;5850.5027072699295;5853.502452291603;5859;5732.856678583069;5871.500922421642;5875.618084824473;5887.234659494238;5991.310999235144;5663.688497132697;5673.06394444912;5673.773049078156;5679.74441150141;5685.60200785941;5724.8282551523525;5772.249607550992;5776.104703770922;5779.162021506774;5784;5442.591805614516;5508.476694713996;5539.224508568723;5541.944580554304;5567.777288908398;5544.75048622821;5566.860828479321;5584.832455026356;5679.460451257124;5709.68596727184;5524.889502210013;5526.55787536988;5526.861828454321;5541.944580554304;5578.693171875586;5543.4018866703245;5607.579431542569;5631.211630371833;5632.690202038927;5646.124850648156;5287.841364759063;5408.54027407659;5499.120140777456;5531.612787104864;5619.438056194348 11:10:16 INFO - 2015-12-18 11:10:16,498 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.4089224529753;594.7620951619355;609.7682880505408;617.3332800575379;622.8131560531845;30824.92112776053;31597.368052638933;31645.52531712023;31653.52519712206;38858.805705971434;42949;43381.34927976083;43384.13231735364;43419.34870976938;43525.7823710881;8711.91288087119;8790.956045219766;8881.333899957497;8884.466931984101;8888.688895888645;7758.534487930714;7983.441159118864;8648.524331161783;10520.105791007774;10752.78494430111;10374.48127593621;10409.791804163911;10461.84307235392;10506.579736810518;10517.211209159344;7753.379729621617;10339.276250662457;10453.11148552374;10454.268201225917;10457.529411176478;7655.349295309906;10529;10781.299215550964;10822.24244302899;10837.133029357632;39772.60227397718;40115.39826902599;40206.396904046465;40237;40240.79879600612;3241.61100667919;3415.1462134466383;3505.7370697197557;3696.3900956342172;3826.789526576037;30038.249043773863;30126.397472050656;30233.697663023308;30690.53964190539;31435.214119646964;3847.1626309564617;3859.8842034739005;3882.2041481496226;3978.562358140602;4010.0977280112033;265259;266570;266696;267710;268250.65874670696;51278;59266;59546.21361359166;59558.70220648869;59578.510537236914;51641.48358516442;51871.481285186666;68559.3144068553;69376.6531167351;69474.65262673654;13614.38735256896;14153.29233538319;14154.575362739135;14317.856821431653;14454.566363009126;10883;10930.125589952944;11050;11109.277896936836;11112.722181945515;19389.51526211828;19645.607087858163;19721.211151553776;19731.210751570063;19808.60382792365;7222.530535515175;7356.816079597946;7454.291842274975;7472.252774722593;7483.513571617827;909.5315912305168;926.5413620258015;961.5769061612868;1064.2337516987757;1072.8122578548723;24757.133500327403;25181.648847185006;25345.95848498192;25462.745372546036;26784.196474105807;1015.8069966706303;1022.0801278848946;1040.9323393979366;1047.6019112737263;1174.277819141222;14078.155310681392;14086.15483071019;14113.717725645429;14256.42974281017;14337.56987290383;316166;318756;318860;320002.39998800325;320194;52781.7360913193;53041.469585304425;53436.46563534315;53519;53549.73225133849;1281.6859869331886;1329.2290471526492;1330.4744625872727;1333.0402110480632;1343.4827591377195;25762.484750305262;27139.86430067916;27256.318592035357;27315.59026614642;28896.7110328894;46688.29967550422;47196.7640161797;47234;47305;47393;249295;257424.69314801838;375338;387822;389220;30870.228244294074;30877;31072.533911990886;31212;31218.21954451157;43486.347704783824;43873.561264386946;44117.55882441263;44961.32558011698;45123.323150152115;36549.81725091358;37052.25895482129;37617.4357384634;38084.619153808104;38431.80784096062;36846.26307473782;37072.25855482929;37221;37681.24637507289;37802;35464.64535354613;35916.58792414716;36737;36943.445848311756;36962.630373695916;30430.69569304367;31454.52818207683;31618.367632646758;31706.841465792524;31729.84135079402;23792.643110353703;24100.39749006289;24141.63787543153;24163.397755209975;24448.388790280384 11:10:16 INFO - 2015-12-18 11:10:16,498 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.07762777963404;357.3282229408712;360.94224924012144;365.12734564391127;365.6727229129927;14046.789298160511;14331.71336573268;16450.34198632055;16806.159692015397;17490.650186996252;13716.93141534291;13810.585682429519;15916.602084947883;16287.429939952104;16546.58633534162;5459.481349271813;5578.832635020955;5585.1063829787245;5592.888142237153;5593.776248950057;4015.437838702584;4126.401671757593;5336.8132115375965;5542.085555883295;5548.472895074961;5929.614575052629;6048.60684055535;6063.060225665029;6075.817725468243;6081.270247570298;5687.744051517671;6016.548758843082;6027.939720602803;6132.049532322497;6137.41694539018;5429.972850135724;5432.348118225798;5432.674039557639;5438.592105592057;5440.238366628675;20800.895995520077;20825.16699332025;21095.050722717515;21122.366329010154;21167.788322116736;2084.333013435701;2195.7255343082115;2243.887805609729;2327.0110203163586;2379.4765151666606;13011.739765204738;13337.733245335136;13355.198688078746;13445.596632101053;13488.258145801978;1751.8773685841995;1766.8144844791368;1772.53027947594;1845.0682405385194;1884.208632374406;57657.711711441596;60587.999999999556;61448.38551614471;61885;62407.6879615599;9743.951280243553;9765.169960553432;9774.951125244328;9860.309778315592;9976.700698979042;13011.722948483977;13026.869731302755;13028.869711302767;13029.674258143623;13042.673933151558;7183.640817959081;7204.2227521727245;7240.2035776064595;7281.381082607932;7347.63261836906;6909.136357955255;6954.687039083254;6975.407090397373;6999.09011828459;7003.894941575881;5826.883462330729;5863.3257175424515;5867.911981320283;5868.178455016301;5910.8817823643285;1591.90448573086;1632.0941877257999;1733.7226043833177;1794.3223086414243;1824.1973531646033;894.9776255593662;898.6540182029966;924.986125208109;928.5078908178676;949.6723630347519;17046.05191378794;17048.82951170497;17146.914265428593;17372.826271737373;17614.559636009202;839.995800020996;906.4470672889532;906.6690657909816;928.0672923711761;942.5569982108398;9187.173154416001;9303.860442093373;9519.619215231312;9897.30718849688;9928.553215105338;524762;534696;539984;542998;549354;80208.19791802124;80884;81401.59299203467;82944.58527707323;83600;1104.6023431564631;1105.7898999190288;1107.5680484611007;1114.6098865397207;1115.9553617855356;15551.611209719847;15613.765793513334;15767.605809854846;15787.21063946775;15871.74629201034;35052.82473587616;35435.645643543234;35829.82085089558;36043.639563604025;36839.26321473609;44659.10681786411;46614.30078548757;46930;47370;50445.495545045545;9278.768030799283;9483.52582370865;9574.186194173573;9580.66467673628;9711.417314961125;11771.11716621274;11835.349055802013;11875.406229688308;11911.880881191077;14587.854121459073;14129.646758831112;14221.217833019284;14338.713225735635;14411.567652970427;14702.55892323232;14480.203588802295;14849.92575037118;14977.925110374379;15092.320845561757;15106.244687765347;10722.73193170177;14317;14360.35378407995;14784.852151478777;15687;9536.475493847905;9572.952135239279;9659.71020869375;9673.806523869624;9693.951530242304;10206;10277.331973421704;11679.416029198335;14277.928610356881;14689.853101468849 11:10:16 INFO - 2015-12-18 11:10:16,498 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1234.3704710597592;1406.2054938959486;1466.2155746675528;1573.622330640646;1727.0501224326617;6648.800535983923;7092.148942126939;7249.275072492761;7266.455015873804;7274.272572742723;7094.929050709504;7211.026511420957;7226.349628533431;7231.746888858891;7243.348098671118;1884.8397886179691;1925.6918892977126;2116.174691870172;2152.3435352217566;2193;2137.10241698487;2139.9893000534976;2143.9892800535977;2144.5603651251454;2144.785521447858;2128.095559387262;2158.0936006877073;2170.5333353329033;2171.576542574199;2174.0434208948013;2068.431181425105;2072.067569593681;2094.7486301643826;2120.162535798366;2138.8823614701187;2133.551954089643;2139.465133716571;2141.453929248047;2158.0181017636937;2160.12514931453;7366.889496657554;7432.739854105081;7435.702571897117;7439.293267139613;7444.739434119834;4388.846390376353;4487.820487180509;4487.977560112211;4488.775561221959;4491.708038977456;2846.4307138572162;2884.62499875017;2927.5169597016466;2930.120963710878;2984.5970793942975;932.0865551759246;935.5836652689555;964.1756298364867;972.2707969023232;983.1397527163732;10174.898251017543;10231.130353919925;10240.385576865487;10242.28304018719;10257.17942564593;3947.644711975936;3995.7003224757677;3998.660113890352;4048.2510735513433;4061.5126184857413;8803.515806630568;8834.160754728291;8841.469511829311;8845.823083538293;8846.336524760669;4498.6626003049905;4517.728936263835;4542.227821270392;4548.74981876;4559.703619264737;4111.280525907954;4132.276851550967;4145.046639272984;4151.356539736345;4169.583041695806;3236.9028929132164;3269.2153883067895;3295.340931813599;3322.3853587086464;3507.7895326280504;1123.253036730565;1133.2803669669654;1133.4219548030399;1144.9313041217554;1154.7575009247985;1080.8702955645374;1254.2913254011455;1319.848217455005;1328.8405391352906;1340.6246251049722;7004.124484439445;7102.751403700846;7109.217986021534;7130.108736407949;7134.607596582237;1098.077614803553;1101.3502033800096;1106.2919731371928;1129.1362107987395;1137.221003612528;5430.91853622196;5471.097268950579;5486.588505861996;5490.917636235459;5499.670019798825;8530.360222983301;8831.955840220759;8867.201951824367;8980.955095224614;9044.547772611342;8783.165599268059;8842.513661748537;8877.556122193864;8878.86681699775;8883.73348799537;6957.199922008933;6962.582245065312;6998.93001069993;7023.613701246481;7046.894296585555;6750.797476075725;6794.42247408956;6797.9320206799275;6802.217744959195;6803.89794153098;7725.690972361042;7917.366610671017;7950.522968621901;8104.959475202586;8109.7161599343735;8067.233612806774;8134.83730325402;8310.626021828912;8320.625571849161;8331.541765202972;6366.5225108118;6644.700988455627;6683.7660681875905;6692.966535167293;6695.765648202289;6299.685015749286;6414.967925160345;6755.763548275787;6939.410150137295;7131.6077615729555;6653.367930046637;6778.220504641832;6797.966010169917;6827.249002609609;6917.23910369869;6625.072489851521;6626.53614246998;6664.3335666434905;6757.526973111835;6769.796906092825;6707;6736.427403670743;6738.797836064926;6742.696578653874;6752.020956961312;5822.155787410887;6204.7828326008375;6226.62640241587;6228.937710622836;6240.063990401476;6393;6443.226812782496;6448.032795080775;6449.645269510222;6450.9354906450335 11:10:16 INFO - 2015-12-18 11:10:16,499 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.46006389776375;338.5970694873101;338.93899098162336;347.8226104686611;350.3710839043916;5853.297604287486;5918.141869428936;5936.851578710529;5944.583879128462;5976.52187824974;5592.384837667853;5695.288088988877;5735.913961290584;5801.767929282823;5872;4507.549245075499;4525.185466616008;4525.321201819737;4528.75091869947;4532.52408497108;4361.302191649337;4543.931841022388;4547.499775024745;4552.408186935694;4559.316102584622;4401.757903315316;4405.471343438792;4474.798634061475;4490.146872094308;4494.617957473619;4444.511103778598;4495.123450927054;4509.729416235036;4523.819047238139;4534.093181363741;4000.6799456043736;4014.8996275093064;4015.2371049500503;4024.879253622396;4024.9798751006056;5429.701366424845;5489.972550137264;5542.722863856791;5544.22380866679;5556.833295001156;5269.209618557209;5273.604479664041;5273.894522109575;5274;5282.260483532308;6128.203333566652;6147.938520614826;6156.907646385308;6158.84602884927;6160.322364539897;4457.821687132511;4459;4466.441694788152;4468.011734778025;4480.260756975095;6262.590917043629;6416.422521972998;6420.133282006916;6432;6434.227892652912;4582.702124361973;4583.2666773316105;4583.587477127075;4584.908301833944;4585.380973568525;4635.814567417266;4636.420447444069;4639.025804581076;4642.141203877226;4642.51253618372;5265.52610265078;5274.4198138204765;5276.182191760283;5281.15501519755;5282.234076059027;6097.085437184458;6234.594751341148;6248.343923888017;6250.406211409909;6255.906161407583;1581.3437423469131;1610.4846449136164;1612.4275882061934;1612.6290953080622;1613.661131162469;1102.614085070235;1126.318577260762;1129.1982692288402;1144.7996600594863;1152.9884701153048;6040.577159598874;6066.908996365058;6067.848303792441;6070.908936365958;6076.483498902643;6447.548671593037;6461.095446637474;6462.612243265419;6473.449756770633;6474.935250647527;5888.9705551472825;5991.5206783457215;6047.15339852421;6100.847478813065;6137.754489820447;3464.7055000325254;3501.229729459515;3508.666706651456;3510.613832478425;3511.543499345069;6707.731690732316;6715.160604924385;6716.697748601325;6721.8655626887185;6730.192376914802;6530.902036469457;6641.734330626818;6649.335066493409;6659.86680266392;6661.501162238457;6692.732290708414;6697.598144111369;6712.026756120335;6713.060171575983;6730.461563074942;6508.674566271762;6514.967425163033;6517.8696426072165;6519.608823470607;6520.347965203442;6302;6396.200474940632;6410.134631824644;6417.7753778617525;6421.518386121153;6686.832829179115;6692.498062645418;6692.665366731547;6693.564918280296;6701.698423570853;4569.086182763394;4570.565796249351;4575.908481830411;4576.656750743641;4576.81692732287;6383.6808159592765;6496.935030649633;6517.4460170886005;6517.804465866032;6518.5111116667385;6325.399087086719;6326.323524266165;6335.524835637253;6337.556371053982;6341.55609107358;6321.715522801393;6326;6326.778562750282;6327.335629758809;6327.873442531216;6070.332263450929;6179.227596550431;6197.845053873689;6200.7519699211525;6213.471854892204;6344.206974128234;6349.333320001333;6351.650659213788;6354.23749150105;6359.14151589548;6184.134221208944;6186.597871138361;6194.4115309045565;6197.318294987638;6202.2867370253 11:10:16 INFO - 2015-12-18 11:10:16,500 DEBUG : BROWSER_OUTPUT: |5;yui.html;739.4084732214227;772.8067983004249;819.8354352200505;832.5379414424991;837.2924878477688;13794.586162415131;13832.515861944834;13910.095843770148;13961.930190349034;14040.087394319362;13086.476540938374;13102.27937463439;13110.47558097675;13277.13698609592;13288.202707837512;797.3899966525613;808.2402541610896;809.5790189101664;810.5258423822071;812.0945146162016;669.9497537684668;681.1077488490093;787.3858390455454;800.2757504458446;806.2662976691212;841.6549214821924;842.1031601344579;844.3835999720177;844.9493030418164;845.8139209373928;697.9336962988508;709.2623671381808;832.8126171611369;835.9289460395873;840.4621042532784;604.4439116013278;614.0911451052423;614.2015380006019;614.594367717309;616.5930485879343;13242.404091815892;13353.465861365534;13361.933190333986;13362.064655474122;13389.66525836852;10498.79002419955;11371.431428428545;11552.009843320524;11684.47419866108;12350.876491235062;9823.607055717834;10033.097021268048;10125;10226.23303252259;10315.329503582243;3618.963810361889;3667.4132138857653;3672.706183505313;3693.778373297584;3763.9811800941093;45205.54794452079;45309.32036019462;45429.77285113553;45513.77243113763;45524.544754552364;9671.516424178762;9787.657431989846;9955.850662240073;10346.068853803194;10395.220358473145;18173.909130454264;18191.90904045498;18211.72682409765;18254.17856196474;18280.542986425447;7322.450816188807;7495.213002634645;7559.5464272143845;7710.7686769397005;7797.337226335825;3924.9018774530296;4035.8183881725395;4054.432379466877;4136.524299705512;4146.419501269825;2811.4658214939095;2812.072016234638;2819.3374556979093;2820.562812764025;2834.4614523240516;478.06061089957706;490.1838438999098;493.0336540380822;500.812195426715;503.0969409909222;628.8490762217035;635.8601107756286;654.1855390039336;658.2956236826645;689.9724011039502;7870.520785952407;7955.363570914313;8032.638531266107;8370.581470926429;8496.745097647081;660.904168895517;665.9367360100782;700.1318365227082;710.1584622222682;719.8272414620558;3745.157339598623;3957.920841583152;3983.2830090583975;3983.661388781986;4138.8551400700835;55043.17435238475;56557.151642725396;57471;57658.71170644204;58586;44645;45565;46084;46093.76953115213;46317.30524042142;41641.167176656905;42420.151596968506;42727.572724272984;45822.541774582496;46196.76901615471;8173.713920012771;8322.583870806315;8423.536705481012;8437.493750374997;8442.577871106298;33434.33131337408;33504;34243.31513369769;34277;34483.65516344804;40906.38640420455;41031.38452923149;42178.578214217465;43555.34666979934;43629.345559817266;10257.17942564608;10396.480175991019;10663.306885052447;10672.8932710675;11246.1565382595;11565.248258863146;11920.701982450508;11959.222650527689;11974.58088966882;12017.339046352534;10984.505697243483;11352.148588856035;11478.598249061242;11735.23720958135;11809.409529523662;10931.344119352865;11098.889011110108;11246;11398.202125851443;11663.416829158678;10630.787384252117;10650.627228046982;10854.511546980248;10920.18098642589;10951.726206844893;9193.954030230074;9309.348345615741;9326.72019839406;9380.48407337603;9499.810003800023;8618.698345557876;8873.533777109435;9145.314101442551;9258.166764991183;9703.854442183232 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1179 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465816489__endTimestamp 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,501 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5273.13 Median:5499.12 stddev:709.06 (12.9%) stddev-sans-first:690.66 11:10:16 INFO - 2015-12-18 11:10:16,502 DEBUG : BROWSER_OUTPUT: Values: 3111.6 3154.6 3176.8 3178.5 3192.3 5056.4 5208.9 5265.7 5285.6 5294.8 5177.3 5180.5 5277.1 5279.6 5312.9 4795.0 4874.8 4941.6 5003.9 5067.2 276.7 4673.3 4863.6 4867.1 5003.1 4832.6 4850.2 4931.3 4933.7 4983.6 4868.2 4884.9 4886.0 4895.0 4937.9 4701.7 4803.1 4824.5 4869.4 4923.8 5171.7 5172.6 5175.0 5179.6 5183.9 5696.3 5709.7 5712.4 5714.0 5722.4 5441.2 5517.6 5529.9 5560.7 5715.7 5270.5 5388.9 5409.4 5412.0 5412.9 5849.6 5899.4 5908.6 5914.2 5963.4 5387.0 5435.1 5501.6 5585.3 5663.4 5674.5 5676.5 5682.0 5683.7 5719.0 5636.9 5639.6 5640.6 5643.4 5647.0 5437.5 5565.9 5567.3 5633.0 5731.3 4352.5 4392.0 4394.8 4423.6 4428.6 3919.0 3919.9 3923.8 3951.5 3959.5 5242.2 5304.9 5331.5 5336.1 5347.5 5784.8 5805.8 5808.7 5811.4 5851.1 5379.3 5439.5 5440.0 5445.6 5449.8 4786.8 4863.8 4883.1 5014.4 5022.2 5978.1 6006.3 6007.5 6013.2 6023.4 5825.7 5844.9 5850.5 5853.5 5859.0 5732.9 5871.5 5875.6 5887.2 5991.3 5663.7 5673.1 5673.8 5679.7 5685.6 5724.8 5772.2 5776.1 5779.2 5784.0 5442.6 5508.5 5539.2 5541.9 5567.8 5544.8 5566.9 5584.8 5679.5 5709.7 5524.9 5526.6 5526.9 5541.9 5578.7 5543.4 5607.6 5631.2 5632.7 5646.1 5287.8 5408.5 5499.1 5531.6 5619.4 11:10:16 INFO - 2015-12-18 11:10:16,502 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,503 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47389.47 Median:319431.20 stddev:81126.69 (25.4%) stddev-sans-first:81278.05 11:10:16 INFO - 2015-12-18 11:10:16,503 DEBUG : BROWSER_OUTPUT: Values: 552.4 594.8 609.8 617.3 622.8 30824.9 31597.4 31645.5 31653.5 38858.8 42949.0 43381.3 43384.1 43419.3 43525.8 8711.9 8791.0 8881.3 8884.5 8888.7 7758.5 7983.4 8648.5 10520.1 10752.8 10374.5 10409.8 10461.8 10506.6 10517.2 7753.4 10339.3 10453.1 10454.3 10457.5 7655.3 10529.0 10781.3 10822.2 10837.1 39772.6 40115.4 40206.4 40237.0 40240.8 3241.6 3415.1 3505.7 3696.4 3826.8 30038.2 30126.4 30233.7 30690.5 31435.2 3847.2 3859.9 3882.2 3978.6 4010.1 265259.0 266570.0 266696.0 267710.0 268250.7 51278.0 59266.0 59546.2 59558.7 59578.5 51641.5 51871.5 68559.3 69376.7 69474.7 13614.4 14153.3 14154.6 14317.9 14454.6 10883.0 10930.1 11050.0 11109.3 11112.7 19389.5 19645.6 19721.2 19731.2 19808.6 7222.5 7356.8 7454.3 7472.3 7483.5 909.5 926.5 961.6 1064.2 1072.8 24757.1 25181.6 25346.0 25462.7 26784.2 1015.8 1022.1 1040.9 1047.6 1174.3 14078.2 14086.2 14113.7 14256.4 14337.6 316166.0 318756.0 318860.0 320002.4 320194.0 52781.7 53041.5 53436.5 53519.0 53549.7 1281.7 1329.2 1330.5 1333.0 1343.5 25762.5 27139.9 27256.3 27315.6 28896.7 46688.3 47196.8 47234.0 47305.0 47393.0 249295.0 257424.7 375338.0 387822.0 389220.0 30870.2 30877.0 31072.5 31212.0 31218.2 43486.3 43873.6 44117.6 44961.3 45123.3 36549.8 37052.3 37617.4 38084.6 38431.8 36846.3 37072.3 37221.0 37681.2 37802.0 35464.6 35916.6 36737.0 36943.4 36962.6 30430.7 31454.5 31618.4 31706.8 31729.8 23792.6 24100.4 24141.6 24163.4 24448.4 11:10:16 INFO - 2015-12-18 11:10:16,503 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,503 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28858.67 Median:4070.92 stddev:88004.00 (2161.8%) stddev-sans-first:88224.84 11:10:16 INFO - 2015-12-18 11:10:16,506 DEBUG : BROWSER_OUTPUT: Values: 354.1 357.3 360.9 365.1 365.7 14046.8 14331.7 16450.3 16806.2 17490.7 13716.9 13810.6 15916.6 16287.4 16546.6 5459.5 5578.8 5585.1 5592.9 5593.8 4015.4 4126.4 5336.8 5542.1 5548.5 5929.6 6048.6 6063.1 6075.8 6081.3 5687.7 6016.5 6027.9 6132.0 6137.4 5430.0 5432.3 5432.7 5438.6 5440.2 20800.9 20825.2 21095.1 21122.4 21167.8 2084.3 2195.7 2243.9 2327.0 2379.5 13011.7 13337.7 13355.2 13445.6 13488.3 1751.9 1766.8 1772.5 1845.1 1884.2 57657.7 60588.0 61448.4 61885.0 62407.7 9744.0 9765.2 9775.0 9860.3 9976.7 13011.7 13026.9 13028.9 13029.7 13042.7 7183.6 7204.2 7240.2 7281.4 7347.6 6909.1 6954.7 6975.4 6999.1 7003.9 5826.9 5863.3 5867.9 5868.2 5910.9 1591.9 1632.1 1733.7 1794.3 1824.2 895.0 898.7 925.0 928.5 949.7 17046.1 17048.8 17146.9 17372.8 17614.6 840.0 906.4 906.7 928.1 942.6 9187.2 9303.9 9519.6 9897.3 9928.6 524762.0 534696.0 539984.0 542998.0 549354.0 80208.2 80884.0 81401.6 82944.6 83600.0 1104.6 1105.8 1107.6 1114.6 1116.0 15551.6 15613.8 15767.6 15787.2 15871.7 35052.8 35435.6 35829.8 36043.6 36839.3 44659.1 46614.3 46930.0 47370.0 50445.5 9278.8 9483.5 9574.2 9580.7 9711.4 11771.1 11835.3 11875.4 11911.9 14587.9 14129.6 14221.2 14338.7 14411.6 14702.6 14480.2 14849.9 14977.9 15092.3 15106.2 10722.7 14317.0 14360.4 14784.9 15687.0 9536.5 9573.0 9659.7 9673.8 9694.0 10206.0 10277.3 11679.4 14277.9 14689.9 11:10:16 INFO - 2015-12-18 11:10:16,506 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5198.14 Median:6333.10 stddev:2686.44 (42.4%) stddev-sans-first:2677.45 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: Values: 1234.4 1406.2 1466.2 1573.6 1727.1 6648.8 7092.1 7249.3 7266.5 7274.3 7094.9 7211.0 7226.3 7231.7 7243.3 1884.8 1925.7 2116.2 2152.3 2193.0 2137.1 2140.0 2144.0 2144.6 2144.8 2128.1 2158.1 2170.5 2171.6 2174.0 2068.4 2072.1 2094.7 2120.2 2138.9 2133.6 2139.5 2141.5 2158.0 2160.1 7366.9 7432.7 7435.7 7439.3 7444.7 4388.8 4487.8 4488.0 4488.8 4491.7 2846.4 2884.6 2927.5 2930.1 2984.6 932.1 935.6 964.2 972.3 983.1 10174.9 10231.1 10240.4 10242.3 10257.2 3947.6 3995.7 3998.7 4048.3 4061.5 8803.5 8834.2 8841.5 8845.8 8846.3 4498.7 4517.7 4542.2 4548.7 4559.7 4111.3 4132.3 4145.0 4151.4 4169.6 3236.9 3269.2 3295.3 3322.4 3507.8 1123.3 1133.3 1133.4 1144.9 1154.8 1080.9 1254.3 1319.8 1328.8 1340.6 7004.1 7102.8 7109.2 7130.1 7134.6 1098.1 1101.4 1106.3 1129.1 1137.2 5430.9 5471.1 5486.6 5490.9 5499.7 8530.4 8832.0 8867.2 8981.0 9044.5 8783.2 8842.5 8877.6 8878.9 8883.7 6957.2 6962.6 6998.9 7023.6 7046.9 6750.8 6794.4 6797.9 6802.2 6803.9 7725.7 7917.4 7950.5 8105.0 8109.7 8067.2 8134.8 8310.6 8320.6 8331.5 6366.5 6644.7 6683.8 6693.0 6695.8 6299.7 6415.0 6755.8 6939.4 7131.6 6653.4 6778.2 6798.0 6827.2 6917.2 6625.1 6626.5 6664.3 6757.5 6769.8 6707.0 6736.4 6738.8 6742.7 6752.0 5822.2 6204.8 6226.6 6228.9 6240.1 6393.0 6443.2 6448.0 6449.6 6450.9 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5261.66 Median:5984.02 stddev:1564.85 (26.2%) stddev-sans-first:1524.97 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: Values: 337.5 338.6 338.9 347.8 350.4 5853.3 5918.1 5936.9 5944.6 5976.5 5592.4 5695.3 5735.9 5801.8 5872.0 4507.5 4525.2 4525.3 4528.8 4532.5 4361.3 4543.9 4547.5 4552.4 4559.3 4401.8 4405.5 4474.8 4490.1 4494.6 4444.5 4495.1 4509.7 4523.8 4534.1 4000.7 4014.9 4015.2 4024.9 4025.0 5429.7 5490.0 5542.7 5544.2 5556.8 5269.2 5273.6 5273.9 5274.0 5282.3 6128.2 6147.9 6156.9 6158.8 6160.3 4457.8 4459.0 4466.4 4468.0 4480.3 6262.6 6416.4 6420.1 6432.0 6434.2 4582.7 4583.3 4583.6 4584.9 4585.4 4635.8 4636.4 4639.0 4642.1 4642.5 5265.5 5274.4 5276.2 5281.2 5282.2 6097.1 6234.6 6248.3 6250.4 6255.9 1581.3 1610.5 1612.4 1612.6 1613.7 1102.6 1126.3 1129.2 1144.8 1153.0 6040.6 6066.9 6067.8 6070.9 6076.5 6447.5 6461.1 6462.6 6473.4 6474.9 5889.0 5991.5 6047.2 6100.8 6137.8 3464.7 3501.2 3508.7 3510.6 3511.5 6707.7 6715.2 6716.7 6721.9 6730.2 6530.9 6641.7 6649.3 6659.9 6661.5 6692.7 6697.6 6712.0 6713.1 6730.5 6508.7 6515.0 6517.9 6519.6 6520.3 6302.0 6396.2 6410.1 6417.8 6421.5 6686.8 6692.5 6692.7 6693.6 6701.7 4569.1 4570.6 4575.9 4576.7 4576.8 6383.7 6496.9 6517.4 6517.8 6518.5 6325.4 6326.3 6335.5 6337.6 6341.6 6321.7 6326.0 6326.8 6327.3 6327.9 6070.3 6179.2 6197.8 6200.8 6213.5 6344.2 6349.3 6351.7 6354.2 6359.1 6184.1 6186.6 6194.4 6197.3 6202.3 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13279.52 Median:45257.43 stddev:15124.48 (33.4%) stddev-sans-first:15137.59 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: Values: 739.4 772.8 819.8 832.5 837.3 13794.6 13832.5 13910.1 13961.9 14040.1 13086.5 13102.3 13110.5 13277.1 13288.2 797.4 808.2 809.6 810.5 812.1 669.9 681.1 787.4 800.3 806.3 841.7 842.1 844.4 844.9 845.8 697.9 709.3 832.8 835.9 840.5 604.4 614.1 614.2 614.6 616.6 13242.4 13353.5 13361.9 13362.1 13389.7 10498.8 11371.4 11552.0 11684.5 12350.9 9823.6 10033.1 10125.0 10226.2 10315.3 3619.0 3667.4 3672.7 3693.8 3764.0 45205.5 45309.3 45429.8 45513.8 45524.5 9671.5 9787.7 9955.9 10346.1 10395.2 18173.9 18191.9 18211.7 18254.2 18280.5 7322.5 7495.2 7559.5 7710.8 7797.3 3924.9 4035.8 4054.4 4136.5 4146.4 2811.5 2812.1 2819.3 2820.6 2834.5 478.1 490.2 493.0 500.8 503.1 628.8 635.9 654.2 658.3 690.0 7870.5 7955.4 8032.6 8370.6 8496.7 660.9 665.9 700.1 710.2 719.8 3745.2 3957.9 3983.3 3983.7 4138.9 55043.2 56557.2 57471.0 57658.7 58586.0 44645.0 45565.0 46084.0 46093.8 46317.3 41641.2 42420.2 42727.6 45822.5 46196.8 8173.7 8322.6 8423.5 8437.5 8442.6 33434.3 33504.0 34243.3 34277.0 34483.7 40906.4 41031.4 42178.6 43555.3 43629.3 10257.2 10396.5 10663.3 10672.9 11246.2 11565.2 11920.7 11959.2 11974.6 12017.3 10984.5 11352.1 11478.6 11735.2 11809.4 10931.3 11098.9 11246.0 11398.2 11663.4 10630.8 10650.6 10854.5 10920.2 10951.7 9194.0 9309.3 9326.7 9380.5 9499.8 8618.7 8873.5 9145.3 9258.2 9703.9 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:10:16 INFO - 2015-12-18 11:10:16,507 DEBUG : BROWSER_OUTPUT: 11:10:17 INFO - 2015-12-18 11:10:17,207 INFO : Browser exited with error code: 0 11:10:17 INFO - 2015-12-18 11:10:17,225 INFO : Completed test dromaeo_css (00:18:32) 11:10:17 INFO - 2015-12-18 11:10:17,226 INFO : Starting test kraken 11:10:17 INFO - 2015-12-18 11:10:17,226 DEBUG : operating with platform_type : linux_ 11:10:17 INFO - 2015-12-18 11:10:17,226 INFO : Initialising browser for kraken test... 11:10:17 INFO - 2015-12-18 11:10:17,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OxNZc/profile http://localhost:47238/getInfo.html 11:10:21 INFO - 2015-12-18 11:10:21,428 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:10:21 INFO - 2015-12-18 11:10:21,429 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:10:21 INFO - 2015-12-18 11:10:21,429 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:10:21 INFO - 2015-12-18 11:10:21,429 DEBUG : BROWSER_OUTPUT: __metrics 11:10:21 INFO - 2015-12-18 11:10:21,545 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:10:21 INFO - 2015-12-18 11:10:21,589 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:22 INFO - 2015-12-18 11:10:22,903 INFO : Browser initialized. 11:10:22 INFO - 2015-12-18 11:10:22,903 INFO : Running cycle 1/1 for kraken test... 11:10:22 INFO - 2015-12-18 11:10:22,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OxNZc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:10:34 INFO - 2015-12-18 11:10:34,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 148508672 11:10:34 INFO - 2015-12-18 11:10:34,559 DEBUG : BROWSER_OUTPUT: 11:10:37 INFO - 2015-12-18 11:10:37,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47238/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:37 INFO - 2015-12-18 11:10:37,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 185581568 11:10:37 INFO - 2015-12-18 11:10:37,641 DEBUG : BROWSER_OUTPUT: 11:10:40 INFO - 2015-12-18 11:10:40,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47238/tests/kraken/driver.html?testName=audio-dft) 11:10:40 INFO - 2015-12-18 11:10:40,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 175026176 11:10:40 INFO - 2015-12-18 11:10:40,832 DEBUG : BROWSER_OUTPUT: 11:10:43 INFO - 2015-12-18 11:10:43,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47238/tests/kraken/driver.html?testName=audio-fft) 11:10:44 INFO - 2015-12-18 11:10:44,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 159432704 11:10:44 INFO - 2015-12-18 11:10:44,279 DEBUG : BROWSER_OUTPUT: 11:10:46 INFO - 2015-12-18 11:10:46,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47238/tests/kraken/driver.html?testName=audio-oscillator) 11:10:46 INFO - 2015-12-18 11:10:46,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 162455552 11:10:46 INFO - 2015-12-18 11:10:46,841 DEBUG : BROWSER_OUTPUT: 11:10:49 INFO - 2015-12-18 11:10:49,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:49 INFO - 2015-12-18 11:10:49,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 163389440 11:10:49 INFO - 2015-12-18 11:10:49,600 DEBUG : BROWSER_OUTPUT: 11:10:52 INFO - 2015-12-18 11:10:52,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47238/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:53 INFO - 2015-12-18 11:10:53,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 164773888 11:10:53 INFO - 2015-12-18 11:10:53,100 DEBUG : BROWSER_OUTPUT: 11:10:56 INFO - 2015-12-18 11:10:56,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47238/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:57 INFO - 2015-12-18 11:10:57,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 165519360 11:10:57 INFO - 2015-12-18 11:10:57,061 DEBUG : BROWSER_OUTPUT: 11:10:59 INFO - 2015-12-18 11:10:59,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47238/tests/kraken/driver.html?testName=json-parse-financial) 11:11:00 INFO - 2015-12-18 11:11:00,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 165806080 11:11:00 INFO - 2015-12-18 11:11:00,358 DEBUG : BROWSER_OUTPUT: 11:11:01 INFO - 2015-12-18 11:11:01,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:02 INFO - 2015-12-18 11:11:02,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 176562176 11:11:02 INFO - 2015-12-18 11:11:02,528 DEBUG : BROWSER_OUTPUT: 11:11:04 INFO - 2015-12-18 11:11:04,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:04 INFO - 2015-12-18 11:11:04,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 172437504 11:11:04 INFO - 2015-12-18 11:11:04,933 DEBUG : BROWSER_OUTPUT: 11:11:06 INFO - 2015-12-18 11:11:06,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:07 INFO - 2015-12-18 11:11:07,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 186769408 11:11:07 INFO - 2015-12-18 11:11:07,532 DEBUG : BROWSER_OUTPUT: 11:11:09 INFO - 2015-12-18 11:11:09,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:10 INFO - 2015-12-18 11:11:10,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 193216512 11:11:10 INFO - 2015-12-18 11:11:10,548 DEBUG : BROWSER_OUTPUT: 11:11:13 INFO - 2015-12-18 11:11:13,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:13 INFO - 2015-12-18 11:11:13,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 189227008 11:11:13 INFO - 2015-12-18 11:11:13,701 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47238/tests/kraken/driver.html?testName=ai-astar) 11:11:15 INFO - 2015-12-18 11:11:15,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 248422400 11:11:15 INFO - 2015-12-18 11:11:15,639 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;106;110;111;111;101;111;110;111 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;134;147;162;130;154;158;132;171;131 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;161;161;162;161;164;164;161 11:11:15 INFO - 2015-12-18 11:11:15,642 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;84;94;70;72;73;93;90;71 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;136;93;95;93;133;93;93;145 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;110;110;109;109;109;110;110 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;152;146;146;145;145;145;146;146;145;146 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;96;96;96;95 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;59;59;58;59;61;67;56;64 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;67;67;69;67;68;69 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;85;84;85;85;85;85;85 11:11:15 INFO - 2015-12-18 11:11:15,643 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;115;118;120;121;124;123;120;116;123 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;143;151;149;152;141;151;165;150;139 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;70;69;70;66;66;70;68;69;67 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:11:15 INFO - 2015-12-18 11:11:15,644 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465875640__endTimestamp 11:11:15 INFO - 2015-12-18 11:11:15,645 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.26 (2.9%) stddev-sans-first:3.44 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 106.0 110.0 111.0 111.0 101.0 111.0 110.0 111.0 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.00 stddev:14.60 (9.6%) stddev-sans-first:15.44 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: Values: 150.0 134.0 147.0 162.0 130.0 154.0 158.0 132.0 171.0 131.0 11:11:15 INFO - 2015-12-18 11:11:15,648 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.41 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 161.0 161.0 162.0 161.0 164.0 164.0 161.0 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:78.50 stddev:9.98 (12.7%) stddev-sans-first:10.34 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 84.0 94.0 70.0 72.0 73.0 93.0 90.0 71.0 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.74 (23.4%) stddev-sans-first:22.56 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 136.0 93.0 95.0 93.0 133.0 93.0 93.0 145.0 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:2.10 (1.4%) stddev-sans-first:0.53 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: Values: 152.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,649 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:3.23 (5.5%) stddev-sans-first:3.35 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 59.0 59.0 58.0 59.0 61.0 67.0 56.0 64.0 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 67.0 67.0 69.0 67.0 68.0 69.0 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.00 stddev:4.58 (3.8%) stddev-sans-first:3.16 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: Values: 131.0 115.0 118.0 120.0 121.0 124.0 123.0 120.0 116.0 123.0 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,650 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.50 stddev:7.50 (5.0%) stddev-sans-first:7.70 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 151.0 149.0 152.0 141.0 151.0 165.0 150.0 139.0 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.73 (2.5%) stddev-sans-first:1.66 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: Values: 66.0 70.0 69.0 70.0 66.0 66.0 70.0 68.0 69.0 67.0 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:11:15 INFO - 2015-12-18 11:11:15,651 DEBUG : BROWSER_OUTPUT: 11:11:16 INFO - 2015-12-18 11:11:16,507 INFO : Browser exited with error code: 0 11:11:16 INFO - 2015-12-18 11:11:16,562 INFO : Completed test kraken (00:00:59) 11:11:16 INFO - 2015-12-18 11:11:16,563 INFO : Starting test v8_7 11:11:16 INFO - 2015-12-18 11:11:16,563 DEBUG : operating with platform_type : linux_ 11:11:16 INFO - 2015-12-18 11:11:16,563 INFO : Initialising browser for v8_7 test... 11:11:16 INFO - 2015-12-18 11:11:16,569 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJqFyfA/profile http://localhost:47238/getInfo.html 11:11:21 INFO - 2015-12-18 11:11:21,131 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:11:21 INFO - 2015-12-18 11:11:21,131 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:11:21 INFO - 2015-12-18 11:11:21,131 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:11:21 INFO - 2015-12-18 11:11:21,131 DEBUG : BROWSER_OUTPUT: __metrics 11:11:21 INFO - 2015-12-18 11:11:21,248 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:11:21 INFO - 2015-12-18 11:11:21,304 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:22 INFO - 2015-12-18 11:11:22,289 INFO : Browser initialized. 11:11:22 INFO - 2015-12-18 11:11:22,290 INFO : Running cycle 1/1 for v8_7 test... 11:11:22 INFO - 2015-12-18 11:11:22,290 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJqFyfA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:11:34 INFO - 2015-12-18 11:11:34,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 149790720 11:11:34 INFO - 2015-12-18 11:11:34,073 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47238/tests/v8_7/run.html (next: http://localhost:47238/tests/v8_7/run.html) 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 621772800 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:11:55 INFO - 2015-12-18 11:11:55,744 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |0;Richards;165.23463317911435 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.35938971557732 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1090.5125408942204 11:11:55 INFO - 2015-12-18 11:11:55,745 DEBUG : BROWSER_OUTPUT: |5;Earley;785.0980392156863 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: |6;Boyer;11662.790697674418 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: |8;Splay;652.1456436931079 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: __startTimestamp1450465915737__endTimestamp 11:11:55 INFO - 2015-12-18 11:11:55,746 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.23 Median:165.23 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: Values: 165.2 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,747 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.36 Median:188.36 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: Values: 188.4 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: Values: 279.0 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,748 DEBUG : BROWSER_OUTPUT: Values: 5133.3 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1090.51 Median:1090.51 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: Values: 1090.5 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.10 Median:785.10 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: Values: 785.1 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,749 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11662.79 Median:11662.79 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: Values: 11662.8 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: Values: 25450.0 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:652.15 Median:652.15 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,750 DEBUG : BROWSER_OUTPUT: Values: 652.1 11:11:55 INFO - 2015-12-18 11:11:55,751 DEBUG : BROWSER_OUTPUT: 11:11:55 INFO - 2015-12-18 11:11:55,751 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:11:55 INFO - 2015-12-18 11:11:55,751 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:11:55 INFO - 2015-12-18 11:11:55,751 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:11:55 INFO - 2015-12-18 11:11:55,751 DEBUG : BROWSER_OUTPUT: 11:11:56 INFO - 2015-12-18 11:11:56,555 INFO : Browser exited with error code: 0 11:11:56 INFO - 2015-12-18 11:11:56,569 INFO : Completed test v8_7 (00:00:40) 11:11:56 INFO - 2015-12-18 11:11:56,732 INFO : Completed test suite (00:20:12) 11:11:56 INFO - 2015-12-18 11:11:56,732 DEBUG : Working with test: dromaeo_css 11:11:56 INFO - 2015-12-18 11:11:56,732 DEBUG : Generating results file: dromaeo_css 11:11:56 INFO - 2015-12-18 11:11:56,733 DEBUG : Working with test: kraken 11:11:56 INFO - 2015-12-18 11:11:56,733 DEBUG : Generating results file: kraken 11:11:56 INFO - 2015-12-18 11:11:56,734 INFO : javascript benchmark 11:11:56 INFO - 2015-12-18 11:11:56,734 DEBUG : Working with test: v8_7 11:11:56 INFO - 2015-12-18 11:11:56,734 DEBUG : Generating results file: v8_7 11:11:56 INFO - 2015-12-18 11:11:56,734 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:56 INFO - 2015-12-18 11:11:56,795 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:11:56 INFO - 2015-12-18 11:11:56,795 DEBUG : process_Request line: dromaeo_css 6904.82 graph.html#tests=[[72,64,35]] 11:11:56 INFO - 2015-12-18 11:11:56,795 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:56 INFO - 2015-12-18 11:11:56,825 DEBUG : process_Request line: kraken 1504.80 graph.html#tests=[[232,64,35]] 11:11:56 INFO - 2015-12-18 11:11:56,825 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:11:56 INFO - 2015-12-18 11:11:56,856 DEBUG : process_Request line: v8_7 21094.86 graph.html#tests=[[230,64,35]] 11:11:56 INFO - 2015-12-18 11:11:56,857 INFO : javascript benchmark 11:11:56 INFO - 2015-12-18 11:11:56,861 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3111.6421611514675, 3154.574132492116, 3176.8411579421036, 3178.4914413693814, 3192.2817366092627, 5056.443791182976, 5208.895822083556, 5265.655359809796, 5285.550728188099, 5294.814681486148, 5177.326947496829, 5180.533751962323, 5277.076511610472, 5279.604029697769, 5312.893742125155, 4794.976025119879, 4874.829380971667, 4941.629377796662, 5003.924941125886, 5067.239914012909, 276.65431175584035, 4673.299005149221, 4863.586595139417, 4867.148249056401, 5003.074431230234, 4832.637552183583, 4850.151223535885, 4931.284963680247, 4933.654644174909, 4983.576396006344, 4868.245421959602, 4884.853454396374, 4886.0, 4895.0, 4937.876553086202, 4701.694389864648, 4803.135435621587, 4824.541668541518, 4869.391326084239, 4923.827666031708, 5171.663841850305, 5172.586193104543, 5175.042617115846, 5179.637425380225, 5183.896322073575, 5696.2594862668, 5709.743061562198, 5712.428757124296, 5714.028615135437, 5722.427757224286, 5441.1838224266285, 5517.586181036439, 5529.889402211933, 5560.6941618210985, 5715.742791574389, 5270.4729527047375, 5388.892222155574, 5409.377921538995, 5412.025835349675, 5412.945870541323, 5849.561282903799, 5899.439553242435, 5908.645481271137, 5914.172015917775, 5963.4334738199805, 5386.976474469838, 5435.10320797064, 5501.642393244426, 5585.301837270341, 5663.405342439067, 5674.517665998436, 5676.489115979499, 5682.0, 5683.7442315095095, 5718.971405143031, 5636.887262254814, 5639.6334238274385, 5640.576956728261, 5643.407442218508, 5647.040003199466, 5437.4562543745305, 5565.888682226333, 5567.331920169525, 5633.0, 5731.254936858182, 4352.542982986804, 4391.978040109843, 4394.802233899482, 4423.557644235615, 4428.579284967923, 3918.9804050979565, 3919.9020024499046, 3923.7841918694176, 3951.4863067801575, 3959.465472161279, 5242.18746094356, 5304.893902122013, 5331.546818520469, 5336.119540275811, 5347.465253474621, 5784.797532086357, 5805.796797112081, 5808.651480911159, 5811.4479124483105, 5851.093080572518, 5379.327584051994, 5439.456054394608, 5440.047991601454, 5445.646033007842, 5449.782008719686, 4786.760661966958, 4863.829765958245, 4883.121038213156, 5014.448410674823, 5022.171341728647, 5978.133170690226, 6006.309274433409, 6007.459328660441, 6013.218281623361, 6023.397660233942, 5825.7378417971295, 5844.912326315024, 5850.5027072699295, 5853.502452291603, 5859.0, 5732.856678583069, 5871.500922421642, 5875.618084824473, 5887.234659494238, 5991.310999235144, 5663.688497132697, 5673.06394444912, 5673.773049078156, 5679.74441150141, 5685.60200785941, 5724.8282551523525, 5772.249607550992, 5776.104703770922, 5779.162021506774, 5784.0, 5442.591805614516, 5508.476694713996, 5539.224508568723, 5541.944580554304, 5567.777288908398, 5544.75048622821, 5566.860828479321, 5584.832455026356, 5679.460451257124, 5709.68596727184, 5524.889502210013, 5526.55787536988, 5526.861828454321, 5541.944580554304, 5578.693171875586, 5543.4018866703245, 5607.579431542569, 5631.211630371833, 5632.690202038927, 5646.124850648156, 5287.841364759063, 5408.54027407659, 5499.120140777456, 5531.612787104864, 5619.438056194348], "unit": "score", "name": "dojo.html", "value": 5229.017859222638}, {"lowerIsBetter": false, "replicates": [552.4089224529753, 594.7620951619355, 609.7682880505408, 617.3332800575379, 622.8131560531845, 30824.92112776053, 31597.368052638933, 31645.52531712023, 31653.52519712206, 38858.805705971434, 42949.0, 43381.34927976083, 43384.13231735364, 43419.34870976938, 43525.7823710881, 8711.91288087119, 8790.956045219766, 8881.333899957497, 8884.466931984101, 8888.688895888645, 7758.534487930714, 7983.441159118864, 8648.524331161783, 10520.105791007774, 10752.78494430111, 10374.48127593621, 10409.791804163911, 10461.84307235392, 10506.579736810518, 10517.211209159344, 7753.379729621617, 10339.276250662457, 10453.11148552374, 10454.268201225917, 10457.529411176478, 7655.349295309906, 10529.0, 10781.299215550964, 10822.24244302899, 10837.133029357632, 39772.60227397718, 40115.39826902599, 40206.396904046465, 40237.0, 40240.79879600612, 3241.61100667919, 3415.1462134466383, 3505.7370697197557, 3696.3900956342172, 3826.789526576037, 30038.249043773863, 30126.397472050656, 30233.697663023308, 30690.53964190539, 31435.214119646964, 3847.1626309564617, 3859.8842034739005, 3882.2041481496226, 3978.562358140602, 4010.0977280112033, 265259.0, 266570.0, 266696.0, 267710.0, 268250.65874670696, 51278.0, 59266.0, 59546.21361359166, 59558.70220648869, 59578.510537236914, 51641.48358516442, 51871.481285186666, 68559.3144068553, 69376.6531167351, 69474.65262673654, 13614.38735256896, 14153.29233538319, 14154.575362739135, 14317.856821431653, 14454.566363009126, 10883.0, 10930.125589952944, 11050.0, 11109.277896936836, 11112.722181945515, 19389.51526211828, 19645.607087858163, 19721.211151553776, 19731.210751570063, 19808.60382792365, 7222.530535515175, 7356.816079597946, 7454.291842274975, 7472.252774722593, 7483.513571617827, 909.5315912305168, 926.5413620258015, 961.5769061612868, 1064.2337516987757, 1072.8122578548723, 24757.133500327403, 25181.648847185006, 25345.95848498192, 25462.745372546036, 26784.196474105807, 1015.8069966706303, 1022.0801278848946, 1040.9323393979366, 1047.6019112737263, 1174.277819141222, 14078.155310681392, 14086.15483071019, 14113.717725645429, 14256.42974281017, 14337.56987290383, 316166.0, 318756.0, 318860.0, 320002.39998800325, 320194.0, 52781.7360913193, 53041.469585304425, 53436.46563534315, 53519.0, 53549.73225133849, 1281.6859869331886, 1329.2290471526492, 1330.4744625872727, 1333.0402110480632, 1343.4827591377195, 25762.484750305262, 27139.86430067916, 27256.318592035357, 27315.59026614642, 28896.7110328894, 46688.29967550422, 47196.7640161797, 47234.0, 47305.0, 47393.0, 249295.0, 257424.69314801838, 375338.0, 387822.0, 389220.0, 30870.228244294074, 30877.0, 31072.533911990886, 31212.0, 31218.21954451157, 43486.347704783824, 43873.561264386946, 44117.55882441263, 44961.32558011698, 45123.323150152115, 36549.81725091358, 37052.25895482129, 37617.4357384634, 38084.619153808104, 38431.80784096062, 36846.26307473782, 37072.25855482929, 37221.0, 37681.24637507289, 37802.0, 35464.64535354613, 35916.58792414716, 36737.0, 36943.445848311756, 36962.630373695916, 30430.69569304367, 31454.52818207683, 31618.367632646758, 31706.841465792524, 31729.84135079402, 23792.643110353703, 24100.39749006289, 24141.63787543153, 24163.397755209975, 24448.388790280384], "unit": "score", "name": "ext.html", "value": 18611.820358506116}, {"lowerIsBetter": false, "replicates": [354.07762777963404, 357.3282229408712, 360.94224924012144, 365.12734564391127, 365.6727229129927, 14046.789298160511, 14331.71336573268, 16450.34198632055, 16806.159692015397, 17490.650186996252, 13716.93141534291, 13810.585682429519, 15916.602084947883, 16287.429939952104, 16546.58633534162, 5459.481349271813, 5578.832635020955, 5585.1063829787245, 5592.888142237153, 5593.776248950057, 4015.437838702584, 4126.401671757593, 5336.8132115375965, 5542.085555883295, 5548.472895074961, 5929.614575052629, 6048.60684055535, 6063.060225665029, 6075.817725468243, 6081.270247570298, 5687.744051517671, 6016.548758843082, 6027.939720602803, 6132.049532322497, 6137.41694539018, 5429.972850135724, 5432.348118225798, 5432.674039557639, 5438.592105592057, 5440.238366628675, 20800.895995520077, 20825.16699332025, 21095.050722717515, 21122.366329010154, 21167.788322116736, 2084.333013435701, 2195.7255343082115, 2243.887805609729, 2327.0110203163586, 2379.4765151666606, 13011.739765204738, 13337.733245335136, 13355.198688078746, 13445.596632101053, 13488.258145801978, 1751.8773685841995, 1766.8144844791368, 1772.53027947594, 1845.0682405385194, 1884.208632374406, 57657.711711441596, 60587.999999999556, 61448.38551614471, 61885.0, 62407.6879615599, 9743.951280243553, 9765.169960553432, 9774.951125244328, 9860.309778315592, 9976.700698979042, 13011.722948483977, 13026.869731302755, 13028.869711302767, 13029.674258143623, 13042.673933151558, 7183.640817959081, 7204.2227521727245, 7240.2035776064595, 7281.381082607932, 7347.63261836906, 6909.136357955255, 6954.687039083254, 6975.407090397373, 6999.09011828459, 7003.894941575881, 5826.883462330729, 5863.3257175424515, 5867.911981320283, 5868.178455016301, 5910.8817823643285, 1591.90448573086, 1632.0941877257999, 1733.7226043833177, 1794.3223086414243, 1824.1973531646033, 894.9776255593662, 898.6540182029966, 924.986125208109, 928.5078908178676, 949.6723630347519, 17046.05191378794, 17048.82951170497, 17146.914265428593, 17372.826271737373, 17614.559636009202, 839.995800020996, 906.4470672889532, 906.6690657909816, 928.0672923711761, 942.5569982108398, 9187.173154416001, 9303.860442093373, 9519.619215231312, 9897.30718849688, 9928.553215105338, 524762.0, 534696.0, 539984.0, 542998.0, 549354.0, 80208.19791802124, 80884.0, 81401.59299203467, 82944.58527707323, 83600.0, 1104.6023431564631, 1105.7898999190288, 1107.5680484611007, 1114.6098865397207, 1115.9553617855356, 15551.611209719847, 15613.765793513334, 15767.605809854846, 15787.21063946775, 15871.74629201034, 35052.82473587616, 35435.645643543234, 35829.82085089558, 36043.639563604025, 36839.26321473609, 44659.10681786411, 46614.30078548757, 46930.0, 47370.0, 50445.495545045545, 9278.768030799283, 9483.52582370865, 9574.186194173573, 9580.66467673628, 9711.417314961125, 11771.11716621274, 11835.349055802013, 11875.406229688308, 11911.880881191077, 14587.854121459073, 14129.646758831112, 14221.217833019284, 14338.713225735635, 14411.567652970427, 14702.55892323232, 14480.203588802295, 14849.92575037118, 14977.925110374379, 15092.320845561757, 15106.244687765347, 10722.73193170177, 14317.0, 14360.35378407995, 14784.852151478777, 15687.0, 9536.475493847905, 9572.952135239279, 9659.71020869375, 9673.806523869624, 9693.951530242304, 10206.0, 10277.331973421704, 11679.416029198335, 14277.928610356881, 14689.853101468849], "unit": "score", "name": "jquery.html", "value": 8910.02239160673}, {"lowerIsBetter": false, "replicates": [1234.3704710597592, 1406.2054938959486, 1466.2155746675528, 1573.622330640646, 1727.0501224326617, 6648.800535983923, 7092.148942126939, 7249.275072492761, 7266.455015873804, 7274.272572742723, 7094.929050709504, 7211.026511420957, 7226.349628533431, 7231.746888858891, 7243.348098671118, 1884.8397886179691, 1925.6918892977126, 2116.174691870172, 2152.3435352217566, 2193.0, 2137.10241698487, 2139.9893000534976, 2143.9892800535977, 2144.5603651251454, 2144.785521447858, 2128.095559387262, 2158.0936006877073, 2170.5333353329033, 2171.576542574199, 2174.0434208948013, 2068.431181425105, 2072.067569593681, 2094.7486301643826, 2120.162535798366, 2138.8823614701187, 2133.551954089643, 2139.465133716571, 2141.453929248047, 2158.0181017636937, 2160.12514931453, 7366.889496657554, 7432.739854105081, 7435.702571897117, 7439.293267139613, 7444.739434119834, 4388.846390376353, 4487.820487180509, 4487.977560112211, 4488.775561221959, 4491.708038977456, 2846.4307138572162, 2884.62499875017, 2927.5169597016466, 2930.120963710878, 2984.5970793942975, 932.0865551759246, 935.5836652689555, 964.1756298364867, 972.2707969023232, 983.1397527163732, 10174.898251017543, 10231.130353919925, 10240.385576865487, 10242.28304018719, 10257.17942564593, 3947.644711975936, 3995.7003224757677, 3998.660113890352, 4048.2510735513433, 4061.5126184857413, 8803.515806630568, 8834.160754728291, 8841.469511829311, 8845.823083538293, 8846.336524760669, 4498.6626003049905, 4517.728936263835, 4542.227821270392, 4548.74981876, 4559.703619264737, 4111.280525907954, 4132.276851550967, 4145.046639272984, 4151.356539736345, 4169.583041695806, 3236.9028929132164, 3269.2153883067895, 3295.340931813599, 3322.3853587086464, 3507.7895326280504, 1123.253036730565, 1133.2803669669654, 1133.4219548030399, 1144.9313041217554, 1154.7575009247985, 1080.8702955645374, 1254.2913254011455, 1319.848217455005, 1328.8405391352906, 1340.6246251049722, 7004.124484439445, 7102.751403700846, 7109.217986021534, 7130.108736407949, 7134.607596582237, 1098.077614803553, 1101.3502033800096, 1106.2919731371928, 1129.1362107987395, 1137.221003612528, 5430.91853622196, 5471.097268950579, 5486.588505861996, 5490.917636235459, 5499.670019798825, 8530.360222983301, 8831.955840220759, 8867.201951824367, 8980.955095224614, 9044.547772611342, 8783.165599268059, 8842.513661748537, 8877.556122193864, 8878.86681699775, 8883.73348799537, 6957.199922008933, 6962.582245065312, 6998.93001069993, 7023.613701246481, 7046.894296585555, 6750.797476075725, 6794.42247408956, 6797.9320206799275, 6802.217744959195, 6803.89794153098, 7725.690972361042, 7917.366610671017, 7950.522968621901, 8104.959475202586, 8109.7161599343735, 8067.233612806774, 8134.83730325402, 8310.626021828912, 8320.625571849161, 8331.541765202972, 6366.5225108118, 6644.700988455627, 6683.7660681875905, 6692.966535167293, 6695.765648202289, 6299.685015749286, 6414.967925160345, 6755.763548275787, 6939.410150137295, 7131.6077615729555, 6653.367930046637, 6778.220504641832, 6797.966010169917, 6827.249002609609, 6917.23910369869, 6625.072489851521, 6626.53614246998, 6664.3335666434905, 6757.526973111835, 6769.796906092825, 6707.0, 6736.427403670743, 6738.797836064926, 6742.696578653874, 6752.020956961312, 5822.155787410887, 6204.7828326008375, 6226.62640241587, 6228.937710622836, 6240.063990401476, 6393.0, 6443.226812782496, 6448.032795080775, 6449.645269510222, 6450.9354906450335], "unit": "score", "name": "mootools.html", "value": 4283.971652293165}, {"lowerIsBetter": false, "replicates": [337.46006389776375, 338.5970694873101, 338.93899098162336, 347.8226104686611, 350.3710839043916, 5853.297604287486, 5918.141869428936, 5936.851578710529, 5944.583879128462, 5976.52187824974, 5592.384837667853, 5695.288088988877, 5735.913961290584, 5801.767929282823, 5872.0, 4507.549245075499, 4525.185466616008, 4525.321201819737, 4528.75091869947, 4532.52408497108, 4361.302191649337, 4543.931841022388, 4547.499775024745, 4552.408186935694, 4559.316102584622, 4401.757903315316, 4405.471343438792, 4474.798634061475, 4490.146872094308, 4494.617957473619, 4444.511103778598, 4495.123450927054, 4509.729416235036, 4523.819047238139, 4534.093181363741, 4000.6799456043736, 4014.8996275093064, 4015.2371049500503, 4024.879253622396, 4024.9798751006056, 5429.701366424845, 5489.972550137264, 5542.722863856791, 5544.22380866679, 5556.833295001156, 5269.209618557209, 5273.604479664041, 5273.894522109575, 5274.0, 5282.260483532308, 6128.203333566652, 6147.938520614826, 6156.907646385308, 6158.84602884927, 6160.322364539897, 4457.821687132511, 4459.0, 4466.441694788152, 4468.011734778025, 4480.260756975095, 6262.590917043629, 6416.422521972998, 6420.133282006916, 6432.0, 6434.227892652912, 4582.702124361973, 4583.2666773316105, 4583.587477127075, 4584.908301833944, 4585.380973568525, 4635.814567417266, 4636.420447444069, 4639.025804581076, 4642.141203877226, 4642.51253618372, 5265.52610265078, 5274.4198138204765, 5276.182191760283, 5281.15501519755, 5282.234076059027, 6097.085437184458, 6234.594751341148, 6248.343923888017, 6250.406211409909, 6255.906161407583, 1581.3437423469131, 1610.4846449136164, 1612.4275882061934, 1612.6290953080622, 1613.661131162469, 1102.614085070235, 1126.318577260762, 1129.1982692288402, 1144.7996600594863, 1152.9884701153048, 6040.577159598874, 6066.908996365058, 6067.848303792441, 6070.908936365958, 6076.483498902643, 6447.548671593037, 6461.095446637474, 6462.612243265419, 6473.449756770633, 6474.935250647527, 5888.9705551472825, 5991.5206783457215, 6047.15339852421, 6100.847478813065, 6137.754489820447, 3464.7055000325254, 3501.229729459515, 3508.666706651456, 3510.613832478425, 3511.543499345069, 6707.731690732316, 6715.160604924385, 6716.697748601325, 6721.8655626887185, 6730.192376914802, 6530.902036469457, 6641.734330626818, 6649.335066493409, 6659.86680266392, 6661.501162238457, 6692.732290708414, 6697.598144111369, 6712.026756120335, 6713.060171575983, 6730.461563074942, 6508.674566271762, 6514.967425163033, 6517.8696426072165, 6519.608823470607, 6520.347965203442, 6302.0, 6396.200474940632, 6410.134631824644, 6417.7753778617525, 6421.518386121153, 6686.832829179115, 6692.498062645418, 6692.665366731547, 6693.564918280296, 6701.698423570853, 4569.086182763394, 4570.565796249351, 4575.908481830411, 4576.656750743641, 4576.81692732287, 6383.6808159592765, 6496.935030649633, 6517.4460170886005, 6517.804465866032, 6518.5111116667385, 6325.399087086719, 6326.323524266165, 6335.524835637253, 6337.556371053982, 6341.55609107358, 6321.715522801393, 6326.0, 6326.778562750282, 6327.335629758809, 6327.873442531216, 6070.332263450929, 6179.227596550431, 6197.845053873689, 6200.7519699211525, 6213.471854892204, 6344.206974128234, 6349.333320001333, 6351.650659213788, 6354.23749150105, 6359.14151589548, 6184.134221208944, 6186.597871138361, 6194.4115309045565, 6197.318294987638, 6202.2867370253], "unit": "score", "name": "prototype.html", "value": 4759.785557825597}, {"lowerIsBetter": false, "replicates": [739.4084732214227, 772.8067983004249, 819.8354352200505, 832.5379414424991, 837.2924878477688, 13794.586162415131, 13832.515861944834, 13910.095843770148, 13961.930190349034, 14040.087394319362, 13086.476540938374, 13102.27937463439, 13110.47558097675, 13277.13698609592, 13288.202707837512, 797.3899966525613, 808.2402541610896, 809.5790189101664, 810.5258423822071, 812.0945146162016, 669.9497537684668, 681.1077488490093, 787.3858390455454, 800.2757504458446, 806.2662976691212, 841.6549214821924, 842.1031601344579, 844.3835999720177, 844.9493030418164, 845.8139209373928, 697.9336962988508, 709.2623671381808, 832.8126171611369, 835.9289460395873, 840.4621042532784, 604.4439116013278, 614.0911451052423, 614.2015380006019, 614.594367717309, 616.5930485879343, 13242.404091815892, 13353.465861365534, 13361.933190333986, 13362.064655474122, 13389.66525836852, 10498.79002419955, 11371.431428428545, 11552.009843320524, 11684.47419866108, 12350.876491235062, 9823.607055717834, 10033.097021268048, 10125.0, 10226.23303252259, 10315.329503582243, 3618.963810361889, 3667.4132138857653, 3672.706183505313, 3693.778373297584, 3763.9811800941093, 45205.54794452079, 45309.32036019462, 45429.77285113553, 45513.77243113763, 45524.544754552364, 9671.516424178762, 9787.657431989846, 9955.850662240073, 10346.068853803194, 10395.220358473145, 18173.909130454264, 18191.90904045498, 18211.72682409765, 18254.17856196474, 18280.542986425447, 7322.450816188807, 7495.213002634645, 7559.5464272143845, 7710.7686769397005, 7797.337226335825, 3924.9018774530296, 4035.8183881725395, 4054.432379466877, 4136.524299705512, 4146.419501269825, 2811.4658214939095, 2812.072016234638, 2819.3374556979093, 2820.562812764025, 2834.4614523240516, 478.06061089957706, 490.1838438999098, 493.0336540380822, 500.812195426715, 503.0969409909222, 628.8490762217035, 635.8601107756286, 654.1855390039336, 658.2956236826645, 689.9724011039502, 7870.520785952407, 7955.363570914313, 8032.638531266107, 8370.581470926429, 8496.745097647081, 660.904168895517, 665.9367360100782, 700.1318365227082, 710.1584622222682, 719.8272414620558, 3745.157339598623, 3957.920841583152, 3983.2830090583975, 3983.661388781986, 4138.8551400700835, 55043.17435238475, 56557.151642725396, 57471.0, 57658.71170644204, 58586.0, 44645.0, 45565.0, 46084.0, 46093.76953115213, 46317.30524042142, 41641.167176656905, 42420.151596968506, 42727.572724272984, 45822.541774582496, 46196.76901615471, 8173.713920012771, 8322.583870806315, 8423.536705481012, 8437.493750374997, 8442.577871106298, 33434.33131337408, 33504.0, 34243.31513369769, 34277.0, 34483.65516344804, 40906.38640420455, 41031.38452923149, 42178.578214217465, 43555.34666979934, 43629.345559817266, 10257.17942564608, 10396.480175991019, 10663.306885052447, 10672.8932710675, 11246.1565382595, 11565.248258863146, 11920.701982450508, 11959.222650527689, 11974.58088966882, 12017.339046352534, 10984.505697243483, 11352.148588856035, 11478.598249061242, 11735.23720958135, 11809.409529523662, 10931.344119352865, 11098.889011110108, 11246.0, 11398.202125851443, 11663.416829158678, 10630.787384252117, 10650.627228046982, 10854.511546980248, 10920.18098642589, 10951.726206844893, 9193.954030230074, 9309.348345615741, 9326.72019839406, 9380.48407337603, 9499.810003800023, 8618.698345557876, 8873.533777109435, 9145.314101442551, 9258.166764991183, 9703.854442183232], "unit": "score", "name": "yui.html", "value": 6128.479167123021}], "name": "dromaeo_css", "value": 6904.824010123475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 111.0, 111.0, 101.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [150.0, 134.0, 147.0, 162.0, 130.0, 154.0, 158.0, 132.0, 171.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 164.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 84.0, 94.0, 70.0, 72.0, 73.0, 93.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 136.0, 93.0, 95.0, 93.0, 133.0, 93.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [152.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 59.0, 61.0, 67.0, 56.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [131.0, 115.0, 118.0, 120.0, 121.0, 124.0, 123.0, 120.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 151.0, 149.0, 152.0, 141.0, 151.0, 165.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 69.0, 70.0, 66.0, 66.0, 70.0, 68.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1504.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.23463317911435], "unit": "score", "name": "Richards", "value": 213.64770399999995}, {"lowerIsBetter": false, "replicates": [188.35938971557732], "unit": "score", "name": "DeltaBlue", "value": 351.0204619999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1090.5125408942204], "unit": "score", "name": "RayTrace", "value": 678.5699129999998}, {"lowerIsBetter": false, "replicates": [785.0980392156863], "unit": "score", "name": "Earley", "value": 848.8914335664339}, {"lowerIsBetter": false, "replicates": [11662.790697674418], "unit": "score", "name": "Boyer", "value": 57.14438484546362}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [652.1456436931079], "unit": "score", "name": "Splay", "value": 124.95828315054831}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21094.85824998209}]} 11:11:56 INFO - RETURN: dromaeo_css: 6904.82 11:11:56 INFO - RETURN: kraken: 1504.80 11:11:56 INFO - RETURN: v8_7: 21094.86 11:11:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21094.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6904.82"}}} 11:11:56 INFO - Return code: 0 11:11:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:11:56 INFO - # TBPL SUCCESS # 11:11:56 INFO - Running post-action listener: _resource_record_post_action 11:11:56 INFO - Running post-run listener: _resource_record_post_run 11:11:58 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557330432; Read time: 12; Write time: 889376 11:11:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 234504192; Read time: 0; Write time: 422116 11:11:58 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322826240; Read time: 12; Write time: 467260 11:11:58 INFO - Running post-run listener: _upload_blobber_files 11:11:58 INFO - Blob upload gear active. 11:11:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:11:58 INFO - Copying logs to upload dir... 11:11:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.143169 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-18 11:11:57.733782) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:57.737509) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009057 build_url: 'https://queue.taskcluster.net/v1/task/XmAgrEqwTrKypiN57pJvLQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:57.788160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:57.788530) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1450464112.486759-903619153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 11:11:57.838946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:11:57.839299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 11:11:57.839600) ========= ========= Total master_lag: 0.27 =========