builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1452231935.96 results: success (0) buildid: 20160107193106 builduid: 38b522f2dbb3461abfcb60ed64d3ba7a revision: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.957923) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.958373) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.958680) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.982817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.983129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.996243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:35.996571) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004734 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.045793) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.046116) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.046472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.046756) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 21:45:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-01-07 21:45:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163647 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.222776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.223155) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016464 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.273012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.273376) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 21:45:36,398 truncating revision to first 12 chars 2016-01-07 21:45:36,399 Setting DEBUG logging. 2016-01-07 21:45:36,399 attempt 1/10 2016-01-07 21:45:36,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7cc8b7aa55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 21:45:36,634 unpacking tar archive at: mozilla-central-8a7cc8b7aa55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.480796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.766714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.767030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.778234) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.778496) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:36.779115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2016-01-07 21:45:36.779398) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:45:36 INFO - MultiFileLogger online at 20160107 21:45:36 in /builds/slave/test-pgo 21:45:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:45:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:45:36 INFO - {'append_to_log': False, 21:45:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:45:36 INFO - 'blob_upload_branch': 'Firefox', 21:45:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:45:36 INFO - 'branch': 'Firefox', 21:45:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:36 INFO - 'config_files': ('talos/linux_config.py',), 21:45:36 INFO - 'default_actions': ('clobber', 21:45:36 INFO - 'read-buildbot-config', 21:45:36 INFO - 'download-and-extract', 21:45:36 INFO - 'populate-webroot', 21:45:36 INFO - 'create-virtualenv', 21:45:36 INFO - 'install', 21:45:36 INFO - 'run-tests'), 21:45:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:36 INFO - 'download_minidump_stackwalk': True, 21:45:36 INFO - 'download_symbols': 'ondemand', 21:45:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:36 INFO - 'installer_path': 'installer.exe', 21:45:36 INFO - 'log_level': 'info', 21:45:36 INFO - 'log_name': 'talos', 21:45:36 INFO - 'log_to_console': True, 21:45:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:45:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:45:36 INFO - 'opt_config_files': (), 21:45:36 INFO - 'pip_index': False, 21:45:36 INFO - 'sps_profile': False, 21:45:36 INFO - 'sps_profile_interval': 0, 21:45:36 INFO - 'suite': 'dromaeojs-e10s', 21:45:36 INFO - 'system_bits': '32', 21:45:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:36 INFO - 'title': 'talos-linux64-ix-054', 21:45:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:36 INFO - 'use_talos_json': True, 21:45:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:45:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:36 INFO - 'work_dir': 'build'} 21:45:36 INFO - ##### 21:45:36 INFO - ##### Running clobber step. 21:45:36 INFO - ##### 21:45:36 INFO - Running pre-action listener: _resource_record_pre_action 21:45:36 INFO - Running main action method: clobber 21:45:36 INFO - rmtree: /builds/slave/test-pgo/build 21:45:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:45:37 INFO - Running post-action listener: _resource_record_post_action 21:45:37 INFO - ##### 21:45:37 INFO - ##### Running read-buildbot-config step. 21:45:37 INFO - ##### 21:45:37 INFO - Running pre-action listener: _resource_record_pre_action 21:45:37 INFO - Running main action method: read_buildbot_config 21:45:37 INFO - Using buildbot properties: 21:45:37 INFO - { 21:45:37 INFO - "project": "", 21:45:37 INFO - "product": "firefox", 21:45:37 INFO - "script_repo_revision": "production", 21:45:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:45:37 INFO - "repository": "", 21:45:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:45:37 INFO - "buildid": "20160107193106", 21:45:37 INFO - "pgo_build": "True", 21:45:37 INFO - "basedir": "/builds/slave/test-pgo", 21:45:37 INFO - "buildnumber": 293, 21:45:37 INFO - "slavename": "talos-linux64-ix-054", 21:45:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:45:37 INFO - "platform": "ubuntu64_hw", 21:45:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:45:37 INFO - "branch": "mozilla-central", 21:45:37 INFO - "repo_path": "mozilla-central", 21:45:37 INFO - "revision": "8a7cc8b7aa556bd50c930f50770fa26661e41c03", 21:45:37 INFO - "stage_platform": "linux64-pgo", 21:45:37 INFO - "builduid": "38b522f2dbb3461abfcb60ed64d3ba7a", 21:45:37 INFO - "slavebuilddir": "test" 21:45:37 INFO - } 21:45:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:45:37 INFO - Running post-action listener: _resource_record_post_action 21:45:37 INFO - ##### 21:45:37 INFO - ##### Running download-and-extract step. 21:45:37 INFO - ##### 21:45:37 INFO - Running pre-action listener: _resource_record_pre_action 21:45:37 INFO - Running main action method: download_and_extract 21:45:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:45:37 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')]} 21:45:37 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:45:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json 21:45:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json 21:45:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:45:39 INFO - Downloaded 1302 bytes. 21:45:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:45:39 INFO - Using the following test package requirements: 21:45:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:45:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'jsshell-linux-x86_64.zip'], 21:45:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:45:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:45:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:45:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:45:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:45:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:45: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')]} 21:45:39 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:40 INFO - Downloaded 24018155 bytes. 21:45:40 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 21:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:40 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 21:45:41 INFO - Return code: 0 21:45:41 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 21:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:41 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:56 INFO - Downloaded 24018155 bytes. 21:45: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 21:45:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45: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 21:45:57 INFO - Return code: 0 21:45: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')]} 21:45:57 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:45:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:58 INFO - Downloaded 11132285 bytes. 21:45:58 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 21:45:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:58 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 21:45:58 INFO - Return code: 0 21:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:58 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:45:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:46:00 INFO - Downloaded 55891965 bytes. 21:46:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:00 INFO - mkdir: /builds/slave/test-pgo/properties 21:46:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:46:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:46:00 INFO - Contents: 21:46:00 INFO - build_url:https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:00 INFO - Running post-action listener: _resource_record_post_action 21:46:00 INFO - Running post-action listener: set_extra_try_arguments 21:46:00 INFO - ##### 21:46:00 INFO - ##### Running populate-webroot step. 21:46:00 INFO - ##### 21:46:00 INFO - Running pre-action listener: _resource_record_pre_action 21:46:00 INFO - Running main action method: populate_webroot 21:46:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:00 INFO - '--tppagecycles', 21:46:00 INFO - '7'], 21:46:00 INFO - 'tests': ['tsvgm']}}, 21:46:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:46:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:46:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:46:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'tests': ['damp', 'tps']}, 21:46:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['damp', 'tps']}, 21:46:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:46:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:00 INFO - 'other': {'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'other_l64': {'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'other_nol64': {'tests': ['a11yr', 21:46:00 INFO - 'ts_paint', 21:46:00 INFO - 'tpaint', 21:46:00 INFO - 'sessionrestore', 21:46:00 INFO - 'sessionrestore_no_auto_restore']}, 21:46:00 INFO - 'svgr': {'tests': ['tsvgx', 21:46:00 INFO - 'tsvgr_opacity', 21:46:00 INFO - 'tart', 21:46:00 INFO - 'tscrollx', 21:46:00 INFO - 'cart']}, 21:46:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['tsvgx', 21:46:00 INFO - 'tsvgr_opacity', 21:46:00 INFO - 'tart', 21:46:00 INFO - 'tscrollx', 21:46:00 INFO - 'cart']}, 21:46:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'tests': ['tp5o']}, 21:46:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'talos_options': ['--e10s'], 21:46:00 INFO - 'tests': ['tp5o']}, 21:46:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'talos_options': ['--xperf_path', 21:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:00 INFO - 'tests': ['tp5n']}, 21:46:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:00 INFO - 'talos_options': ['--e10s', 21:46:00 INFO - '--xperf_path', 21:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:00 INFO - 'tests': ['tp5n']}}, 21:46:00 INFO - 'talos.zip': {'path': '', 21:46:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:00 INFO - Running post-action listener: _resource_record_post_action 21:46:00 INFO - ##### 21:46:00 INFO - ##### Running create-virtualenv step. 21:46:00 INFO - ##### 21:46:00 INFO - Running pre-action listener: _resource_record_pre_action 21:46:00 INFO - Running main action method: create_virtualenv 21:46:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:46:00 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 21:46:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:46:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:00 INFO - Using real prefix '/usr' 21:46:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:46:00 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:02 INFO - Installing pip.................done. 21:46:02 INFO - Return code: 0 21:46:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:46:02 INFO - Using env: {'DISPLAY': ':0', 21:46:02 INFO - 'HOME': '/home/cltbld', 21:46:02 INFO - 'LANG': 'en_US.UTF-8', 21:46:02 INFO - 'LANGUAGE': 'en_US:en', 21:46:02 INFO - 'LOGNAME': 'cltbld', 21:46:02 INFO - 'MAIL': '/var/mail/cltbld', 21:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:02 INFO - 'MOZ_NO_REMOTE': '1', 21:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:02 INFO - 'NO_EM_RESTART': '1', 21:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:02 INFO - 'SHELL': '/bin/bash', 21:46:02 INFO - 'SHLVL': '1', 21:46:02 INFO - 'TERM': 'linux', 21:46:02 INFO - 'TMOUT': '86400', 21:46:02 INFO - 'USER': 'cltbld', 21:46:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:02 INFO - '_': '/tools/buildbot/bin/python'} 21:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:03 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 21:46:03 INFO - Cleaning up... 21:46:03 INFO - Return code: 0 21:46:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:03 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 21:46:03 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 21:46:03 INFO - Using env: {'DISPLAY': ':0', 21:46:03 INFO - 'HOME': '/home/cltbld', 21:46:03 INFO - 'LANG': 'en_US.UTF-8', 21:46:03 INFO - 'LANGUAGE': 'en_US:en', 21:46:03 INFO - 'LOGNAME': 'cltbld', 21:46:03 INFO - 'MAIL': '/var/mail/cltbld', 21:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:03 INFO - 'MOZ_NO_REMOTE': '1', 21:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:03 INFO - 'NO_EM_RESTART': '1', 21:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:03 INFO - 'SHELL': '/bin/bash', 21:46:03 INFO - 'SHLVL': '1', 21:46:03 INFO - 'TERM': 'linux', 21:46:03 INFO - 'TMOUT': '86400', 21:46:03 INFO - 'USER': 'cltbld', 21:46:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:03 INFO - '_': '/tools/buildbot/bin/python'} 21:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:03 INFO - Downloading/unpacking psutil>=0.7.1 21:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:46:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:46:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:05 INFO - Installing collected packages: psutil 21:46:05 INFO - Running setup.py install for psutil 21:46:05 INFO - building 'psutil._psutil_linux' extension 21:46:05 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 21:46:05 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 21:46:05 INFO - building 'psutil._psutil_posix' extension 21:46:05 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 21:46:05 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 21:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:05 INFO - Successfully installed psutil 21:46:05 INFO - Cleaning up... 21:46:05 INFO - Return code: 0 21:46:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:46:05 INFO - Using env: {'DISPLAY': ':0', 21:46:05 INFO - 'HOME': '/home/cltbld', 21:46:05 INFO - 'LANG': 'en_US.UTF-8', 21:46:05 INFO - 'LANGUAGE': 'en_US:en', 21:46:05 INFO - 'LOGNAME': 'cltbld', 21:46:05 INFO - 'MAIL': '/var/mail/cltbld', 21:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:05 INFO - 'MOZ_NO_REMOTE': '1', 21:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:05 INFO - 'NO_EM_RESTART': '1', 21:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:05 INFO - 'SHELL': '/bin/bash', 21:46:05 INFO - 'SHLVL': '1', 21:46:05 INFO - 'TERM': 'linux', 21:46:05 INFO - 'TMOUT': '86400', 21:46:05 INFO - 'USER': 'cltbld', 21:46:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:05 INFO - '_': '/tools/buildbot/bin/python'} 21:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:46:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:46:07 INFO - Installing collected packages: mozsystemmonitor 21:46:07 INFO - Running setup.py install for mozsystemmonitor 21:46:07 INFO - Successfully installed mozsystemmonitor 21:46:07 INFO - Cleaning up... 21:46:07 INFO - Return code: 0 21:46:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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', '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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:46: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 blobuploader==1.2.4 21:46:07 INFO - Using env: {'DISPLAY': ':0', 21:46:07 INFO - 'HOME': '/home/cltbld', 21:46:07 INFO - 'LANG': 'en_US.UTF-8', 21:46:07 INFO - 'LANGUAGE': 'en_US:en', 21:46:07 INFO - 'LOGNAME': 'cltbld', 21:46:07 INFO - 'MAIL': '/var/mail/cltbld', 21:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:07 INFO - 'MOZ_NO_REMOTE': '1', 21:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:07 INFO - 'NO_EM_RESTART': '1', 21:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:07 INFO - 'SHELL': '/bin/bash', 21:46:07 INFO - 'SHLVL': '1', 21:46:07 INFO - 'TERM': 'linux', 21:46:07 INFO - 'TMOUT': '86400', 21:46:07 INFO - 'USER': 'cltbld', 21:46:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:07 INFO - '_': '/tools/buildbot/bin/python'} 21:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:46:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:46:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:10 INFO - Downloading docopt-0.6.1.tar.gz 21:46:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:46:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:10 INFO - Running setup.py install for blobuploader 21:46:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:46:10 INFO - Running setup.py install for requests 21:46:10 INFO - Running setup.py install for docopt 21:46:10 INFO - Successfully installed blobuploader requests docopt 21:46:10 INFO - Cleaning up... 21:46:11 INFO - Return code: 0 21:46:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:11 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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:11 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 21:46:11 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 21:46:11 INFO - Using env: {'DISPLAY': ':0', 21:46:11 INFO - 'HOME': '/home/cltbld', 21:46:11 INFO - 'LANG': 'en_US.UTF-8', 21:46:11 INFO - 'LANGUAGE': 'en_US:en', 21:46:11 INFO - 'LOGNAME': 'cltbld', 21:46:11 INFO - 'MAIL': '/var/mail/cltbld', 21:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:11 INFO - 'MOZ_NO_REMOTE': '1', 21:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:11 INFO - 'NO_EM_RESTART': '1', 21:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:11 INFO - 'SHELL': '/bin/bash', 21:46:11 INFO - 'SHLVL': '1', 21:46:11 INFO - 'TERM': 'linux', 21:46:11 INFO - 'TMOUT': '86400', 21:46:11 INFO - 'USER': 'cltbld', 21:46:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:11 INFO - '_': '/tools/buildbot/bin/python'} 21:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:11 INFO - Running setup.py (path:/tmp/pip-aH9no_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:11 INFO - Running setup.py (path:/tmp/pip-7HLWMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:11 INFO - Running setup.py (path:/tmp/pip-0QCp51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:11 INFO - Running setup.py (path:/tmp/pip-EtRgn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:11 INFO - Running setup.py (path:/tmp/pip-dAb_w5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:11 INFO - Running setup.py (path:/tmp/pip-Sf94x_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:11 INFO - Running setup.py (path:/tmp/pip-NOYkQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:11 INFO - Running setup.py (path:/tmp/pip-QZboR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:11 INFO - Running setup.py (path:/tmp/pip-mcA1b9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:11 INFO - Running setup.py (path:/tmp/pip-Jglw1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:11 INFO - Running setup.py (path:/tmp/pip-61CzUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:12 INFO - Running setup.py (path:/tmp/pip-dIlaQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:12 INFO - Running setup.py (path:/tmp/pip-ahtLxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:12 INFO - Running setup.py (path:/tmp/pip-sQWFuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:12 INFO - Running setup.py (path:/tmp/pip-P1_OPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:12 INFO - Running setup.py (path:/tmp/pip-gMlkQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:12 INFO - Running setup.py (path:/tmp/pip-wv39w2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:12 INFO - Running setup.py install for manifestparser 21:46:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:46:12 INFO - Running setup.py install for mozcrash 21:46:12 INFO - Running setup.py install for mozdebug 21:46:12 INFO - Running setup.py install for mozdevice 21:46:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:46:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:46:12 INFO - Running setup.py install for mozfile 21:46:12 INFO - Running setup.py install for mozhttpd 21:46:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozinfo 21:46:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozInstall 21:46:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozleak 21:46:13 INFO - Running setup.py install for mozlog 21:46:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for moznetwork 21:46:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozprocess 21:46:13 INFO - Running setup.py install for mozprofile 21:46:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozrunner 21:46:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:46:13 INFO - Running setup.py install for mozscreenshot 21:46:13 INFO - Running setup.py install for moztest 21:46:14 INFO - Running setup.py install for mozversion 21:46:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:46:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:14 INFO - Cleaning up... 21:46:14 INFO - Return code: 0 21:46:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46:14 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')]} 21:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:14 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')]} 21:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:14 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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:14 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 21:46:14 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 21:46:14 INFO - Using env: {'DISPLAY': ':0', 21:46:14 INFO - 'HOME': '/home/cltbld', 21:46:14 INFO - 'LANG': 'en_US.UTF-8', 21:46:14 INFO - 'LANGUAGE': 'en_US:en', 21:46:14 INFO - 'LOGNAME': 'cltbld', 21:46:14 INFO - 'MAIL': '/var/mail/cltbld', 21:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:14 INFO - 'MOZ_NO_REMOTE': '1', 21:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:14 INFO - 'NO_EM_RESTART': '1', 21:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:14 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:14 INFO - 'SHELL': '/bin/bash', 21:46:14 INFO - 'SHLVL': '1', 21:46:14 INFO - 'TERM': 'linux', 21:46:14 INFO - 'TMOUT': '86400', 21:46:14 INFO - 'USER': 'cltbld', 21:46:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:14 INFO - '_': '/tools/buildbot/bin/python'} 21:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:14 INFO - Running setup.py (path:/tmp/pip-7iyqAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:14 INFO - Running setup.py (path:/tmp/pip-a9Yv7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:14 INFO - Running setup.py (path:/tmp/pip-Fp8gL9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:14 INFO - Running setup.py (path:/tmp/pip-ySJNcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:14 INFO - Running setup.py (path:/tmp/pip-I9eAZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:14 INFO - Running setup.py (path:/tmp/pip-Jp5DcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:14 INFO - Running setup.py (path:/tmp/pip-KxlvY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:14 INFO - Running setup.py (path:/tmp/pip-WsB4Az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:14 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)) 21:46:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:14 INFO - Running setup.py (path:/tmp/pip-IXyPQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:15 INFO - Running setup.py (path:/tmp/pip-6MzTvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:15 INFO - Running setup.py (path:/tmp/pip-mTnE7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:15 INFO - Running setup.py (path:/tmp/pip-p3gXVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:15 INFO - Running setup.py (path:/tmp/pip-aWENIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:15 INFO - Running setup.py (path:/tmp/pip-Geul0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:15 INFO - Running setup.py (path:/tmp/pip-CC5Pj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:15 INFO - Running setup.py (path:/tmp/pip-FHtwWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:15 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)) 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:15 INFO - Running setup.py (path:/tmp/pip-GxSVi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:15 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)) 21:46:15 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)) 21:46:15 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)) 21:46:15 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)) 21:46:15 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)) 21:46:15 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)) 21:46:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:17 INFO - Downloading blessings-1.5.1.tar.gz 21:46:17 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 21:46:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:17 INFO - Installing collected packages: blessings 21:46:17 INFO - Running setup.py install for blessings 21:46:17 INFO - Successfully installed blessings 21:46:17 INFO - Cleaning up... 21:46:17 INFO - Return code: 0 21:46:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:46:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:46:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:17 INFO - Reading from file tmpfile_stdout 21:46:17 INFO - Current package versions: 21:46:17 INFO - argparse == 1.2.1 21:46:17 INFO - blessings == 1.5.1 21:46:17 INFO - blobuploader == 1.2.4 21:46:17 INFO - docopt == 0.6.1 21:46:17 INFO - manifestparser == 1.1 21:46:17 INFO - mozInstall == 1.12 21:46:17 INFO - mozcrash == 0.16 21:46:17 INFO - mozdebug == 0.1 21:46:17 INFO - mozdevice == 0.47 21:46:17 INFO - mozfile == 1.2 21:46:17 INFO - mozhttpd == 0.7 21:46:17 INFO - mozinfo == 0.9 21:46:17 INFO - mozleak == 0.1 21:46:17 INFO - mozlog == 3.1 21:46:17 INFO - moznetwork == 0.27 21:46:17 INFO - mozprocess == 0.22 21:46:17 INFO - mozprofile == 0.28 21:46:17 INFO - mozrunner == 6.11 21:46:17 INFO - mozscreenshot == 0.1 21:46:17 INFO - mozsystemmonitor == 0.0 21:46:17 INFO - moztest == 0.7 21:46:17 INFO - mozversion == 1.4 21:46:17 INFO - psutil == 3.1.1 21:46:17 INFO - requests == 1.2.3 21:46:17 INFO - wsgiref == 0.1.2 21:46:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46:17 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')]} 21:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:17 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')]} 21:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:17 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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:17 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 21:46:17 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 21:46:17 INFO - Using env: {'DISPLAY': ':0', 21:46:17 INFO - 'HOME': '/home/cltbld', 21:46:17 INFO - 'LANG': 'en_US.UTF-8', 21:46:17 INFO - 'LANGUAGE': 'en_US:en', 21:46:17 INFO - 'LOGNAME': 'cltbld', 21:46:17 INFO - 'MAIL': '/var/mail/cltbld', 21:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:17 INFO - 'MOZ_NO_REMOTE': '1', 21:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:17 INFO - 'NO_EM_RESTART': '1', 21:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:17 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:17 INFO - 'SHELL': '/bin/bash', 21:46:17 INFO - 'SHLVL': '1', 21:46:17 INFO - 'TERM': 'linux', 21:46:17 INFO - 'TMOUT': '86400', 21:46:17 INFO - 'USER': 'cltbld', 21:46:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:17 INFO - '_': '/tools/buildbot/bin/python'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:46:18 INFO - Cleaning up... 21:46:18 INFO - Return code: 0 21:46:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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', '--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 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:18 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 21:46:18 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 21:46:18 INFO - Using env: {'DISPLAY': ':0', 21:46:18 INFO - 'HOME': '/home/cltbld', 21:46:18 INFO - 'LANG': 'en_US.UTF-8', 21:46:18 INFO - 'LANGUAGE': 'en_US:en', 21:46:18 INFO - 'LOGNAME': 'cltbld', 21:46:18 INFO - 'MAIL': '/var/mail/cltbld', 21:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:18 INFO - 'MOZ_NO_REMOTE': '1', 21:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:18 INFO - 'NO_EM_RESTART': '1', 21:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:18 INFO - 'SHELL': '/bin/bash', 21:46:18 INFO - 'SHLVL': '1', 21:46:18 INFO - 'TERM': 'linux', 21:46:18 INFO - 'TMOUT': '86400', 21:46:18 INFO - 'USER': 'cltbld', 21:46:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:18 INFO - '_': '/tools/buildbot/bin/python'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 INFO - Downloading/unpacking jsonschema 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:19 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 21:46:19 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:20 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:46:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:20 INFO - warning: no files found matching '*.txt' 21:46:20 INFO - no previously-included directories found matching 'build' 21:46:20 INFO - no previously-included directories found matching 'dist' 21:46:20 INFO - no previously-included directories found matching '.git*' 21:46:20 INFO - Installing collected packages: jsonschema, functools32 21:46:20 INFO - Running setup.py install for functools32 21:46:20 INFO - warning: no files found matching '*.txt' 21:46:20 INFO - no previously-included directories found matching 'build' 21:46:20 INFO - no previously-included directories found matching 'dist' 21:46:20 INFO - no previously-included directories found matching '.git*' 21:46:20 INFO - Successfully installed jsonschema functools32 21:46:20 INFO - Cleaning up... 21:46:20 INFO - Return code: 0 21:46:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f70e10cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22c1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, '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': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', '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 21:46:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:46:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:46:20 INFO - Using env: {'DISPLAY': ':0', 21:46:20 INFO - 'HOME': '/home/cltbld', 21:46:20 INFO - 'LANG': 'en_US.UTF-8', 21:46:20 INFO - 'LANGUAGE': 'en_US:en', 21:46:20 INFO - 'LOGNAME': 'cltbld', 21:46:20 INFO - 'MAIL': '/var/mail/cltbld', 21:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:20 INFO - 'MOZ_NO_REMOTE': '1', 21:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:20 INFO - 'NO_EM_RESTART': '1', 21:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:20 INFO - 'SHELL': '/bin/bash', 21:46:20 INFO - 'SHLVL': '1', 21:46:20 INFO - 'TERM': 'linux', 21:46:20 INFO - 'TMOUT': '86400', 21:46:20 INFO - 'USER': 'cltbld', 21:46:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:20 INFO - '_': '/tools/buildbot/bin/python'} 21:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:20 INFO - Downloading/unpacking flake8 21:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:22 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 21:46:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:22 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 21:46:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:22 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 21:46:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:46:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:22 INFO - no previously-included directories found matching 'docs/_build' 21:46:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:23 INFO - Running setup.py install for pep8 21:46:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:23 INFO - no previously-included directories found matching 'docs/_build' 21:46:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:46:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:23 INFO - Cleaning up... 21:46:23 INFO - Return code: 0 21:46:23 INFO - Running post-action listener: _resource_record_post_action 21:46:23 INFO - Running post-action listener: _start_resource_monitoring 21:46:23 INFO - Starting resource monitoring. 21:46:23 INFO - ##### 21:46:23 INFO - ##### Running install step. 21:46:23 INFO - ##### 21:46:23 INFO - Running pre-action listener: _resource_record_pre_action 21:46:23 INFO - Running main action method: install 21:46:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:23 INFO - Reading from file tmpfile_stdout 21:46:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:46:23 INFO - Reading from file tmpfile_stdout 21:46:23 INFO - Output received: 21:46:23 INFO - Usage: mozinstall [options] installer 21:46:23 INFO - Options: 21:46:23 INFO - -h, --help show this help message and exit 21:46:23 INFO - -d DEST, --destination=DEST 21:46:23 INFO - Directory to install application into. [default: 21:46:23 INFO - "/builds/slave/test-pgo"] 21:46:23 INFO - --app=APP Application being installed. [default: firefox] 21:46:23 INFO - mkdir: /builds/slave/test-pgo/build/application 21:46:23 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'] 21:46:23 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 21:46:39 INFO - Reading from file tmpfile_stdout 21:46:39 INFO - Output received: 21:46:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:46:39 INFO - Running post-action listener: _resource_record_post_action 21:46:39 INFO - ##### 21:46:39 INFO - ##### Running run-tests step. 21:46:39 INFO - ##### 21:46:39 INFO - Running pre-action listener: _resource_record_pre_action 21:46:39 INFO - Running main action method: run_tests 21:46:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:46:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:46:39 INFO - Python 2.7.3 21:46:39 INFO - Return code: 0 21:46:39 INFO - grabbing minidump binary from tooltool 21:46: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')]} 21:46:39 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 0x2350660>, '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 0x2351560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2351a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:46:39 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 21:46:39 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 21:46:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:39 INFO - Return code: 0 21:46:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:46:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:46:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:46:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:46:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:46:40 INFO - Return code: 0 21:46:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:46:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:46:40 INFO - Using env: {'DISPLAY': ':0', 21:46:40 INFO - 'HOME': '/home/cltbld', 21:46:40 INFO - 'LANG': 'en_US.UTF-8', 21:46:40 INFO - 'LANGUAGE': 'en_US:en', 21:46:40 INFO - 'LOGNAME': 'cltbld', 21:46:40 INFO - 'MAIL': '/var/mail/cltbld', 21:46:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:40 INFO - 'MOZ_NO_REMOTE': '1', 21:46:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:40 INFO - 'NO_EM_RESTART': '1', 21:46:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:40 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:46:40 INFO - 'SHELL': '/bin/bash', 21:46:40 INFO - 'SHLVL': '1', 21:46:40 INFO - 'TERM': 'linux', 21:46:40 INFO - 'TMOUT': '86400', 21:46:40 INFO - 'USER': 'cltbld', 21:46:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455', 21:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:40 INFO - '_': '/tools/buildbot/bin/python'} 21:46:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:46:40 INFO - mozversion application_buildid: 20160107193106 21:46:40 INFO - mozversion application_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 21:46:40 INFO - mozversion application_display_name: Nightly 21:46:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:40 INFO - mozversion application_name: Firefox 21:46:40 INFO - mozversion application_remotingname: firefox 21:46:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:46:40 INFO - mozversion application_vendor: Mozilla 21:46:40 INFO - mozversion application_version: 46.0a1 21:46:40 INFO - mozversion platform_buildid: 20160107193106 21:46:40 INFO - mozversion platform_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 21:46:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:46:40 INFO - mozversion platform_version: 46.0a1 21:46:40 INFO - using testdate: 1452232000 21:46:40 INFO - actual date: 1452232000 21:46:40 INFO - starting webserver on 'localhost:40397' 21:46:40 INFO - SUITE-START | Running 3 tests 21:46:40 INFO - TEST-START | dromaeo_css 21:46:40 INFO - operating with platform_type : linux_ 21:46:40 INFO - Initialising browser for dromaeo_css test... 21:46:40 INFO - TEST-INFO | started process 15776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUvyc3f/profile http://localhost:40397/getInfo.html) 21:46:44 INFO - PROCESS | 15776 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 21:46:45 INFO - PROCESS | 15776 | __metrics Screen width/height:1600/1200 21:46:45 INFO - PROCESS | 15776 | colorDepth:24 21:46:45 INFO - PROCESS | 15776 | Browser inner width/height: 1024/697 21:46:45 INFO - PROCESS | 15776 | __metrics 21:46:45 INFO - PROCESS | 15776 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:46:46 INFO - TEST-INFO | 15776: exit 0 21:46:46 INFO - Browser initialized. 21:46:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:46 INFO - TEST-INFO | started process 15909 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUvyc3f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:46:58 INFO - PROCESS | 15909 | RSS: Main: 150757376 21:46:58 INFO - PROCESS | 15909 | 21:47:47 INFO - PROCESS | 15909 | 1452232067881 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] 21:49:56 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40397/tests/dromaeo/cssquery-ext.html) 21:49:57 INFO - PROCESS | 15909 | RSS: Main: 157892608 21:49:57 INFO - PROCESS | 15909 | 21:53:00 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-ext.html (next: http://localhost:40397/tests/dromaeo/cssquery-jquery.html) 21:53:00 INFO - PROCESS | 15909 | RSS: Main: 156196864 21:53:00 INFO - PROCESS | 15909 | 21:56:02 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40397/tests/dromaeo/cssquery-mootools.html) 21:56:03 INFO - PROCESS | 15909 | RSS: Main: 154267648 21:56:03 INFO - PROCESS | 15909 | 21:59:04 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40397/tests/dromaeo/cssquery-prototype.html) 21:59:05 INFO - PROCESS | 15909 | RSS: Main: 152702976 21:59:05 INFO - PROCESS | 15909 | 22:02:07 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40397/tests/dromaeo/cssquery-yui.html) 22:02:08 INFO - PROCESS | 15909 | RSS: Main: 151773184 22:02:08 INFO - PROCESS | 15909 | 22:05:10 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:40397/tests/dromaeo/cssquery-yui.html (next: http://localhost:40397/tests/dromaeo/cssquery-dojo.html) 22:05:11 INFO - PROCESS | 15909 | RSS: Main: 155680768 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | __start_tp_report 22:05:11 INFO - PROCESS | 15909 | _x_x_mozilla_page_load 22:05:11 INFO - PROCESS | 15909 | _x_x_mozilla_page_load_details 22:05:11 INFO - PROCESS | 15909 | |i|pagename|runs| 22:05:11 INFO - PROCESS | 15909 | |0;dojo.html;3133.3889891471167;3197.0408877336795;3203.4874420092783;3219.7746157768966;3253.642099369069;5063.265826455162;5114.923276150861;5174.611904107188;5188.325517682701;5227.764750586223;5109.948900510994;5127.487251274871;5154.0980328442465;5186.896262074766;5207.166853303473;4702.130105930405;4725.929111063337;4725.929111063337;4796.640251981098;4797.136515427222;4762.928556071662;4788.209945359012;4794.7842347094465;4805.639577031719;4806.591439727627;4462.531434199411;4681.976590117045;4733.313669517935;4746.121967436035;4760.809567617292;4720.811167553294;4742.668013239075;4744.572988431058;4761.880952976168;4774.880627984294;4619.584237418615;4687.671862969593;4733.384659994179;4747.35910652061;4775.283707443911;4975.3532040834825;5015.0471410432265;5018.322526458918;5018.949810501885;5082.1360368737405;5521.254630624854;5524.116141417394;5528.806491772769;5529.529989950859;5572.637778544382;5447.836564903059;5541.418151094117;5563.527100196488;5570.164475328693;5572.164175373686;5206.661566998133;5239.973800131013;5287.312649355597;5288.524032837063;5300.125479295912;5685.505880017896;5685.914711279334;5706.600537962303;5708.457696518824;5812.331581868055;5291.232771248147;5407.972960135253;5429.972850135803;5526.834194974157;5541.113421852565;5609.607327487119;5609.719514024282;5625.803096891589;5634.971825140848;5650.802221922213;5528.170774383874;5560.2493663355735;5564.527015203672;5576.832695019156;5589.776408943597;5429.918551221735;5530.5852061095575;5543.805966791143;5617.185508101303;5686.147077938343;4339.73961562301;4352.238358287287;4356.281213599784;4363.214621368121;4400.537943515948;3825.7757517594105;3900.7464514806447;3928.705347098979;3947.5657677655436;3957.782321972319;5180.559652429586;5199;5226.320578324793;5241.449647787003;5321.122014867504;5565.860853478695;5616.073347897551;5626.746796394172;5646.520045796154;5647.576431767634;5149.176131818891;5223.973880130575;5230.968126895789;5260.026895024356;5308.681479111266;4731.243001119804;4784.976075119602;4798.04039192163;4810.350602668665;4850.83022094225;5791.333996590446;5836.445537673914;5837.09525023622;5844.532437404998;5878.294604647384;5486.204500347507;5533.253010843485;5609.691466969356;5639.125935480007;5642.153676948491;5772.797952071657;5799.188113664006;5806.68063256525;5815.94184058154;5816.069428891357;5495.725213739377;5571;5580.414056524169;5583.162525621189;5583.581231407579;5438;5550;5618.185363122406;5627.971860140673;5675.829725108253;5488.890222195613;5501.0648189807025;5508.44915508446;5516.9448305518035;5524.171374293888;5448.210009548672;5478.205660179331;5489.313835770528;5489.984352894728;5506.807261745819;5168.896622067613;5311.229871668664;5322.121849894879;5323.494268044529;5326.9733651333045;5385.515303622693;5435.429279925551;5435.728213589384;5456.045192091288;5464.781408743765;5293.761780719799;5307.601929855354;5391.892162156656;5413.675179489243;5442.891142177055 22:05:11 INFO - PROCESS | 15909 | |1;ext.html;529.6213207556597;532.5499952540105;534.6471328922909;549.8048192891523;556.8886222755444;34155.487667684974;35456;35502.82248588757;35522.93431197065;35564.644353556454;38529.229415411675;39011;39130;39132.60867391325;39141.41287880677;8442.282405995482;8577.742667719947;8622.956885215564;8646.308295336357;8663;8306.460080094774;8524.147585241488;8544.74365769028;8709.25971292441;8721.212151508957;8698.652053917867;8745.912540874606;8782.209601135897;8796;8802.239552089575;8619.353548483858;8631.050584435707;8651.870221946707;8730.388872778907;8735.868961965576;8450.746477605682;8607.09625489321;8616.267617252479;8636.39545231834;8644;38325.42511862324;38354.616453835384;38693.419598706045;38732.806335968424;38981.61018389808;3193.297474555594;3209.823459709715;3282.441984862579;3506.8421921013614;3563.768355056913;28650.713492865012;29328.560071598942;29346.853265733534;29382.55926161109;29872.40255194884;3895.14306852492;4037.899052523681;4062.55311915692;4076.2458945095254;4188.790560471964;256484;258548;259628;260189.69905150353;260565;41109.38335924964;41411.37882931758;41451.7927410361;41563.843615638194;56016.71991640016;39748.60251397507;40063.39904901429;40131.39802902959;40169;40261;13650;13771.724565508634;13775.793363099561;13779.724405512034;13799.172049677052;10846.78306433867;10887.346759194315;10968.067714244218;10969.341839489656;11046.56394668688;13983.860161398256;14085.929570352082;14178.078424902349;14209.218492982985;14264.072835265675;5530;5557.249771280906;5637.379888212376;5657.15142728594;5667.291588551431;853.7865533616596;884.1070518776082;913.1963871792913;998.1765043838863;1007.7279134633608;26488.205353839414;27289.31776705598;27316.726832731816;27489.89856107559;27609.585856212172;994.174834887042;1004.7186787699455;1072.8122578548723;1113.1929351220463;1129.1192869561755;14543.85456145425;14662.120272783666;14662.706745865024;14740;14854.405823766929;312251;312450;312532;314411;314602;50045.24932126021;50216.49783502191;50337;50604;50931.23603145956;1251.3242848861512;1278.7634287656813;1285.190330092036;1301.635542048228;1306.751717173734;25796.61305080463;27014.594781077907;27142.457150857266;27482.725172748815;33639.4954075694;46763.53236467592;47709.284360733924;47753.28370074382;47785.28322075102;48148.27777583269;212525;216576;216886;217516;217791;38744;39155.60844391634;39621;39705.2058958825;39752.20495590014;42272.15455690931;46150.769246153555;46477.767611161726;46666.766666166455;47311;38807.80596097114;39060.609393905695;39596;39674;40430.393544096274;38153.61846381501;38801.61198388093;39213.41179882247;39373.21253574855;39557;38369.42445863259;38482.230355393294;38765;39812;39880.60119398885;32549.18627034343;33387.66612333846;34804.82597586996;35651.46522802108;35889.282214355044;25973.740262597134;26424.471510570067;26460.676966152;26487.33781655474;26889.462210756068 22:05:11 INFO - PROCESS | 15909 | |2;jquery.html;353.18943025755885;354.8740197229983;357.6155632694854;357.97673151245175;358.8226256498704;16004.279807408666;16030;16737.16314184292;16909.915450422763;17499.037552934617;15733.213339333044;15767.763483547757;16114.033158010498;16268.51194464165;16315.59211019725;4948.999999999991;5066.290719299301;5110.616703747215;5125.077486052509;5129.076766182105;4915.631327650441;4952.207646776516;5076.44159142494;5448.264484294609;5491.368492623359;5472.26124473195;5492.505674489295;6058.545609079315;6396.584222025576;6414.807555773311;6189.226346706684;6336.493080553568;6387.552871299011;6515.250746164204;6537.607743535403;6131;6245.843853903643;6278.089676996856;6306.716197771111;6600.966995164993;20942;21221;21365.57268854614;21467.892660536752;22383.10467581295;2087.5824835033054;2098.26560703754;2124.352072617851;2189.2447105748493;2246.5731511012855;13302.467901283937;13362.198268103944;13592.524261650893;13786.172829630254;14292.499762508367;1872.26981477224;1872.662920674278;1931.6619591571418;1951.9902400487906;1958.0405601255281;60982.69508652428;62585.68707156435;63631.045534317025;64082.35917640811;64404;14057.43770249199;14639.268036598127;14742.557723268319;14828.555143345717;14858.2570871456;12396.132270740962;12761.489540418279;12896.871031289755;23338.416539586306;23353.299401017997;7113.288671132846;7315.707371705179;7555.13115991668;7557.488502299562;7589.810254743676;7258.927410725931;7279.272072792678;7289.963550182321;7310.232425595343;7345;4344.869653910388;4383.895730049594;4389.978050109729;4394.077243778778;4509.706869053501;1761.6652835961127;1784.3130394798097;1811.818818118204;1852.4720454670355;1855;839.727088696164;878.1526124297726;1024.6362541297733;1034.798214348195;1051.0172988256006;16140.919295403448;16256.83947532792;16387.34450621962;16564.254608542644;16754.83245167557;900.8739375074819;905.8414777413926;912.4844462878452;915.9358844880794;957.095544710256;9481.525923703788;9659.758506037264;9672.75818104539;9696.903030969741;9827.656032038843;433199;434086;435233;446362;471502;69503.3049669507;70562;70719;73861;74895;1044.5038606661926;1048.4286064095086;1066.983995240072;1079.2607064161075;1083.9024487796137;14260.714785704435;14459.13245205291;14860.702785944437;14893.40426382976;15009.024413413093;29408.705912940597;30393.848030759706;30882;31044.379112418075;31263.68736312608;36129;36661;36787.08032299214;38126;39048.80475597604;2966.228780517038;6445.516586255956;6912.55068420551;7247.021652076902;7277.781666550012;10526.947365263124;10650.57397704083;11351.54593816238;11601.941990290332;11614.767704646029;9393.29749605317;9503.952480237554;9643.18709580758;9813.362131461432;10071.194304455772;9333.113354231336;9601.47191904452;9897.604095836086;9956.850647240153;10084.294099412971;9823.36148150368;10018.39889606626;10169.542370593488;10194.43930583825;10217.182625389802;6898.448124150156;7135.179454362815;7157.212706602374;7160.964195178991;7457.776266712007;10004;10028.899711002796;10052.849207262043;10145.746356341151;10349.327293725884 22:05:11 INFO - PROCESS | 15909 | |3;mootools.html;1384.8822850057745;1405.3746082993068;1509.3811537269721;1684.1074230657755;1688.9831101688972;6967.059446974657;7041.155061392634;7117.608531530764;7245.855082898339;7262.237465066171;7132.893006604892;7170.103737032871;7203.171635261933;7218.819529511765;7232.927670723291;2217.246136313653;2236.373815331706;2253.9436514087197;2255.86464812111;2260.886955652219;2277.5786479501344;2292.151903795598;2312.9884350578222;2319.1998760427628;2321.303608917318;2266.1388672304583;2266.172846910882;2283.6232021716396;2292.2206449807063;2294.4149241943283;2218.4453886528368;2252.042881775239;2270.988645056764;2272.6591011348264;2277.294038847946;2244.0574958517464;2259.807916327114;2260.107257633242;2261.7512073672046;2262.479629685165;7025.051618031552;7032.92967070333;7041.92958070423;7046.929530704679;7089.361957423805;4479.037007043468;4608.1705293047235;4611.584957353821;4617.907641847144;4628.09752098341;3027.197792584967;3051.5727798108283;3151.11768704763;3160.383725173592;3172.3496683180124;1018.623109449501;1052.4369462337688;1056.0706578211202;1088.5264909764198;1089.6513115802945;9769.316147869651;9808.068233517733;9863.408195508293;9901.900980990169;9902.059304366074;4125.443065186161;4166.0834616384345;4237.745735255833;4258.297380932111;4275.166342563232;8609.268212202032;8615.956920215483;8619.965604127545;8638.17937295956;8658.134186581292;4641.280601506772;4708.670393072452;4710.788014539354;4713.29300604912;4734.881627959328;4261.424707664488;4263.4031235627035;4287.957120428756;4298.4841818981295;4326.896641356497;3540.0972751948602;3576.1238496567985;3581.552305961755;3590.281943611288;3611.115276757211;1141.7773534160924;1191.2137988927266;1192.451472322724;1202.6091520255952;1203.5306230570084;794.9006374203225;875.369733791669;1052.8104941110673;1088.2708585247904;1234.3396282988738;6392.968035159887;6395.392437718409;6444.742210311629;6452.774152904626;6454.709538070798;594.8423667728056;596.4542443664086;601.485729701108;608.3916083916084;741.0773586884363;4819.373481447389;4870.659053866266;4880.585150262196;4913.041956818386;4935.654504184673;8132.390070744717;8432.831343373098;8479.915200847912;8506.872396913928;8676.175763302475;8519.829603408021;8585.8712119317;8632.568371581396;8643.09247529013;8653.69712060075;6529.7388104475285;6553.868922621521;6561.606303621798;6570.080188773575;6687.531872768956;6264.498840092872;6381.457576105898;6403.135576697086;6418.101465794699;6443.484521238383;7472.850542989001;7581.090269167735;7739.226077392215;7742.883856742041;7860.489068210548;7808.375329973702;7838.098618658699;7905.249001344863;8035.116137225017;8050.959745201237;6034.547408944259;6149.046897730859;6150.938490615036;6156.168917196301;6171.413715697002;6404.327545607644;6454.160959075478;6504.349565043647;6661.566998145105;6667.433268172065;6219.813405597658;6271.529635277281;6294.370562943669;6372.139761132188;6404.199475065617;6204.844878877883;6244.687765611792;6245.375462453719;6302.338254483213;6323.557350985387;6143.078538219303;6199.380061993765;6313.652749098844;6325;6369.617822930639;5745.080787074048;5764.106563482667;5770.307563092456;5772.855678608068;5794;5839;5848.6783226921225;5882.558808089325;5944.4352786485215;5968.283805943314 22:05:11 INFO - PROCESS | 15909 | |4;prototype.html;332.4730302470584;346.19509640086795;346.6689311707318;353.21057436629116;358.90847833802377;6214.223222097238;6222.439980401763;6236.253848922298;6241.063840423939;6336.841578960528;6218.25380954285;6271.404216599427;6274.435300822936;6280.6859657017085;6287.59130656507;4780.928286075694;4783.186858234091;4785.784639691205;4786.138495070886;4794.089123066624;4778.904421911559;4780.091782561302;4790.54489823468;4793.5925446337105;4796.184648609745;4654.720716756989;4731.313959475874;4732.716037037789;4735.9526404736025;4736.194846876022;4713.858584242478;4714.292856071583;4731.313959475891;4754.263089221142;4762.76168196268;4115.259253334399;4120.423140760296;4128.566500517462;4135.731177473454;4137.048478849852;5954.196183515213;5954.821355359346;5966.343702192756;5969.611975221596;5983.431574000463;5477.20580515827;5530.5852061095575;5580.051391263454;5581.6371935824045;5587.608867379285;6677.699503522354;6685.0640910272605;6694.928811390154;6696.330366963265;6697.6986035628515;4573.679842411033;4588.105319462706;4591.334256532784;4596.816127354902;4598.931016034762;6811.284815094443;6906.861862762717;6954.4436445084275;6964.164300283998;6970.268121847234;4669.60308373792;4672.462666793294;4678.60231880294;4679.251319788817;4686.859394218179;4736.621070314367;4738.099761045391;4742.691725037862;4743.501932297128;4744.430668319824;5520.91718624221;5527.474889885454;5529.115341545334;5529.917051244234;5531.557475401958;6589.143411356493;6690.163729533809;6710.563813352116;6715.160604924385;6726.890063139527;1609.1793185475492;1643.8767092468113;1671.3732350368612;1671.707451196036;1672.3143511160365;1086.190787863047;1092.6503518874042;1093.748437859281;1098.2147764348529;1104.9502772375263;6240.31356550779;6252.718627661766;6269.341719119518;6300.054991751183;6300.149479820166;6804.693788779517;6813.080234168423;6813.931860681429;6821.1814582250445;6829.897551536731;6170.691465426711;6261.405166509175;6266.185395898504;6286.18279623646;6308.369163083655;3693.261347730465;3709.7943168469815;3711.4989476420337;3713.665770080706;3714.312852122312;7140.214576396592;7144.24985376528;7145.785626431111;7148.714051437988;7170.92829071713;6893.0694356261265;6962.268961758942;7011.964940175267;7012.719491220396;7023.192332881784;7130.215676275606;7155.356017958408;7158.749443769443;7186.568805871664;7240.312170343915;6789.694463749242;6792.626405547742;6797.966010169917;6801.761938332134;6816.863662726619;6568.146141001639;6726.293739157513;6743.7302507901095;6750.6624668767345;6753.527253092237;7056.894146587908;7107.111611048619;7109.502334836512;7123.109611298588;7164.426845852215;4663.510331415153;4677.134730074947;4695.506971768052;4696.2486002239475;4721.952780472288;6706.530542861953;6849.1780986281965;6870.175578930361;6890;6913.101296831581;6730.596164230162;6734.528582999143;6753.2909044549615;6762.763303284558;6765.1205343305055;6715.328467153441;6720.361565651256;6722.831929201809;6732.360425759545;6737.29258427858;6495.837604059936;6595.043718660671;6606.933930660632;6620.966895165493;6633.800985970235;6681.966590167018;6688.398044176048;6708.22855371619;6713.227978782503;6781.287964763629;6523;6582.341765823379;6588.308227636029;6594.208694956636;6607.471402287902 22:05:11 INFO - PROCESS | 15909 | |5;yui.html;623.2520974830202;670.1087553553774;727.4398712990997;812.3460614205562;827.4786884262913;13171.20972741635;13225.801612975813;13261.403236854341;13506.054576179671;13551.119177253497;12378.133530652858;12386.81419778704;12400.81398779019;12417.441215145318;12434.62696119118;775.9602133141589;791.181127533002;803.0925054688195;803.148662417836;804.1355542791493;801.1227705662319;809.4091313341264;811.3509192645889;811.7118422959824;813.259933460551;846.8687353460224;848.4485084694936;851.7913111287743;851.8381507513552;852.735651947895;835.2983493865122;843.4348986179306;843.4601854812925;844.0125053687201;845.6744153500946;617.4042049422284;618.9721462534196;619.2476141488114;620.0667994668041;620.7485968182893;13204.471821127143;13214.669633259246;13264.87761958082;13291.268980206085;13335.599932001958;11849.229800062969;12041.518339266506;12056.819147712791;12187.32969686667;12243.632691019284;9902.752431189207;10033;10116.241281903887;10274.075333220046;10395;3483.860645574174;3537.964620353789;3545.840437180333;3555.8577656893694;3667.6332366763377;41846.999999999694;41864.37203441951;42353.788231058956;42522.787386062875;42606.248156499096;9314.673986410444;9370.203532699661;9432.922378737041;9573.569189386495;9584.472853993097;16459.670806583803;16545.420910268083;16619;16622.75065874013;16666.749998750027;7550.131734850453;7638.236176382428;7661.540307581563;7673.769786906401;8056.355491560661;4222.4933008038615;4254.276772948606;4305.440292761921;4325.437693099877;4404.075144219686;2868.827870327745;2875.7555607773156;2877.4676684813376;2895.1604034829666;2909;539.2935254816203;563.1159080243978;571.2316933724135;574.9051406517962;575.0827430248746;498.12827551784375;508.189437846634;543.7308532276548;562.9408912064256;613.6900865063204;7491.887621685679;7792.766217013499;8250.834983300421;8556.443831150955;8829.779255518664;652.5953908576713;666.1539844397588;677.5291172634971;680.8195828105556;695.0824911117277;3961.168154687548;4252.55348188442;4353.238183317907;4353.651707863427;4378.562143785596;47038.29442558364;58247.417525824196;58495.70752146212;58586;63314.683426582575;45889.31166032512;46744.766276168404;46813.765931170805;46844.297335539995;47096.29355559669;48169.75915120472;48347.516524835;53337.466625334026;54021;55013.449865500836;8339.374546909128;8757.737267881974;8813.338999575186;8887;9049.819003620023;31890.36219275555;32338.191545211557;34424.65575344315;34580.13549661178;37170.8141459291;41351.1729765409;42705.5729442714;42735.1452970945;43556.78221608998;44831.77584112189;10897.346159230472;11174.161937854531;11197;11299.152563557931;11481.655550333504;11451.083913287084;11713.1800773945;11753.706157346134;11957.282563046245;12874.806877897026;11301.547938082713;11439.542418303508;11449.656510304705;11477;11686.532538698357;11368.090552755924;11606.419679016184;11702.765944681229;12059.276443413422;12107.33409662477;10126.341787783771;10590.735231618963;10916.454177291262;10937.352942633284;11465.885341146482;9318.921187952717;9380.906190938276;9442.433453992782;9467.905320946702;9665.226781857575;8606.569671516525;9094.681686140953;9204.43021614199;9356.298277629068;9759.951200244237 22:05:11 INFO - PROCESS | 15909 | __end_tp_report 22:05:11 INFO - PROCESS | 15909 | __start_cc_report 22:05:11 INFO - PROCESS | 15909 | _x_x_mozilla_cycle_collect,311 22:05:11 INFO - PROCESS | 15909 | __end_cc_report 22:05:11 INFO - PROCESS | 15909 | __startTimestamp1452233111116__endTimestamp 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | ------- Summary: start ------- 22:05:11 INFO - PROCESS | 15909 | Number of tests: 6 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#0] dojo.html Cycles:165 Average:5184.09 Median:5326.97 stddev:561.76 (10.5%) stddev-sans-first:539.96 22:05:11 INFO - PROCESS | 15909 | Values: 3133.4 3197.0 3203.5 3219.8 3253.6 5063.3 5114.9 5174.6 5188.3 5227.8 5109.9 5127.5 5154.1 5186.9 5207.2 4702.1 4725.9 4725.9 4796.6 4797.1 4762.9 4788.2 4794.8 4805.6 4806.6 4462.5 4682.0 4733.3 4746.1 4760.8 4720.8 4742.7 4744.6 4761.9 4774.9 4619.6 4687.7 4733.4 4747.4 4775.3 4975.4 5015.0 5018.3 5018.9 5082.1 5521.3 5524.1 5528.8 5529.5 5572.6 5447.8 5541.4 5563.5 5570.2 5572.2 5206.7 5240.0 5287.3 5288.5 5300.1 5685.5 5685.9 5706.6 5708.5 5812.3 5291.2 5408.0 5430.0 5526.8 5541.1 5609.6 5609.7 5625.8 5635.0 5650.8 5528.2 5560.2 5564.5 5576.8 5589.8 5429.9 5530.6 5543.8 5617.2 5686.1 4339.7 4352.2 4356.3 4363.2 4400.5 3825.8 3900.7 3928.7 3947.6 3957.8 5180.6 5199.0 5226.3 5241.4 5321.1 5565.9 5616.1 5626.7 5646.5 5647.6 5149.2 5224.0 5231.0 5260.0 5308.7 4731.2 4785.0 4798.0 4810.4 4850.8 5791.3 5836.4 5837.1 5844.5 5878.3 5486.2 5533.3 5609.7 5639.1 5642.2 5772.8 5799.2 5806.7 5815.9 5816.1 5495.7 5571.0 5580.4 5583.2 5583.6 5438.0 5550.0 5618.2 5628.0 5675.8 5488.9 5501.1 5508.4 5516.9 5524.2 5448.2 5478.2 5489.3 5490.0 5506.8 5168.9 5311.2 5322.1 5323.5 5327.0 5385.5 5435.4 5435.7 5456.0 5464.8 5293.8 5307.6 5391.9 5413.7 5442.9 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#1] ext.html Cycles:180 Average:42940.89 Median:38804.71 stddev:69320.03 (178.6%) stddev-sans-first:69441.35 22:05:11 INFO - PROCESS | 15909 | Values: 529.6 532.5 534.6 549.8 556.9 34155.5 35456.0 35502.8 35522.9 35564.6 38529.2 39011.0 39130.0 39132.6 39141.4 8442.3 8577.7 8623.0 8646.3 8663.0 8306.5 8524.1 8544.7 8709.3 8721.2 8698.7 8745.9 8782.2 8796.0 8802.2 8619.4 8631.1 8651.9 8730.4 8735.9 8450.7 8607.1 8616.3 8636.4 8644.0 38325.4 38354.6 38693.4 38732.8 38981.6 3193.3 3209.8 3282.4 3506.8 3563.8 28650.7 29328.6 29346.9 29382.6 29872.4 3895.1 4037.9 4062.6 4076.2 4188.8 256484.0 258548.0 259628.0 260189.7 260565.0 41109.4 41411.4 41451.8 41563.8 56016.7 39748.6 40063.4 40131.4 40169.0 40261.0 13650.0 13771.7 13775.8 13779.7 13799.2 10846.8 10887.3 10968.1 10969.3 11046.6 13983.9 14085.9 14178.1 14209.2 14264.1 5530.0 5557.2 5637.4 5657.2 5667.3 853.8 884.1 913.2 998.2 1007.7 26488.2 27289.3 27316.7 27489.9 27609.6 994.2 1004.7 1072.8 1113.2 1129.1 14543.9 14662.1 14662.7 14740.0 14854.4 312251.0 312450.0 312532.0 314411.0 314602.0 50045.2 50216.5 50337.0 50604.0 50931.2 1251.3 1278.8 1285.2 1301.6 1306.8 25796.6 27014.6 27142.5 27482.7 33639.5 46763.5 47709.3 47753.3 47785.3 48148.3 212525.0 216576.0 216886.0 217516.0 217791.0 38744.0 39155.6 39621.0 39705.2 39752.2 42272.2 46150.8 46477.8 46666.8 47311.0 38807.8 39060.6 39596.0 39674.0 40430.4 38153.6 38801.6 39213.4 39373.2 39557.0 38369.4 38482.2 38765.0 39812.0 39880.6 32549.2 33387.7 34804.8 35651.5 35889.3 25973.7 26424.5 26460.7 26487.3 26889.5 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#2] jquery.html Cycles:180 Average:25239.67 Median:36395.00 stddev:72695.38 (199.7%) stddev-sans-first:72875.29 22:05:11 INFO - PROCESS | 15909 | Values: 353.2 354.9 357.6 358.0 358.8 16004.3 16030.0 16737.2 16909.9 17499.0 15733.2 15767.8 16114.0 16268.5 16315.6 4949.0 5066.3 5110.6 5125.1 5129.1 4915.6 4952.2 5076.4 5448.3 5491.4 5472.3 5492.5 6058.5 6396.6 6414.8 6189.2 6336.5 6387.6 6515.3 6537.6 6131.0 6245.8 6278.1 6306.7 6601.0 20942.0 21221.0 21365.6 21467.9 22383.1 2087.6 2098.3 2124.4 2189.2 2246.6 13302.5 13362.2 13592.5 13786.2 14292.5 1872.3 1872.7 1931.7 1952.0 1958.0 60982.7 62585.7 63631.0 64082.4 64404.0 14057.4 14639.3 14742.6 14828.6 14858.3 12396.1 12761.5 12896.9 23338.4 23353.3 7113.3 7315.7 7555.1 7557.5 7589.8 7258.9 7279.3 7290.0 7310.2 7345.0 4344.9 4383.9 4390.0 4394.1 4509.7 1761.7 1784.3 1811.8 1852.5 1855.0 839.7 878.2 1024.6 1034.8 1051.0 16140.9 16256.8 16387.3 16564.3 16754.8 900.9 905.8 912.5 915.9 957.1 9481.5 9659.8 9672.8 9696.9 9827.7 433199.0 434086.0 435233.0 446362.0 471502.0 69503.3 70562.0 70719.0 73861.0 74895.0 1044.5 1048.4 1067.0 1079.3 1083.9 14260.7 14459.1 14860.7 14893.4 15009.0 29408.7 30393.8 30882.0 31044.4 31263.7 36129.0 36661.0 36787.1 38126.0 39048.8 2966.2 6445.5 6912.6 7247.0 7277.8 10526.9 10650.6 11351.5 11601.9 11614.8 9393.3 9504.0 9643.2 9813.4 10071.2 9333.1 9601.5 9897.6 9956.9 10084.3 9823.4 10018.4 10169.5 10194.4 10217.2 6898.4 7135.2 7157.2 7161.0 7457.8 10004.0 10028.9 10052.8 10145.7 10349.3 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#3] mootools.html Cycles:180 Average:5033.59 Median:3318.02 stddev:2527.86 (76.2%) stddev-sans-first:2520.08 22:05:11 INFO - PROCESS | 15909 | Values: 1384.9 1405.4 1509.4 1684.1 1689.0 6967.1 7041.2 7117.6 7245.9 7262.2 7132.9 7170.1 7203.2 7218.8 7232.9 2217.2 2236.4 2253.9 2255.9 2260.9 2277.6 2292.2 2313.0 2319.2 2321.3 2266.1 2266.2 2283.6 2292.2 2294.4 2218.4 2252.0 2271.0 2272.7 2277.3 2244.1 2259.8 2260.1 2261.8 2262.5 7025.1 7032.9 7041.9 7046.9 7089.4 4479.0 4608.2 4611.6 4617.9 4628.1 3027.2 3051.6 3151.1 3160.4 3172.3 1018.6 1052.4 1056.1 1088.5 1089.7 9769.3 9808.1 9863.4 9901.9 9902.1 4125.4 4166.1 4237.7 4258.3 4275.2 8609.3 8616.0 8620.0 8638.2 8658.1 4641.3 4708.7 4710.8 4713.3 4734.9 4261.4 4263.4 4288.0 4298.5 4326.9 3540.1 3576.1 3581.6 3590.3 3611.1 1141.8 1191.2 1192.5 1202.6 1203.5 794.9 875.4 1052.8 1088.3 1234.3 6393.0 6395.4 6444.7 6452.8 6454.7 594.8 596.5 601.5 608.4 741.1 4819.4 4870.7 4880.6 4913.0 4935.7 8132.4 8432.8 8479.9 8506.9 8676.2 8519.8 8585.9 8632.6 8643.1 8653.7 6529.7 6553.9 6561.6 6570.1 6687.5 6264.5 6381.5 6403.1 6418.1 6443.5 7472.9 7581.1 7739.2 7742.9 7860.5 7808.4 7838.1 7905.2 8035.1 8051.0 6034.5 6149.0 6150.9 6156.2 6171.4 6404.3 6454.2 6504.3 6661.6 6667.4 6219.8 6271.5 6294.4 6372.1 6404.2 6204.8 6244.7 6245.4 6302.3 6323.6 6143.1 6199.4 6313.7 6325.0 6369.6 5745.1 5764.1 5770.3 5772.9 5794.0 5839.0 5848.7 5882.6 5944.4 5968.3 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#4] prototype.html Cycles:180 Average:5555.45 Median:6270.37 stddev:1687.98 (26.9%) stddev-sans-first:1646.56 22:05:11 INFO - PROCESS | 15909 | Values: 332.5 346.2 346.7 353.2 358.9 6214.2 6222.4 6236.3 6241.1 6336.8 6218.3 6271.4 6274.4 6280.7 6287.6 4780.9 4783.2 4785.8 4786.1 4794.1 4778.9 4780.1 4790.5 4793.6 4796.2 4654.7 4731.3 4732.7 4736.0 4736.2 4713.9 4714.3 4731.3 4754.3 4762.8 4115.3 4120.4 4128.6 4135.7 4137.0 5954.2 5954.8 5966.3 5969.6 5983.4 5477.2 5530.6 5580.1 5581.6 5587.6 6677.7 6685.1 6694.9 6696.3 6697.7 4573.7 4588.1 4591.3 4596.8 4598.9 6811.3 6906.9 6954.4 6964.2 6970.3 4669.6 4672.5 4678.6 4679.3 4686.9 4736.6 4738.1 4742.7 4743.5 4744.4 5520.9 5527.5 5529.1 5529.9 5531.6 6589.1 6690.2 6710.6 6715.2 6726.9 1609.2 1643.9 1671.4 1671.7 1672.3 1086.2 1092.7 1093.7 1098.2 1105.0 6240.3 6252.7 6269.3 6300.1 6300.1 6804.7 6813.1 6813.9 6821.2 6829.9 6170.7 6261.4 6266.2 6286.2 6308.4 3693.3 3709.8 3711.5 3713.7 3714.3 7140.2 7144.2 7145.8 7148.7 7170.9 6893.1 6962.3 7012.0 7012.7 7023.2 7130.2 7155.4 7158.7 7186.6 7240.3 6789.7 6792.6 6798.0 6801.8 6816.9 6568.1 6726.3 6743.7 6750.7 6753.5 7056.9 7107.1 7109.5 7123.1 7164.4 4663.5 4677.1 4695.5 4696.2 4722.0 6706.5 6849.2 6870.2 6890.0 6913.1 6730.6 6734.5 6753.3 6762.8 6765.1 6715.3 6720.4 6722.8 6732.4 6737.3 6495.8 6595.0 6606.9 6621.0 6633.8 6682.0 6688.4 6708.2 6713.2 6781.3 6523.0 6582.3 6588.3 6594.2 6607.5 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - PROCESS | 15909 | [#5] yui.html Cycles:180 Average:13449.71 Median:46779.27 stddev:15561.99 (33.3%) stddev-sans-first:15575.84 22:05:11 INFO - PROCESS | 15909 | Values: 623.3 670.1 727.4 812.3 827.5 13171.2 13225.8 13261.4 13506.1 13551.1 12378.1 12386.8 12400.8 12417.4 12434.6 776.0 791.2 803.1 803.1 804.1 801.1 809.4 811.4 811.7 813.3 846.9 848.4 851.8 851.8 852.7 835.3 843.4 843.5 844.0 845.7 617.4 619.0 619.2 620.1 620.7 13204.5 13214.7 13264.9 13291.3 13335.6 11849.2 12041.5 12056.8 12187.3 12243.6 9902.8 10033.0 10116.2 10274.1 10395.0 3483.9 3538.0 3545.8 3555.9 3667.6 41847.0 41864.4 42353.8 42522.8 42606.2 9314.7 9370.2 9432.9 9573.6 9584.5 16459.7 16545.4 16619.0 16622.8 16666.7 7550.1 7638.2 7661.5 7673.8 8056.4 4222.5 4254.3 4305.4 4325.4 4404.1 2868.8 2875.8 2877.5 2895.2 2909.0 539.3 563.1 571.2 574.9 575.1 498.1 508.2 543.7 562.9 613.7 7491.9 7792.8 8250.8 8556.4 8829.8 652.6 666.2 677.5 680.8 695.1 3961.2 4252.6 4353.2 4353.7 4378.6 47038.3 58247.4 58495.7 58586.0 63314.7 45889.3 46744.8 46813.8 46844.3 47096.3 48169.8 48347.5 53337.5 54021.0 55013.4 8339.4 8757.7 8813.3 8887.0 9049.8 31890.4 32338.2 34424.7 34580.1 37170.8 41351.2 42705.6 42735.1 43556.8 44831.8 10897.3 11174.2 11197.0 11299.2 11481.7 11451.1 11713.2 11753.7 11957.3 12874.8 11301.5 11439.5 11449.7 11477.0 11686.5 11368.1 11606.4 11702.8 12059.3 12107.3 10126.3 10590.7 10916.5 10937.4 11465.9 9318.9 9380.9 9442.4 9467.9 9665.2 8606.6 9094.7 9204.4 9356.3 9760.0 22:05:11 INFO - PROCESS | 15909 | -------- Summary: end -------- 22:05:11 INFO - PROCESS | 15909 | 22:05:11 INFO - TEST-INFO | 15909: exit 0 22:05:11 INFO - TEST-OK | dromaeo_css | took 1111068ms 22:05:11 INFO - TEST-START | kraken 22:05:11 INFO - operating with platform_type : linux_ 22:05:11 INFO - Initialising browser for kraken test... 22:05:11 INFO - TEST-INFO | started process 16147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHVkkV/profile http://localhost:40397/getInfo.html) 22:05:15 INFO - PROCESS | 16147 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 22:05:16 INFO - PROCESS | 16147 | __metrics Screen width/height:1600/1200 22:05:16 INFO - PROCESS | 16147 | colorDepth:24 22:05:16 INFO - PROCESS | 16147 | Browser inner width/height: 1024/697 22:05:16 INFO - PROCESS | 16147 | __metrics 22:05:16 INFO - PROCESS | 16147 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:05:17 INFO - TEST-INFO | 16147: exit 0 22:05:17 INFO - Browser initialized. 22:05:17 INFO - Running cycle 1/1 for kraken test... 22:05:17 INFO - TEST-INFO | started process 16271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeHVkkV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:29 INFO - PROCESS | 16271 | RSS: Main: 150835200 22:05:29 INFO - PROCESS | 16271 | 22:05:31 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40397/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:32 INFO - PROCESS | 16271 | RSS: Main: 152186880 22:05:32 INFO - PROCESS | 16271 | 22:05:34 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40397/tests/kraken/driver.html?testName=audio-dft) 22:05:35 INFO - PROCESS | 16271 | RSS: Main: 151445504 22:05:35 INFO - PROCESS | 16271 | 22:05:38 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40397/tests/kraken/driver.html?testName=audio-fft) 22:05:38 INFO - PROCESS | 16271 | RSS: Main: 146792448 22:05:38 INFO - PROCESS | 16271 | 22:05:41 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40397/tests/kraken/driver.html?testName=audio-oscillator) 22:05:41 INFO - PROCESS | 16271 | RSS: Main: 146735104 22:05:41 INFO - PROCESS | 16271 | 22:05:43 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:44 INFO - PROCESS | 16271 | RSS: Main: 146567168 22:05:44 INFO - PROCESS | 16271 | 22:05:47 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40397/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:47 INFO - PROCESS | 16271 | RSS: Main: 148156416 22:05:47 INFO - PROCESS | 16271 | 22:05:51 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40397/tests/kraken/driver.html?testName=imaging-desaturate) 22:05:51 INFO - PROCESS | 16271 | RSS: Main: 149463040 22:05:51 INFO - PROCESS | 16271 | 22:05:54 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40397/tests/kraken/driver.html?testName=json-parse-financial) 22:05:55 INFO - PROCESS | 16271 | RSS: Main: 148377600 22:05:55 INFO - PROCESS | 16271 | 22:05:56 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:05:57 INFO - PROCESS | 16271 | RSS: Main: 149368832 22:05:57 INFO - PROCESS | 16271 | 22:05:59 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:05:59 INFO - PROCESS | 16271 | RSS: Main: 148762624 22:05:59 INFO - PROCESS | 16271 | 22:06:02 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:02 INFO - PROCESS | 16271 | RSS: Main: 149135360 22:06:02 INFO - PROCESS | 16271 | 22:06:05 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:05 INFO - PROCESS | 16271 | RSS: Main: 149168128 22:06:05 INFO - PROCESS | 16271 | 22:06:08 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:08 INFO - PROCESS | 16271 | RSS: Main: 148725760 22:06:08 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | Cycle 1(1): loaded http://localhost:40397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40397/tests/kraken/driver.html?testName=ai-astar) 22:06:10 INFO - PROCESS | 16271 | RSS: Main: 148480000 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | __start_tp_report 22:06:10 INFO - PROCESS | 16271 | _x_x_mozilla_page_load 22:06:10 INFO - PROCESS | 16271 | _x_x_mozilla_page_load_details 22:06:10 INFO - PROCESS | 16271 | |i|pagename|runs| 22:06:10 INFO - PROCESS | 16271 | |0;ai-astar;111;105;112;111;113;123;112;112;112;112 22:06:10 INFO - PROCESS | 16271 | |1;audio-beat-detection;153;135;165;165;124;153;159;129;168;127 22:06:10 INFO - PROCESS | 16271 | |2;audio-dft;163;165;163;161;161;166;164;165;176;162 22:06:10 INFO - PROCESS | 16271 | |3;audio-fft;72;75;74;75;75;143;74;74;75;72 22:06:10 INFO - PROCESS | 16271 | |4;audio-oscillator;97;97;146;97;97;96;141;97;96;139 22:06:10 INFO - PROCESS | 16271 | |5;imaging-gaussian-blur;110;109;110;110;111;109;110;110;110;111 22:06:10 INFO - PROCESS | 16271 | |6;imaging-darkroom;148;147;147;145;146;148;146;147;147;146 22:06:10 INFO - PROCESS | 16271 | |7;imaging-desaturate;96;96;97;96;96;97;96;97;97;96 22:06:10 INFO - PROCESS | 16271 | |8;json-parse-financial;58;57;57;56;58;60;60;59;58;55 22:06:10 INFO - PROCESS | 16271 | |9;json-stringify-tinderbox;71;67;67;67;67;67;68;67;67;67 22:06:10 INFO - PROCESS | 16271 | |10;stanford-crypto-aes;85;86;86;86;84;85;86;94;87;86 22:06:10 INFO - PROCESS | 16271 | |11;stanford-crypto-ccm;115;118;127;114;120;127;126;129;120;124 22:06:10 INFO - PROCESS | 16271 | |12;stanford-crypto-pbkdf2;148;151;153;151;153;149;156;148;150;152 22:06:10 INFO - PROCESS | 16271 | |13;stanford-crypto-sha256-iterative;68;68;69;70;68;74;66;67;68;70 22:06:10 INFO - PROCESS | 16271 | __end_tp_report 22:06:10 INFO - PROCESS | 16271 | __start_cc_report 22:06:10 INFO - PROCESS | 16271 | _x_x_mozilla_cycle_collect,748 22:06:10 INFO - PROCESS | 16271 | __end_cc_report 22:06:10 INFO - PROCESS | 16271 | __startTimestamp1452233170796__endTimestamp 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | ------- Summary: start ------- 22:06:10 INFO - PROCESS | 16271 | Number of tests: 14 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.37 (3.9%) stddev-sans-first:4.61 22:06:10 INFO - PROCESS | 16271 | Values: 111.0 105.0 112.0 111.0 113.0 123.0 112.0 112.0 112.0 112.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:156.00 stddev:17.31 (11.1%) stddev-sans-first:18.25 22:06:10 INFO - PROCESS | 16271 | Values: 153.0 135.0 165.0 165.0 124.0 153.0 159.0 129.0 168.0 127.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:4.35 (2.6%) stddev-sans-first:4.58 22:06:10 INFO - PROCESS | 16271 | Values: 163.0 165.0 163.0 161.0 161.0 166.0 164.0 165.0 176.0 162.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.50 stddev:21.85 (29.3%) stddev-sans-first:22.94 22:06:10 INFO - PROCESS | 16271 | Values: 72.0 75.0 74.0 75.0 75.0 143.0 74.0 74.0 75.0 72.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:97.00 stddev:21.94 (22.6%) stddev-sans-first:22.74 22:06:10 INFO - PROCESS | 16271 | Values: 97.0 97.0 146.0 97.0 97.0 96.0 141.0 97.0 96.0 139.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:06:10 INFO - PROCESS | 16271 | Values: 110.0 109.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 111.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 22:06:10 INFO - PROCESS | 16271 | Values: 148.0 147.0 147.0 145.0 146.0 148.0 146.0 147.0 147.0 146.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:06:10 INFO - PROCESS | 16271 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.62 (2.8%) stddev-sans-first:1.72 22:06:10 INFO - PROCESS | 16271 | Values: 58.0 57.0 57.0 56.0 58.0 60.0 60.0 59.0 58.0 55.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.27 (1.9%) stddev-sans-first:0.33 22:06:10 INFO - PROCESS | 16271 | Values: 71.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.76 (3.2%) stddev-sans-first:2.87 22:06:10 INFO - PROCESS | 16271 | Values: 85.0 86.0 86.0 86.0 84.0 85.0 86.0 94.0 87.0 86.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:125.00 stddev:5.33 (4.3%) stddev-sans-first:5.02 22:06:10 INFO - PROCESS | 16271 | Values: 115.0 118.0 127.0 114.0 120.0 127.0 126.0 129.0 120.0 124.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:151.50 stddev:2.51 (1.7%) stddev-sans-first:2.40 22:06:10 INFO - PROCESS | 16271 | Values: 148.0 151.0 153.0 151.0 153.0 149.0 156.0 148.0 150.0 152.0 22:06:10 INFO - PROCESS | 16271 | 22:06:10 INFO - PROCESS | 16271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.20 (3.2%) stddev-sans-first:2.32 22:06:10 INFO - PROCESS | 16271 | Values: 68.0 68.0 69.0 70.0 68.0 74.0 66.0 67.0 68.0 70.0 22:06:10 INFO - PROCESS | 16271 | -------- Summary: end -------- 22:06:10 INFO - PROCESS | 16271 | 22:06:11 INFO - TEST-INFO | 16271: exit 0 22:06:11 INFO - TEST-OK | kraken | took 59883ms 22:06:11 INFO - TEST-START | v8_7 22:06:11 INFO - operating with platform_type : linux_ 22:06:11 INFO - Initialising browser for v8_7 test... 22:06:11 INFO - TEST-INFO | started process 16560 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0DcTOs/profile http://localhost:40397/getInfo.html) 22:06:15 INFO - PROCESS | 16560 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 22:06:16 INFO - PROCESS | 16560 | __metrics Screen width/height:1600/1200 22:06:16 INFO - PROCESS | 16560 | colorDepth:24 22:06:16 INFO - PROCESS | 16560 | Browser inner width/height: 1024/697 22:06:16 INFO - PROCESS | 16560 | __metrics 22:06:16 INFO - PROCESS | 16560 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:06:17 INFO - TEST-INFO | 16560: exit 0 22:06:17 INFO - Browser initialized. 22:06:17 INFO - Running cycle 1/1 for v8_7 test... 22:06:17 INFO - TEST-INFO | started process 16681 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0DcTOs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:29 INFO - PROCESS | 16681 | RSS: Main: 150724608 22:06:29 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | Cycle 1(1): loaded http://localhost:40397/tests/v8_7/run.html (next: http://localhost:40397/tests/v8_7/run.html) 22:06:51 INFO - PROCESS | 16681 | RSS: Main: 147320832 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | __start_tp_report 22:06:51 INFO - PROCESS | 16681 | _x_x_mozilla_page_load 22:06:51 INFO - PROCESS | 16681 | _x_x_mozilla_page_load_details 22:06:51 INFO - PROCESS | 16681 | |i|pagename|runs| 22:06:51 INFO - PROCESS | 16681 | |0;Richards;170.2707304614337 22:06:51 INFO - PROCESS | 16681 | |1;DeltaBlue;190.47619047619048 22:06:51 INFO - PROCESS | 16681 | |2;Encrypt;280.3476310625175 22:06:51 INFO - PROCESS | 16681 | |3;Decrypt;5229.166666666667 22:06:51 INFO - PROCESS | 16681 | |4;RayTrace;1100.1100110011 22:06:51 INFO - PROCESS | 16681 | |5;Earley;746.8259895444362 22:06:51 INFO - PROCESS | 16681 | |6;Boyer;12192.77108433735 22:06:51 INFO - PROCESS | 16681 | |7;RegExp;41346.93877551021 22:06:51 INFO - PROCESS | 16681 | |8;Splay;565.2911249293386 22:06:51 INFO - PROCESS | 16681 | |9;NavierStokes;4835.748792270531 22:06:51 INFO - PROCESS | 16681 | __end_tp_report 22:06:51 INFO - PROCESS | 16681 | __startTimestamp1452233211776__endTimestamp 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | ------- Summary: start ------- 22:06:51 INFO - PROCESS | 16681 | Number of tests: 10 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#0] Richards Cycles:1 Average:170.27 Median:170.27 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 170.3 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#1] DeltaBlue Cycles:1 Average:190.48 Median:190.48 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 190.5 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 280.3 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 5229.2 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 1100.1 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#5] Earley Cycles:1 Average:746.83 Median:746.83 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 746.8 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 12192.8 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#7] RegExp Cycles:1 Average:41346.94 Median:41346.94 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 41346.9 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#8] Splay Cycles:1 Average:565.29 Median:565.29 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 565.3 22:06:51 INFO - PROCESS | 16681 | 22:06:51 INFO - PROCESS | 16681 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:06:51 INFO - PROCESS | 16681 | Values: 4835.7 22:06:51 INFO - PROCESS | 16681 | -------- Summary: end -------- 22:06:51 INFO - PROCESS | 16681 | 22:06:52 INFO - TEST-INFO | 16681: exit 0 22:06:52 INFO - TEST-OK | v8_7 | took 40872ms 22:06:52 INFO - SUITE-END | took 1211s 22:06:52 INFO - Completed test suite (00:20:12) 22:06:52 INFO - Working with test: dromaeo_css 22:06:52 INFO - Generating results file: dromaeo_css 22:06:52 INFO - Working with test: kraken 22:06:52 INFO - Generating results file: kraken 22:06:52 INFO - javascript benchmark 22:06:52 INFO - Working with test: v8_7 22:06:52 INFO - Generating results file: v8_7 22:06:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:06:52 INFO - process_Request line: dromaeo_css 6787.72 graph.html#tests=[[72,1,43]] 22:06:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:52 INFO - process_Request line: kraken 1522.70 graph.html#tests=[[232,1,43]] 22:06:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:52 INFO - process_Request line: v8_7 20276.05 graph.html#tests=[[230,1,43]] 22:06:52 INFO - RETURN: dromaeo_css: 6787.72 22:06:52 INFO - RETURN: kraken: 1522.70 22:06:52 INFO - RETURN: v8_7: 20276.05 22:06:52 INFO - javascript benchmark 22:06:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3133.3889891471167, 3197.0408877336795, 3203.4874420092783, 3219.7746157768966, 3253.642099369069, 5063.265826455162, 5114.923276150861, 5174.611904107188, 5188.325517682701, 5227.764750586223, 5109.948900510994, 5127.487251274871, 5154.0980328442465, 5186.896262074766, 5207.166853303473, 4702.130105930405, 4725.929111063337, 4725.929111063337, 4796.640251981098, 4797.136515427222, 4762.928556071662, 4788.209945359012, 4794.7842347094465, 4805.639577031719, 4806.591439727627, 4462.531434199411, 4681.976590117045, 4733.313669517935, 4746.121967436035, 4760.809567617292, 4720.811167553294, 4742.668013239075, 4744.572988431058, 4761.880952976168, 4774.880627984294, 4619.584237418615, 4687.671862969593, 4733.384659994179, 4747.35910652061, 4775.283707443911, 4975.3532040834825, 5015.0471410432265, 5018.322526458918, 5018.949810501885, 5082.1360368737405, 5521.254630624854, 5524.116141417394, 5528.806491772769, 5529.529989950859, 5572.637778544382, 5447.836564903059, 5541.418151094117, 5563.527100196488, 5570.164475328693, 5572.164175373686, 5206.661566998133, 5239.973800131013, 5287.312649355597, 5288.524032837063, 5300.125479295912, 5685.505880017896, 5685.914711279334, 5706.600537962303, 5708.457696518824, 5812.331581868055, 5291.232771248147, 5407.972960135253, 5429.972850135803, 5526.834194974157, 5541.113421852565, 5609.607327487119, 5609.719514024282, 5625.803096891589, 5634.971825140848, 5650.802221922213, 5528.170774383874, 5560.2493663355735, 5564.527015203672, 5576.832695019156, 5589.776408943597, 5429.918551221735, 5530.5852061095575, 5543.805966791143, 5617.185508101303, 5686.147077938343, 4339.73961562301, 4352.238358287287, 4356.281213599784, 4363.214621368121, 4400.537943515948, 3825.7757517594105, 3900.7464514806447, 3928.705347098979, 3947.5657677655436, 3957.782321972319, 5180.559652429586, 5199.0, 5226.320578324793, 5241.449647787003, 5321.122014867504, 5565.860853478695, 5616.073347897551, 5626.746796394172, 5646.520045796154, 5647.576431767634, 5149.176131818891, 5223.973880130575, 5230.968126895789, 5260.026895024356, 5308.681479111266, 4731.243001119804, 4784.976075119602, 4798.04039192163, 4810.350602668665, 4850.83022094225, 5791.333996590446, 5836.445537673914, 5837.09525023622, 5844.532437404998, 5878.294604647384, 5486.204500347507, 5533.253010843485, 5609.691466969356, 5639.125935480007, 5642.153676948491, 5772.797952071657, 5799.188113664006, 5806.68063256525, 5815.94184058154, 5816.069428891357, 5495.725213739377, 5571.0, 5580.414056524169, 5583.162525621189, 5583.581231407579, 5438.0, 5550.0, 5618.185363122406, 5627.971860140673, 5675.829725108253, 5488.890222195613, 5501.0648189807025, 5508.44915508446, 5516.9448305518035, 5524.171374293888, 5448.210009548672, 5478.205660179331, 5489.313835770528, 5489.984352894728, 5506.807261745819, 5168.896622067613, 5311.229871668664, 5322.121849894879, 5323.494268044529, 5326.9733651333045, 5385.515303622693, 5435.429279925551, 5435.728213589384, 5456.045192091288, 5464.781408743765, 5293.761780719799, 5307.601929855354, 5391.892162156656, 5413.675179489243, 5442.891142177055], "unit": "score", "name": "dojo.html", "value": 5149.111104879876}, {"lowerIsBetter": false, "replicates": [529.6213207556597, 532.5499952540105, 534.6471328922909, 549.8048192891523, 556.8886222755444, 34155.487667684974, 35456.0, 35502.82248588757, 35522.93431197065, 35564.644353556454, 38529.229415411675, 39011.0, 39130.0, 39132.60867391325, 39141.41287880677, 8442.282405995482, 8577.742667719947, 8622.956885215564, 8646.308295336357, 8663.0, 8306.460080094774, 8524.147585241488, 8544.74365769028, 8709.25971292441, 8721.212151508957, 8698.652053917867, 8745.912540874606, 8782.209601135897, 8796.0, 8802.239552089575, 8619.353548483858, 8631.050584435707, 8651.870221946707, 8730.388872778907, 8735.868961965576, 8450.746477605682, 8607.09625489321, 8616.267617252479, 8636.39545231834, 8644.0, 38325.42511862324, 38354.616453835384, 38693.419598706045, 38732.806335968424, 38981.61018389808, 3193.297474555594, 3209.823459709715, 3282.441984862579, 3506.8421921013614, 3563.768355056913, 28650.713492865012, 29328.560071598942, 29346.853265733534, 29382.55926161109, 29872.40255194884, 3895.14306852492, 4037.899052523681, 4062.55311915692, 4076.2458945095254, 4188.790560471964, 256484.0, 258548.0, 259628.0, 260189.69905150353, 260565.0, 41109.38335924964, 41411.37882931758, 41451.7927410361, 41563.843615638194, 56016.71991640016, 39748.60251397507, 40063.39904901429, 40131.39802902959, 40169.0, 40261.0, 13650.0, 13771.724565508634, 13775.793363099561, 13779.724405512034, 13799.172049677052, 10846.78306433867, 10887.346759194315, 10968.067714244218, 10969.341839489656, 11046.56394668688, 13983.860161398256, 14085.929570352082, 14178.078424902349, 14209.218492982985, 14264.072835265675, 5530.0, 5557.249771280906, 5637.379888212376, 5657.15142728594, 5667.291588551431, 853.7865533616596, 884.1070518776082, 913.1963871792913, 998.1765043838863, 1007.7279134633608, 26488.205353839414, 27289.31776705598, 27316.726832731816, 27489.89856107559, 27609.585856212172, 994.174834887042, 1004.7186787699455, 1072.8122578548723, 1113.1929351220463, 1129.1192869561755, 14543.85456145425, 14662.120272783666, 14662.706745865024, 14740.0, 14854.405823766929, 312251.0, 312450.0, 312532.0, 314411.0, 314602.0, 50045.24932126021, 50216.49783502191, 50337.0, 50604.0, 50931.23603145956, 1251.3242848861512, 1278.7634287656813, 1285.190330092036, 1301.635542048228, 1306.751717173734, 25796.61305080463, 27014.594781077907, 27142.457150857266, 27482.725172748815, 33639.4954075694, 46763.53236467592, 47709.284360733924, 47753.28370074382, 47785.28322075102, 48148.27777583269, 212525.0, 216576.0, 216886.0, 217516.0, 217791.0, 38744.0, 39155.60844391634, 39621.0, 39705.2058958825, 39752.20495590014, 42272.15455690931, 46150.769246153555, 46477.767611161726, 46666.766666166455, 47311.0, 38807.80596097114, 39060.609393905695, 39596.0, 39674.0, 40430.393544096274, 38153.61846381501, 38801.61198388093, 39213.41179882247, 39373.21253574855, 39557.0, 38369.42445863259, 38482.230355393294, 38765.0, 39812.0, 39880.60119398885, 32549.18627034343, 33387.66612333846, 34804.82597586996, 35651.46522802108, 35889.282214355044, 25973.740262597134, 26424.471510570067, 26460.676966152, 26487.33781655474, 26889.462210756068], "unit": "score", "name": "ext.html", "value": 17607.799756499277}, {"lowerIsBetter": false, "replicates": [353.18943025755885, 354.8740197229983, 357.6155632694854, 357.97673151245175, 358.8226256498704, 16004.279807408666, 16030.0, 16737.16314184292, 16909.915450422763, 17499.037552934617, 15733.213339333044, 15767.763483547757, 16114.033158010498, 16268.51194464165, 16315.59211019725, 4948.999999999991, 5066.290719299301, 5110.616703747215, 5125.077486052509, 5129.076766182105, 4915.631327650441, 4952.207646776516, 5076.44159142494, 5448.264484294609, 5491.368492623359, 5472.26124473195, 5492.505674489295, 6058.545609079315, 6396.584222025576, 6414.807555773311, 6189.226346706684, 6336.493080553568, 6387.552871299011, 6515.250746164204, 6537.607743535403, 6131.0, 6245.843853903643, 6278.089676996856, 6306.716197771111, 6600.966995164993, 20942.0, 21221.0, 21365.57268854614, 21467.892660536752, 22383.10467581295, 2087.5824835033054, 2098.26560703754, 2124.352072617851, 2189.2447105748493, 2246.5731511012855, 13302.467901283937, 13362.198268103944, 13592.524261650893, 13786.172829630254, 14292.499762508367, 1872.26981477224, 1872.662920674278, 1931.6619591571418, 1951.9902400487906, 1958.0405601255281, 60982.69508652428, 62585.68707156435, 63631.045534317025, 64082.35917640811, 64404.0, 14057.43770249199, 14639.268036598127, 14742.557723268319, 14828.555143345717, 14858.2570871456, 12396.132270740962, 12761.489540418279, 12896.871031289755, 23338.416539586306, 23353.299401017997, 7113.288671132846, 7315.707371705179, 7555.13115991668, 7557.488502299562, 7589.810254743676, 7258.927410725931, 7279.272072792678, 7289.963550182321, 7310.232425595343, 7345.0, 4344.869653910388, 4383.895730049594, 4389.978050109729, 4394.077243778778, 4509.706869053501, 1761.6652835961127, 1784.3130394798097, 1811.818818118204, 1852.4720454670355, 1855.0, 839.727088696164, 878.1526124297726, 1024.6362541297733, 1034.798214348195, 1051.0172988256006, 16140.919295403448, 16256.83947532792, 16387.34450621962, 16564.254608542644, 16754.83245167557, 900.8739375074819, 905.8414777413926, 912.4844462878452, 915.9358844880794, 957.095544710256, 9481.525923703788, 9659.758506037264, 9672.75818104539, 9696.903030969741, 9827.656032038843, 433199.0, 434086.0, 435233.0, 446362.0, 471502.0, 69503.3049669507, 70562.0, 70719.0, 73861.0, 74895.0, 1044.5038606661926, 1048.4286064095086, 1066.983995240072, 1079.2607064161075, 1083.9024487796137, 14260.714785704435, 14459.13245205291, 14860.702785944437, 14893.40426382976, 15009.024413413093, 29408.705912940597, 30393.848030759706, 30882.0, 31044.379112418075, 31263.68736312608, 36129.0, 36661.0, 36787.08032299214, 38126.0, 39048.80475597604, 2966.228780517038, 6445.516586255956, 6912.55068420551, 7247.021652076902, 7277.781666550012, 10526.947365263124, 10650.57397704083, 11351.54593816238, 11601.941990290332, 11614.767704646029, 9393.29749605317, 9503.952480237554, 9643.18709580758, 9813.362131461432, 10071.194304455772, 9333.113354231336, 9601.47191904452, 9897.604095836086, 9956.850647240153, 10084.294099412971, 9823.36148150368, 10018.39889606626, 10169.542370593488, 10194.43930583825, 10217.182625389802, 6898.448124150156, 7135.179454362815, 7157.212706602374, 7160.964195178991, 7457.776266712007, 10004.0, 10028.899711002796, 10052.849207262043, 10145.746356341151, 10349.327293725884], "unit": "score", "name": "jquery.html", "value": 8402.208029685837}, {"lowerIsBetter": false, "replicates": [1384.8822850057745, 1405.3746082993068, 1509.3811537269721, 1684.1074230657755, 1688.9831101688972, 6967.059446974657, 7041.155061392634, 7117.608531530764, 7245.855082898339, 7262.237465066171, 7132.893006604892, 7170.103737032871, 7203.171635261933, 7218.819529511765, 7232.927670723291, 2217.246136313653, 2236.373815331706, 2253.9436514087197, 2255.86464812111, 2260.886955652219, 2277.5786479501344, 2292.151903795598, 2312.9884350578222, 2319.1998760427628, 2321.303608917318, 2266.1388672304583, 2266.172846910882, 2283.6232021716396, 2292.2206449807063, 2294.4149241943283, 2218.4453886528368, 2252.042881775239, 2270.988645056764, 2272.6591011348264, 2277.294038847946, 2244.0574958517464, 2259.807916327114, 2260.107257633242, 2261.7512073672046, 2262.479629685165, 7025.051618031552, 7032.92967070333, 7041.92958070423, 7046.929530704679, 7089.361957423805, 4479.037007043468, 4608.1705293047235, 4611.584957353821, 4617.907641847144, 4628.09752098341, 3027.197792584967, 3051.5727798108283, 3151.11768704763, 3160.383725173592, 3172.3496683180124, 1018.623109449501, 1052.4369462337688, 1056.0706578211202, 1088.5264909764198, 1089.6513115802945, 9769.316147869651, 9808.068233517733, 9863.408195508293, 9901.900980990169, 9902.059304366074, 4125.443065186161, 4166.0834616384345, 4237.745735255833, 4258.297380932111, 4275.166342563232, 8609.268212202032, 8615.956920215483, 8619.965604127545, 8638.17937295956, 8658.134186581292, 4641.280601506772, 4708.670393072452, 4710.788014539354, 4713.29300604912, 4734.881627959328, 4261.424707664488, 4263.4031235627035, 4287.957120428756, 4298.4841818981295, 4326.896641356497, 3540.0972751948602, 3576.1238496567985, 3581.552305961755, 3590.281943611288, 3611.115276757211, 1141.7773534160924, 1191.2137988927266, 1192.451472322724, 1202.6091520255952, 1203.5306230570084, 794.9006374203225, 875.369733791669, 1052.8104941110673, 1088.2708585247904, 1234.3396282988738, 6392.968035159887, 6395.392437718409, 6444.742210311629, 6452.774152904626, 6454.709538070798, 594.8423667728056, 596.4542443664086, 601.485729701108, 608.3916083916084, 741.0773586884363, 4819.373481447389, 4870.659053866266, 4880.585150262196, 4913.041956818386, 4935.654504184673, 8132.390070744717, 8432.831343373098, 8479.915200847912, 8506.872396913928, 8676.175763302475, 8519.829603408021, 8585.8712119317, 8632.568371581396, 8643.09247529013, 8653.69712060075, 6529.7388104475285, 6553.868922621521, 6561.606303621798, 6570.080188773575, 6687.531872768956, 6264.498840092872, 6381.457576105898, 6403.135576697086, 6418.101465794699, 6443.484521238383, 7472.850542989001, 7581.090269167735, 7739.226077392215, 7742.883856742041, 7860.489068210548, 7808.375329973702, 7838.098618658699, 7905.249001344863, 8035.116137225017, 8050.959745201237, 6034.547408944259, 6149.046897730859, 6150.938490615036, 6156.168917196301, 6171.413715697002, 6404.327545607644, 6454.160959075478, 6504.349565043647, 6661.566998145105, 6667.433268172065, 6219.813405597658, 6271.529635277281, 6294.370562943669, 6372.139761132188, 6404.199475065617, 6204.844878877883, 6244.687765611792, 6245.375462453719, 6302.338254483213, 6323.557350985387, 6143.078538219303, 6199.380061993765, 6313.652749098844, 6325.0, 6369.617822930639, 5745.080787074048, 5764.106563482667, 5770.307563092456, 5772.855678608068, 5794.0, 5839.0, 5848.6783226921225, 5882.558808089325, 5944.4352786485215, 5968.283805943314], "unit": "score", "name": "mootools.html", "value": 4160.3450884806}, {"lowerIsBetter": false, "replicates": [332.4730302470584, 346.19509640086795, 346.6689311707318, 353.21057436629116, 358.90847833802377, 6214.223222097238, 6222.439980401763, 6236.253848922298, 6241.063840423939, 6336.841578960528, 6218.25380954285, 6271.404216599427, 6274.435300822936, 6280.6859657017085, 6287.59130656507, 4780.928286075694, 4783.186858234091, 4785.784639691205, 4786.138495070886, 4794.089123066624, 4778.904421911559, 4780.091782561302, 4790.54489823468, 4793.5925446337105, 4796.184648609745, 4654.720716756989, 4731.313959475874, 4732.716037037789, 4735.9526404736025, 4736.194846876022, 4713.858584242478, 4714.292856071583, 4731.313959475891, 4754.263089221142, 4762.76168196268, 4115.259253334399, 4120.423140760296, 4128.566500517462, 4135.731177473454, 4137.048478849852, 5954.196183515213, 5954.821355359346, 5966.343702192756, 5969.611975221596, 5983.431574000463, 5477.20580515827, 5530.5852061095575, 5580.051391263454, 5581.6371935824045, 5587.608867379285, 6677.699503522354, 6685.0640910272605, 6694.928811390154, 6696.330366963265, 6697.6986035628515, 4573.679842411033, 4588.105319462706, 4591.334256532784, 4596.816127354902, 4598.931016034762, 6811.284815094443, 6906.861862762717, 6954.4436445084275, 6964.164300283998, 6970.268121847234, 4669.60308373792, 4672.462666793294, 4678.60231880294, 4679.251319788817, 4686.859394218179, 4736.621070314367, 4738.099761045391, 4742.691725037862, 4743.501932297128, 4744.430668319824, 5520.91718624221, 5527.474889885454, 5529.115341545334, 5529.917051244234, 5531.557475401958, 6589.143411356493, 6690.163729533809, 6710.563813352116, 6715.160604924385, 6726.890063139527, 1609.1793185475492, 1643.8767092468113, 1671.3732350368612, 1671.707451196036, 1672.3143511160365, 1086.190787863047, 1092.6503518874042, 1093.748437859281, 1098.2147764348529, 1104.9502772375263, 6240.31356550779, 6252.718627661766, 6269.341719119518, 6300.054991751183, 6300.149479820166, 6804.693788779517, 6813.080234168423, 6813.931860681429, 6821.1814582250445, 6829.897551536731, 6170.691465426711, 6261.405166509175, 6266.185395898504, 6286.18279623646, 6308.369163083655, 3693.261347730465, 3709.7943168469815, 3711.4989476420337, 3713.665770080706, 3714.312852122312, 7140.214576396592, 7144.24985376528, 7145.785626431111, 7148.714051437988, 7170.92829071713, 6893.0694356261265, 6962.268961758942, 7011.964940175267, 7012.719491220396, 7023.192332881784, 7130.215676275606, 7155.356017958408, 7158.749443769443, 7186.568805871664, 7240.312170343915, 6789.694463749242, 6792.626405547742, 6797.966010169917, 6801.761938332134, 6816.863662726619, 6568.146141001639, 6726.293739157513, 6743.7302507901095, 6750.6624668767345, 6753.527253092237, 7056.894146587908, 7107.111611048619, 7109.502334836512, 7123.109611298588, 7164.426845852215, 4663.510331415153, 4677.134730074947, 4695.506971768052, 4696.2486002239475, 4721.952780472288, 6706.530542861953, 6849.1780986281965, 6870.175578930361, 6890.0, 6913.101296831581, 6730.596164230162, 6734.528582999143, 6753.2909044549615, 6762.763303284558, 6765.1205343305055, 6715.328467153441, 6720.361565651256, 6722.831929201809, 6732.360425759545, 6737.29258427858, 6495.837604059936, 6595.043718660671, 6606.933930660632, 6620.966895165493, 6633.800985970235, 6681.966590167018, 6688.398044176048, 6708.22855371619, 6713.227978782503, 6781.287964763629, 6523.0, 6582.341765823379, 6588.308227636029, 6594.208694956636, 6607.471402287902], "unit": "score", "name": "prototype.html", "value": 5001.829049777456}, {"lowerIsBetter": false, "replicates": [623.2520974830202, 670.1087553553774, 727.4398712990997, 812.3460614205562, 827.4786884262913, 13171.20972741635, 13225.801612975813, 13261.403236854341, 13506.054576179671, 13551.119177253497, 12378.133530652858, 12386.81419778704, 12400.81398779019, 12417.441215145318, 12434.62696119118, 775.9602133141589, 791.181127533002, 803.0925054688195, 803.148662417836, 804.1355542791493, 801.1227705662319, 809.4091313341264, 811.3509192645889, 811.7118422959824, 813.259933460551, 846.8687353460224, 848.4485084694936, 851.7913111287743, 851.8381507513552, 852.735651947895, 835.2983493865122, 843.4348986179306, 843.4601854812925, 844.0125053687201, 845.6744153500946, 617.4042049422284, 618.9721462534196, 619.2476141488114, 620.0667994668041, 620.7485968182893, 13204.471821127143, 13214.669633259246, 13264.87761958082, 13291.268980206085, 13335.599932001958, 11849.229800062969, 12041.518339266506, 12056.819147712791, 12187.32969686667, 12243.632691019284, 9902.752431189207, 10033.0, 10116.241281903887, 10274.075333220046, 10395.0, 3483.860645574174, 3537.964620353789, 3545.840437180333, 3555.8577656893694, 3667.6332366763377, 41846.999999999694, 41864.37203441951, 42353.788231058956, 42522.787386062875, 42606.248156499096, 9314.673986410444, 9370.203532699661, 9432.922378737041, 9573.569189386495, 9584.472853993097, 16459.670806583803, 16545.420910268083, 16619.0, 16622.75065874013, 16666.749998750027, 7550.131734850453, 7638.236176382428, 7661.540307581563, 7673.769786906401, 8056.355491560661, 4222.4933008038615, 4254.276772948606, 4305.440292761921, 4325.437693099877, 4404.075144219686, 2868.827870327745, 2875.7555607773156, 2877.4676684813376, 2895.1604034829666, 2909.0, 539.2935254816203, 563.1159080243978, 571.2316933724135, 574.9051406517962, 575.0827430248746, 498.12827551784375, 508.189437846634, 543.7308532276548, 562.9408912064256, 613.6900865063204, 7491.887621685679, 7792.766217013499, 8250.834983300421, 8556.443831150955, 8829.779255518664, 652.5953908576713, 666.1539844397588, 677.5291172634971, 680.8195828105556, 695.0824911117277, 3961.168154687548, 4252.55348188442, 4353.238183317907, 4353.651707863427, 4378.562143785596, 47038.29442558364, 58247.417525824196, 58495.70752146212, 58586.0, 63314.683426582575, 45889.31166032512, 46744.766276168404, 46813.765931170805, 46844.297335539995, 47096.29355559669, 48169.75915120472, 48347.516524835, 53337.466625334026, 54021.0, 55013.449865500836, 8339.374546909128, 8757.737267881974, 8813.338999575186, 8887.0, 9049.819003620023, 31890.36219275555, 32338.191545211557, 34424.65575344315, 34580.13549661178, 37170.8141459291, 41351.1729765409, 42705.5729442714, 42735.1452970945, 43556.78221608998, 44831.77584112189, 10897.346159230472, 11174.161937854531, 11197.0, 11299.152563557931, 11481.655550333504, 11451.083913287084, 11713.1800773945, 11753.706157346134, 11957.282563046245, 12874.806877897026, 11301.547938082713, 11439.542418303508, 11449.656510304705, 11477.0, 11686.532538698357, 11368.090552755924, 11606.419679016184, 11702.765944681229, 12059.276443413422, 12107.33409662477, 10126.341787783771, 10590.735231618963, 10916.454177291262, 10937.352942633284, 11465.885341146482, 9318.921187952717, 9380.906190938276, 9442.433453992782, 9467.905320946702, 9665.226781857575, 8606.569671516525, 9094.681686140953, 9204.43021614199, 9356.298277629068, 9759.951200244237], "unit": "score", "name": "yui.html", "value": 6169.004340962146}], "name": "dromaeo_css", "value": 6787.7172725813425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 111.0, 113.0, 123.0, 112.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 165.0, 165.0, 124.0, 153.0, 159.0, 129.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 163.0, 161.0, 161.0, 166.0, 164.0, 165.0, 176.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 74.0, 75.0, 75.0, 143.0, 74.0, 74.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 146.0, 97.0, 97.0, 96.0, 141.0, 97.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 145.0, 146.0, 148.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 56.0, 58.0, 60.0, 60.0, 59.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 86.0, 84.0, 85.0, 86.0, 94.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 127.0, 114.0, 120.0, 127.0, 126.0, 129.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 153.0, 151.0, 153.0, 149.0, 156.0, 148.0, 150.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 70.0, 68.0, 74.0, 66.0, 67.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1522.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.2707304614337], "unit": "score", "name": "Richards", "value": 207.32864600000002}, {"lowerIsBetter": false, "replicates": [190.47619047619048], "unit": "score", "name": "DeltaBlue", "value": 347.1194999999999}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1100.1100110011], "unit": "score", "name": "RayTrace", "value": 672.6500009999999}, {"lowerIsBetter": false, "replicates": [746.8259895444362], "unit": "score", "name": "Earley", "value": 892.3939569999998}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [41346.93877551021], "unit": "score", "name": "RegExp", "value": 22.03270730503455}, {"lowerIsBetter": false, "replicates": [565.2911249293386], "unit": "score", "name": "Splay", "value": 144.15757899999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20276.052512807022}]} 22:06:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20276.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6787.72"}}} 22:06:53 INFO - Return code: 0 22:06:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:06:53 INFO - # TBPL SUCCESS # 22:06:53 INFO - Running post-action listener: _resource_record_post_action 22:06:53 INFO - Running post-run listener: _resource_record_post_run 22:06:54 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 562466816; Read time: 0; Write time: 501312 22:06:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239198208; Read time: 0; Write time: 317524 22:06:54 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 323268608; Read time: 0; Write time: 183788 22:06:54 INFO - Running post-run listener: _upload_blobber_files 22:06:54 INFO - Blob upload gear active. 22:06:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:06:54 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:06:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:06:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:08:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:29 INFO - (blobuploader) - INFO - Done attempting. 22:08:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:08:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:35 INFO - (blobuploader) - INFO - Done attempting. 22:08:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:35 INFO - Return code: 0 22:08:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:08:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2269e276dfda2be562c5a673192b81a57997cbe205ee376290f911224383627e79aff4c37688a65c7393551fd64b0122cdc44b67b1330a7f5e12e0817f9ceada", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09c2b58a9e5b9a9980c1924e1129e11b690e1826502532e4e09acfa8e56e1e3ac2a61e705d1bfa0cf7c1759ffb658e8df68f3e54a9d144c8ab0cd22963dcb0b2"} 22:08:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:08:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:08:35 INFO - Contents: 22:08:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2269e276dfda2be562c5a673192b81a57997cbe205ee376290f911224383627e79aff4c37688a65c7393551fd64b0122cdc44b67b1330a7f5e12e0817f9ceada", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09c2b58a9e5b9a9980c1924e1129e11b690e1826502532e4e09acfa8e56e1e3ac2a61e705d1bfa0cf7c1759ffb658e8df68f3e54a9d144c8ab0cd22963dcb0b2"} 22:08:35 INFO - Copying logs to upload dir... 22:08:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1378.856154 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2016-01-07 22:08:35.642206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:35.645387) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2269e276dfda2be562c5a673192b81a57997cbe205ee376290f911224383627e79aff4c37688a65c7393551fd64b0122cdc44b67b1330a7f5e12e0817f9ceada", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09c2b58a9e5b9a9980c1924e1129e11b690e1826502532e4e09acfa8e56e1e3ac2a61e705d1bfa0cf7c1759ffb658e8df68f3e54a9d144c8ab0cd22963dcb0b2"} build_url:https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2269e276dfda2be562c5a673192b81a57997cbe205ee376290f911224383627e79aff4c37688a65c7393551fd64b0122cdc44b67b1330a7f5e12e0817f9ceada", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09c2b58a9e5b9a9980c1924e1129e11b690e1826502532e4e09acfa8e56e1e3ac2a61e705d1bfa0cf7c1759ffb658e8df68f3e54a9d144c8ab0cd22963dcb0b2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:35.669499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:35.669799) ========= 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=cbe409c6de289db6ac707de3000001d4-1452231482.441531-1230482455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:35.755850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 22:08:35.756184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 22:08:35.756468) ========= ========= Total master_lag: 0.22 =========