builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1452127824.62 results: success (0) buildid: 20160106143005 builduid: 6f026addd85f4fff9b8a0abe20d012bb revision: 5eec88560653613a325bd083dc9a5d95528a3685 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.621483) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.621976) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.622298) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.651873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.652245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.686549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.686887) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.753234) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.753572) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.754214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.754551) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 16:50:25-- 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% 221M=0s 2016-01-06 16:50:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.937410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:24.937764) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016081 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:25.014616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 16:50:25.015027) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5eec88560653613a325bd083dc9a5d95528a3685 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5eec88560653613a325bd083dc9a5d95528a3685 --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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 16:50:25,308 truncating revision to first 12 chars 2016-01-06 16:50:25,308 Setting DEBUG logging. 2016-01-06 16:50:25,308 attempt 1/10 2016-01-06 16:50:25,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5eec88560653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 16:50:26,438 unpacking tar archive at: fx-team-5eec88560653/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 16:50:26.468633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:26.469230) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:26.479056) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:26.479358) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 16:50:26.479830) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-06 16:50:26.480151) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:26 INFO - MultiFileLogger online at 20160106 16:50:26 in /builds/slave/test-pgo 16:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:50:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:50:26 INFO - {'append_to_log': False, 16:50:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:50:26 INFO - 'blob_upload_branch': 'Fx-Team', 16:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:50:26 INFO - 'branch': 'Fx-Team', 16:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:26 INFO - 'config_files': ('talos/linux_config.py',), 16:50:26 INFO - 'default_actions': ('clobber', 16:50:26 INFO - 'read-buildbot-config', 16:50:26 INFO - 'download-and-extract', 16:50:26 INFO - 'populate-webroot', 16:50:26 INFO - 'create-virtualenv', 16:50:26 INFO - 'install', 16:50:26 INFO - 'run-tests'), 16:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:26 INFO - 'download_minidump_stackwalk': True, 16:50:26 INFO - 'download_symbols': 'ondemand', 16:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:26 INFO - 'installer_path': 'installer.exe', 16:50:26 INFO - 'log_level': 'info', 16:50:26 INFO - 'log_name': 'talos', 16:50:26 INFO - 'log_to_console': True, 16:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:26 INFO - 'opt_config_files': (), 16:50:26 INFO - 'pip_index': False, 16:50:26 INFO - 'sps_profile': False, 16:50:26 INFO - 'sps_profile_interval': 0, 16:50:26 INFO - 'suite': 'dromaeojs', 16:50:26 INFO - 'system_bits': '32', 16:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:26 INFO - 'title': 'talos-linux64-ix-005', 16:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:26 INFO - 'use_talos_json': True, 16:50:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:26 INFO - 'work_dir': 'build'} 16:50:26 INFO - ##### 16:50:26 INFO - ##### Running clobber step. 16:50:26 INFO - ##### 16:50:26 INFO - Running pre-action listener: _resource_record_pre_action 16:50:26 INFO - Running main action method: clobber 16:50:26 INFO - rmtree: /builds/slave/test-pgo/build 16:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running read-buildbot-config step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: read_buildbot_config 16:50:27 INFO - Using buildbot properties: 16:50:27 INFO - { 16:50:27 INFO - "project": "", 16:50:27 INFO - "product": "firefox", 16:50:27 INFO - "script_repo_revision": "production", 16:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:50:27 INFO - "repository": "", 16:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:50:27 INFO - "buildid": "20160106143005", 16:50:27 INFO - "pgo_build": "True", 16:50:27 INFO - "basedir": "/builds/slave/test-pgo", 16:50:27 INFO - "buildnumber": 879, 16:50:27 INFO - "slavename": "talos-linux64-ix-005", 16:50:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:50:27 INFO - "platform": "ubuntu64_hw", 16:50:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:50:27 INFO - "branch": "fx-team", 16:50:27 INFO - "repo_path": "integration/fx-team", 16:50:27 INFO - "revision": "5eec88560653613a325bd083dc9a5d95528a3685", 16:50:27 INFO - "stage_platform": "linux64-pgo", 16:50:27 INFO - "builduid": "6f026addd85f4fff9b8a0abe20d012bb", 16:50:27 INFO - "slavebuilddir": "test" 16:50:27 INFO - } 16:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running download-and-extract step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: download_and_extract 16:50:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:50:27 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')]} 16:50:27 INFO - https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/test_packages.json 16:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/test_packages.json 16:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:50:37 INFO - Downloaded 1302 bytes. 16:50:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:50:37 INFO - Using the following test package requirements: 16:50:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'jsshell-linux-x86_64.zip'], 16:50:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50: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')]} 16:50:37 INFO - https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:45 INFO - Downloaded 24102051 bytes. 16:50:45 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 16:50:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:45 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 16:50:46 INFO - Return code: 0 16:50:46 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 16:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:46 INFO - https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:47 INFO - Downloaded 24102051 bytes. 16:50:47 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 16:50:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:47 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 16:50:48 INFO - Return code: 0 16:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:48 INFO - https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:50:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:49 INFO - Downloaded 11132285 bytes. 16:50:49 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 16:50:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:49 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 16:50:49 INFO - Return code: 0 16:50:49 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')]} 16:50:49 INFO - https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMRgKqp0Sx-QYemeUMcXDA/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 16:50:51 INFO - Downloaded 55053627 bytes. 16:50:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:51 INFO - mkdir: /builds/slave/test-pgo/properties 16:50:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:50:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:50:51 INFO - Contents: 16:50:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:51 INFO - Running post-action listener: _resource_record_post_action 16:50:51 INFO - Running post-action listener: set_extra_try_arguments 16:50:51 INFO - ##### 16:50:51 INFO - ##### Running populate-webroot step. 16:50:51 INFO - ##### 16:50:51 INFO - Running pre-action listener: _resource_record_pre_action 16:50:51 INFO - Running main action method: populate_webroot 16:50:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:51 INFO - '--tppagecycles', 16:50:51 INFO - '7'], 16:50:51 INFO - 'tests': ['tsvgm']}}, 16:50:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:50:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['damp', 'tps']}, 16:50:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['damp', 'tps']}, 16:50:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:50:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:51 INFO - 'other': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'other_l64': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'other_nol64': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore']}, 16:50:51 INFO - 'svgr': {'tests': ['tsvgx', 16:50:51 INFO - 'tsvgr_opacity', 16:50:51 INFO - 'tart', 16:50:51 INFO - 'tscrollx', 16:50:51 INFO - 'cart']}, 16:50:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['tsvgx', 16:50:51 INFO - 'tsvgr_opacity', 16:50:51 INFO - 'tart', 16:50:51 INFO - 'tscrollx', 16:50:51 INFO - 'cart']}, 16:50:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['tp5o']}, 16:50:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--e10s'], 16:50:51 INFO - 'tests': ['tp5o']}, 16:50:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--xperf_path', 16:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:51 INFO - 'tests': ['tp5n']}, 16:50:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--e10s', 16:50:51 INFO - '--xperf_path', 16:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:51 INFO - 'tests': ['tp5n']}}, 16:50:51 INFO - 'talos.zip': {'path': '', 16:50:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:51 INFO - Running post-action listener: _resource_record_post_action 16:50:51 INFO - ##### 16:50:51 INFO - ##### Running create-virtualenv step. 16:50:51 INFO - ##### 16:50:51 INFO - Running pre-action listener: _resource_record_pre_action 16:50:51 INFO - Running main action method: create_virtualenv 16:50:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:50:51 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 16:50:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:50:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:51 INFO - Using real prefix '/usr' 16:50:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:50:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:53 INFO - Installing pip.................done. 16:50:53 INFO - Return code: 0 16:50:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:50:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 16:50:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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 16:50:53 INFO - Using env: {'DISPLAY': ':0', 16:50:53 INFO - 'HOME': '/home/cltbld', 16:50:53 INFO - 'LANG': 'en_US.UTF-8', 16:50:53 INFO - 'LANGUAGE': 'en_US:en', 16:50:53 INFO - 'LOGNAME': 'cltbld', 16:50:53 INFO - 'MAIL': '/var/mail/cltbld', 16:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:53 INFO - 'MOZ_NO_REMOTE': '1', 16:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:53 INFO - 'NO_EM_RESTART': '1', 16:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:53 INFO - 'SHELL': '/bin/bash', 16:50:53 INFO - 'SHLVL': '1', 16:50:53 INFO - 'TERM': 'linux', 16:50:53 INFO - 'TMOUT': '86400', 16:50:53 INFO - 'USER': 'cltbld', 16:50:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:53 INFO - '_': '/tools/buildbot/bin/python'} 16:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:53 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 16:50:53 INFO - Cleaning up... 16:50:53 INFO - Return code: 0 16:50:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:50:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 16:50:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --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 16:50:53 INFO - Using env: {'DISPLAY': ':0', 16:50:53 INFO - 'HOME': '/home/cltbld', 16:50:53 INFO - 'LANG': 'en_US.UTF-8', 16:50:53 INFO - 'LANGUAGE': 'en_US:en', 16:50:53 INFO - 'LOGNAME': 'cltbld', 16:50:53 INFO - 'MAIL': '/var/mail/cltbld', 16:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:53 INFO - 'MOZ_NO_REMOTE': '1', 16:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:53 INFO - 'NO_EM_RESTART': '1', 16:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:53 INFO - 'SHELL': '/bin/bash', 16:50:53 INFO - 'SHLVL': '1', 16:50:53 INFO - 'TERM': 'linux', 16:50:53 INFO - 'TMOUT': '86400', 16:50:53 INFO - 'USER': 'cltbld', 16:50:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:53 INFO - '_': '/tools/buildbot/bin/python'} 16:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:54 INFO - Downloading/unpacking psutil>=0.7.1 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:50:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:50:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:55 INFO - Installing collected packages: psutil 16:50:55 INFO - Running setup.py install for psutil 16:50:55 INFO - building 'psutil._psutil_linux' extension 16:50:55 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 16:50:56 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 16:50:56 INFO - building 'psutil._psutil_posix' extension 16:50:56 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 16:50:56 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 16:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:56 INFO - Successfully installed psutil 16:50:56 INFO - Cleaning up... 16:50:56 INFO - Return code: 0 16:50:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:50:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:50:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:50:56 INFO - Using env: {'DISPLAY': ':0', 16:50:56 INFO - 'HOME': '/home/cltbld', 16:50:56 INFO - 'LANG': 'en_US.UTF-8', 16:50:56 INFO - 'LANGUAGE': 'en_US:en', 16:50:56 INFO - 'LOGNAME': 'cltbld', 16:50:56 INFO - 'MAIL': '/var/mail/cltbld', 16:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:56 INFO - 'MOZ_NO_REMOTE': '1', 16:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:56 INFO - 'NO_EM_RESTART': '1', 16:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:56 INFO - 'SHELL': '/bin/bash', 16:50:56 INFO - 'SHLVL': '1', 16:50:56 INFO - 'TERM': 'linux', 16:50:56 INFO - 'TMOUT': '86400', 16:50:56 INFO - 'USER': 'cltbld', 16:50:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:56 INFO - '_': '/tools/buildbot/bin/python'} 16:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:50:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:50:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:50:58 INFO - Installing collected packages: mozsystemmonitor 16:50:58 INFO - Running setup.py install for mozsystemmonitor 16:50:58 INFO - Successfully installed mozsystemmonitor 16:50:58 INFO - Cleaning up... 16:50:58 INFO - Return code: 0 16:50:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:50:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:50:58 INFO - Using env: {'DISPLAY': ':0', 16:50:58 INFO - 'HOME': '/home/cltbld', 16:50:58 INFO - 'LANG': 'en_US.UTF-8', 16:50:58 INFO - 'LANGUAGE': 'en_US:en', 16:50:58 INFO - 'LOGNAME': 'cltbld', 16:50:58 INFO - 'MAIL': '/var/mail/cltbld', 16:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:58 INFO - 'MOZ_NO_REMOTE': '1', 16:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:58 INFO - 'NO_EM_RESTART': '1', 16:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:58 INFO - 'SHELL': '/bin/bash', 16:50:58 INFO - 'SHLVL': '1', 16:50:58 INFO - 'TERM': 'linux', 16:50:58 INFO - 'TMOUT': '86400', 16:50:58 INFO - 'USER': 'cltbld', 16:50:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:58 INFO - '_': '/tools/buildbot/bin/python'} 16:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:51:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:51:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:01 INFO - Downloading docopt-0.6.1.tar.gz 16:51:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:51:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:01 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:01 INFO - Running setup.py install for blobuploader 16:51:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:51:01 INFO - Running setup.py install for requests 16:51:01 INFO - Running setup.py install for docopt 16:51:01 INFO - Successfully installed blobuploader requests docopt 16:51:01 INFO - Cleaning up... 16:51:01 INFO - Return code: 0 16:51:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:51:01 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 16:51:01 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 16:51:01 INFO - Using env: {'DISPLAY': ':0', 16:51:01 INFO - 'HOME': '/home/cltbld', 16:51:01 INFO - 'LANG': 'en_US.UTF-8', 16:51:01 INFO - 'LANGUAGE': 'en_US:en', 16:51:01 INFO - 'LOGNAME': 'cltbld', 16:51:01 INFO - 'MAIL': '/var/mail/cltbld', 16:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:01 INFO - 'MOZ_NO_REMOTE': '1', 16:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:01 INFO - 'NO_EM_RESTART': '1', 16:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:01 INFO - 'SHELL': '/bin/bash', 16:51:01 INFO - 'SHLVL': '1', 16:51:01 INFO - 'TERM': 'linux', 16:51:01 INFO - 'TMOUT': '86400', 16:51:01 INFO - 'USER': 'cltbld', 16:51:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:01 INFO - '_': '/tools/buildbot/bin/python'} 16:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:02 INFO - Running setup.py (path:/tmp/pip-uFPP2y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:02 INFO - Running setup.py (path:/tmp/pip-jr_W09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:02 INFO - Running setup.py (path:/tmp/pip-fPWOpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:02 INFO - Running setup.py (path:/tmp/pip-FhW2th-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:02 INFO - Running setup.py (path:/tmp/pip-l8rKMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:02 INFO - Running setup.py (path:/tmp/pip-XtLT1a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:02 INFO - Running setup.py (path:/tmp/pip-K313DQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:02 INFO - Running setup.py (path:/tmp/pip-ESEzGO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:02 INFO - Running setup.py (path:/tmp/pip-MINqVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:02 INFO - Running setup.py (path:/tmp/pip-U4rwaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:02 INFO - Running setup.py (path:/tmp/pip-PQKfiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:02 INFO - Running setup.py (path:/tmp/pip-s_yUHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:02 INFO - Running setup.py (path:/tmp/pip-VOeIn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:02 INFO - Running setup.py (path:/tmp/pip-_yPTl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:03 INFO - Running setup.py (path:/tmp/pip-wgik_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:03 INFO - Running setup.py (path:/tmp/pip-Oxlgud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:03 INFO - Running setup.py (path:/tmp/pip-72KRko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:03 INFO - Running setup.py install for manifestparser 16:51:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:51:03 INFO - Running setup.py install for mozcrash 16:51:03 INFO - Running setup.py install for mozdebug 16:51:03 INFO - Running setup.py install for mozdevice 16:51:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:51:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:51:03 INFO - Running setup.py install for mozfile 16:51:03 INFO - Running setup.py install for mozhttpd 16:51:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:51:03 INFO - Running setup.py install for mozinfo 16:51:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:51:03 INFO - Running setup.py install for mozInstall 16:51:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Running setup.py install for mozleak 16:51:04 INFO - Running setup.py install for mozlog 16:51:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Running setup.py install for moznetwork 16:51:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Running setup.py install for mozprocess 16:51:04 INFO - Running setup.py install for mozprofile 16:51:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Running setup.py install for mozrunner 16:51:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:51:04 INFO - Running setup.py install for mozscreenshot 16:51:04 INFO - Running setup.py install for moztest 16:51:04 INFO - Running setup.py install for mozversion 16:51:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:05 INFO - Cleaning up... 16:51:05 INFO - Return code: 0 16:51:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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', '-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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:51:05 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 16:51:05 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 16:51:05 INFO - Using env: {'DISPLAY': ':0', 16:51:05 INFO - 'HOME': '/home/cltbld', 16:51:05 INFO - 'LANG': 'en_US.UTF-8', 16:51:05 INFO - 'LANGUAGE': 'en_US:en', 16:51:05 INFO - 'LOGNAME': 'cltbld', 16:51:05 INFO - 'MAIL': '/var/mail/cltbld', 16:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:05 INFO - 'MOZ_NO_REMOTE': '1', 16:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:05 INFO - 'NO_EM_RESTART': '1', 16:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:05 INFO - 'SHELL': '/bin/bash', 16:51:05 INFO - 'SHLVL': '1', 16:51:05 INFO - 'TERM': 'linux', 16:51:05 INFO - 'TMOUT': '86400', 16:51:05 INFO - 'USER': 'cltbld', 16:51:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:05 INFO - '_': '/tools/buildbot/bin/python'} 16:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:05 INFO - Running setup.py (path:/tmp/pip-aQAbPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:05 INFO - Running setup.py (path:/tmp/pip-nN_TeQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:05 INFO - Running setup.py (path:/tmp/pip-tVP3dO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:05 INFO - Running setup.py (path:/tmp/pip-Y0H_Rk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:05 INFO - Running setup.py (path:/tmp/pip-5FccVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:05 INFO - Running setup.py (path:/tmp/pip-YPw3Nk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:05 INFO - Running setup.py (path:/tmp/pip-6CcuCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:05 INFO - Running setup.py (path:/tmp/pip-CBwVU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:05 INFO - Running setup.py (path:/tmp/pip-_WN9pg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:05 INFO - Running setup.py (path:/tmp/pip-3UoHgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:06 INFO - Running setup.py (path:/tmp/pip-8egqhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:06 INFO - Running setup.py (path:/tmp/pip-VTei3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:06 INFO - Running setup.py (path:/tmp/pip-QRoJPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:06 INFO - Running setup.py (path:/tmp/pip-63LsmM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:06 INFO - Running setup.py (path:/tmp/pip-8iJ_Rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:06 INFO - Running setup.py (path:/tmp/pip-DQB07m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:06 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)) 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:06 INFO - Running setup.py (path:/tmp/pip-XbumWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:08 INFO - Downloading blessings-1.5.1.tar.gz 16:51:08 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 16:51:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:08 INFO - Installing collected packages: blessings 16:51:08 INFO - Running setup.py install for blessings 16:51:08 INFO - Successfully installed blessings 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:51:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:08 INFO - Reading from file tmpfile_stdout 16:51:08 INFO - Current package versions: 16:51:08 INFO - argparse == 1.2.1 16:51:08 INFO - blessings == 1.5.1 16:51:08 INFO - blobuploader == 1.2.4 16:51:08 INFO - docopt == 0.6.1 16:51:08 INFO - manifestparser == 1.1 16:51:08 INFO - mozInstall == 1.12 16:51:08 INFO - mozcrash == 0.16 16:51:08 INFO - mozdebug == 0.1 16:51:08 INFO - mozdevice == 0.47 16:51:08 INFO - mozfile == 1.2 16:51:08 INFO - mozhttpd == 0.7 16:51:08 INFO - mozinfo == 0.9 16:51:08 INFO - mozleak == 0.1 16:51:08 INFO - mozlog == 3.1 16:51:08 INFO - moznetwork == 0.27 16:51:08 INFO - mozprocess == 0.22 16:51:08 INFO - mozprofile == 0.28 16:51:08 INFO - mozrunner == 6.11 16:51:08 INFO - mozscreenshot == 0.1 16:51:08 INFO - mozsystemmonitor == 0.0 16:51:08 INFO - moztest == 0.7 16:51:08 INFO - mozversion == 1.4 16:51:08 INFO - psutil == 3.1.1 16:51:08 INFO - requests == 1.2.3 16:51:08 INFO - wsgiref == 0.1.2 16:51:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:08 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')]} 16:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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')]} 16:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:51:08 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 16:51:08 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 16:51:08 INFO - Using env: {'DISPLAY': ':0', 16:51:08 INFO - 'HOME': '/home/cltbld', 16:51:08 INFO - 'LANG': 'en_US.UTF-8', 16:51:08 INFO - 'LANGUAGE': 'en_US:en', 16:51:08 INFO - 'LOGNAME': 'cltbld', 16:51:08 INFO - 'MAIL': '/var/mail/cltbld', 16:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:08 INFO - 'MOZ_NO_REMOTE': '1', 16:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:08 INFO - 'NO_EM_RESTART': '1', 16:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:08 INFO - 'SHELL': '/bin/bash', 16:51:08 INFO - 'SHLVL': '1', 16:51:08 INFO - 'TERM': 'linux', 16:51:08 INFO - 'TMOUT': '86400', 16:51:08 INFO - 'USER': 'cltbld', 16:51:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:08 INFO - '_': '/tools/buildbot/bin/python'} 16:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:51:08 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')]} 16:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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')]} 16:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:51:08 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 16:51:08 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 16:51:08 INFO - Using env: {'DISPLAY': ':0', 16:51:08 INFO - 'HOME': '/home/cltbld', 16:51:08 INFO - 'LANG': 'en_US.UTF-8', 16:51:08 INFO - 'LANGUAGE': 'en_US:en', 16:51:08 INFO - 'LOGNAME': 'cltbld', 16:51:08 INFO - 'MAIL': '/var/mail/cltbld', 16:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:08 INFO - 'MOZ_NO_REMOTE': '1', 16:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:08 INFO - 'NO_EM_RESTART': '1', 16:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:08 INFO - 'SHELL': '/bin/bash', 16:51:08 INFO - 'SHLVL': '1', 16:51:08 INFO - 'TERM': 'linux', 16:51:08 INFO - 'TMOUT': '86400', 16:51:08 INFO - 'USER': 'cltbld', 16:51:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:08 INFO - '_': '/tools/buildbot/bin/python'} 16:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:09 INFO - Downloading/unpacking jsonschema 16:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:10 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 16:51:10 INFO - Downloading/unpacking functools32 (from jsonschema) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:51:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:11 INFO - warning: no files found matching '*.txt' 16:51:11 INFO - no previously-included directories found matching 'build' 16:51:11 INFO - no previously-included directories found matching 'dist' 16:51:11 INFO - no previously-included directories found matching '.git*' 16:51:11 INFO - Installing collected packages: jsonschema, functools32 16:51:11 INFO - Running setup.py install for functools32 16:51:11 INFO - warning: no files found matching '*.txt' 16:51:11 INFO - no previously-included directories found matching 'build' 16:51:11 INFO - no previously-included directories found matching 'dist' 16:51:11 INFO - no previously-included directories found matching '.git*' 16:51:11 INFO - Successfully installed jsonschema functools32 16:51:11 INFO - Cleaning up... 16:51:11 INFO - Return code: 0 16:51:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9275a2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', '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 16:51:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:51:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:51:11 INFO - Using env: {'DISPLAY': ':0', 16:51:11 INFO - 'HOME': '/home/cltbld', 16:51:11 INFO - 'LANG': 'en_US.UTF-8', 16:51:11 INFO - 'LANGUAGE': 'en_US:en', 16:51:11 INFO - 'LOGNAME': 'cltbld', 16:51:11 INFO - 'MAIL': '/var/mail/cltbld', 16:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:11 INFO - 'MOZ_NO_REMOTE': '1', 16:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:11 INFO - 'NO_EM_RESTART': '1', 16:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:11 INFO - 'SHELL': '/bin/bash', 16:51:11 INFO - 'SHLVL': '1', 16:51:11 INFO - 'TERM': 'linux', 16:51:11 INFO - 'TMOUT': '86400', 16:51:11 INFO - 'USER': 'cltbld', 16:51:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:11 INFO - '_': '/tools/buildbot/bin/python'} 16:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:11 INFO - Downloading/unpacking flake8 16:51:11 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 16:51:11 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 16:51:11 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 16:51:11 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 16:51:11 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 16:51:11 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 16:51:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:51:13 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 16:51:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:51:13 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 16:51:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 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 16:51:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:51:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:13 INFO - no previously-included directories found matching 'docs/_build' 16:51:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:51:13 INFO - Running setup.py install for pep8 16:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:13 INFO - no previously-included directories found matching 'docs/_build' 16:51:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:51:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:51:14 INFO - Cleaning up... 16:51:14 INFO - Return code: 0 16:51:14 INFO - Running post-action listener: _resource_record_post_action 16:51:14 INFO - Running post-action listener: _start_resource_monitoring 16:51:14 INFO - Starting resource monitoring. 16:51:14 INFO - ##### 16:51:14 INFO - ##### Running install step. 16:51:14 INFO - ##### 16:51:14 INFO - Running pre-action listener: _resource_record_pre_action 16:51:14 INFO - Running main action method: install 16:51:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:14 INFO - Reading from file tmpfile_stdout 16:51:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:51:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:51:14 INFO - Reading from file tmpfile_stdout 16:51:14 INFO - Output received: 16:51:14 INFO - Usage: mozinstall [options] installer 16:51:14 INFO - Options: 16:51:14 INFO - -h, --help show this help message and exit 16:51:14 INFO - -d DEST, --destination=DEST 16:51:14 INFO - Directory to install application into. [default: 16:51:14 INFO - "/builds/slave/test-pgo"] 16:51:14 INFO - --app=APP Application being installed. [default: firefox] 16:51:14 INFO - mkdir: /builds/slave/test-pgo/build/application 16:51:14 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'] 16:51:14 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 16:51:30 INFO - Reading from file tmpfile_stdout 16:51:30 INFO - Output received: 16:51:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:51:30 INFO - Running post-action listener: _resource_record_post_action 16:51:30 INFO - ##### 16:51:30 INFO - ##### Running run-tests step. 16:51:30 INFO - ##### 16:51:30 INFO - Running pre-action listener: _resource_record_pre_action 16:51:30 INFO - Running main action method: run_tests 16:51:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:51:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:51:30 INFO - Python 2.7.3 16:51:30 INFO - Return code: 0 16:51:30 INFO - grabbing minidump binary from tooltool 16:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:30 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 0x1d80840>, '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 0x1ced6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cedb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:51:30 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 16:51:30 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 16:51:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:30 INFO - Return code: 0 16:51:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:51:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:51:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:51:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:51:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:51:31 INFO - Return code: 0 16:51:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:51:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:51:31 INFO - Using env: {'DISPLAY': ':0', 16:51:31 INFO - 'HOME': '/home/cltbld', 16:51:31 INFO - 'LANG': 'en_US.UTF-8', 16:51:31 INFO - 'LANGUAGE': 'en_US:en', 16:51:31 INFO - 'LOGNAME': 'cltbld', 16:51:31 INFO - 'MAIL': '/var/mail/cltbld', 16:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:31 INFO - 'MOZ_NO_REMOTE': '1', 16:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:31 INFO - 'NO_EM_RESTART': '1', 16:51:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:51:31 INFO - 'SHELL': '/bin/bash', 16:51:31 INFO - 'SHLVL': '1', 16:51:31 INFO - 'TERM': 'linux', 16:51:31 INFO - 'TMOUT': '86400', 16:51:31 INFO - 'USER': 'cltbld', 16:51:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952', 16:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:31 INFO - '_': '/tools/buildbot/bin/python'} 16:51:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:51:31 INFO - mozversion application_buildid: 20160106143005 16:51:31 INFO - mozversion application_changeset: 5eec88560653613a325bd083dc9a5d95528a3685 16:51:31 INFO - mozversion application_display_name: Nightly 16:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:31 INFO - mozversion application_name: Firefox 16:51:31 INFO - mozversion application_remotingname: firefox 16:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:51:31 INFO - mozversion application_vendor: Mozilla 16:51:31 INFO - mozversion application_version: 46.0a1 16:51:31 INFO - mozversion platform_buildid: 20160106143005 16:51:31 INFO - mozversion platform_changeset: 5eec88560653613a325bd083dc9a5d95528a3685 16:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:51:31 INFO - mozversion platform_version: 46.0a1 16:51:31 INFO - using testdate: 1452127891 16:51:31 INFO - actual date: 1452127891 16:51:31 INFO - starting webserver on 'localhost:51767' 16:51:31 INFO - SUITE-START | Running 3 tests 16:51:31 INFO - TEST-START | dromaeo_css 16:51:31 INFO - operating with platform_type : linux_ 16:51:31 INFO - Initialising browser for dromaeo_css test... 16:51:31 INFO - TEST-INFO | started process 4570 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPl31YG/profile http://localhost:51767/getInfo.html) 16:51:35 INFO - PROCESS | 4570 | __metrics Screen width/height:1600/1200 16:51:35 INFO - PROCESS | 4570 | colorDepth:24 16:51:35 INFO - PROCESS | 4570 | Browser inner width/height: 1024/697 16:51:35 INFO - PROCESS | 4570 | __metrics 16:51:35 INFO - PROCESS | 4570 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:51:35 INFO - PROCESS | 4570 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:36 INFO - TEST-INFO | 4570: exit 0 16:51:36 INFO - Browser initialized. 16:51:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:36 INFO - TEST-INFO | started process 4664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPl31YG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:48 INFO - PROCESS | 4664 | RSS: Main: 149938176 16:51:48 INFO - PROCESS | 4664 | 16:52:39 INFO - PROCESS | 4664 | 1452127959616 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] 16:54:48 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51767/tests/dromaeo/cssquery-ext.html) 16:54:49 INFO - PROCESS | 4664 | RSS: Main: 290983936 16:54:49 INFO - PROCESS | 4664 | 16:57:51 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-ext.html (next: http://localhost:51767/tests/dromaeo/cssquery-jquery.html) 16:57:52 INFO - PROCESS | 4664 | RSS: Main: 231006208 16:57:52 INFO - PROCESS | 4664 | 17:00:54 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51767/tests/dromaeo/cssquery-mootools.html) 17:00:54 INFO - PROCESS | 4664 | RSS: Main: 230121472 17:00:54 INFO - PROCESS | 4664 | 17:03:56 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51767/tests/dromaeo/cssquery-prototype.html) 17:03:57 INFO - PROCESS | 4664 | RSS: Main: 214736896 17:03:57 INFO - PROCESS | 4664 | 17:06:59 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51767/tests/dromaeo/cssquery-yui.html) 17:07:00 INFO - PROCESS | 4664 | RSS: Main: 220372992 17:07:00 INFO - PROCESS | 4664 | 17:10:02 INFO - PROCESS | 4664 | Cycle 1(1): loaded http://localhost:51767/tests/dromaeo/cssquery-yui.html (next: http://localhost:51767/tests/dromaeo/cssquery-dojo.html) 17:10:03 INFO - PROCESS | 4664 | RSS: Main: 286031872 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | __start_tp_report 17:10:03 INFO - PROCESS | 4664 | _x_x_mozilla_page_load 17:10:03 INFO - PROCESS | 4664 | _x_x_mozilla_page_load_details 17:10:03 INFO - PROCESS | 4664 | |i|pagename|runs| 17:10:03 INFO - PROCESS | 4664 | |0;dojo.html;3061.8315992620405;3111.237746752043;3138.8430578471057;3140.0265917565557;3175.825329606872;5102.77037533311;5127.461616530267;5154.974225128869;5156.329677141971;5202.141646628302;5093.159628661276;5106.821261255856;5107.7701503432345;5149.639525233235;5224.399194092681;4724.787384567703;4730.574248317651;4739.123262196487;4778.928316075262;4792.209285467894;410.0548922967627;4611.677182597219;4742.573168414842;4772.498887616785;4795.136875362434;4684.203685373494;4719.268513380432;4733.502982186872;4756.690815097025;4772.832950846739;4728.456227533843;4747.192977193886;4754.9286760698615;4757.833475828364;4807.615390768765;4595.931061034087;4692.648051396159;4699.107169637758;4737.73942433166;4779.61763058958;4935.457099719028;4992.350994370745;4999.075171093323;5026.698398096126;5052.797888084472;5512.724363781795;5519.39286678465;5533.889322213573;5535.778568857241;5575.498205161555;5485.753141108659;5580;5592.720363981825;5596.4403559644115;5598.412166722517;5065.848024559269;5105.693658380472;5113.897722045538;5116.539511443988;5133.922991155136;5616.354119276336;5641.323041234996;5653.462921022497;5663.631863928831;5667.971660141673;5307.230451584499;5351.09031464652;5389.568834493231;5406.999705054577;5424.267723857308;5508.091164957737;5535.059039963216;5567.387587365387;5574.303212098488;5629.099344104923;5533.08704063833;5535.612507124462;5544.7782088716;5573.359063707644;5580.358258800209;5470.890582188334;5525.364583072917;5531.751071201806;5532.640378375473;5536.695481748462;4200.5169405518145;4251.766152861561;4288.335308027261;4302.612764851178;4359.934600980988;3819.8663046793786;3866.38137897935;3867.7485963412287;3890.7471014383973;3899.922001559953;5085.084684756779;5125.615578831528;5140.922886156711;5159.277701121846;5185.118529849935;5436.673799572039;5527.309086364205;5534.391216966131;5536.252605898152;5539.612227144061;5107.591392688576;5159.638825282194;5174.663646863017;5179.456157103526;5221.477852214748;4719;4720.881977950578;4730.101280756645;4732.195526760459;4762.618990480753;5484.067708489566;5588.189712491666;5604.3835178130375;5694.487496125369;5711.371749107595;5481.671099734029;5497.752601132878;5520.1167813149705;5529.889402211853;5582.888342233051;5723.198752174616;5760.279965004374;5777.45114214149;5786.33457152416;5795.565332600157;5377.865553361197;5385.40760516335;5467;5514.310711161105;5529.391766905556;5532.861678458071;5541.418151094238;5546.112621980464;5548.667079975215;5581.804636837691;5372.62391632582;5414.404415514369;5420.83737487876;5426.7829286829665;5452.127659574449;5265.289185959847;5351.411344752152;5386.165144402624;5386.192071189196;5408.675479471244;5292.9735351323;5293.285406470077;5294.232336311136;5310.787568497217;5342.652727572696;5396.244525766318;5397.568194544348;5439.347278326626;5451.400345961862;5469.097598896137;5232.790688372423;5301.098813201842;5333.573314134937;5333.759980800795;5359.981603495324 17:10:03 INFO - PROCESS | 4664 | |1;ext.html;534.2147043845548;546.2052713302146;566.1451208674899;567.2653913182427;578.8379253808932;27466.313342166457;27755.444891102165;35360.82319588398;35853.64146358536;35871.10322241945;39449.40825887614;39879.60120398795;39884.60115398845;39897.00257493564;40067.398989015186;7482.850342993137;8413.074561798197;8588;8590;8596.226339629433;7570.3565196958325;7687.423443241779;10052;10253.897461025406;10262.486875656188;9885.555150018266;9982.351147175446;9990.700278991642;10018.298719089667;10023.198144148451;7679.7312094077;7840.372770178372;9844;9890.653827116088;9945;9998.900010999869;10188.337758045778;10227.590896364136;10228.43743594102;10238.23213259001;36254.63745362539;36679.08302292437;36707.26585468302;36712.53149874029;36758.63241367579;3017.6529699084667;3066.938661226763;3091.412631599989;3117.8596963136715;3703.814809259526;27775.58336624952;28285.57571636427;28395.290117747016;30336.54495182574;30415;3465.42820434628;3504.847129008203;3547.2018795771005;3557.6620221079215;3595.7842529448317;265743;266598;266851.9999999981;267561;267621;51274.743626281626;52454.47545524572;58424;58866.41133588609;58886;61342.386576133664;62113;62266;62315.37684623096;62423.687881560305;15095.849041509664;15130.470433534774;15284.38862445512;15312.310946007234;15333.769993450107;11415.885841141482;11497.137714671433;11529.827052594217;11572.94213528927;11583.07335413165;18902.243910243436;18987.620247594972;18993;19667.311644092388;19668.901655491918;6866.004429357715;7174.461915356264;7174.569525828467;7211.711531538785;7288.9271107289305;892.6340200517757;1005.7133716890797;1028.6862506935306;1045.968620941373;1053.252190944438;28461.36979748045;28483.57274640882;28522.286942826595;28828.423431531253;29003.41993160125;942.886853577575;1076.56399158341;1140.3841925360377;1156.2773266708307;1186.1993154620768;14899.404023838924;14985.32566034531;15000.549983500512;15246.085234885943;15281.541553753405;307380;311101;311603;312358;313603;52612.94774104573;52666.47333526692;52879.20681189785;53076;53118.20322695163;1284.916480428769;1290.2903403128241;1305.3799445263423;1306.3664122900386;1308.7775078236532;27249.86375068112;28083.859580701966;28276.8161957184;28305.292367690974;28320.575191371732;46808.76595617;47239.165650061106;47266.52733472621;47292.29061564011;47311.76344118257;289698;290776;291607;292402;292699;27789.722102779524;30851.537226941164;31130.37739245157;31193.220169495038;31685.20786980344;36826.447603285436;37731.43402849014;37985.48058077646;38368.04079898025;38449.42325865058;35024.29951401009;35933.46099808453;36212.63787362093;36618.8169059153;37032.62967370292;28863.278418039718;32131.196720082185;32583.511247330836;34475;35718.821405892806;34403.4839477403;34916.127096821765;35226.11934701653;35349.82325088461;35361.29277414489;29676.554851677673;30546.541801872547;32572.185695357806;32593.674063259063;32701.18247043843;24046.87976560106;24246.272611821674;24417.755822441548;24591.262262132164;24632.507349852545 17:10:03 INFO - PROCESS | 4664 | |2;jquery.html;339.11491008467897;339.2959608811713;349.4757863205192;354.36214813336;356.8073240450157;16244.187790610467;16498.422555210556;17876.106194690245;18132.909335453303;18145.90927045363;16725;16732.41436549721;16973.745393819103;17084.060376679277;17440.82559174408;5233.528982391584;5302.125149350352;5415.783368665268;5419.132938729804;5422.322209723785;5386.91919621206;5418.8916221675545;5418.972905135489;5420.512153906147;5422.132458806592;4009.1781184857036;4120.917581648365;5356.491133342346;5379.542738867201;5772.0476121439915;5729.799457019005;5732.484076433141;5735.741891614866;5737.225474560964;5739.942600573982;4839.903201935942;4977.9751101244265;5011.2483127530795;5018.197088465828;5021.568852876949;10490.947545262301;10735;11832.645020649394;12184.878151218463;12384.947279481255;1870.1584287070873;1913.7033759767257;1986.0764744393782;2046.6418376784152;2203.43812327857;8734.432261902955;8862.069482704288;8931.419457735292;9125;9142.131497507726;1592.6575786206022;1615.2241347547044;1678.1022153148128;1694.2799310293076;1712.494814029864;59558;61036.084458733596;61365.6931715343;62297;62429;9940.40357578533;10128.848067278997;10219.897801021894;10263.435511046815;10358.53386597605;13441.596752097452;13499.595012149652;13535.864641353657;13544.05191636576;13546.187228766306;7424.480286379901;7481.438892083115;7519.172890981988;7537.698492060256;7704.8459030820195;7197.280271972865;7273.599952002691;7293.52592081513;7335.266473352622;7373.668184931691;4389.736615803062;4451.821927122944;4466.843660471933;4486.955130448719;4505.481869584974;1794.0491539484094;1800.1629242402346;1801.8738688291694;1815.4190658989262;1857.2199676136056;367.3039589977032;411.60897147709795;447.5233875922132;452.6763364194617;981.4062492192263;10350.016748408889;10409.167266618653;10535.420551869567;10556;10831.83752243717;437.43352358695563;439.2181916189188;439.26861775144664;449.8852792537882;453.23855922050615;5101.948980510221;5387.24578559002;5813.447722466359;6127.253732686163;6203.348648391944;576755;589029;589033;591019;597981;73339.63330183315;76226;81604.18395815966;82803;83485.58257208797;1140.863096428434;1145.450183911727;1191.3566673996118;1203.1878482024774;1222.8165775133623;14628.92685536608;15046.097234165985;15504.844951550791;15675.451359202374;15867.841321586637;21876.124955001622;29604.703952961056;34292;34620;34941.650583494855;47027.52972470231;47624.523754763395;49299.75350123226;51931.74034129805;52397.47602524079;9352.906470935475;9420.95289523548;9450.716478505656;9465.763355915882;9682.419054856731;11747.941260293645;11775.23460975034;11818.704532386759;11857.98414269559;14769.335379908145;13747.862521374658;13779.586612401645;14516.709665806837;14523.273836308354;15021.324040418425;13108.934455327662;13222.603321900358;13894.861051389356;14325.140491570539;14560.85439145595;14527.346269418113;14530.346134423766;14677.55967320982;14769.113853168845;14784.704305914036;7766.223377662189;7958.0848202457455;9079.45523268606;9116.954415227881;9356.906430935876;12890.67773305675;13076.542321018718;13299.401526931118;14139.64650883736;14278.571642850731 17:10:03 INFO - PROCESS | 4664 | |3;mootools.html;1257.0886107572005;1420.8508106648806;1429.914205147691;1539.2380771518094;1715.048148277706;6744.08954791103;7333.779986600404;7395.075615548057;7416.110066791993;7428.405727541797;7302.853942921139;7454.403647708184;7472.887906681404;7477.887831682529;7484.839849823286;1930.1700268884374;1955.8435325173953;1960.059171597634;2268.104098880941;2322.3381336319067;2024.6760518317071;2297.310806757974;2308.861468311898;2326.6161083421216;2329.6505524171425;2207.1612787140944;2230.8996095175758;2243.2036626997424;2271.5229801741652;2274.931752047433;2127.7765834587376;2135.348718640814;2136.957260854774;2137.1665050630268;2237.496563273267;2177.444751588335;2199.846010779246;2200.702905107822;2201.6037113319594;2215.6787265846524;7521.661525231378;7550.169481357047;7610.467267291292;7610.885836712454;7614.657340419639;4643.16423043852;4687.10944920464;4707.976460117712;4727.5272472752795;4732.100900828831;2916.533354663265;2923.693012233706;2967.3768508613216;3003.849807509616;3032.1964679359985;896.3725392225404;906.2251774732574;906.6645341223724;941.1341565759518;962.93259471837;10279.588816447333;10440.425776582286;10449.791004179873;10452.529636166315;10470.84293735587;4212.831486740496;4269.893252668646;4327.718698284664;4328.783560821947;4337.284348082594;8996.235319997873;9011.143941325563;9013.098690130935;9020.8646870297;9021.639134434548;4677.415323084614;4732.1718699227495;4740.976295118502;4753.952460475351;4777.8088876445245;4257.6168144867115;4263.914721705611;4268.932766808298;4303.784810759449;4304.5480224576595;3394.5247665326874;3443.6556344365863;3503.2993401319327;3525.2773181498246;3571.4464258040043;1160.7156246719608;1170.1633332167542;1197.1978774221293;1210.2556927489532;1219.9756004879853;1020.5764607687875;1038.2317085356933;1041.833306670929;1080.8378743188584;1093.971666633362;6963.7562685305775;6993.580385176804;7019.719211231596;7024.5434046786795;7027.297270273034;609.960352577081;610.572972434569;618.6473709985265;621.5493767018875;752.3304259209308;5539.944600554023;5657.632253903483;5658.660480371191;5720.885582288331;5736.885262294731;8513.19124683154;8643.135686431306;8663.913360866436;8710.25962793157;8802.119788021148;8640.827183456297;8651.134886511425;8702.6518939243;8705.260052895575;8706.738797836075;6909.827254318682;6944.756933507303;7179.89230161548;7271.236520165412;7281.381082608038;7253.057102576631;7299.489035767445;7306;7306.305900939402;7308.59802710856;7869.803254918673;8201.26188643025;8398.706045288385;8399.790005249673;8456.40805143634;8241.876371854307;8438.409311348147;8444.451110677786;8584.227419532272;8596.699115530926;6502.544821862424;6701.966490167518;6710.664466776544;6716.429103526255;6857.485688573277;6593.076969224217;6698.129243198353;6973.442124629916;7023.859522809617;7024.4029257513685;6840.965795170992;6842.863142737217;6915.101036865175;6919.481038922202;7047.119110111236;6595.538312318092;6749.358810912955;6769.864602708017;6778.084958530535;6834.965825170842;6776.15298087739;6817.93182068173;6823.28355522663;6823.89764153548;6824.522283440111;6290.622562646256;6320.557560970872;6329.272133704683;6406.0390941359165;6408.327125651926;6484.870302594016;6591.934080659324;6613.768518101843;6615.206175259;6620.404163625297 17:10:03 INFO - PROCESS | 4664 | |4;prototype.html;335.35778983247076;340.5589761259169;341.4042495844751;348.10710527496985;348.4198808983044;5848.327442344132;5898.52811775058;5907.763689452428;5936.287645482548;5970.104484327342;5830.154627578999;5833.795817146401;5860.648361098337;5865.442782935625;5865.560082993782;4550.749708766025;4550.8862278442975;4556.54434556545;4561.498235194126;4569.725816451007;4396.956030439686;4505.121501307246;4507.752073635948;4508.797104130322;4517.751523666197;4447.822087116511;4452.577005184518;4454.220511410506;4456.59890609845;4465.196264672358;4294.849680261192;4329.805158767863;4355.216061108999;4456.844010459635;4461.263891457922;3808.409696497047;3809.0667786392232;3814.256220037094;3828.655421012122;3849.191669749356;5589.357223919261;5598.188262701926;5601.29983752031;5609.186667933127;5620.775168993236;4960.305557221992;5022.824201152978;5040.193569028975;5165.044466773659;5169.81905633301;6195;6229.2836323822885;6236.251649802008;6241.594296370721;6261.9373806262265;4230.2174097792;4236.428082208924;4243.766592837393;4243.80902859369;4246.59657332556;6407.967960160169;6444.033394990742;6519.5436319457185;6521.445677117451;6524.836879078013;4480.372747815309;4480.753558554311;4485.955140448619;4486.2597671383855;4489.753063581535;4533.455985281787;4536.841210557614;4543.34121552373;4544.477385100756;4545.068261006486;5217.087009773274;5230.110881150214;5245.816396426183;5250.947490525045;5253.711045892436;6168.1056246843955;6283.937160628335;6290.55966082379;6305.873882522415;6306.2747784004505;1575.346231313992;1607.879409044303;1608.549606110291;1609.1632351177323;1609.6297851493987;1053.378506681062;1070.8982646648556;1074.6829685242872;1084.5661735305941;1097.5006372100675;5972.492338151305;5995.370486098896;5995.970020149872;5996.070609055516;5998.670073145931;6475.740970361133;6477.805665830033;6482.740690372332;6483.7082331295205;6489.448396886318;5797.391273916262;5910.497607703393;5914.112883067574;5915.792947246826;5924.7926322578505;3463.9826800865835;3504.281622267429;3504.6495350464747;3505.071156143624;3506.526618906466;6669;6712.39588437043;6713.26154123046;6717.261101278856;6719.42884854783;6367.777127800505;6491.318411566812;6578.736850525926;6578.967105164444;6581.506387020897;6602;6680.7953375386005;6753.797386078524;6772.661366931634;6794.66026698673;6458.935410645833;6494.837629059311;6500.187476565429;6504;6506.4469520091325;6347.365263473615;6428.774992875227;6463.57986730861;6474.1907261592305;6476.190476190476;6786;6791.524593278621;6792.286809885089;6794.626295553792;6798.966005169942;4512.9097418052115;4516.074204788077;4522.4573051234065;4525.50219475864;4526.2305408081365;6487.059376390492;6508.186476690414;6535.183102112236;6538.542302038812;6554.279029306677;6362.586431881913;6365.52258580599;6382.425581697669;6382.7766028190645;6387.616742995249;6354.983202687547;6358.078078678658;6363;6364.427201551883;6365.490760739037;6130.6628135452975;6251.874962500816;6271.717772700148;6274.247090349188;6274.498040156685;6363.809085727436;6387;6395.136656551306;6396.6481843497195;6402.711877965409;6234.875302494015;6240.781572644935;6241.6879156041105;6244.406781355764;6248.937510624835 17:10:03 INFO - PROCESS | 4664 | |5;yui.html;739.5562662402556;831.968359234549;861.4917198852676;869.5826003518312;870.6169285514374;12553.497860085597;12718.55485058023;12739.936300318508;12767.297798621072;12819.48722051118;11935.522579096847;12008.579699710512;12009.75980480392;12011.759764804721;12017.879821201806;671.2079745899837;679.8266442057269;782.026377160436;791.2522666080556;807.8626633472294;795.8010497375656;801.3749275565068;803.8593246181924;807.0839597057353;807.2008711375754;835.5613303015905;852.5225873510853;852.6418904060309;853.5433543054467;853.7609469348592;689.6000319814495;697.4420463629102;826.1366871619173;846.3102571404286;847.3179090831878;619.1950464396311;623.9937600623981;624.4536030972898;624.491039802564;626.2829060725444;12040.81938770919;12139.817902731465;12147.331896745676;12174.208676436092;12183.390830458531;11223.60717374888;11330.603428880033;11337.093032557375;11488.253263537843;11715.824262636068;10228.64199753005;10232.283740138193;10359.378437293786;10480.318779279323;10522.42126683032;3472.8437220325145;3561;3578.141246100943;3585.3008663310666;3656.542932133483;47748.761256193844;48506.757466212446;49097.509024909654;49134.75432622814;49135.26297105546;8973.36513615586;9048.683296084606;9177.403468774643;9263;9294;17610.823891761174;17614.383496577557;17621.7356739649;17660.646787064445;17675.20461579232;6838.555493892981;6925.930740692629;7029.156501219886;7034.3669069782945;7121.92878071223;3741.56971948224;3816.1604447022164;3837.3860182370686;3853.807309634507;3875.6318149775725;3030.0606811888383;3057.3121047764075;3058.7247147756366;3060.265536271279;3070.6929307069113;537.8332716857786;556.8496505943373;558.7820749907539;563.892860356531;575.5913301555859;536.8362649391973;577.6880484538386;647.6081970407836;678.3250665587772;683.7811900191891;7849.960750196213;7877.724279650185;8027.438079334507;8047.758567242992;8283.875741863876;534.9919751203735;541.9621424971136;542.953848922846;566.5156291370901;600.588596811177;3559.7330200235087;3652.7990960497427;3807.1814559869763;3844.308024555607;3988.940165897514;49717.50282497201;50171;50383.24425133626;50506.74746626317;50537;46667;46860.297095543596;47427.525724742314;47790;49968.25047624289;42087.78956105261;42583.78708106501;44037;44599.55400446019;44820.3276950846;8046.356291496783;8292.585370731318;8419.957900210704;8543.40196186261;8613.483191008308;32170.19574510656;32568.67431325751;33010.33979320352;33437.16407089745;34220.31559368749;38412.61587384091;39407.80296098501;43587.78206109076;44539.77730111329;45012.77493612511;10237;10346.844797327896;10533.420661863365;10727.249092563447;10889.673309800719;11525.88474115248;11717.121215909012;11758.176927614984;11760.470778815145;11836.289822610672;9982.900170998488;10436.686899393031;10575.894241057491;10575.894241057798;10770.73073173177;10369.377837329785;10467.685969420929;10700.250982431155;10920.235583509078;10963.616273430393;10008.39949603026;10039.498025098861;10155.39067655943;10303.742406439898;10512.159027277952;9028;9156.816863662823;9328.207102396102;9350.812983740423;9362.438253704799;8252.546109963769;8331.541765202972;8679.218870301704;8887.244584210415;9054.773630659287 17:10:03 INFO - PROCESS | 4664 | __end_tp_report 17:10:03 INFO - PROCESS | 4664 | __start_cc_report 17:10:03 INFO - PROCESS | 4664 | _x_x_mozilla_cycle_collect,914 17:10:03 INFO - PROCESS | 4664 | __end_cc_report 17:10:03 INFO - PROCESS | 4664 | __startTimestamp1452129003131__endTimestamp 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | ------- Summary: start ------- 17:10:03 INFO - PROCESS | 4664 | Number of tests: 6 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#0] dojo.html Cycles:165 Average:5107.35 Median:5310.79 stddev:664.19 (12.5%) stddev-sans-first:646.55 17:10:03 INFO - PROCESS | 4664 | Values: 3061.8 3111.2 3138.8 3140.0 3175.8 5102.8 5127.5 5155.0 5156.3 5202.1 5093.2 5106.8 5107.8 5149.6 5224.4 4724.8 4730.6 4739.1 4778.9 4792.2 410.1 4611.7 4742.6 4772.5 4795.1 4684.2 4719.3 4733.5 4756.7 4772.8 4728.5 4747.2 4754.9 4757.8 4807.6 4595.9 4692.6 4699.1 4737.7 4779.6 4935.5 4992.4 4999.1 5026.7 5052.8 5512.7 5519.4 5533.9 5535.8 5575.5 5485.8 5580.0 5592.7 5596.4 5598.4 5065.8 5105.7 5113.9 5116.5 5133.9 5616.4 5641.3 5653.5 5663.6 5668.0 5307.2 5351.1 5389.6 5407.0 5424.3 5508.1 5535.1 5567.4 5574.3 5629.1 5533.1 5535.6 5544.8 5573.4 5580.4 5470.9 5525.4 5531.8 5532.6 5536.7 4200.5 4251.8 4288.3 4302.6 4359.9 3819.9 3866.4 3867.7 3890.7 3899.9 5085.1 5125.6 5140.9 5159.3 5185.1 5436.7 5527.3 5534.4 5536.3 5539.6 5107.6 5159.6 5174.7 5179.5 5221.5 4719.0 4720.9 4730.1 4732.2 4762.6 5484.1 5588.2 5604.4 5694.5 5711.4 5481.7 5497.8 5520.1 5529.9 5582.9 5723.2 5760.3 5777.5 5786.3 5795.6 5377.9 5385.4 5467.0 5514.3 5529.4 5532.9 5541.4 5546.1 5548.7 5581.8 5372.6 5414.4 5420.8 5426.8 5452.1 5265.3 5351.4 5386.2 5386.2 5408.7 5293.0 5293.3 5294.2 5310.8 5342.7 5396.2 5397.6 5439.3 5451.4 5469.1 5232.8 5301.1 5333.6 5333.8 5360.0 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#1] ext.html Cycles:180 Average:45452.96 Median:31908.20 stddev:75888.54 (237.8%) stddev-sans-first:76026.48 17:10:03 INFO - PROCESS | 4664 | Values: 534.2 546.2 566.1 567.3 578.8 27466.3 27755.4 35360.8 35853.6 35871.1 39449.4 39879.6 39884.6 39897.0 40067.4 7482.9 8413.1 8588.0 8590.0 8596.2 7570.4 7687.4 10052.0 10253.9 10262.5 9885.6 9982.4 9990.7 10018.3 10023.2 7679.7 7840.4 9844.0 9890.7 9945.0 9998.9 10188.3 10227.6 10228.4 10238.2 36254.6 36679.1 36707.3 36712.5 36758.6 3017.7 3066.9 3091.4 3117.9 3703.8 27775.6 28285.6 28395.3 30336.5 30415.0 3465.4 3504.8 3547.2 3557.7 3595.8 265743.0 266598.0 266852.0 267561.0 267621.0 51274.7 52454.5 58424.0 58866.4 58886.0 61342.4 62113.0 62266.0 62315.4 62423.7 15095.8 15130.5 15284.4 15312.3 15333.8 11415.9 11497.1 11529.8 11572.9 11583.1 18902.2 18987.6 18993.0 19667.3 19668.9 6866.0 7174.5 7174.6 7211.7 7288.9 892.6 1005.7 1028.7 1046.0 1053.3 28461.4 28483.6 28522.3 28828.4 29003.4 942.9 1076.6 1140.4 1156.3 1186.2 14899.4 14985.3 15000.5 15246.1 15281.5 307380.0 311101.0 311603.0 312358.0 313603.0 52612.9 52666.5 52879.2 53076.0 53118.2 1284.9 1290.3 1305.4 1306.4 1308.8 27249.9 28083.9 28276.8 28305.3 28320.6 46808.8 47239.2 47266.5 47292.3 47311.8 289698.0 290776.0 291607.0 292402.0 292699.0 27789.7 30851.5 31130.4 31193.2 31685.2 36826.4 37731.4 37985.5 38368.0 38449.4 35024.3 35933.5 36212.6 36618.8 37032.6 28863.3 32131.2 32583.5 34475.0 35718.8 34403.5 34916.1 35226.1 35349.8 35361.3 29676.6 30546.5 32572.2 32593.7 32701.2 24046.9 24246.3 24417.8 24591.3 24632.5 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#2] jquery.html Cycles:180 Average:29472.52 Median:2210.39 stddev:96277.98 (4355.7%) stddev-sans-first:96523.21 17:10:03 INFO - PROCESS | 4664 | Values: 339.1 339.3 349.5 354.4 356.8 16244.2 16498.4 17876.1 18132.9 18145.9 16725.0 16732.4 16973.7 17084.1 17440.8 5233.5 5302.1 5415.8 5419.1 5422.3 5386.9 5418.9 5419.0 5420.5 5422.1 4009.2 4120.9 5356.5 5379.5 5772.0 5729.8 5732.5 5735.7 5737.2 5739.9 4839.9 4978.0 5011.2 5018.2 5021.6 10490.9 10735.0 11832.6 12184.9 12384.9 1870.2 1913.7 1986.1 2046.6 2203.4 8734.4 8862.1 8931.4 9125.0 9142.1 1592.7 1615.2 1678.1 1694.3 1712.5 59558.0 61036.1 61365.7 62297.0 62429.0 9940.4 10128.8 10219.9 10263.4 10358.5 13441.6 13499.6 13535.9 13544.1 13546.2 7424.5 7481.4 7519.2 7537.7 7704.8 7197.3 7273.6 7293.5 7335.3 7373.7 4389.7 4451.8 4466.8 4487.0 4505.5 1794.0 1800.2 1801.9 1815.4 1857.2 367.3 411.6 447.5 452.7 981.4 10350.0 10409.2 10535.4 10556.0 10831.8 437.4 439.2 439.3 449.9 453.2 5101.9 5387.2 5813.4 6127.3 6203.3 576755.0 589029.0 589033.0 591019.0 597981.0 73339.6 76226.0 81604.2 82803.0 83485.6 1140.9 1145.5 1191.4 1203.2 1222.8 14628.9 15046.1 15504.8 15675.5 15867.8 21876.1 29604.7 34292.0 34620.0 34941.7 47027.5 47624.5 49299.8 51931.7 52397.5 9352.9 9421.0 9450.7 9465.8 9682.4 11747.9 11775.2 11818.7 11858.0 14769.3 13747.9 13779.6 14516.7 14523.3 15021.3 13108.9 13222.6 13894.9 14325.1 14560.9 14527.3 14530.3 14677.6 14769.1 14784.7 7766.2 7958.1 9079.5 9117.0 9356.9 12890.7 13076.5 13299.4 14139.6 14278.6 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#3] mootools.html Cycles:180 Average:5292.62 Median:6547.24 stddev:2747.37 (42.0%) stddev-sans-first:2738.32 17:10:03 INFO - PROCESS | 4664 | Values: 1257.1 1420.9 1429.9 1539.2 1715.0 6744.1 7333.8 7395.1 7416.1 7428.4 7302.9 7454.4 7472.9 7477.9 7484.8 1930.2 1955.8 1960.1 2268.1 2322.3 2024.7 2297.3 2308.9 2326.6 2329.7 2207.2 2230.9 2243.2 2271.5 2274.9 2127.8 2135.3 2137.0 2137.2 2237.5 2177.4 2199.8 2200.7 2201.6 2215.7 7521.7 7550.2 7610.5 7610.9 7614.7 4643.2 4687.1 4708.0 4727.5 4732.1 2916.5 2923.7 2967.4 3003.8 3032.2 896.4 906.2 906.7 941.1 962.9 10279.6 10440.4 10449.8 10452.5 10470.8 4212.8 4269.9 4327.7 4328.8 4337.3 8996.2 9011.1 9013.1 9020.9 9021.6 4677.4 4732.2 4741.0 4754.0 4777.8 4257.6 4263.9 4268.9 4303.8 4304.5 3394.5 3443.7 3503.3 3525.3 3571.4 1160.7 1170.2 1197.2 1210.3 1220.0 1020.6 1038.2 1041.8 1080.8 1094.0 6963.8 6993.6 7019.7 7024.5 7027.3 610.0 610.6 618.6 621.5 752.3 5539.9 5657.6 5658.7 5720.9 5736.9 8513.2 8643.1 8663.9 8710.3 8802.1 8640.8 8651.1 8702.7 8705.3 8706.7 6909.8 6944.8 7179.9 7271.2 7281.4 7253.1 7299.5 7306.0 7306.3 7308.6 7869.8 8201.3 8398.7 8399.8 8456.4 8241.9 8438.4 8444.5 8584.2 8596.7 6502.5 6702.0 6710.7 6716.4 6857.5 6593.1 6698.1 6973.4 7023.9 7024.4 6841.0 6842.9 6915.1 6919.5 7047.1 6595.5 6749.4 6769.9 6778.1 6835.0 6776.2 6817.9 6823.3 6823.9 6824.5 6290.6 6320.6 6329.3 6406.0 6408.3 6484.9 6591.9 6613.8 6615.2 6620.4 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#4] prototype.html Cycles:180 Average:5245.61 Median:5914.95 stddev:1591.22 (26.9%) stddev-sans-first:1552.42 17:10:03 INFO - PROCESS | 4664 | Values: 335.4 340.6 341.4 348.1 348.4 5848.3 5898.5 5907.8 5936.3 5970.1 5830.2 5833.8 5860.6 5865.4 5865.6 4550.7 4550.9 4556.5 4561.5 4569.7 4397.0 4505.1 4507.8 4508.8 4517.8 4447.8 4452.6 4454.2 4456.6 4465.2 4294.8 4329.8 4355.2 4456.8 4461.3 3808.4 3809.1 3814.3 3828.7 3849.2 5589.4 5598.2 5601.3 5609.2 5620.8 4960.3 5022.8 5040.2 5165.0 5169.8 6195.0 6229.3 6236.3 6241.6 6261.9 4230.2 4236.4 4243.8 4243.8 4246.6 6408.0 6444.0 6519.5 6521.4 6524.8 4480.4 4480.8 4486.0 4486.3 4489.8 4533.5 4536.8 4543.3 4544.5 4545.1 5217.1 5230.1 5245.8 5250.9 5253.7 6168.1 6283.9 6290.6 6305.9 6306.3 1575.3 1607.9 1608.5 1609.2 1609.6 1053.4 1070.9 1074.7 1084.6 1097.5 5972.5 5995.4 5996.0 5996.1 5998.7 6475.7 6477.8 6482.7 6483.7 6489.4 5797.4 5910.5 5914.1 5915.8 5924.8 3464.0 3504.3 3504.6 3505.1 3506.5 6669.0 6712.4 6713.3 6717.3 6719.4 6367.8 6491.3 6578.7 6579.0 6581.5 6602.0 6680.8 6753.8 6772.7 6794.7 6458.9 6494.8 6500.2 6504.0 6506.4 6347.4 6428.8 6463.6 6474.2 6476.2 6786.0 6791.5 6792.3 6794.6 6799.0 4512.9 4516.1 4522.5 4525.5 4526.2 6487.1 6508.2 6535.2 6538.5 6554.3 6362.6 6365.5 6382.4 6382.8 6387.6 6355.0 6358.1 6363.0 6364.4 6365.5 6130.7 6251.9 6271.7 6274.2 6274.5 6363.8 6387.0 6395.1 6396.6 6402.7 6234.9 6240.8 6241.7 6244.4 6248.9 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - PROCESS | 4664 | [#5] yui.html Cycles:180 Average:12959.88 Median:47143.91 stddev:14933.55 (31.7%) stddev-sans-first:14947.24 17:10:03 INFO - PROCESS | 4664 | Values: 739.6 832.0 861.5 869.6 870.6 12553.5 12718.6 12739.9 12767.3 12819.5 11935.5 12008.6 12009.8 12011.8 12017.9 671.2 679.8 782.0 791.3 807.9 795.8 801.4 803.9 807.1 807.2 835.6 852.5 852.6 853.5 853.8 689.6 697.4 826.1 846.3 847.3 619.2 624.0 624.5 624.5 626.3 12040.8 12139.8 12147.3 12174.2 12183.4 11223.6 11330.6 11337.1 11488.3 11715.8 10228.6 10232.3 10359.4 10480.3 10522.4 3472.8 3561.0 3578.1 3585.3 3656.5 47748.8 48506.8 49097.5 49134.8 49135.3 8973.4 9048.7 9177.4 9263.0 9294.0 17610.8 17614.4 17621.7 17660.6 17675.2 6838.6 6925.9 7029.2 7034.4 7121.9 3741.6 3816.2 3837.4 3853.8 3875.6 3030.1 3057.3 3058.7 3060.3 3070.7 537.8 556.8 558.8 563.9 575.6 536.8 577.7 647.6 678.3 683.8 7850.0 7877.7 8027.4 8047.8 8283.9 535.0 542.0 543.0 566.5 600.6 3559.7 3652.8 3807.2 3844.3 3988.9 49717.5 50171.0 50383.2 50506.7 50537.0 46667.0 46860.3 47427.5 47790.0 49968.3 42087.8 42583.8 44037.0 44599.6 44820.3 8046.4 8292.6 8420.0 8543.4 8613.5 32170.2 32568.7 33010.3 33437.2 34220.3 38412.6 39407.8 43587.8 44539.8 45012.8 10237.0 10346.8 10533.4 10727.2 10889.7 11525.9 11717.1 11758.2 11760.5 11836.3 9982.9 10436.7 10575.9 10575.9 10770.7 10369.4 10467.7 10700.3 10920.2 10963.6 10008.4 10039.5 10155.4 10303.7 10512.2 9028.0 9156.8 9328.2 9350.8 9362.4 8252.5 8331.5 8679.2 8887.2 9054.8 17:10:03 INFO - PROCESS | 4664 | -------- Summary: end -------- 17:10:03 INFO - PROCESS | 4664 | 17:10:03 INFO - TEST-INFO | 4664: exit 0 17:10:03 INFO - TEST-OK | dromaeo_css | took 1112441ms 17:10:03 INFO - TEST-START | kraken 17:10:03 INFO - operating with platform_type : linux_ 17:10:03 INFO - Initialising browser for kraken test... 17:10:03 INFO - TEST-INFO | started process 4857 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEkFOUB/profile http://localhost:51767/getInfo.html) 17:10:07 INFO - PROCESS | 4857 | __metrics Screen width/height:1600/1200 17:10:07 INFO - PROCESS | 4857 | colorDepth:24 17:10:07 INFO - PROCESS | 4857 | Browser inner width/height: 1024/697 17:10:07 INFO - PROCESS | 4857 | __metrics 17:10:07 INFO - PROCESS | 4857 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:07 INFO - PROCESS | 4857 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:08 INFO - TEST-INFO | 4857: exit 0 17:10:08 INFO - Browser initialized. 17:10:08 INFO - Running cycle 1/1 for kraken test... 17:10:08 INFO - TEST-INFO | started process 4937 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEkFOUB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:20 INFO - PROCESS | 4937 | RSS: Main: 149721088 17:10:20 INFO - PROCESS | 4937 | 17:10:22 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51767/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:23 INFO - PROCESS | 4937 | RSS: Main: 185655296 17:10:23 INFO - PROCESS | 4937 | 17:10:26 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51767/tests/kraken/driver.html?testName=audio-dft) 17:10:26 INFO - PROCESS | 4937 | RSS: Main: 175960064 17:10:26 INFO - PROCESS | 4937 | 17:10:29 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51767/tests/kraken/driver.html?testName=audio-fft) 17:10:30 INFO - PROCESS | 4937 | RSS: Main: 159924224 17:10:30 INFO - PROCESS | 4937 | 17:10:32 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51767/tests/kraken/driver.html?testName=audio-oscillator) 17:10:32 INFO - PROCESS | 4937 | RSS: Main: 161370112 17:10:32 INFO - PROCESS | 4937 | 17:10:34 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:35 INFO - PROCESS | 4937 | RSS: Main: 163287040 17:10:35 INFO - PROCESS | 4937 | 17:10:38 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51767/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:38 INFO - PROCESS | 4937 | RSS: Main: 163794944 17:10:38 INFO - PROCESS | 4937 | 17:10:42 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51767/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:42 INFO - PROCESS | 4937 | RSS: Main: 164839424 17:10:42 INFO - PROCESS | 4937 | 17:10:45 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51767/tests/kraken/driver.html?testName=json-parse-financial) 17:10:46 INFO - PROCESS | 4937 | RSS: Main: 165961728 17:10:46 INFO - PROCESS | 4937 | 17:10:47 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:48 INFO - PROCESS | 4937 | RSS: Main: 180629504 17:10:48 INFO - PROCESS | 4937 | 17:10:50 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:50 INFO - PROCESS | 4937 | RSS: Main: 177352704 17:10:50 INFO - PROCESS | 4937 | 17:10:52 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:53 INFO - PROCESS | 4937 | RSS: Main: 182620160 17:10:53 INFO - PROCESS | 4937 | 17:10:55 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:56 INFO - PROCESS | 4937 | RSS: Main: 192872448 17:10:56 INFO - PROCESS | 4937 | 17:10:58 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:59 INFO - PROCESS | 4937 | RSS: Main: 190242816 17:10:59 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | Cycle 1(1): loaded http://localhost:51767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51767/tests/kraken/driver.html?testName=ai-astar) 17:11:01 INFO - PROCESS | 4937 | RSS: Main: 247910400 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | __start_tp_report 17:11:01 INFO - PROCESS | 4937 | _x_x_mozilla_page_load 17:11:01 INFO - PROCESS | 4937 | _x_x_mozilla_page_load_details 17:11:01 INFO - PROCESS | 4937 | |i|pagename|runs| 17:11:01 INFO - PROCESS | 4937 | |0;ai-astar;108;110;105;109;110;110;100;109;110;117 17:11:01 INFO - PROCESS | 4937 | |1;audio-beat-detection;154;138;152;163;127;156;148;126;165;127 17:11:01 INFO - PROCESS | 4937 | |2;audio-dft;162;161;161;162;160;160;161;162;160;163 17:11:01 INFO - PROCESS | 4937 | |3;audio-fft;74;76;89;92;72;72;75;118;90;73 17:11:01 INFO - PROCESS | 4937 | |4;audio-oscillator;97;97;148;97;97;96;139;96;99;139 17:11:01 INFO - PROCESS | 4937 | |5;imaging-gaussian-blur;110;110;110;109;109;109;109;109;110;109 17:11:01 INFO - PROCESS | 4937 | |6;imaging-darkroom;145;145;145;145;145;146;146;146;145;145 17:11:01 INFO - PROCESS | 4937 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;98;96 17:11:01 INFO - PROCESS | 4937 | |8;json-parse-financial;57;57;56;57;56;57;56;57;62;55 17:11:01 INFO - PROCESS | 4937 | |9;json-stringify-tinderbox;67;67;67;67;67;67;68;68;67;68 17:11:01 INFO - PROCESS | 4937 | |10;stanford-crypto-aes;85;85;87;85;87;93;86;94;86;86 17:11:01 INFO - PROCESS | 4937 | |11;stanford-crypto-ccm;117;124;120;125;137;128;120;118;118;119 17:11:01 INFO - PROCESS | 4937 | |12;stanford-crypto-pbkdf2;142;150;157;155;151;144;152;151;151;140 17:11:01 INFO - PROCESS | 4937 | |13;stanford-crypto-sha256-iterative;69;69;72;68;67;70;69;70;71;66 17:11:01 INFO - PROCESS | 4937 | __end_tp_report 17:11:01 INFO - PROCESS | 4937 | __start_cc_report 17:11:01 INFO - PROCESS | 4937 | _x_x_mozilla_cycle_collect,938 17:11:01 INFO - PROCESS | 4937 | __end_cc_report 17:11:01 INFO - PROCESS | 4937 | __startTimestamp1452129061510__endTimestamp 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | ------- Summary: start ------- 17:11:01 INFO - PROCESS | 4937 | Number of tests: 14 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:4.29 (3.9%) stddev-sans-first:4.54 17:11:01 INFO - PROCESS | 4937 | Values: 108.0 110.0 105.0 109.0 110.0 110.0 100.0 109.0 110.0 117.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.00 stddev:15.05 (9.8%) stddev-sans-first:15.65 17:11:01 INFO - PROCESS | 4937 | Values: 154.0 138.0 152.0 163.0 127.0 156.0 148.0 126.0 165.0 127.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 17:11:01 INFO - PROCESS | 4937 | Values: 162.0 161.0 161.0 162.0 160.0 160.0 161.0 162.0 160.0 163.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.50 stddev:14.63 (19.4%) stddev-sans-first:15.14 17:11:01 INFO - PROCESS | 4937 | Values: 74.0 76.0 89.0 92.0 72.0 72.0 75.0 118.0 90.0 73.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:97.00 stddev:21.89 (22.6%) stddev-sans-first:22.67 17:11:01 INFO - PROCESS | 4937 | Values: 97.0 97.0 148.0 97.0 97.0 96.0 139.0 96.0 99.0 139.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:11:01 INFO - PROCESS | 4937 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:11:01 INFO - PROCESS | 4937 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 17:11:01 INFO - PROCESS | 4937 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 98.0 96.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.89 (3.3%) stddev-sans-first:2.00 17:11:01 INFO - PROCESS | 4937 | Values: 57.0 57.0 56.0 57.0 56.0 57.0 56.0 57.0 62.0 55.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:11:01 INFO - PROCESS | 4937 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 68.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:3.31 (3.8%) stddev-sans-first:3.39 17:11:01 INFO - PROCESS | 4937 | Values: 85.0 85.0 87.0 85.0 87.0 93.0 86.0 94.0 86.0 86.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:122.00 stddev:6.19 (5.1%) stddev-sans-first:6.22 17:11:01 INFO - PROCESS | 4937 | Values: 117.0 124.0 120.0 125.0 137.0 128.0 120.0 118.0 118.0 119.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.00 stddev:5.54 (3.7%) stddev-sans-first:5.21 17:11:01 INFO - PROCESS | 4937 | Values: 142.0 150.0 157.0 155.0 151.0 144.0 152.0 151.0 151.0 140.0 17:11:01 INFO - PROCESS | 4937 | 17:11:01 INFO - PROCESS | 4937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.79 (2.6%) stddev-sans-first:1.90 17:11:01 INFO - PROCESS | 4937 | Values: 69.0 69.0 72.0 68.0 67.0 70.0 69.0 70.0 71.0 66.0 17:11:01 INFO - PROCESS | 4937 | -------- Summary: end -------- 17:11:01 INFO - PROCESS | 4937 | 17:11:02 INFO - TEST-INFO | 4937: exit 0 17:11:02 INFO - TEST-OK | kraken | took 58473ms 17:11:02 INFO - TEST-START | v8_7 17:11:02 INFO - operating with platform_type : linux_ 17:11:02 INFO - Initialising browser for v8_7 test... 17:11:02 INFO - TEST-INFO | started process 5187 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO069gI/profile http://localhost:51767/getInfo.html) 17:11:06 INFO - PROCESS | 5187 | __metrics Screen width/height:1600/1200 17:11:06 INFO - PROCESS | 5187 | colorDepth:24 17:11:06 INFO - PROCESS | 5187 | Browser inner width/height: 1024/697 17:11:06 INFO - PROCESS | 5187 | __metrics 17:11:06 INFO - PROCESS | 5187 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:11:06 INFO - PROCESS | 5187 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:07 INFO - TEST-INFO | 5187: exit 0 17:11:07 INFO - Browser initialized. 17:11:07 INFO - Running cycle 1/1 for v8_7 test... 17:11:07 INFO - TEST-INFO | started process 5271 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO069gI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:19 INFO - PROCESS | 5271 | RSS: Main: 149762048 17:11:19 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | Cycle 1(1): loaded http://localhost:51767/tests/v8_7/run.html (next: http://localhost:51767/tests/v8_7/run.html) 17:11:40 INFO - PROCESS | 5271 | RSS: Main: 635015168 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | __start_tp_report 17:11:40 INFO - PROCESS | 5271 | _x_x_mozilla_page_load 17:11:40 INFO - PROCESS | 5271 | _x_x_mozilla_page_load_details 17:11:40 INFO - PROCESS | 5271 | |i|pagename|runs| 17:11:40 INFO - PROCESS | 5271 | |0;Richards;166.86133822793258 17:11:40 INFO - PROCESS | 5271 | |1;DeltaBlue;190.3311762466692 17:11:40 INFO - PROCESS | 5271 | |2;Encrypt;279.9552071668533 17:11:40 INFO - PROCESS | 5271 | |3;Decrypt;5256.544502617801 17:11:40 INFO - PROCESS | 5271 | |4;RayTrace;1116.0714285714287 17:11:40 INFO - PROCESS | 5271 | |5;Earley;786.1635220125786 17:11:40 INFO - PROCESS | 5271 | |6;Boyer;12243.90243902439 17:11:40 INFO - PROCESS | 5271 | |7;RegExp;26000 17:11:40 INFO - PROCESS | 5271 | |8;Splay;641.5816326530612 17:11:40 INFO - PROCESS | 5271 | |9;NavierStokes;4830.917874396136 17:11:40 INFO - PROCESS | 5271 | __end_tp_report 17:11:40 INFO - PROCESS | 5271 | __startTimestamp1452129100743__endTimestamp 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | ------- Summary: start ------- 17:11:40 INFO - PROCESS | 5271 | Number of tests: 10 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 166.9 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#1] DeltaBlue Cycles:1 Average:190.33 Median:190.33 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 190.3 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 280.0 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 5256.5 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 1116.1 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 786.2 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 12243.9 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 26000.0 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#8] Splay Cycles:1 Average:641.58 Median:641.58 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 641.6 17:11:40 INFO - PROCESS | 5271 | 17:11:40 INFO - PROCESS | 5271 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:11:40 INFO - PROCESS | 5271 | Values: 4830.9 17:11:40 INFO - PROCESS | 5271 | -------- Summary: end -------- 17:11:40 INFO - PROCESS | 5271 | 17:11:41 INFO - TEST-INFO | 5271: exit 0 17:11:41 INFO - TEST-OK | v8_7 | took 39239ms 17:11:41 INFO - SUITE-END | took 1210s 17:11:41 INFO - Completed test suite (00:20:10) 17:11:41 INFO - Working with test: dromaeo_css 17:11:41 INFO - Generating results file: dromaeo_css 17:11:41 INFO - Working with test: kraken 17:11:41 INFO - Generating results file: kraken 17:11:41 INFO - javascript benchmark 17:11:41 INFO - Working with test: v8_7 17:11:41 INFO - Generating results file: v8_7 17:11:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:11:41 INFO - process_Request line: dromaeo_css 6690.20 graph.html#tests=[[72,64,35]] 17:11:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:41 INFO - process_Request line: kraken 1512.70 graph.html#tests=[[232,64,35]] 17:11:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:41 INFO - process_Request line: v8_7 20834.51 graph.html#tests=[[230,64,35]] 17:11:41 INFO - RETURN: dromaeo_css: 6690.20 17:11:41 INFO - RETURN: kraken: 1512.70 17:11:41 INFO - RETURN: v8_7: 20834.51 17:11:41 INFO - javascript benchmark 17:11:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3061.8315992620405, 3111.237746752043, 3138.8430578471057, 3140.0265917565557, 3175.825329606872, 5102.77037533311, 5127.461616530267, 5154.974225128869, 5156.329677141971, 5202.141646628302, 5093.159628661276, 5106.821261255856, 5107.7701503432345, 5149.639525233235, 5224.399194092681, 4724.787384567703, 4730.574248317651, 4739.123262196487, 4778.928316075262, 4792.209285467894, 410.0548922967627, 4611.677182597219, 4742.573168414842, 4772.498887616785, 4795.136875362434, 4684.203685373494, 4719.268513380432, 4733.502982186872, 4756.690815097025, 4772.832950846739, 4728.456227533843, 4747.192977193886, 4754.9286760698615, 4757.833475828364, 4807.615390768765, 4595.931061034087, 4692.648051396159, 4699.107169637758, 4737.73942433166, 4779.61763058958, 4935.457099719028, 4992.350994370745, 4999.075171093323, 5026.698398096126, 5052.797888084472, 5512.724363781795, 5519.39286678465, 5533.889322213573, 5535.778568857241, 5575.498205161555, 5485.753141108659, 5580.0, 5592.720363981825, 5596.4403559644115, 5598.412166722517, 5065.848024559269, 5105.693658380472, 5113.897722045538, 5116.539511443988, 5133.922991155136, 5616.354119276336, 5641.323041234996, 5653.462921022497, 5663.631863928831, 5667.971660141673, 5307.230451584499, 5351.09031464652, 5389.568834493231, 5406.999705054577, 5424.267723857308, 5508.091164957737, 5535.059039963216, 5567.387587365387, 5574.303212098488, 5629.099344104923, 5533.08704063833, 5535.612507124462, 5544.7782088716, 5573.359063707644, 5580.358258800209, 5470.890582188334, 5525.364583072917, 5531.751071201806, 5532.640378375473, 5536.695481748462, 4200.5169405518145, 4251.766152861561, 4288.335308027261, 4302.612764851178, 4359.934600980988, 3819.8663046793786, 3866.38137897935, 3867.7485963412287, 3890.7471014383973, 3899.922001559953, 5085.084684756779, 5125.615578831528, 5140.922886156711, 5159.277701121846, 5185.118529849935, 5436.673799572039, 5527.309086364205, 5534.391216966131, 5536.252605898152, 5539.612227144061, 5107.591392688576, 5159.638825282194, 5174.663646863017, 5179.456157103526, 5221.477852214748, 4719.0, 4720.881977950578, 4730.101280756645, 4732.195526760459, 4762.618990480753, 5484.067708489566, 5588.189712491666, 5604.3835178130375, 5694.487496125369, 5711.371749107595, 5481.671099734029, 5497.752601132878, 5520.1167813149705, 5529.889402211853, 5582.888342233051, 5723.198752174616, 5760.279965004374, 5777.45114214149, 5786.33457152416, 5795.565332600157, 5377.865553361197, 5385.40760516335, 5467.0, 5514.310711161105, 5529.391766905556, 5532.861678458071, 5541.418151094238, 5546.112621980464, 5548.667079975215, 5581.804636837691, 5372.62391632582, 5414.404415514369, 5420.83737487876, 5426.7829286829665, 5452.127659574449, 5265.289185959847, 5351.411344752152, 5386.165144402624, 5386.192071189196, 5408.675479471244, 5292.9735351323, 5293.285406470077, 5294.232336311136, 5310.787568497217, 5342.652727572696, 5396.244525766318, 5397.568194544348, 5439.347278326626, 5451.400345961862, 5469.097598896137, 5232.790688372423, 5301.098813201842, 5333.573314134937, 5333.759980800795, 5359.981603495324], "unit": "score", "name": "dojo.html", "value": 5067.645691093867}, {"lowerIsBetter": false, "replicates": [534.2147043845548, 546.2052713302146, 566.1451208674899, 567.2653913182427, 578.8379253808932, 27466.313342166457, 27755.444891102165, 35360.82319588398, 35853.64146358536, 35871.10322241945, 39449.40825887614, 39879.60120398795, 39884.60115398845, 39897.00257493564, 40067.398989015186, 7482.850342993137, 8413.074561798197, 8588.0, 8590.0, 8596.226339629433, 7570.3565196958325, 7687.423443241779, 10052.0, 10253.897461025406, 10262.486875656188, 9885.555150018266, 9982.351147175446, 9990.700278991642, 10018.298719089667, 10023.198144148451, 7679.7312094077, 7840.372770178372, 9844.0, 9890.653827116088, 9945.0, 9998.900010999869, 10188.337758045778, 10227.590896364136, 10228.43743594102, 10238.23213259001, 36254.63745362539, 36679.08302292437, 36707.26585468302, 36712.53149874029, 36758.63241367579, 3017.6529699084667, 3066.938661226763, 3091.412631599989, 3117.8596963136715, 3703.814809259526, 27775.58336624952, 28285.57571636427, 28395.290117747016, 30336.54495182574, 30415.0, 3465.42820434628, 3504.847129008203, 3547.2018795771005, 3557.6620221079215, 3595.7842529448317, 265743.0, 266598.0, 266851.9999999981, 267561.0, 267621.0, 51274.743626281626, 52454.47545524572, 58424.0, 58866.41133588609, 58886.0, 61342.386576133664, 62113.0, 62266.0, 62315.37684623096, 62423.687881560305, 15095.849041509664, 15130.470433534774, 15284.38862445512, 15312.310946007234, 15333.769993450107, 11415.885841141482, 11497.137714671433, 11529.827052594217, 11572.94213528927, 11583.07335413165, 18902.243910243436, 18987.620247594972, 18993.0, 19667.311644092388, 19668.901655491918, 6866.004429357715, 7174.461915356264, 7174.569525828467, 7211.711531538785, 7288.9271107289305, 892.6340200517757, 1005.7133716890797, 1028.6862506935306, 1045.968620941373, 1053.252190944438, 28461.36979748045, 28483.57274640882, 28522.286942826595, 28828.423431531253, 29003.41993160125, 942.886853577575, 1076.56399158341, 1140.3841925360377, 1156.2773266708307, 1186.1993154620768, 14899.404023838924, 14985.32566034531, 15000.549983500512, 15246.085234885943, 15281.541553753405, 307380.0, 311101.0, 311603.0, 312358.0, 313603.0, 52612.94774104573, 52666.47333526692, 52879.20681189785, 53076.0, 53118.20322695163, 1284.916480428769, 1290.2903403128241, 1305.3799445263423, 1306.3664122900386, 1308.7775078236532, 27249.86375068112, 28083.859580701966, 28276.8161957184, 28305.292367690974, 28320.575191371732, 46808.76595617, 47239.165650061106, 47266.52733472621, 47292.29061564011, 47311.76344118257, 289698.0, 290776.0, 291607.0, 292402.0, 292699.0, 27789.722102779524, 30851.537226941164, 31130.37739245157, 31193.220169495038, 31685.20786980344, 36826.447603285436, 37731.43402849014, 37985.48058077646, 38368.04079898025, 38449.42325865058, 35024.29951401009, 35933.46099808453, 36212.63787362093, 36618.8169059153, 37032.62967370292, 28863.278418039718, 32131.196720082185, 32583.511247330836, 34475.0, 35718.821405892806, 34403.4839477403, 34916.127096821765, 35226.11934701653, 35349.82325088461, 35361.29277414489, 29676.554851677673, 30546.541801872547, 32572.185695357806, 32593.674063259063, 32701.18247043843, 24046.87976560106, 24246.272611821674, 24417.755822441548, 24591.262262132164, 24632.507349852545], "unit": "score", "name": "ext.html", "value": 18127.96919608817}, {"lowerIsBetter": false, "replicates": [339.11491008467897, 339.2959608811713, 349.4757863205192, 354.36214813336, 356.8073240450157, 16244.187790610467, 16498.422555210556, 17876.106194690245, 18132.909335453303, 18145.90927045363, 16725.0, 16732.41436549721, 16973.745393819103, 17084.060376679277, 17440.82559174408, 5233.528982391584, 5302.125149350352, 5415.783368665268, 5419.132938729804, 5422.322209723785, 5386.91919621206, 5418.8916221675545, 5418.972905135489, 5420.512153906147, 5422.132458806592, 4009.1781184857036, 4120.917581648365, 5356.491133342346, 5379.542738867201, 5772.0476121439915, 5729.799457019005, 5732.484076433141, 5735.741891614866, 5737.225474560964, 5739.942600573982, 4839.903201935942, 4977.9751101244265, 5011.2483127530795, 5018.197088465828, 5021.568852876949, 10490.947545262301, 10735.0, 11832.645020649394, 12184.878151218463, 12384.947279481255, 1870.1584287070873, 1913.7033759767257, 1986.0764744393782, 2046.6418376784152, 2203.43812327857, 8734.432261902955, 8862.069482704288, 8931.419457735292, 9125.0, 9142.131497507726, 1592.6575786206022, 1615.2241347547044, 1678.1022153148128, 1694.2799310293076, 1712.494814029864, 59558.0, 61036.084458733596, 61365.6931715343, 62297.0, 62429.0, 9940.40357578533, 10128.848067278997, 10219.897801021894, 10263.435511046815, 10358.53386597605, 13441.596752097452, 13499.595012149652, 13535.864641353657, 13544.05191636576, 13546.187228766306, 7424.480286379901, 7481.438892083115, 7519.172890981988, 7537.698492060256, 7704.8459030820195, 7197.280271972865, 7273.599952002691, 7293.52592081513, 7335.266473352622, 7373.668184931691, 4389.736615803062, 4451.821927122944, 4466.843660471933, 4486.955130448719, 4505.481869584974, 1794.0491539484094, 1800.1629242402346, 1801.8738688291694, 1815.4190658989262, 1857.2199676136056, 367.3039589977032, 411.60897147709795, 447.5233875922132, 452.6763364194617, 981.4062492192263, 10350.016748408889, 10409.167266618653, 10535.420551869567, 10556.0, 10831.83752243717, 437.43352358695563, 439.2181916189188, 439.26861775144664, 449.8852792537882, 453.23855922050615, 5101.948980510221, 5387.24578559002, 5813.447722466359, 6127.253732686163, 6203.348648391944, 576755.0, 589029.0, 589033.0, 591019.0, 597981.0, 73339.63330183315, 76226.0, 81604.18395815966, 82803.0, 83485.58257208797, 1140.863096428434, 1145.450183911727, 1191.3566673996118, 1203.1878482024774, 1222.8165775133623, 14628.92685536608, 15046.097234165985, 15504.844951550791, 15675.451359202374, 15867.841321586637, 21876.124955001622, 29604.703952961056, 34292.0, 34620.0, 34941.650583494855, 47027.52972470231, 47624.523754763395, 49299.75350123226, 51931.74034129805, 52397.47602524079, 9352.906470935475, 9420.95289523548, 9450.716478505656, 9465.763355915882, 9682.419054856731, 11747.941260293645, 11775.23460975034, 11818.704532386759, 11857.98414269559, 14769.335379908145, 13747.862521374658, 13779.586612401645, 14516.709665806837, 14523.273836308354, 15021.324040418425, 13108.934455327662, 13222.603321900358, 13894.861051389356, 14325.140491570539, 14560.85439145595, 14527.346269418113, 14530.346134423766, 14677.55967320982, 14769.113853168845, 14784.704305914036, 7766.223377662189, 7958.0848202457455, 9079.45523268606, 9116.954415227881, 9356.906430935876, 12890.67773305675, 13076.542321018718, 13299.401526931118, 14139.64650883736, 14278.571642850731], "unit": "score", "name": "jquery.html", "value": 8049.051649346179}, {"lowerIsBetter": false, "replicates": [1257.0886107572005, 1420.8508106648806, 1429.914205147691, 1539.2380771518094, 1715.048148277706, 6744.08954791103, 7333.779986600404, 7395.075615548057, 7416.110066791993, 7428.405727541797, 7302.853942921139, 7454.403647708184, 7472.887906681404, 7477.887831682529, 7484.839849823286, 1930.1700268884374, 1955.8435325173953, 1960.059171597634, 2268.104098880941, 2322.3381336319067, 2024.6760518317071, 2297.310806757974, 2308.861468311898, 2326.6161083421216, 2329.6505524171425, 2207.1612787140944, 2230.8996095175758, 2243.2036626997424, 2271.5229801741652, 2274.931752047433, 2127.7765834587376, 2135.348718640814, 2136.957260854774, 2137.1665050630268, 2237.496563273267, 2177.444751588335, 2199.846010779246, 2200.702905107822, 2201.6037113319594, 2215.6787265846524, 7521.661525231378, 7550.169481357047, 7610.467267291292, 7610.885836712454, 7614.657340419639, 4643.16423043852, 4687.10944920464, 4707.976460117712, 4727.5272472752795, 4732.100900828831, 2916.533354663265, 2923.693012233706, 2967.3768508613216, 3003.849807509616, 3032.1964679359985, 896.3725392225404, 906.2251774732574, 906.6645341223724, 941.1341565759518, 962.93259471837, 10279.588816447333, 10440.425776582286, 10449.791004179873, 10452.529636166315, 10470.84293735587, 4212.831486740496, 4269.893252668646, 4327.718698284664, 4328.783560821947, 4337.284348082594, 8996.235319997873, 9011.143941325563, 9013.098690130935, 9020.8646870297, 9021.639134434548, 4677.415323084614, 4732.1718699227495, 4740.976295118502, 4753.952460475351, 4777.8088876445245, 4257.6168144867115, 4263.914721705611, 4268.932766808298, 4303.784810759449, 4304.5480224576595, 3394.5247665326874, 3443.6556344365863, 3503.2993401319327, 3525.2773181498246, 3571.4464258040043, 1160.7156246719608, 1170.1633332167542, 1197.1978774221293, 1210.2556927489532, 1219.9756004879853, 1020.5764607687875, 1038.2317085356933, 1041.833306670929, 1080.8378743188584, 1093.971666633362, 6963.7562685305775, 6993.580385176804, 7019.719211231596, 7024.5434046786795, 7027.297270273034, 609.960352577081, 610.572972434569, 618.6473709985265, 621.5493767018875, 752.3304259209308, 5539.944600554023, 5657.632253903483, 5658.660480371191, 5720.885582288331, 5736.885262294731, 8513.19124683154, 8643.135686431306, 8663.913360866436, 8710.25962793157, 8802.119788021148, 8640.827183456297, 8651.134886511425, 8702.6518939243, 8705.260052895575, 8706.738797836075, 6909.827254318682, 6944.756933507303, 7179.89230161548, 7271.236520165412, 7281.381082608038, 7253.057102576631, 7299.489035767445, 7306.0, 7306.305900939402, 7308.59802710856, 7869.803254918673, 8201.26188643025, 8398.706045288385, 8399.790005249673, 8456.40805143634, 8241.876371854307, 8438.409311348147, 8444.451110677786, 8584.227419532272, 8596.699115530926, 6502.544821862424, 6701.966490167518, 6710.664466776544, 6716.429103526255, 6857.485688573277, 6593.076969224217, 6698.129243198353, 6973.442124629916, 7023.859522809617, 7024.4029257513685, 6840.965795170992, 6842.863142737217, 6915.101036865175, 6919.481038922202, 7047.119110111236, 6595.538312318092, 6749.358810912955, 6769.864602708017, 6778.084958530535, 6834.965825170842, 6776.15298087739, 6817.93182068173, 6823.28355522663, 6823.89764153548, 6824.522283440111, 6290.622562646256, 6320.557560970872, 6329.272133704683, 6406.0390941359165, 6408.327125651926, 6484.870302594016, 6591.934080659324, 6613.768518101843, 6615.206175259, 6620.404163625297], "unit": "score", "name": "mootools.html", "value": 4291.781481937934}, {"lowerIsBetter": false, "replicates": [335.35778983247076, 340.5589761259169, 341.4042495844751, 348.10710527496985, 348.4198808983044, 5848.327442344132, 5898.52811775058, 5907.763689452428, 5936.287645482548, 5970.104484327342, 5830.154627578999, 5833.795817146401, 5860.648361098337, 5865.442782935625, 5865.560082993782, 4550.749708766025, 4550.8862278442975, 4556.54434556545, 4561.498235194126, 4569.725816451007, 4396.956030439686, 4505.121501307246, 4507.752073635948, 4508.797104130322, 4517.751523666197, 4447.822087116511, 4452.577005184518, 4454.220511410506, 4456.59890609845, 4465.196264672358, 4294.849680261192, 4329.805158767863, 4355.216061108999, 4456.844010459635, 4461.263891457922, 3808.409696497047, 3809.0667786392232, 3814.256220037094, 3828.655421012122, 3849.191669749356, 5589.357223919261, 5598.188262701926, 5601.29983752031, 5609.186667933127, 5620.775168993236, 4960.305557221992, 5022.824201152978, 5040.193569028975, 5165.044466773659, 5169.81905633301, 6195.0, 6229.2836323822885, 6236.251649802008, 6241.594296370721, 6261.9373806262265, 4230.2174097792, 4236.428082208924, 4243.766592837393, 4243.80902859369, 4246.59657332556, 6407.967960160169, 6444.033394990742, 6519.5436319457185, 6521.445677117451, 6524.836879078013, 4480.372747815309, 4480.753558554311, 4485.955140448619, 4486.2597671383855, 4489.753063581535, 4533.455985281787, 4536.841210557614, 4543.34121552373, 4544.477385100756, 4545.068261006486, 5217.087009773274, 5230.110881150214, 5245.816396426183, 5250.947490525045, 5253.711045892436, 6168.1056246843955, 6283.937160628335, 6290.55966082379, 6305.873882522415, 6306.2747784004505, 1575.346231313992, 1607.879409044303, 1608.549606110291, 1609.1632351177323, 1609.6297851493987, 1053.378506681062, 1070.8982646648556, 1074.6829685242872, 1084.5661735305941, 1097.5006372100675, 5972.492338151305, 5995.370486098896, 5995.970020149872, 5996.070609055516, 5998.670073145931, 6475.740970361133, 6477.805665830033, 6482.740690372332, 6483.7082331295205, 6489.448396886318, 5797.391273916262, 5910.497607703393, 5914.112883067574, 5915.792947246826, 5924.7926322578505, 3463.9826800865835, 3504.281622267429, 3504.6495350464747, 3505.071156143624, 3506.526618906466, 6669.0, 6712.39588437043, 6713.26154123046, 6717.261101278856, 6719.42884854783, 6367.777127800505, 6491.318411566812, 6578.736850525926, 6578.967105164444, 6581.506387020897, 6602.0, 6680.7953375386005, 6753.797386078524, 6772.661366931634, 6794.66026698673, 6458.935410645833, 6494.837629059311, 6500.187476565429, 6504.0, 6506.4469520091325, 6347.365263473615, 6428.774992875227, 6463.57986730861, 6474.1907261592305, 6476.190476190476, 6786.0, 6791.524593278621, 6792.286809885089, 6794.626295553792, 6798.966005169942, 4512.9097418052115, 4516.074204788077, 4522.4573051234065, 4525.50219475864, 4526.2305408081365, 6487.059376390492, 6508.186476690414, 6535.183102112236, 6538.542302038812, 6554.279029306677, 6362.586431881913, 6365.52258580599, 6382.425581697669, 6382.7766028190645, 6387.616742995249, 6354.983202687547, 6358.078078678658, 6363.0, 6364.427201551883, 6365.490760739037, 6130.6628135452975, 6251.874962500816, 6271.717772700148, 6274.247090349188, 6274.498040156685, 6363.809085727436, 6387.0, 6395.136656551306, 6396.6481843497195, 6402.711877965409, 6234.875302494015, 6240.781572644935, 6241.6879156041105, 6244.406781355764, 6248.937510624835], "unit": "score", "name": "prototype.html", "value": 4733.513558780024}, {"lowerIsBetter": false, "replicates": [739.5562662402556, 831.968359234549, 861.4917198852676, 869.5826003518312, 870.6169285514374, 12553.497860085597, 12718.55485058023, 12739.936300318508, 12767.297798621072, 12819.48722051118, 11935.522579096847, 12008.579699710512, 12009.75980480392, 12011.759764804721, 12017.879821201806, 671.2079745899837, 679.8266442057269, 782.026377160436, 791.2522666080556, 807.8626633472294, 795.8010497375656, 801.3749275565068, 803.8593246181924, 807.0839597057353, 807.2008711375754, 835.5613303015905, 852.5225873510853, 852.6418904060309, 853.5433543054467, 853.7609469348592, 689.6000319814495, 697.4420463629102, 826.1366871619173, 846.3102571404286, 847.3179090831878, 619.1950464396311, 623.9937600623981, 624.4536030972898, 624.491039802564, 626.2829060725444, 12040.81938770919, 12139.817902731465, 12147.331896745676, 12174.208676436092, 12183.390830458531, 11223.60717374888, 11330.603428880033, 11337.093032557375, 11488.253263537843, 11715.824262636068, 10228.64199753005, 10232.283740138193, 10359.378437293786, 10480.318779279323, 10522.42126683032, 3472.8437220325145, 3561.0, 3578.141246100943, 3585.3008663310666, 3656.542932133483, 47748.761256193844, 48506.757466212446, 49097.509024909654, 49134.75432622814, 49135.26297105546, 8973.36513615586, 9048.683296084606, 9177.403468774643, 9263.0, 9294.0, 17610.823891761174, 17614.383496577557, 17621.7356739649, 17660.646787064445, 17675.20461579232, 6838.555493892981, 6925.930740692629, 7029.156501219886, 7034.3669069782945, 7121.92878071223, 3741.56971948224, 3816.1604447022164, 3837.3860182370686, 3853.807309634507, 3875.6318149775725, 3030.0606811888383, 3057.3121047764075, 3058.7247147756366, 3060.265536271279, 3070.6929307069113, 537.8332716857786, 556.8496505943373, 558.7820749907539, 563.892860356531, 575.5913301555859, 536.8362649391973, 577.6880484538386, 647.6081970407836, 678.3250665587772, 683.7811900191891, 7849.960750196213, 7877.724279650185, 8027.438079334507, 8047.758567242992, 8283.875741863876, 534.9919751203735, 541.9621424971136, 542.953848922846, 566.5156291370901, 600.588596811177, 3559.7330200235087, 3652.7990960497427, 3807.1814559869763, 3844.308024555607, 3988.940165897514, 49717.50282497201, 50171.0, 50383.24425133626, 50506.74746626317, 50537.0, 46667.0, 46860.297095543596, 47427.525724742314, 47790.0, 49968.25047624289, 42087.78956105261, 42583.78708106501, 44037.0, 44599.55400446019, 44820.3276950846, 8046.356291496783, 8292.585370731318, 8419.957900210704, 8543.40196186261, 8613.483191008308, 32170.19574510656, 32568.67431325751, 33010.33979320352, 33437.16407089745, 34220.31559368749, 38412.61587384091, 39407.80296098501, 43587.78206109076, 44539.77730111329, 45012.77493612511, 10237.0, 10346.844797327896, 10533.420661863365, 10727.249092563447, 10889.673309800719, 11525.88474115248, 11717.121215909012, 11758.176927614984, 11760.470778815145, 11836.289822610672, 9982.900170998488, 10436.686899393031, 10575.894241057491, 10575.894241057798, 10770.73073173177, 10369.377837329785, 10467.685969420929, 10700.250982431155, 10920.235583509078, 10963.616273430393, 10008.39949603026, 10039.498025098861, 10155.39067655943, 10303.742406439898, 10512.159027277952, 9028.0, 9156.816863662823, 9328.207102396102, 9350.812983740423, 9362.438253704799, 8252.546109963769, 8331.541765202972, 8679.218870301704, 8887.244584210415, 9054.773630659287], "unit": "score", "name": "yui.html", "value": 5968.638101527358}], "name": "dromaeo_css", "value": 6690.204610191207}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 110.0, 100.0, 109.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [154.0, 138.0, 152.0, 163.0, 127.0, 156.0, 148.0, 126.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 161.0, 162.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 89.0, 92.0, 72.0, 72.0, 75.0, 118.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 148.0, 97.0, 97.0, 96.0, 139.0, 96.0, 99.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 57.0, 62.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 85.0, 87.0, 93.0, 86.0, 94.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [117.0, 124.0, 120.0, 125.0, 137.0, 128.0, 120.0, 118.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [142.0, 150.0, 157.0, 155.0, 151.0, 144.0, 152.0, 151.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 72.0, 68.0, 67.0, 70.0, 69.0, 70.0, 71.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1512.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [190.3311762466692], "unit": "score", "name": "DeltaBlue", "value": 347.3839720000001}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1116.0714285714287], "unit": "score", "name": "RayTrace", "value": 663.0301440000001}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [641.5816326530612], "unit": "score", "name": "Splay", "value": 127.01579324055665}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20834.51100598354}]} 17:11:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20834.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1512.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6690.20"}}} 17:11:41 INFO - Return code: 0 17:11:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:11:41 INFO - # TBPL SUCCESS # 17:11:41 INFO - Running post-action listener: _resource_record_post_action 17:11:41 INFO - Running post-run listener: _resource_record_post_run 17:11:43 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 547819520; Read time: 0; Write time: 399224 17:11:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238252032; Read time: 0; Write time: 203520 17:11:43 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 308445184; Read time: 0; Write time: 195692 17:11:43 INFO - Running post-run listener: _upload_blobber_files 17:11:43 INFO - Blob upload gear active. 17:11:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:11:43 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 17:11:43 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:11:43 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:11:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:44 INFO - (blobuploader) - INFO - Done attempting. 17:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:45 INFO - (blobuploader) - INFO - Done attempting. 17:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:45 INFO - Return code: 0 17:11:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01f82492fd391833a3c9feb2202d15f92d80e312ad7bf3b1c64a6aac8dbd07dc4684480207bd92165075f01c220016c3e95bf562b69a572e694ce5d4858bb42a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6685ac847325a24996dbc736e6e84429a2924835b5bde283dd736b78d4e8714dd85c4695f16062cfe0cd7889fa02c24bff9e516ee886fb5cf414a6490a485e23"} 17:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:11:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:11:45 INFO - Contents: 17:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01f82492fd391833a3c9feb2202d15f92d80e312ad7bf3b1c64a6aac8dbd07dc4684480207bd92165075f01c220016c3e95bf562b69a572e694ce5d4858bb42a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6685ac847325a24996dbc736e6e84429a2924835b5bde283dd736b78d4e8714dd85c4695f16062cfe0cd7889fa02c24bff9e516ee886fb5cf414a6490a485e23"} 17:11:45 INFO - Copying logs to upload dir... 17:11:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.581367 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-06 17:11:45.110017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 17:11:45.119182) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01f82492fd391833a3c9feb2202d15f92d80e312ad7bf3b1c64a6aac8dbd07dc4684480207bd92165075f01c220016c3e95bf562b69a572e694ce5d4858bb42a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6685ac847325a24996dbc736e6e84429a2924835b5bde283dd736b78d4e8714dd85c4695f16062cfe0cd7889fa02c24bff9e516ee886fb5cf414a6490a485e23"} build_url:https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/HMRgKqp0Sx-QYemeUMcXDA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01f82492fd391833a3c9feb2202d15f92d80e312ad7bf3b1c64a6aac8dbd07dc4684480207bd92165075f01c220016c3e95bf562b69a572e694ce5d4858bb42a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6685ac847325a24996dbc736e6e84429a2924835b5bde283dd736b78d4e8714dd85c4695f16062cfe0cd7889fa02c24bff9e516ee886fb5cf414a6490a485e23"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 17:11:45.143557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 17:11:45.148001) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452126471.776696-1178255952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 17:11:45.226511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 17:11:45.228897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 17:11:45.229271) ========= ========= Total master_lag: 0.32 =========