builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1452159929.04 results: success (0) buildid: 20160106233009 builduid: d2b783abb62749c18bae8890378f4079 revision: d9766669880bcab85f600f1741aebb01aa9b224f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.041933) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.042431) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.042839) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.066326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.066616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.118929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.119213) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.167456) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.167715) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.168063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.168340) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 01:45:29-- 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% 56.6M=0s 2016-01-07 01:45:29 (56.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.341178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.341478) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021322 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.393554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:29.393867) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9766669880bcab85f600f1741aebb01aa9b224f --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 d9766669880bcab85f600f1741aebb01aa9b224f --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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 01:45:30,047 truncating revision to first 12 chars 2016-01-07 01:45:30,047 Setting DEBUG logging. 2016-01-07 01:45:30,047 attempt 1/10 2016-01-07 01:45:30,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9766669880b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 01:45:30,706 unpacking tar archive at: fx-team-d9766669880b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:30.361672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:30.361980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:30.374211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:30.374499) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 01:45:30.374937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-07 01:45:30.375298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:45:31 INFO - MultiFileLogger online at 20160107 01:45:31 in /builds/slave/test-pgo 01:45:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:45:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:45:31 INFO - {'append_to_log': False, 01:45:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:45:31 INFO - 'blob_upload_branch': 'Fx-Team', 01:45:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:45:31 INFO - 'branch': 'Fx-Team', 01:45:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:45:31 INFO - 'config_files': ('talos/linux_config.py',), 01:45:31 INFO - 'default_actions': ('clobber', 01:45:31 INFO - 'read-buildbot-config', 01:45:31 INFO - 'download-and-extract', 01:45:31 INFO - 'populate-webroot', 01:45:31 INFO - 'create-virtualenv', 01:45:31 INFO - 'install', 01:45:31 INFO - 'run-tests'), 01:45:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:45:31 INFO - 'download_minidump_stackwalk': True, 01:45:31 INFO - 'download_symbols': 'ondemand', 01:45:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:45:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:45:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:45:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:45:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:45:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:45:31 INFO - 'installer_path': 'installer.exe', 01:45:31 INFO - 'log_level': 'info', 01:45:31 INFO - 'log_name': 'talos', 01:45:31 INFO - 'log_to_console': True, 01:45:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:45:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:45:31 INFO - 'opt_config_files': (), 01:45:31 INFO - 'pip_index': False, 01:45:31 INFO - 'sps_profile': False, 01:45:31 INFO - 'sps_profile_interval': 0, 01:45:31 INFO - 'suite': 'dromaeojs-e10s', 01:45:31 INFO - 'system_bits': '32', 01:45:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:45:31 INFO - 'title': 'talos-linux64-ix-008', 01:45:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:45:31 INFO - 'use_talos_json': True, 01:45:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:45:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:45:31 INFO - 'work_dir': 'build'} 01:45:31 INFO - ##### 01:45:31 INFO - ##### Running clobber step. 01:45:31 INFO - ##### 01:45:31 INFO - Running pre-action listener: _resource_record_pre_action 01:45:31 INFO - Running main action method: clobber 01:45:31 INFO - rmtree: /builds/slave/test-pgo/build 01:45:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:45:31 INFO - Running post-action listener: _resource_record_post_action 01:45:31 INFO - ##### 01:45:31 INFO - ##### Running read-buildbot-config step. 01:45:31 INFO - ##### 01:45:31 INFO - Running pre-action listener: _resource_record_pre_action 01:45:31 INFO - Running main action method: read_buildbot_config 01:45:31 INFO - Using buildbot properties: 01:45:31 INFO - { 01:45:31 INFO - "project": "", 01:45:31 INFO - "product": "firefox", 01:45:31 INFO - "script_repo_revision": "production", 01:45:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:45:31 INFO - "repository": "", 01:45:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:45:31 INFO - "buildid": "20160106233009", 01:45:31 INFO - "pgo_build": "True", 01:45:31 INFO - "basedir": "/builds/slave/test-pgo", 01:45:31 INFO - "buildnumber": 187, 01:45:31 INFO - "slavename": "talos-linux64-ix-008", 01:45:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:45:31 INFO - "platform": "ubuntu64_hw", 01:45:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:45:31 INFO - "branch": "fx-team", 01:45:31 INFO - "repo_path": "integration/fx-team", 01:45:31 INFO - "revision": "d9766669880bcab85f600f1741aebb01aa9b224f", 01:45:31 INFO - "stage_platform": "linux64-pgo", 01:45:31 INFO - "builduid": "d2b783abb62749c18bae8890378f4079", 01:45:31 INFO - "slavebuilddir": "test" 01:45:31 INFO - } 01:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:45:31 INFO - Running post-action listener: _resource_record_post_action 01:45:31 INFO - ##### 01:45:31 INFO - ##### Running download-and-extract step. 01:45:31 INFO - ##### 01:45:31 INFO - Running pre-action listener: _resource_record_pre_action 01:45:31 INFO - Running main action method: download_and_extract 01:45:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:31 INFO - https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/test_packages.json 01:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/test_packages.json 01:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:45:36 INFO - Downloaded 1302 bytes. 01:45:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:45:36 INFO - Using the following test package requirements: 01:45:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:45:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'jsshell-linux-x86_64.zip'], 01:45:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:45:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:45:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:45:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:45:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:45:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:36 INFO - https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:44 INFO - Downloaded 24102051 bytes. 01:45:44 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 01:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:44 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 01:45:45 INFO - Return code: 0 01:45:45 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 01:45:45 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')]} 01:45:45 INFO - https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:47 INFO - Downloaded 24102051 bytes. 01:45: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 01:45:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45: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 01:45:49 INFO - Return code: 0 01:45: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')]} 01:45:49 INFO - https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:45:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:50 INFO - Downloaded 11132285 bytes. 01:45:50 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 01:45:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:50 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 01:45:50 INFO - Return code: 0 01:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:50 INFO - https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/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 01:45:51 INFO - Downloaded 55050625 bytes. 01:45:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:51 INFO - mkdir: /builds/slave/test-pgo/properties 01:45:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:45:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:45:51 INFO - Contents: 01:45:51 INFO - build_url:https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:51 INFO - Running post-action listener: _resource_record_post_action 01:45:51 INFO - Running post-action listener: set_extra_try_arguments 01:45:51 INFO - ##### 01:45:51 INFO - ##### Running populate-webroot step. 01:45:51 INFO - ##### 01:45:51 INFO - Running pre-action listener: _resource_record_pre_action 01:45:51 INFO - Running main action method: populate_webroot 01:45:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:51 INFO - '--tppagecycles', 01:45:51 INFO - '7'], 01:45:51 INFO - 'tests': ['tsvgm']}}, 01:45:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:45:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'tests': ['damp', 'tps']}, 01:45:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['damp', 'tps']}, 01:45:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:45:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:51 INFO - 'other': {'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'other_l64': {'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'other_nol64': {'tests': ['a11yr', 01:45:51 INFO - 'ts_paint', 01:45:51 INFO - 'tpaint', 01:45:51 INFO - 'sessionrestore', 01:45:51 INFO - 'sessionrestore_no_auto_restore']}, 01:45:51 INFO - 'svgr': {'tests': ['tsvgx', 01:45:51 INFO - 'tsvgr_opacity', 01:45:51 INFO - 'tart', 01:45:51 INFO - 'tscrollx', 01:45:51 INFO - 'cart']}, 01:45:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['tsvgx', 01:45:51 INFO - 'tsvgr_opacity', 01:45:51 INFO - 'tart', 01:45:51 INFO - 'tscrollx', 01:45:51 INFO - 'cart']}, 01:45:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'tests': ['tp5o']}, 01:45:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'talos_options': ['--e10s'], 01:45:51 INFO - 'tests': ['tp5o']}, 01:45:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'talos_options': ['--xperf_path', 01:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:51 INFO - 'tests': ['tp5n']}, 01:45:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:51 INFO - 'talos_options': ['--e10s', 01:45:51 INFO - '--xperf_path', 01:45:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:51 INFO - 'tests': ['tp5n']}}, 01:45:51 INFO - 'talos.zip': {'path': '', 01:45:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:51 INFO - Running post-action listener: _resource_record_post_action 01:45:51 INFO - ##### 01:45:51 INFO - ##### Running create-virtualenv step. 01:45:51 INFO - ##### 01:45:51 INFO - Running pre-action listener: _resource_record_pre_action 01:45:51 INFO - Running main action method: create_virtualenv 01:45:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:45: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 01:45:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:45:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:51 INFO - Using real prefix '/usr' 01:45:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:45:52 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:54 INFO - Installing pip.................done. 01:45:54 INFO - Return code: 0 01:45:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:45:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:45:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:45:54 INFO - Using env: {'DISPLAY': ':0', 01:45:54 INFO - 'HOME': '/home/cltbld', 01:45:54 INFO - 'LANG': 'en_US.UTF-8', 01:45:54 INFO - 'LANGUAGE': 'en_US:en', 01:45:54 INFO - 'LOGNAME': 'cltbld', 01:45:54 INFO - 'MAIL': '/var/mail/cltbld', 01:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:54 INFO - 'MOZ_NO_REMOTE': '1', 01:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:54 INFO - 'NO_EM_RESTART': '1', 01:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:54 INFO - 'SHELL': '/bin/bash', 01:45:54 INFO - 'SHLVL': '1', 01:45:54 INFO - 'TERM': 'linux', 01:45:54 INFO - 'TMOUT': '86400', 01:45:54 INFO - 'USER': 'cltbld', 01:45:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:54 INFO - '_': '/tools/buildbot/bin/python'} 01:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:54 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 01:45:54 INFO - Cleaning up... 01:45:54 INFO - Return code: 0 01:45:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:45:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:45:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:45:54 INFO - Using env: {'DISPLAY': ':0', 01:45:54 INFO - 'HOME': '/home/cltbld', 01:45:54 INFO - 'LANG': 'en_US.UTF-8', 01:45:54 INFO - 'LANGUAGE': 'en_US:en', 01:45:54 INFO - 'LOGNAME': 'cltbld', 01:45:54 INFO - 'MAIL': '/var/mail/cltbld', 01:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:54 INFO - 'MOZ_NO_REMOTE': '1', 01:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:54 INFO - 'NO_EM_RESTART': '1', 01:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:54 INFO - 'SHELL': '/bin/bash', 01:45:54 INFO - 'SHLVL': '1', 01:45:54 INFO - 'TERM': 'linux', 01:45:54 INFO - 'TMOUT': '86400', 01:45:54 INFO - 'USER': 'cltbld', 01:45:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:54 INFO - '_': '/tools/buildbot/bin/python'} 01:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:54 INFO - Downloading/unpacking psutil>=0.7.1 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:56 INFO - Installing collected packages: psutil 01:45:56 INFO - Running setup.py install for psutil 01:45:56 INFO - building 'psutil._psutil_linux' extension 01:45:56 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 01:45: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 01:45:56 INFO - building 'psutil._psutil_posix' extension 01:45: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 01:45:57 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 01:45:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:57 INFO - Successfully installed psutil 01:45:57 INFO - Cleaning up... 01:45:57 INFO - Return code: 0 01:45:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:45:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:45:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:45:57 INFO - Using env: {'DISPLAY': ':0', 01:45:57 INFO - 'HOME': '/home/cltbld', 01:45:57 INFO - 'LANG': 'en_US.UTF-8', 01:45:57 INFO - 'LANGUAGE': 'en_US:en', 01:45:57 INFO - 'LOGNAME': 'cltbld', 01:45:57 INFO - 'MAIL': '/var/mail/cltbld', 01:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:57 INFO - 'MOZ_NO_REMOTE': '1', 01:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:57 INFO - 'NO_EM_RESTART': '1', 01:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:57 INFO - 'SHELL': '/bin/bash', 01:45:57 INFO - 'SHLVL': '1', 01:45:57 INFO - 'TERM': 'linux', 01:45:57 INFO - 'TMOUT': '86400', 01:45:57 INFO - 'USER': 'cltbld', 01:45:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:57 INFO - '_': '/tools/buildbot/bin/python'} 01:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:45:57 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 01:45:57 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 01:45:57 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 01:45:57 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 01:45:57 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 01:45:57 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 01:45:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:45:59 INFO - Installing collected packages: mozsystemmonitor 01:45:59 INFO - Running setup.py install for mozsystemmonitor 01:45:59 INFO - Successfully installed mozsystemmonitor 01:45:59 INFO - Cleaning up... 01:45:59 INFO - Return code: 0 01:45:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:45:59 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')]} 01:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:59 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')]} 01:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:59 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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:45:59 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 01:45:59 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 01:45:59 INFO - Using env: {'DISPLAY': ':0', 01:45:59 INFO - 'HOME': '/home/cltbld', 01:45:59 INFO - 'LANG': 'en_US.UTF-8', 01:45:59 INFO - 'LANGUAGE': 'en_US:en', 01:45:59 INFO - 'LOGNAME': 'cltbld', 01:45:59 INFO - 'MAIL': '/var/mail/cltbld', 01:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:59 INFO - 'MOZ_NO_REMOTE': '1', 01:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:59 INFO - 'NO_EM_RESTART': '1', 01:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:59 INFO - 'SHELL': '/bin/bash', 01:45:59 INFO - 'SHLVL': '1', 01:45:59 INFO - 'TERM': 'linux', 01:45:59 INFO - 'TMOUT': '86400', 01:45:59 INFO - 'USER': 'cltbld', 01:45:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:59 INFO - '_': '/tools/buildbot/bin/python'} 01:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:59 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:59 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 01:45:59 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 01:45:59 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 01:45:59 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 01:45:59 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 01:45:59 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 01:46:01 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:46:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 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 01:46:01 INFO - Downloading docopt-0.6.1.tar.gz 01:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:01 INFO - Running setup.py install for blobuploader 01:46:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:46:01 INFO - Running setup.py install for requests 01:46:02 INFO - Running setup.py install for docopt 01:46:02 INFO - Successfully installed blobuploader requests docopt 01:46:02 INFO - Cleaning up... 01:46:02 INFO - Return code: 0 01:46:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:02 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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:46:02 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 01:46:02 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 01:46:02 INFO - Using env: {'DISPLAY': ':0', 01:46:02 INFO - 'HOME': '/home/cltbld', 01:46:02 INFO - 'LANG': 'en_US.UTF-8', 01:46:02 INFO - 'LANGUAGE': 'en_US:en', 01:46:02 INFO - 'LOGNAME': 'cltbld', 01:46:02 INFO - 'MAIL': '/var/mail/cltbld', 01:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:02 INFO - 'MOZ_NO_REMOTE': '1', 01:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:02 INFO - 'NO_EM_RESTART': '1', 01:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:02 INFO - 'SHELL': '/bin/bash', 01:46:02 INFO - 'SHLVL': '1', 01:46:02 INFO - 'TERM': 'linux', 01:46:02 INFO - 'TMOUT': '86400', 01:46:02 INFO - 'USER': 'cltbld', 01:46:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:02 INFO - '_': '/tools/buildbot/bin/python'} 01:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46:02 INFO - Running setup.py (path:/tmp/pip-HfDhgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46:02 INFO - Running setup.py (path:/tmp/pip-Jq6NT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46:02 INFO - Running setup.py (path:/tmp/pip-Tnv36x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46:02 INFO - Running setup.py (path:/tmp/pip-aZlzkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46:03 INFO - Running setup.py (path:/tmp/pip-1L06KC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46:03 INFO - Running setup.py (path:/tmp/pip-9Anrl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46:03 INFO - Running setup.py (path:/tmp/pip-sXL6Uv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46:03 INFO - Running setup.py (path:/tmp/pip-8SvWHK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46:03 INFO - Running setup.py (path:/tmp/pip-Y_OYtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46:03 INFO - Running setup.py (path:/tmp/pip-7sId4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46:03 INFO - Running setup.py (path:/tmp/pip-QQUy_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46:03 INFO - Running setup.py (path:/tmp/pip-Bjg8LR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46:03 INFO - Running setup.py (path:/tmp/pip-p3TWYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46:03 INFO - Running setup.py (path:/tmp/pip-VcU5zJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46:03 INFO - Running setup.py (path:/tmp/pip-pTigyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:46:03 INFO - Running setup.py (path:/tmp/pip-gFaS8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46:03 INFO - Running setup.py (path:/tmp/pip-IgNOsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:46:03 INFO - Running setup.py install for manifestparser 01:46:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for mozcrash 01:46:04 INFO - Running setup.py install for mozdebug 01:46:04 INFO - Running setup.py install for mozdevice 01:46:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for mozfile 01:46:04 INFO - Running setup.py install for mozhttpd 01:46:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for mozinfo 01:46:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for mozInstall 01:46:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for mozleak 01:46:04 INFO - Running setup.py install for mozlog 01:46:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:46:04 INFO - Running setup.py install for moznetwork 01:46:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Running setup.py install for mozprocess 01:46:05 INFO - Running setup.py install for mozprofile 01:46:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Running setup.py install for mozrunner 01:46:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Running setup.py install for mozscreenshot 01:46:05 INFO - Running setup.py install for moztest 01:46:05 INFO - Running setup.py install for mozversion 01:46:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:46:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:46:05 INFO - Cleaning up... 01:46:05 INFO - Return code: 0 01:46:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:46:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 01:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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 01:46:05 INFO - Using env: {'DISPLAY': ':0', 01:46:05 INFO - 'HOME': '/home/cltbld', 01:46:05 INFO - 'LANG': 'en_US.UTF-8', 01:46:05 INFO - 'LANGUAGE': 'en_US:en', 01:46:05 INFO - 'LOGNAME': 'cltbld', 01:46:05 INFO - 'MAIL': '/var/mail/cltbld', 01:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:05 INFO - 'MOZ_NO_REMOTE': '1', 01:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:05 INFO - 'NO_EM_RESTART': '1', 01:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:05 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:05 INFO - 'SHELL': '/bin/bash', 01:46:05 INFO - 'SHLVL': '1', 01:46:05 INFO - 'TERM': 'linux', 01:46:05 INFO - 'TMOUT': '86400', 01:46:05 INFO - 'USER': 'cltbld', 01:46:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:05 INFO - '_': '/tools/buildbot/bin/python'} 01:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46:05 INFO - Running setup.py (path:/tmp/pip-o0tvId-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46: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)) 01:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46:05 INFO - Running setup.py (path:/tmp/pip-tEep7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46:06 INFO - Running setup.py (path:/tmp/pip-8mLJXl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46:06 INFO - Running setup.py (path:/tmp/pip-yeks9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46:06 INFO - Running setup.py (path:/tmp/pip-Q2LWcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46:06 INFO - Running setup.py (path:/tmp/pip-nZ8rtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46:06 INFO - Running setup.py (path:/tmp/pip-XNekss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46:06 INFO - Running setup.py (path:/tmp/pip-40j81O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46:06 INFO - Running setup.py (path:/tmp/pip-_sDxVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46:06 INFO - Running setup.py (path:/tmp/pip-7Pj7JG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46:06 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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46:06 INFO - Running setup.py (path:/tmp/pip-4B3TRp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46: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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46:06 INFO - Running setup.py (path:/tmp/pip-yAgSgq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46: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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46:06 INFO - Running setup.py (path:/tmp/pip-9Jw98D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46: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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46:06 INFO - Running setup.py (path:/tmp/pip-gVuE0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46: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)) 01:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46:06 INFO - Running setup.py (path:/tmp/pip-35xySI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46:07 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)) 01:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:46:07 INFO - Running setup.py (path:/tmp/pip-i7LaZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:46:07 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)) 01:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46:07 INFO - Running setup.py (path:/tmp/pip-55MPl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46:07 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)) 01:46:07 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)) 01:46:07 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)) 01:46:07 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)) 01:46:07 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)) 01:46:07 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)) 01:46:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:08 INFO - Downloading blessings-1.5.1.tar.gz 01:46: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 01:46:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:46:08 INFO - Installing collected packages: blessings 01:46:08 INFO - Running setup.py install for blessings 01:46:09 INFO - Successfully installed blessings 01:46:09 INFO - Cleaning up... 01:46:09 INFO - Return code: 0 01:46:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:46:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:46:09 INFO - Reading from file tmpfile_stdout 01:46:09 INFO - Current package versions: 01:46:09 INFO - argparse == 1.2.1 01:46:09 INFO - blessings == 1.5.1 01:46:09 INFO - blobuploader == 1.2.4 01:46:09 INFO - docopt == 0.6.1 01:46:09 INFO - manifestparser == 1.1 01:46:09 INFO - mozInstall == 1.12 01:46:09 INFO - mozcrash == 0.16 01:46:09 INFO - mozdebug == 0.1 01:46:09 INFO - mozdevice == 0.47 01:46:09 INFO - mozfile == 1.2 01:46:09 INFO - mozhttpd == 0.7 01:46:09 INFO - mozinfo == 0.9 01:46:09 INFO - mozleak == 0.1 01:46:09 INFO - mozlog == 3.1 01:46:09 INFO - moznetwork == 0.27 01:46:09 INFO - mozprocess == 0.22 01:46:09 INFO - mozprofile == 0.28 01:46:09 INFO - mozrunner == 6.11 01:46:09 INFO - mozscreenshot == 0.1 01:46:09 INFO - mozsystemmonitor == 0.0 01:46:09 INFO - moztest == 0.7 01:46:09 INFO - mozversion == 1.4 01:46:09 INFO - psutil == 3.1.1 01:46:09 INFO - requests == 1.2.3 01:46:09 INFO - wsgiref == 0.1.2 01:46:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 01:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 01:46:09 INFO - Using env: {'DISPLAY': ':0', 01:46:09 INFO - 'HOME': '/home/cltbld', 01:46:09 INFO - 'LANG': 'en_US.UTF-8', 01:46:09 INFO - 'LANGUAGE': 'en_US:en', 01:46:09 INFO - 'LOGNAME': 'cltbld', 01:46:09 INFO - 'MAIL': '/var/mail/cltbld', 01:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:09 INFO - 'MOZ_NO_REMOTE': '1', 01:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:09 INFO - 'NO_EM_RESTART': '1', 01:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:09 INFO - 'SHELL': '/bin/bash', 01:46:09 INFO - 'SHLVL': '1', 01:46:09 INFO - 'TERM': 'linux', 01:46:09 INFO - 'TMOUT': '86400', 01:46:09 INFO - 'USER': 'cltbld', 01:46:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:09 INFO - '_': '/tools/buildbot/bin/python'} 01:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 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)) 01:46:09 INFO - Cleaning up... 01:46:09 INFO - Return code: 0 01:46:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:46:09 INFO - Using env: {'DISPLAY': ':0', 01:46:09 INFO - 'HOME': '/home/cltbld', 01:46:09 INFO - 'LANG': 'en_US.UTF-8', 01:46:09 INFO - 'LANGUAGE': 'en_US:en', 01:46:09 INFO - 'LOGNAME': 'cltbld', 01:46:09 INFO - 'MAIL': '/var/mail/cltbld', 01:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:09 INFO - 'MOZ_NO_REMOTE': '1', 01:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:09 INFO - 'NO_EM_RESTART': '1', 01:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:09 INFO - 'SHELL': '/bin/bash', 01:46:09 INFO - 'SHLVL': '1', 01:46:09 INFO - 'TERM': 'linux', 01:46:09 INFO - 'TMOUT': '86400', 01:46:09 INFO - 'USER': 'cltbld', 01:46:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:09 INFO - '_': '/tools/buildbot/bin/python'} 01:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:09 INFO - Downloading/unpacking jsonschema 01:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:11 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 01:46:11 INFO - Downloading/unpacking functools32 (from jsonschema) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:11 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46: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 01:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:11 INFO - warning: no files found matching '*.txt' 01:46:11 INFO - no previously-included directories found matching 'build' 01:46:11 INFO - no previously-included directories found matching 'dist' 01:46:11 INFO - no previously-included directories found matching '.git*' 01:46:11 INFO - Installing collected packages: jsonschema, functools32 01:46:11 INFO - Running setup.py install for functools32 01:46:11 INFO - warning: no files found matching '*.txt' 01:46:11 INFO - no previously-included directories found matching 'build' 01:46:11 INFO - no previously-included directories found matching 'dist' 01:46:11 INFO - no previously-included directories found matching '.git*' 01:46:11 INFO - Successfully installed jsonschema functools32 01:46:11 INFO - Cleaning up... 01:46:11 INFO - Return code: 0 01:46:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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 0x7f482a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1275630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, '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': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', '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 01:46: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 01:46: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 01:46:11 INFO - Using env: {'DISPLAY': ':0', 01:46:11 INFO - 'HOME': '/home/cltbld', 01:46:11 INFO - 'LANG': 'en_US.UTF-8', 01:46:11 INFO - 'LANGUAGE': 'en_US:en', 01:46:11 INFO - 'LOGNAME': 'cltbld', 01:46:11 INFO - 'MAIL': '/var/mail/cltbld', 01:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:11 INFO - 'MOZ_NO_REMOTE': '1', 01:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:11 INFO - 'NO_EM_RESTART': '1', 01:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:11 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:11 INFO - 'SHELL': '/bin/bash', 01:46:11 INFO - 'SHLVL': '1', 01:46:11 INFO - 'TERM': 'linux', 01:46:11 INFO - 'TMOUT': '86400', 01:46:11 INFO - 'USER': 'cltbld', 01:46:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:11 INFO - '_': '/tools/buildbot/bin/python'} 01:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:12 INFO - Downloading/unpacking flake8 01:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:46: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 01:46:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:46:14 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 01:46:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:14 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 01:46:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:14 INFO - no previously-included directories found matching 'docs/_build' 01:46:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:46:14 INFO - Running setup.py install for pep8 01:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:14 INFO - no previously-included directories found matching 'docs/_build' 01:46:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:46:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:46:14 INFO - Cleaning up... 01:46:14 INFO - Return code: 0 01:46:14 INFO - Running post-action listener: _resource_record_post_action 01:46:14 INFO - Running post-action listener: _start_resource_monitoring 01:46:14 INFO - Starting resource monitoring. 01:46:14 INFO - ##### 01:46:14 INFO - ##### Running install step. 01:46:14 INFO - ##### 01:46:14 INFO - Running pre-action listener: _resource_record_pre_action 01:46:14 INFO - Running main action method: install 01:46:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:46:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:46:15 INFO - Reading from file tmpfile_stdout 01:46:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:46:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:46:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:46:15 INFO - Reading from file tmpfile_stdout 01:46:15 INFO - Output received: 01:46:15 INFO - Usage: mozinstall [options] installer 01:46:15 INFO - Options: 01:46:15 INFO - -h, --help show this help message and exit 01:46:15 INFO - -d DEST, --destination=DEST 01:46:15 INFO - Directory to install application into. [default: 01:46:15 INFO - "/builds/slave/test-pgo"] 01:46:15 INFO - --app=APP Application being installed. [default: firefox] 01:46:15 INFO - mkdir: /builds/slave/test-pgo/build/application 01:46:15 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'] 01:46:15 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 01:46:30 INFO - Reading from file tmpfile_stdout 01:46:30 INFO - Output received: 01:46:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:46:30 INFO - Running post-action listener: _resource_record_post_action 01:46:30 INFO - ##### 01:46:30 INFO - ##### Running run-tests step. 01:46:30 INFO - ##### 01:46:30 INFO - Running pre-action listener: _resource_record_pre_action 01:46:30 INFO - Running main action method: run_tests 01:46:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:46:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:46:30 INFO - Python 2.7.3 01:46:30 INFO - Return code: 0 01:46:30 INFO - grabbing minidump binary from tooltool 01:46: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')]} 01:46: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 0x1306840>, '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 0x12736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1273b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:46: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 01:46: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 01:46:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:46:31 INFO - Return code: 0 01:46:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:46:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:46:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:46:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:46:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:46:31 INFO - Return code: 0 01:46: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 01:46: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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:46:31 INFO - Using env: {'DISPLAY': ':0', 01:46:31 INFO - 'HOME': '/home/cltbld', 01:46:31 INFO - 'LANG': 'en_US.UTF-8', 01:46:31 INFO - 'LANGUAGE': 'en_US:en', 01:46:31 INFO - 'LOGNAME': 'cltbld', 01:46:31 INFO - 'MAIL': '/var/mail/cltbld', 01:46:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:31 INFO - 'MOZ_NO_REMOTE': '1', 01:46:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:31 INFO - 'NO_EM_RESTART': '1', 01:46:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:31 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:46:31 INFO - 'SHELL': '/bin/bash', 01:46:31 INFO - 'SHLVL': '1', 01:46:31 INFO - 'TERM': 'linux', 01:46:31 INFO - 'TMOUT': '86400', 01:46:31 INFO - 'USER': 'cltbld', 01:46:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796', 01:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:31 INFO - '_': '/tools/buildbot/bin/python'} 01:46: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:46:32 INFO - mozversion application_buildid: 20160106233009 01:46:32 INFO - mozversion application_changeset: d9766669880bcab85f600f1741aebb01aa9b224f 01:46:32 INFO - mozversion application_display_name: Nightly 01:46:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:46:32 INFO - mozversion application_name: Firefox 01:46:32 INFO - mozversion application_remotingname: firefox 01:46:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:46:32 INFO - mozversion application_vendor: Mozilla 01:46:32 INFO - mozversion application_version: 46.0a1 01:46:32 INFO - mozversion platform_buildid: 20160106233009 01:46:32 INFO - mozversion platform_changeset: d9766669880bcab85f600f1741aebb01aa9b224f 01:46:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:46:32 INFO - mozversion platform_version: 46.0a1 01:46:32 INFO - using testdate: 1452159992 01:46:32 INFO - actual date: 1452159992 01:46:32 INFO - starting webserver on 'localhost:45736' 01:46:32 INFO - SUITE-START | Running 3 tests 01:46:32 INFO - TEST-START | dromaeo_css 01:46:32 INFO - operating with platform_type : linux_ 01:46:32 INFO - Initialising browser for dromaeo_css test... 01:46:32 INFO - TEST-INFO | started process 32438 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcIrtC5/profile http://localhost:45736/getInfo.html) 01:46:35 INFO - PROCESS | 32438 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:46:36 INFO - PROCESS | 32438 | __metrics Screen width/height:1600/1200 01:46:36 INFO - PROCESS | 32438 | colorDepth:24 01:46:36 INFO - PROCESS | 32438 | Browser inner width/height: 1024/697 01:46:36 INFO - PROCESS | 32438 | __metrics 01:46:36 INFO - PROCESS | 32438 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:46:37 INFO - TEST-INFO | 32438: exit 0 01:46:37 INFO - Browser initialized. 01:46:37 INFO - Running cycle 1/1 for dromaeo_css test... 01:46:37 INFO - TEST-INFO | started process 32570 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcIrtC5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:49 INFO - PROCESS | 32570 | RSS: Main: 150454272 01:46:49 INFO - PROCESS | 32570 | 01:47:39 INFO - PROCESS | 32570 | 1452160059161 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] 01:49:48 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45736/tests/dromaeo/cssquery-ext.html) 01:49:49 INFO - PROCESS | 32570 | RSS: Main: 158740480 01:49:49 INFO - PROCESS | 32570 | 01:52:51 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-ext.html (next: http://localhost:45736/tests/dromaeo/cssquery-jquery.html) 01:52:52 INFO - PROCESS | 32570 | RSS: Main: 153464832 01:52:52 INFO - PROCESS | 32570 | 01:55:53 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45736/tests/dromaeo/cssquery-mootools.html) 01:55:54 INFO - PROCESS | 32570 | RSS: Main: 154116096 01:55:54 INFO - PROCESS | 32570 | 01:58:56 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45736/tests/dromaeo/cssquery-prototype.html) 01:58:56 INFO - PROCESS | 32570 | RSS: Main: 152444928 01:58:56 INFO - PROCESS | 32570 | 02:01:59 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45736/tests/dromaeo/cssquery-yui.html) 02:01:59 INFO - PROCESS | 32570 | RSS: Main: 153333760 02:01:59 INFO - PROCESS | 32570 | 02:05:01 INFO - PROCESS | 32570 | Cycle 1(1): loaded http://localhost:45736/tests/dromaeo/cssquery-yui.html (next: http://localhost:45736/tests/dromaeo/cssquery-dojo.html) 02:05:02 INFO - PROCESS | 32570 | RSS: Main: 155013120 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | __start_tp_report 02:05:02 INFO - PROCESS | 32570 | _x_x_mozilla_page_load 02:05:02 INFO - PROCESS | 32570 | _x_x_mozilla_page_load_details 02:05:02 INFO - PROCESS | 32570 | |i|pagename|runs| 02:05:02 INFO - PROCESS | 32570 | |0;dojo.html;3138.262508310547;3195.105370496262;3213.5340375645533;3217.3243618840042;3235.0941736313835;5324.680519168853;5343.41222465529;5362.4637536246355;5377.247185394048;5378.731063446827;5329.440408757083;5351.063563876316;5395.919061214085;5480.671159730419;5491.643043202199;4831.71009739415;4898.681585696918;4923.901521969558;4970.229614409773;4972.950270497285;4874.902501949959;4941.4811444798315;4957.925631115536;4968.155413579682;5038.59691224703;4822.252550854623;4834.758262086917;4896.387951506062;4953.900921981576;4954.554090131887;4908.0429316283335;4919.704817710949;4924.409070911478;4928.359313289249;4938.259261110827;4867.34290870735;4911.533404326583;4911.975440122812;4917.877053073666;4921.384826896638;5187.170052791573;5254.185601231815;5291.629585928987;5296.205569164617;5330.1205301125265;5620.606557540974;5695.14572814077;5708.5433165347085;5733.541316694655;5801.941980580183;5836.212111364954;5841.591088623798;5853.29760428747;5857.502112320458;5859.501942334907;5327.280817089682;5416.0792665247;5433;5434.7826086956475;5441.945580544223;5826.300843898759;5864.296284445893;5871.853203669943;5879.3826648202175;5928.851778705481;5643.492085712305;5743.167240750068;5754.683492407874;5759.049756790083;5763.423657634203;5720.542356611544;5755.85610359736;5774.220480235199;5813.505852002627;5838;5654.9821032214595;5681.119426488901;5682.6306290091015;5691.459311365414;5723.971380143073;5678.3186017678145;5685.971570142123;5687.488126068591;5688.317401911714;5706.229658996065;4378.934315985262;4414.668899832525;4429.534898835575;4431.423914891044;4463.152001119777;3976.304146774303;3986.8205930732606;3989.162275922031;3992.121733218687;4025.879223623296;5382.138857782736;5466.262054622654;5482.396936337;5498.752556134984;5541.445855414427;5697.202391665171;5756.107803290497;5795.362510123883;5821.359650438449;5846.123081537803;5421.539169170585;5437.483439073281;5440.510354068074;5444.210589464585;5448.346198456132;4916.606671466274;4923.950760492421;4926.630502712311;4929.507049295042;4978.079055374695;5937.851553711105;6018.849528761816;6065.727042283108;6092.329843717188;6113.877722445615;5678.4605462480995;5853.795117170878;5855.531557475477;5857.677827719346;5872.354041055395;5991.2510936132985;5993.130996005468;6002.729877155626;6007.339192688713;6076.848078798065;5694.345150307768;5694.658320500783;5699.715014249188;5700.201971723879;5709.571782116441;5693.971530142323;5751.166080918327;5757.97121014409;5821.854453638693;5837.474627283565;5578.776848925998;5639.407862174413;5642.351129619982;5648;5698.401667824819;5642.407547207648;5643.35101463337;5659.122835960433;5666.206731057738;5676.545876329967;5503.422140675171;5514.172874068761;5542.861428464321;5591.965486385032;5631;5657.886842263049;5697.487226149667;5751.194832723339;5770.307563092456;5778.797742079007;5608.298962629671;5616.803411880564;5617.775288988395;5621.325440947113;5639.210510528447 02:05:02 INFO - PROCESS | 32570 | |1;ext.html;512.1114865707996;540.9648372855762;574.5231457889952;574.9856253593659;579.3453397660643;35561.82219088904;36060;36130;36139.277214455695;36150.81924590373;38265.808670956605;38317.616823831755;38332.616673833254;38439.23121537568;38606.61393386065;8394.286485648712;8590;8600.05399406068;8610.225079742822;8619.439736417113;8307.293880020206;8438.746837594881;8439.409241353107;8635.093315201908;8666.653333866638;8603.225709686127;8670.566471676422;8746.475211487299;8776.517291548962;8808.867866982;8593.441426307301;8634.093420190853;8688.956555217215;8691.47851128928;8708.433951793113;8492.83014339716;8610.53620884451;8615;8629.65481380744;8649.870251946226;38709.22581548381;38953;39087.41368879469;39237.41143882844;39302.80348598267;3049.237690577356;3068.6317641882893;3106.130283520618;3506.2812123514873;3593.7484376093685;28791.712082879112;29277.70722292771;29515.852420737974;29622;30186;3667.963320366789;3726.664600185969;3783.081993408558;3813.4470501777364;3872.7289089763726;250560;250594;251085;251435;251486.74256628784;51819.48180518222;53026.20460693093;56561.43438565644;56729;57015.429845701015;58469.12296315558;58499;58564;58566.70716646389;58818.41181588129;14690.926545367205;14783;14873.18197499148;14879.181645009628;14896.329665165094;10934.125269978382;10941.070009049161;10957.232993690524;11009.339439633648;11014.39420831846;19806.60386792256;20107.49731256701;20294.898525507277;20320.69518957217;20430.69353959692;7446.478746487694;7588.468807183444;7667.616619169019;7785.922140778633;7795.532268063935;833.8624127018974;923.7228831350702;927.3508544019079;1047.836901039845;1112.410422476089;24788;24951;28307.858460707976;29000.41999160005;30209.546856797166;974.3763991045737;1012.6708819633501;1062.7555662197738;1082.9620963266248;1122.955081796719;14017.5093871714;14205.21871297068;14464.349104290332;14545.78181327281;15159.696806063817;303308;306437;309462;309776;312955;50723;51329.74335128375;51407.485925141016;51429;51648.225276620884;1324.3113580937859;1345.7039451320693;1358.1307962903552;1365.3173413293352;1367.1796921846615;27739.306517337227;28316.292092697848;28413.573796393484;28679.713202868537;28761.712382875903;44943.32585011162;44963.775181123885;45176.77411612921;45463.31805022861;45513.54486455093;281358;283087;283191;284860;285231;27039;27508.58737118905;29987.400251995274;30846;30952.53571196479;37290;37919;37956;38069;38521;33692.66307336895;33899.83050084832;33984.15039624029;34200.14499637529;34337;33864.49203261904;33898.49152262669;34774.13064673403;34793.47809782906;34800.82599586986;32815.34369312553;33631.83184084064;33641.15897102592;33717.3256534863;33781;28610;31015.844920775253;31135.53296700506;31516.842415787774;31796.523052153774;24083.518329633658;24223;24265;24341.756582433947;24463 02:05:02 INFO - PROCESS | 32570 | |2;jquery.html;332.32040477224075;332.38508758796246;332.99167520811983;333.5080755885069;334.9966500334999;11394.772104557904;11707.414629268545;16472.341106355747;16637.334506619736;17203.65592688147;16280.592985175346;16285.511434656979;16614;16647.1676416179;16671.24979375931;5634.0703783875715;5825.679587622679;5878.059510478324;5884.794032208873;5891.499222566087;5754.798582049629;5901.645901245917;5945.524358051367;5948.553858460611;5950.464458198761;5889.293284805829;5915.911261331084;6209.782657606962;6414.871702565946;6458.418742313191;6308.968455157741;6345.8413539661415;6417.486601071903;6513.674316284167;6824.965875170592;6516.283208847023;6516.9674151629415;6517.120188774549;6517.217933847968;6535.967320163416;21751.78248217529;22566.51768305485;22858.885705571367;23505.52988940229;23926.64110038351;2197.835162362829;2198.164697414988;2250.3586477853896;2279.3275983584717;2280.2589158523547;14225.502107426191;14233.359498822578;14386.35261413239;14609.78085328721;14976.550703478913;1866.5333666583354;1941.4855063408208;1945.1635796607454;1970.2414570390504;1987.1355960157377;62919;69048;70124.2987570128;71834;72321.27678723198;10160.288779785493;10242.283040187116;10354.068133867837;10418.21863360251;10422.635207767691;13249.801252981213;13267.270300133585;13399.464021439033;13407.262600556867;13441.932790336181;7333.413326933833;7370.226126256773;7496.175420703718;7555.508891922007;7691.846163076707;6931.029655848185;6944.305569443015;7002.299770022957;7033.6483175841;7033.964830175919;4423.137488189772;4494.483134439582;4525.818967241274;4534.501204867528;4545.977270113628;1812.7915289741584;1847.4457662701404;1900.3063881683363;1901.8573606979533;1902.0965041605127;407.2486262845046;416.0576294692524;849.2611428057629;925.708401853414;1012.5544760305442;10000.399976001463;10593;10814.56741730322;10867.45662716861;10924.453777311102;433.55777107350957;436.86238834767585;438.7542975933487;449.26545098763756;461.16759249554207;5789.247397838339;5892.646441213541;5906.645601263938;5936.1095835625;5959.731812068468;398624;403069;564487;575308;576554;75138.24861751312;79475.60262198652;81902;82552;83121;1056.7146870344964;1089.232091375594;1096.4736926275432;1111.5664890692635;1133.4616057372848;14548.49080282185;15428.30572624257;15534.533963981099;15699.058056516646;15725.44960926362;31637;34324.65675343315;35200.11999700028;35305.47041794426;35415.82292088626;44533.33200002067;44685.329720053574;44887.32669010033;45450;46072.539274606825;8587.441816281922;9160.862587061332;9196.724098277062;9200.539973001189;9210.401323913924;11398.259113157617;11493.655190344303;16606.0079580231;17822;17933.910330448263;14140.646483837574;14360.928195358956;14671.92664036673;14783.778243326575;14986.325615347117;14135.15189088658;14216.71566568642;14454.638634033812;14483.275836207937;14932.104073755609;14279.857201428269;14398.20809855468;14650.63373415673;14816.851831481546;15041.849581504044;9258.72223833286;9308.115729005734;9483.952580237055;9489.145976862115;9567.234621230424;14431.278436078364;14568.635784105058;14675.19286439256;14768.556943291718;15160.848391515943 02:05:02 INFO - PROCESS | 32570 | |3;mootools.html;1251.8560365557964;1307.8757518035784;1330.7272009238102;1727.7235642297235;1742.3030787684925;7494.7002119915205;7533.434992375566;7645.694172233118;7665.156832748393;7680.692772289116;7580.962095189517;7656.54060756355;7706.460547761659;7722.65248063837;7732.613369331525;2214.944626384341;2240.607893618618;2244.9887750561224;2249.302716157996;2254.921077762279;2151.677248412735;2205.757366689671;2245.0346351069034;2246.9662955055687;2250.7861753133425;2193.473566344074;2215.4572129828216;2224.92212772553;2232.352617740861;2259.548090381922;2205.1730601024615;2218.101668824129;2222.355516900097;2236;2238.350878245307;2200.3179014505554;2266.150193677371;2268.9205877794197;2269.5574362999223;2281.6691579721014;7518.586477743722;7577.696892124309;7586.203448637869;7593;7638.885416718754;4468.374427580141;4470.173017991682;4491.528389519119;4516.706414083074;4553.066621342617;2947.1600593830653;2953.6012638293987;2975.5536669499534;3004.9549256760947;3019.8339091349967;939.281449690987;939.4128669581512;944.7496413450441;965.9758506037335;991.2218908157062;10361.740956476073;10378.377297362107;10430.843537346946;10444.060034596847;10449.320794148356;3889.3388124018984;3926.4895563577124;3960.7623542587535;3996.680265578747;4022.35642297231;8452.915470845213;8476.745697629081;8481.575921203916;8491.787705307417;8501.574921254036;4296.3555466680245;4300.3549467580115;4301.139772045603;4302.3546468030045;4314.7411155330155;3956.8219430125714;3957.881263562098;3962.890390690611;4002.2595819772855;4032.697547683935;3198.8240646764184;3201.599800024997;3205.5351973963643;3274.6397896231397;3285.9835700821823;1024.4979959819784;1037.2635428845454;1039.719275795531;1042.0361165921645;1043.5617040842865;957.7701351675547;960.9855852162223;1028.3829702178632;1065.9946700266448;1308.908376413642;6842.589444633338;6933.826654333682;6947.513674042769;6953.478489113236;6959.164900212007;1072.8980746829038;1096.5175322857917;1100.0814320042693;1100.4002818463796;1101.4878081692052;5602.747876345574;5650;5654.123610840326;5685.658860468385;5699.544036477072;8648.870266946002;8796.560171991376;9102.954485227532;9178.724638260863;9248.26013918885;9213.124753148575;9284.814303714023;9287.117723816227;9297.070292970784;9345.579448924815;6929.341712537301;7048.224695283412;7132.037174981415;7137.072180616487;7184.6048467334795;7108.431325493844;7139.607321597155;7179.8564028720175;7180.3537681608905;7212.603306818175;7941.324987375907;8177.754667359989;8204.83590328178;8368.24685778283;8385.371097167616;8049.557274349967;8280.627371768405;8284.83430331402;8313.376496762889;8336.958315208627;6549.410553050248;6594.307597702172;6932.93067069343;6935.375816176568;6959.652017399008;6931.376176144171;7034.311765176423;7048.823779405556;7050.5769653820935;7057.329553692391;6592.80221593353;6863.10779598649;6864.759733409307;6934.410575101173;6952.478564107611;6302.71637776292;6350.841228969312;6368.140301059483;6440.355964403522;6467.223933128054;6415.454686351713;6429.22849258092;6455.322191169859;6461.224653041665;6463.515236357386;5808.651480911159;5864.354920958776;5992.730327135202;6000.339962604197;6023.247094113236;6065.939340606537;6091.817245482643;6106.114613380946;6115.449609535163;6190.442860142609 02:05:02 INFO - PROCESS | 32570 | |4;prototype.html;322.40516247523317;324.3593902043464;328.70580830156996;329.2197491944093;333.94322965095915;6247.750089996401;6293.056041593757;6295.685215739218;6302.180716506853;6461.6446095464735;6226.40849119333;6265.968670156654;6271.780487682932;6290.119383286332;6304.684765761705;4721.787519561628;4729.432468103832;4735.4317481902135;4739;4747.311639812225;4754.334393184957;4759.16714574948;4776.044791041805;4777.116233496814;4777.235642297233;4532.0256144928835;4658.930116048262;4659.440867095953;4663.114008338422;4727.409073865767;4627.190241707688;4651.023285110131;4653.022865198295;4654.697444666086;4655.86032419028;4038.374052021941;4052.0882801369753;4058.269511487931;4059.04612416082;4064.837406503766;5832.912506312408;5865.178874957509;5917.52659787216;5934.940650593482;5948.0371477412355;5408.405075441738;5500.147477141049;5566.526845218162;5623.8594035149445;5670.121131224667;6608.438282745972;6613.074169616258;6616.536842421033;6663.06717059612;6663.2337281212795;4628.375169352128;4647.442306923191;4647.907041859177;4651.5813576778255;4654.488006319302;6795.116634837439;6855.280195579492;6928.237893831674;6931.965340173267;6943.548669336477;4767.69010014348;4769.332293478916;4771.976140119277;4777.689450185727;4780.49804770501;4825.396825396825;4840.83057093;4846.491118432585;4848.7090774553635;4870.050340183701;5554.833354999357;5560.610757247035;5562.499375056183;5570.359408667974;5583.525400340935;6571.605703657796;6625.933740662628;6637.502187335969;6666.100076489709;6696.1629796275465;1677.9664406711797;1701.821308762562;1721.1566332496986;1726.0506721303234;1729.8616110711114;1139.5954436175205;1152.7233463968755;1158.3281696616111;1169.6841852699724;1175.7243390920946;6162.815115546541;6171.876562468815;6218.31598524162;6242.469390101892;6273.843153921189;6733;6737.326267373223;6745.190577130677;6748.628825414551;6753.696083676246;6094.238220222473;6188.133661287423;6205.5345849060595;6223.253209614784;6226.750929962841;3687.520622319081;3706.6849317808287;3708.2398108387715;3716.201016781405;3723.4600982857332;7067.116610423697;7103.289671032855;7179.748708795167;7185.065941427581;7185.856282874418;6719.697613607399;6931.306869313028;6934.549254298455;6937.618430986243;6950.617716025566;7053.329933656294;7073.115860517435;7074.540154889915;7109.8933515997305;7124.358807707331;6743.696533656095;6769.120014398097;6770.661466926733;6780.627065511444;6795.524313298021;6602.339766023551;6704.4301234395625;6732.158480189976;6733.360330768569;6737.461003119641;7052.5063245574365;7059.682314295766;7094.574325540484;7097.077379940574;7101.964490177723;4745.098431298043;4757.881052973703;4760.214564596941;4794.880127996828;4795.136875362468;6644.036614690939;6769.627670477974;6790.388865002174;6819.249882513019;6912.619805910723;6659.733610655713;6684.866302673822;6719.865602688016;6745.93254067453;6754.12196414463;6724.630145341857;6729.461643068641;6745.325467453215;6752.7298908045095;6771.018202360531;6500.057491663588;6593.505487088391;6609.801705948829;6610;6620.933790662224;6744.055832183596;6756.864862702817;6788.151481064867;6790.388865002174;6820.249772525118;6569.211694596679;6591.011348297794;6618.801435956929;6624.138861947916;6625.469962403093 02:05:02 INFO - PROCESS | 32570 | |5;yui.html;719.8488317453334;738.9261073892611;767.3017554025841;771.3173841150583;792.9216265878408;12484.375781210949;12730.172538784973;12808.167469114502;12821.294828784414;12851.485940562367;11785.587504437324;11879.990200832939;11886.583969561067;11904.107191960617;11917.284962902231;787.3897729259827;789.4631650477672;800;802.1176705623825;803.9236272554098;804.8551260773058;805.923437273458;807.9151689072651;810.4610434061342;814.5886327404652;815.2173913043486;823.5799742131526;826.6073615032872;827.3960009193293;827.668932427028;813.3737022492677;816.6896579299857;819.1112642782588;821.6959724901765;822.1244374740882;603.5865432178972;607.6323824086409;608.6196127420362;609.7713357490941;611.9571629985903;11710.238834475816;11711.765764684744;11816.88183118175;11837.704057398549;11885.524579016828;11390.177571588507;11685.599357999854;11778.882211177865;11780.941095294469;11840.289582624984;9097;9158.216322184522;9286.907130928672;9559.665411710557;9590.328676992613;3325.783824051429;3377.560917080764;3385.306012267504;3425.366307233145;3521.683048525645;47865.52134478645;48241.75879120617;48513;48681.756591216814;50105.49894501045;8761.824763504694;8834.95582522096;8835.425697329652;8901.109889011177;9030.096990300917;17463.12684365802;17499.65000699979;17505;17529.7370539442;17555.82444175542;7085.751998680022;7219.205887352387;7281.854362912712;7313.341799238094;7543.585102819288;4189.581041895786;4198.475190601175;4229.344451610005;4240.385144154142;4248.723832950848;3051.8708078011277;3072.8617212225504;3083.676213997498;3084.0901933929545;3112.1130477813713;538.8329617818489;551.2943432406526;552.3068548971096;558.9608727389044;562.6511562831071;478.09162591077234;489.5031542983874;490.9435414927258;512.8871648237382;557.5706705836565;7191.280871912872;7704.614769261627;7750.651220695082;7785.688572457038;7826.0608726952;451.6684990936931;471.5452828025511;549.6152693114756;596.2517041113375;608.2123649873424;3760.304343696425;3861.362875125629;3884.6503814656253;4028.6601337935085;4045.3527435610163;54121.729391353576;54931.725341373036;55417.168742468086;58620.12069818956;58997.11504327438;47472;47640.52359476361;47746.76126619414;48597.757011214715;50013.24980125301;45133.09733805371;45255.54744452579;45517;47126;47354.76322618365;7839.372850172087;8314.41799074059;8451.168364290043;8511.489310641382;8667.393282470166;33336.1665958353;33823;33916;34614.480782787774;35161.64838351686;39530.40704389494;44732.77633611811;45137.09725805531;45175.32237016513;45306;9924.305298629026;10107.64623238183;10222.437765922945;10278.486075696335;10328.896711032794;10449.738756531147;10906.563737450731;11279.436028198721;11381.829272561085;11495.655130346104;10155.187584993331;10391.532381043022;10447.791044178923;10671.46642667879;10855.511501982272;9831.89198292172;9995.600175992879;10067;10326.173906087344;10414.635487757892;9152.267818574364;10191;10202.132818710492;10213.795724085328;10280.897191027994;8579.442336248125;8664.393492455467;8677.219050285505;8796.208341249318;9075.092490750872;8016.318612917968;8129.187081291823;8505.574721264036;8554.645322978397;8655.956720216358 02:05:02 INFO - PROCESS | 32570 | __end_tp_report 02:05:02 INFO - PROCESS | 32570 | __start_cc_report 02:05:02 INFO - PROCESS | 32570 | _x_x_mozilla_cycle_collect,311 02:05:02 INFO - PROCESS | 32570 | __end_cc_report 02:05:02 INFO - PROCESS | 32570 | __startTimestamp1452161102248__endTimestamp 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | ------- Summary: start ------- 02:05:02 INFO - PROCESS | 32570 | Number of tests: 6 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#0] dojo.html Cycles:165 Average:5369.21 Median:5617.78 stddev:599.65 (10.7%) stddev-sans-first:575.38 02:05:02 INFO - PROCESS | 32570 | Values: 3138.3 3195.1 3213.5 3217.3 3235.1 5324.7 5343.4 5362.5 5377.2 5378.7 5329.4 5351.1 5395.9 5480.7 5491.6 4831.7 4898.7 4923.9 4970.2 4973.0 4874.9 4941.5 4957.9 4968.2 5038.6 4822.3 4834.8 4896.4 4953.9 4954.6 4908.0 4919.7 4924.4 4928.4 4938.3 4867.3 4911.5 4912.0 4917.9 4921.4 5187.2 5254.2 5291.6 5296.2 5330.1 5620.6 5695.1 5708.5 5733.5 5801.9 5836.2 5841.6 5853.3 5857.5 5859.5 5327.3 5416.1 5433.0 5434.8 5441.9 5826.3 5864.3 5871.9 5879.4 5928.9 5643.5 5743.2 5754.7 5759.0 5763.4 5720.5 5755.9 5774.2 5813.5 5838.0 5655.0 5681.1 5682.6 5691.5 5724.0 5678.3 5686.0 5687.5 5688.3 5706.2 4378.9 4414.7 4429.5 4431.4 4463.2 3976.3 3986.8 3989.2 3992.1 4025.9 5382.1 5466.3 5482.4 5498.8 5541.4 5697.2 5756.1 5795.4 5821.4 5846.1 5421.5 5437.5 5440.5 5444.2 5448.3 4916.6 4924.0 4926.6 4929.5 4978.1 5937.9 6018.8 6065.7 6092.3 6113.9 5678.5 5853.8 5855.5 5857.7 5872.4 5991.3 5993.1 6002.7 6007.3 6076.8 5694.3 5694.7 5699.7 5700.2 5709.6 5694.0 5751.2 5758.0 5821.9 5837.5 5578.8 5639.4 5642.4 5648.0 5698.4 5642.4 5643.4 5659.1 5666.2 5676.5 5503.4 5514.2 5542.9 5592.0 5631.0 5657.9 5697.5 5751.2 5770.3 5778.8 5608.3 5616.8 5617.8 5621.3 5639.2 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#1] ext.html Cycles:180 Average:44396.59 Median:34555.57 stddev:73645.42 (213.1%) stddev-sans-first:73778.31 02:05:02 INFO - PROCESS | 32570 | Values: 512.1 541.0 574.5 575.0 579.3 35561.8 36060.0 36130.0 36139.3 36150.8 38265.8 38317.6 38332.6 38439.2 38606.6 8394.3 8590.0 8600.1 8610.2 8619.4 8307.3 8438.7 8439.4 8635.1 8666.7 8603.2 8670.6 8746.5 8776.5 8808.9 8593.4 8634.1 8689.0 8691.5 8708.4 8492.8 8610.5 8615.0 8629.7 8649.9 38709.2 38953.0 39087.4 39237.4 39302.8 3049.2 3068.6 3106.1 3506.3 3593.7 28791.7 29277.7 29515.9 29622.0 30186.0 3668.0 3726.7 3783.1 3813.4 3872.7 250560.0 250594.0 251085.0 251435.0 251486.7 51819.5 53026.2 56561.4 56729.0 57015.4 58469.1 58499.0 58564.0 58566.7 58818.4 14690.9 14783.0 14873.2 14879.2 14896.3 10934.1 10941.1 10957.2 11009.3 11014.4 19806.6 20107.5 20294.9 20320.7 20430.7 7446.5 7588.5 7667.6 7785.9 7795.5 833.9 923.7 927.4 1047.8 1112.4 24788.0 24951.0 28307.9 29000.4 30209.5 974.4 1012.7 1062.8 1083.0 1123.0 14017.5 14205.2 14464.3 14545.8 15159.7 303308.0 306437.0 309462.0 309776.0 312955.0 50723.0 51329.7 51407.5 51429.0 51648.2 1324.3 1345.7 1358.1 1365.3 1367.2 27739.3 28316.3 28413.6 28679.7 28761.7 44943.3 44963.8 45176.8 45463.3 45513.5 281358.0 283087.0 283191.0 284860.0 285231.0 27039.0 27508.6 29987.4 30846.0 30952.5 37290.0 37919.0 37956.0 38069.0 38521.0 33692.7 33899.8 33984.2 34200.1 34337.0 33864.5 33898.5 34774.1 34793.5 34800.8 32815.3 33631.8 33641.2 33717.3 33781.0 28610.0 31015.8 31135.5 31516.8 31796.5 24083.5 24223.0 24265.0 24341.8 24463.0 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#2] jquery.html Cycles:180 Average:27985.01 Median:334.25 stddev:83646.64 (25025.0%) stddev-sans-first:83855.52 02:05:02 INFO - PROCESS | 32570 | Values: 332.3 332.4 333.0 333.5 335.0 11394.8 11707.4 16472.3 16637.3 17203.7 16280.6 16285.5 16614.0 16647.2 16671.2 5634.1 5825.7 5878.1 5884.8 5891.5 5754.8 5901.6 5945.5 5948.6 5950.5 5889.3 5915.9 6209.8 6414.9 6458.4 6309.0 6345.8 6417.5 6513.7 6825.0 6516.3 6517.0 6517.1 6517.2 6536.0 21751.8 22566.5 22858.9 23505.5 23926.6 2197.8 2198.2 2250.4 2279.3 2280.3 14225.5 14233.4 14386.4 14609.8 14976.6 1866.5 1941.5 1945.2 1970.2 1987.1 62919.0 69048.0 70124.3 71834.0 72321.3 10160.3 10242.3 10354.1 10418.2 10422.6 13249.8 13267.3 13399.5 13407.3 13441.9 7333.4 7370.2 7496.2 7555.5 7691.8 6931.0 6944.3 7002.3 7033.6 7034.0 4423.1 4494.5 4525.8 4534.5 4546.0 1812.8 1847.4 1900.3 1901.9 1902.1 407.2 416.1 849.3 925.7 1012.6 10000.4 10593.0 10814.6 10867.5 10924.5 433.6 436.9 438.8 449.3 461.2 5789.2 5892.6 5906.6 5936.1 5959.7 398624.0 403069.0 564487.0 575308.0 576554.0 75138.2 79475.6 81902.0 82552.0 83121.0 1056.7 1089.2 1096.5 1111.6 1133.5 14548.5 15428.3 15534.5 15699.1 15725.4 31637.0 34324.7 35200.1 35305.5 35415.8 44533.3 44685.3 44887.3 45450.0 46072.5 8587.4 9160.9 9196.7 9200.5 9210.4 11398.3 11493.7 16606.0 17822.0 17933.9 14140.6 14360.9 14671.9 14783.8 14986.3 14135.2 14216.7 14454.6 14483.3 14932.1 14279.9 14398.2 14650.6 14816.9 15041.8 9258.7 9308.1 9484.0 9489.1 9567.2 14431.3 14568.6 14675.2 14768.6 15160.8 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#3] mootools.html Cycles:180 Average:5239.96 Median:6110.78 stddev:2741.52 (44.9%) stddev-sans-first:2732.82 02:05:02 INFO - PROCESS | 32570 | Values: 1251.9 1307.9 1330.7 1727.7 1742.3 7494.7 7533.4 7645.7 7665.2 7680.7 7581.0 7656.5 7706.5 7722.7 7732.6 2214.9 2240.6 2245.0 2249.3 2254.9 2151.7 2205.8 2245.0 2247.0 2250.8 2193.5 2215.5 2224.9 2232.4 2259.5 2205.2 2218.1 2222.4 2236.0 2238.4 2200.3 2266.2 2268.9 2269.6 2281.7 7518.6 7577.7 7586.2 7593.0 7638.9 4468.4 4470.2 4491.5 4516.7 4553.1 2947.2 2953.6 2975.6 3005.0 3019.8 939.3 939.4 944.7 966.0 991.2 10361.7 10378.4 10430.8 10444.1 10449.3 3889.3 3926.5 3960.8 3996.7 4022.4 8452.9 8476.7 8481.6 8491.8 8501.6 4296.4 4300.4 4301.1 4302.4 4314.7 3956.8 3957.9 3962.9 4002.3 4032.7 3198.8 3201.6 3205.5 3274.6 3286.0 1024.5 1037.3 1039.7 1042.0 1043.6 957.8 961.0 1028.4 1066.0 1308.9 6842.6 6933.8 6947.5 6953.5 6959.2 1072.9 1096.5 1100.1 1100.4 1101.5 5602.7 5650.0 5654.1 5685.7 5699.5 8648.9 8796.6 9103.0 9178.7 9248.3 9213.1 9284.8 9287.1 9297.1 9345.6 6929.3 7048.2 7132.0 7137.1 7184.6 7108.4 7139.6 7179.9 7180.4 7212.6 7941.3 8177.8 8204.8 8368.2 8385.4 8049.6 8280.6 8284.8 8313.4 8337.0 6549.4 6594.3 6932.9 6935.4 6959.7 6931.4 7034.3 7048.8 7050.6 7057.3 6592.8 6863.1 6864.8 6934.4 6952.5 6302.7 6350.8 6368.1 6440.4 6467.2 6415.5 6429.2 6455.3 6461.2 6463.5 5808.7 5864.4 5992.7 6000.3 6023.2 6065.9 6091.8 6106.1 6115.4 6190.4 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#4] prototype.html Cycles:180 Average:5544.88 Median:6256.86 stddev:1670.91 (26.7%) stddev-sans-first:1628.97 02:05:02 INFO - PROCESS | 32570 | Values: 322.4 324.4 328.7 329.2 333.9 6247.8 6293.1 6295.7 6302.2 6461.6 6226.4 6266.0 6271.8 6290.1 6304.7 4721.8 4729.4 4735.4 4739.0 4747.3 4754.3 4759.2 4776.0 4777.1 4777.2 4532.0 4658.9 4659.4 4663.1 4727.4 4627.2 4651.0 4653.0 4654.7 4655.9 4038.4 4052.1 4058.3 4059.0 4064.8 5832.9 5865.2 5917.5 5934.9 5948.0 5408.4 5500.1 5566.5 5623.9 5670.1 6608.4 6613.1 6616.5 6663.1 6663.2 4628.4 4647.4 4647.9 4651.6 4654.5 6795.1 6855.3 6928.2 6932.0 6943.5 4767.7 4769.3 4772.0 4777.7 4780.5 4825.4 4840.8 4846.5 4848.7 4870.1 5554.8 5560.6 5562.5 5570.4 5583.5 6571.6 6625.9 6637.5 6666.1 6696.2 1678.0 1701.8 1721.2 1726.1 1729.9 1139.6 1152.7 1158.3 1169.7 1175.7 6162.8 6171.9 6218.3 6242.5 6273.8 6733.0 6737.3 6745.2 6748.6 6753.7 6094.2 6188.1 6205.5 6223.3 6226.8 3687.5 3706.7 3708.2 3716.2 3723.5 7067.1 7103.3 7179.7 7185.1 7185.9 6719.7 6931.3 6934.5 6937.6 6950.6 7053.3 7073.1 7074.5 7109.9 7124.4 6743.7 6769.1 6770.7 6780.6 6795.5 6602.3 6704.4 6732.2 6733.4 6737.5 7052.5 7059.7 7094.6 7097.1 7102.0 4745.1 4757.9 4760.2 4794.9 4795.1 6644.0 6769.6 6790.4 6819.2 6912.6 6659.7 6684.9 6719.9 6745.9 6754.1 6724.6 6729.5 6745.3 6752.7 6771.0 6500.1 6593.5 6609.8 6610.0 6620.9 6744.1 6756.9 6788.2 6790.4 6820.2 6569.2 6591.0 6618.8 6624.1 6625.5 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - PROCESS | 32570 | [#5] yui.html Cycles:180 Average:13183.79 Median:48639.76 stddev:15717.16 (32.3%) stddev-sans-first:15733.38 02:05:02 INFO - PROCESS | 32570 | Values: 719.8 738.9 767.3 771.3 792.9 12484.4 12730.2 12808.2 12821.3 12851.5 11785.6 11880.0 11886.6 11904.1 11917.3 787.4 789.5 800.0 802.1 803.9 804.9 805.9 807.9 810.5 814.6 815.2 823.6 826.6 827.4 827.7 813.4 816.7 819.1 821.7 822.1 603.6 607.6 608.6 609.8 612.0 11710.2 11711.8 11816.9 11837.7 11885.5 11390.2 11685.6 11778.9 11780.9 11840.3 9097.0 9158.2 9286.9 9559.7 9590.3 3325.8 3377.6 3385.3 3425.4 3521.7 47865.5 48241.8 48513.0 48681.8 50105.5 8761.8 8835.0 8835.4 8901.1 9030.1 17463.1 17499.7 17505.0 17529.7 17555.8 7085.8 7219.2 7281.9 7313.3 7543.6 4189.6 4198.5 4229.3 4240.4 4248.7 3051.9 3072.9 3083.7 3084.1 3112.1 538.8 551.3 552.3 559.0 562.7 478.1 489.5 490.9 512.9 557.6 7191.3 7704.6 7750.7 7785.7 7826.1 451.7 471.5 549.6 596.3 608.2 3760.3 3861.4 3884.7 4028.7 4045.4 54121.7 54931.7 55417.2 58620.1 58997.1 47472.0 47640.5 47746.8 48597.8 50013.2 45133.1 45255.5 45517.0 47126.0 47354.8 7839.4 8314.4 8451.2 8511.5 8667.4 33336.2 33823.0 33916.0 34614.5 35161.6 39530.4 44732.8 45137.1 45175.3 45306.0 9924.3 10107.6 10222.4 10278.5 10328.9 10449.7 10906.6 11279.4 11381.8 11495.7 10155.2 10391.5 10447.8 10671.5 10855.5 9831.9 9995.6 10067.0 10326.2 10414.6 9152.3 10191.0 10202.1 10213.8 10280.9 8579.4 8664.4 8677.2 8796.2 9075.1 8016.3 8129.2 8505.6 8554.6 8656.0 02:05:02 INFO - PROCESS | 32570 | -------- Summary: end -------- 02:05:02 INFO - PROCESS | 32570 | 02:05:02 INFO - TEST-INFO | 32570: exit 0 02:05:02 INFO - TEST-OK | dromaeo_css | took 1110734ms 02:05:02 INFO - TEST-START | kraken 02:05:02 INFO - operating with platform_type : linux_ 02:05:02 INFO - Initialising browser for kraken test... 02:05:03 INFO - TEST-INFO | started process 345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo94z_q/profile http://localhost:45736/getInfo.html) 02:05:06 INFO - PROCESS | 345 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 02:05:07 INFO - PROCESS | 345 | __metrics Screen width/height:1600/1200 02:05:07 INFO - PROCESS | 345 | colorDepth:24 02:05:07 INFO - PROCESS | 345 | Browser inner width/height: 1024/697 02:05:07 INFO - PROCESS | 345 | __metrics 02:05:07 INFO - PROCESS | 345 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:05:08 INFO - TEST-INFO | 345: exit 0 02:05:08 INFO - Browser initialized. 02:05:08 INFO - Running cycle 1/1 for kraken test... 02:05:08 INFO - TEST-INFO | started process 472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo94z_q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:05:20 INFO - PROCESS | 472 | RSS: Main: 150028288 02:05:20 INFO - PROCESS | 472 | 02:05:22 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45736/tests/kraken/driver.html?testName=audio-beat-detection) 02:05:23 INFO - PROCESS | 472 | RSS: Main: 151289856 02:05:23 INFO - PROCESS | 472 | 02:05:25 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45736/tests/kraken/driver.html?testName=audio-dft) 02:05:26 INFO - PROCESS | 472 | RSS: Main: 152387584 02:05:26 INFO - PROCESS | 472 | 02:05:29 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45736/tests/kraken/driver.html?testName=audio-fft) 02:05:29 INFO - PROCESS | 472 | RSS: Main: 145678336 02:05:29 INFO - PROCESS | 472 | 02:05:31 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45736/tests/kraken/driver.html?testName=audio-oscillator) 02:05:32 INFO - PROCESS | 472 | RSS: Main: 146432000 02:05:32 INFO - PROCESS | 472 | 02:05:34 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:35 INFO - PROCESS | 472 | RSS: Main: 147296256 02:05:35 INFO - PROCESS | 472 | 02:05:38 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45736/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:38 INFO - PROCESS | 472 | RSS: Main: 147038208 02:05:38 INFO - PROCESS | 472 | 02:05:42 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45736/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:42 INFO - PROCESS | 472 | RSS: Main: 148946944 02:05:42 INFO - PROCESS | 472 | 02:05:45 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45736/tests/kraken/driver.html?testName=json-parse-financial) 02:05:46 INFO - PROCESS | 472 | RSS: Main: 148226048 02:05:46 INFO - PROCESS | 472 | 02:05:47 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:48 INFO - PROCESS | 472 | RSS: Main: 147992576 02:05:48 INFO - PROCESS | 472 | 02:05:50 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:50 INFO - PROCESS | 472 | RSS: Main: 148451328 02:05:50 INFO - PROCESS | 472 | 02:05:52 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:53 INFO - PROCESS | 472 | RSS: Main: 148504576 02:05:53 INFO - PROCESS | 472 | 02:05:56 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:56 INFO - PROCESS | 472 | RSS: Main: 149037056 02:05:56 INFO - PROCESS | 472 | 02:05:59 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:59 INFO - PROCESS | 472 | RSS: Main: 148566016 02:05:59 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | Cycle 1(1): loaded http://localhost:45736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45736/tests/kraken/driver.html?testName=ai-astar) 02:06:01 INFO - PROCESS | 472 | RSS: Main: 149778432 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | __start_tp_report 02:06:01 INFO - PROCESS | 472 | _x_x_mozilla_page_load 02:06:01 INFO - PROCESS | 472 | _x_x_mozilla_page_load_details 02:06:01 INFO - PROCESS | 472 | |i|pagename|runs| 02:06:01 INFO - PROCESS | 472 | |0;ai-astar;111;108;111;113;112;123;112;111;110;110 02:06:01 INFO - PROCESS | 472 | |1;audio-beat-detection;156;127;153;163;127;155;156;137;165;127 02:06:01 INFO - PROCESS | 472 | |2;audio-dft;163;163;162;164;162;167;162;168;168;163 02:06:01 INFO - PROCESS | 472 | |3;audio-fft;72;75;75;75;74;152;74;71;72;76 02:06:01 INFO - PROCESS | 472 | |4;audio-oscillator;96;96;136;95;95;96;134;96;96;134 02:06:01 INFO - PROCESS | 472 | |5;imaging-gaussian-blur;109;110;109;110;110;110;109;110;109;109 02:06:01 INFO - PROCESS | 472 | |6;imaging-darkroom;147;148;147;146;147;147;146;146;148;147 02:06:01 INFO - PROCESS | 472 | |7;imaging-desaturate;97;96;97;97;96;98;97;96;97;96 02:06:01 INFO - PROCESS | 472 | |8;json-parse-financial;60;62;62;64;62;61;62;71;63;59 02:06:01 INFO - PROCESS | 472 | |9;json-stringify-tinderbox;66;67;68;67;68;68;67;67;67;69 02:06:01 INFO - PROCESS | 472 | |10;stanford-crypto-aes;94;89;87;87;86;87;87;88;87;86 02:06:01 INFO - PROCESS | 472 | |11;stanford-crypto-ccm;126;127;119;127;131;130;136;122;123;120 02:06:01 INFO - PROCESS | 472 | |12;stanford-crypto-pbkdf2;155;145;157;158;153;141;155;154;146;140 02:06:01 INFO - PROCESS | 472 | |13;stanford-crypto-sha256-iterative;71;71;69;71;69;70;72;70;70;71 02:06:01 INFO - PROCESS | 472 | __end_tp_report 02:06:01 INFO - PROCESS | 472 | __start_cc_report 02:06:01 INFO - PROCESS | 472 | _x_x_mozilla_cycle_collect,743 02:06:01 INFO - PROCESS | 472 | __end_cc_report 02:06:01 INFO - PROCESS | 472 | __startTimestamp1452161161744__endTimestamp 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | ------- Summary: start ------- 02:06:01 INFO - PROCESS | 472 | Number of tests: 14 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:4.07 (3.6%) stddev-sans-first:4.29 02:06:01 INFO - PROCESS | 472 | Values: 111.0 108.0 111.0 113.0 112.0 123.0 112.0 111.0 110.0 110.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:155.50 stddev:15.42 (9.9%) stddev-sans-first:15.98 02:06:01 INFO - PROCESS | 472 | Values: 156.0 127.0 153.0 163.0 127.0 155.0 156.0 137.0 165.0 127.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.49 (1.5%) stddev-sans-first:2.60 02:06:01 INFO - PROCESS | 472 | Values: 163.0 163.0 162.0 164.0 162.0 167.0 162.0 168.0 168.0 163.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:24.79 (33.3%) stddev-sans-first:26.05 02:06:01 INFO - PROCESS | 472 | Values: 72.0 75.0 75.0 75.0 74.0 152.0 74.0 71.0 72.0 76.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:96.00 stddev:18.83 (19.6%) stddev-sans-first:19.51 02:06:01 INFO - PROCESS | 472 | Values: 96.0 96.0 136.0 95.0 95.0 96.0 134.0 96.0 96.0 134.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:06:01 INFO - PROCESS | 472 | Values: 109.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:06:01 INFO - PROCESS | 472 | Values: 147.0 148.0 147.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:06:01 INFO - PROCESS | 472 | Values: 97.0 96.0 97.0 97.0 96.0 98.0 97.0 96.0 97.0 96.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:62.00 stddev:3.27 (5.3%) stddev-sans-first:3.33 02:06:01 INFO - PROCESS | 472 | Values: 60.0 62.0 62.0 64.0 62.0 61.0 62.0 71.0 63.0 59.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 02:06:01 INFO - PROCESS | 472 | Values: 66.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 69.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.35 (2.7%) stddev-sans-first:0.93 02:06:01 INFO - PROCESS | 472 | Values: 94.0 89.0 87.0 87.0 86.0 87.0 87.0 88.0 87.0 86.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:5.30 (4.2%) stddev-sans-first:5.62 02:06:01 INFO - PROCESS | 472 | Values: 126.0 127.0 119.0 127.0 131.0 130.0 136.0 122.0 123.0 120.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:154.50 stddev:6.74 (4.4%) stddev-sans-first:6.94 02:06:01 INFO - PROCESS | 472 | Values: 155.0 145.0 157.0 158.0 153.0 141.0 155.0 154.0 146.0 140.0 02:06:01 INFO - PROCESS | 472 | 02:06:01 INFO - PROCESS | 472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 02:06:01 INFO - PROCESS | 472 | Values: 71.0 71.0 69.0 71.0 69.0 70.0 72.0 70.0 70.0 71.0 02:06:01 INFO - PROCESS | 472 | -------- Summary: end -------- 02:06:01 INFO - PROCESS | 472 | 02:06:02 INFO - TEST-INFO | 472: exit 0 02:06:02 INFO - TEST-OK | kraken | took 59901ms 02:06:02 INFO - TEST-START | v8_7 02:06:02 INFO - operating with platform_type : linux_ 02:06:02 INFO - Initialising browser for v8_7 test... 02:06:02 INFO - TEST-INFO | started process 763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8MQqI/profile http://localhost:45736/getInfo.html) 02:06:06 INFO - PROCESS | 763 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 02:06:07 INFO - PROCESS | 763 | __metrics Screen width/height:1600/1200 02:06:07 INFO - PROCESS | 763 | colorDepth:24 02:06:07 INFO - PROCESS | 763 | Browser inner width/height: 1024/697 02:06:07 INFO - PROCESS | 763 | __metrics 02:06:07 INFO - PROCESS | 763 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:06:08 INFO - TEST-INFO | 763: exit 0 02:06:08 INFO - Browser initialized. 02:06:08 INFO - Running cycle 1/1 for v8_7 test... 02:06:08 INFO - TEST-INFO | started process 890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8MQqI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:20 INFO - PROCESS | 890 | RSS: Main: 150392832 02:06:20 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | Cycle 1(1): loaded http://localhost:45736/tests/v8_7/run.html (next: http://localhost:45736/tests/v8_7/run.html) 02:06:41 INFO - PROCESS | 890 | RSS: Main: 147095552 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | __start_tp_report 02:06:41 INFO - PROCESS | 890 | _x_x_mozilla_page_load 02:06:41 INFO - PROCESS | 890 | _x_x_mozilla_page_load_details 02:06:41 INFO - PROCESS | 890 | |i|pagename|runs| 02:06:41 INFO - PROCESS | 890 | |0;Richards;166.25103906899417 02:06:41 INFO - PROCESS | 890 | |1;DeltaBlue;189.25056775170324 02:06:41 INFO - PROCESS | 890 | |2;Encrypt;282.2466836014677 02:06:41 INFO - PROCESS | 890 | |3;Decrypt;5218.75 02:06:41 INFO - PROCESS | 890 | |4;RayTrace;1079.8274002157498 02:06:41 INFO - PROCESS | 890 | |5;Earley;728 02:06:41 INFO - PROCESS | 890 | |6;Boyer;12345.67901234568 02:06:41 INFO - PROCESS | 890 | |7;RegExp;25100 02:06:41 INFO - PROCESS | 890 | |8;Splay;599.5203836930456 02:06:41 INFO - PROCESS | 890 | |9;NavierStokes;4826.923076923077 02:06:41 INFO - PROCESS | 890 | __end_tp_report 02:06:41 INFO - PROCESS | 890 | __startTimestamp1452161201900__endTimestamp 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | ------- Summary: start ------- 02:06:41 INFO - PROCESS | 890 | Number of tests: 10 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 166.3 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#1] DeltaBlue Cycles:1 Average:189.25 Median:189.25 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 189.3 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 282.2 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 5218.8 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#4] RayTrace Cycles:1 Average:1079.83 Median:1079.83 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 1079.8 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#5] Earley Cycles:1 Average:728.00 Median:728.00 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 728.0 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 12345.7 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 25100.0 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 599.5 02:06:41 INFO - PROCESS | 890 | 02:06:41 INFO - PROCESS | 890 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:06:41 INFO - PROCESS | 890 | Values: 4826.9 02:06:41 INFO - PROCESS | 890 | -------- Summary: end -------- 02:06:41 INFO - PROCESS | 890 | 02:06:42 INFO - TEST-INFO | 890: exit 0 02:06:42 INFO - TEST-OK | v8_7 | took 39872ms 02:06:42 INFO - SUITE-END | took 1210s 02:06:42 INFO - Completed test suite (00:20:10) 02:06:42 INFO - Working with test: dromaeo_css 02:06:42 INFO - Generating results file: dromaeo_css 02:06:42 INFO - Working with test: kraken 02:06:42 INFO - Generating results file: kraken 02:06:42 INFO - javascript benchmark 02:06:42 INFO - Working with test: v8_7 02:06:42 INFO - Generating results file: v8_7 02:06:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:06:42 INFO - process_Request line: dromaeo_css 6860.31 graph.html#tests=[[72,64,43]] 02:06:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:43 INFO - process_Request line: kraken 1529.70 graph.html#tests=[[232,64,43]] 02:06:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:43 INFO - process_Request line: v8_7 21283.61 graph.html#tests=[[230,64,43]] 02:06:43 INFO - RETURN: dromaeo_css: 6860.31 02:06:43 INFO - RETURN: kraken: 1529.70 02:06:43 INFO - RETURN: v8_7: 21283.61 02:06:43 INFO - javascript benchmark 02:06:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.262508310547, 3195.105370496262, 3213.5340375645533, 3217.3243618840042, 3235.0941736313835, 5324.680519168853, 5343.41222465529, 5362.4637536246355, 5377.247185394048, 5378.731063446827, 5329.440408757083, 5351.063563876316, 5395.919061214085, 5480.671159730419, 5491.643043202199, 4831.71009739415, 4898.681585696918, 4923.901521969558, 4970.229614409773, 4972.950270497285, 4874.902501949959, 4941.4811444798315, 4957.925631115536, 4968.155413579682, 5038.59691224703, 4822.252550854623, 4834.758262086917, 4896.387951506062, 4953.900921981576, 4954.554090131887, 4908.0429316283335, 4919.704817710949, 4924.409070911478, 4928.359313289249, 4938.259261110827, 4867.34290870735, 4911.533404326583, 4911.975440122812, 4917.877053073666, 4921.384826896638, 5187.170052791573, 5254.185601231815, 5291.629585928987, 5296.205569164617, 5330.1205301125265, 5620.606557540974, 5695.14572814077, 5708.5433165347085, 5733.541316694655, 5801.941980580183, 5836.212111364954, 5841.591088623798, 5853.29760428747, 5857.502112320458, 5859.501942334907, 5327.280817089682, 5416.0792665247, 5433.0, 5434.7826086956475, 5441.945580544223, 5826.300843898759, 5864.296284445893, 5871.853203669943, 5879.3826648202175, 5928.851778705481, 5643.492085712305, 5743.167240750068, 5754.683492407874, 5759.049756790083, 5763.423657634203, 5720.542356611544, 5755.85610359736, 5774.220480235199, 5813.505852002627, 5838.0, 5654.9821032214595, 5681.119426488901, 5682.6306290091015, 5691.459311365414, 5723.971380143073, 5678.3186017678145, 5685.971570142123, 5687.488126068591, 5688.317401911714, 5706.229658996065, 4378.934315985262, 4414.668899832525, 4429.534898835575, 4431.423914891044, 4463.152001119777, 3976.304146774303, 3986.8205930732606, 3989.162275922031, 3992.121733218687, 4025.879223623296, 5382.138857782736, 5466.262054622654, 5482.396936337, 5498.752556134984, 5541.445855414427, 5697.202391665171, 5756.107803290497, 5795.362510123883, 5821.359650438449, 5846.123081537803, 5421.539169170585, 5437.483439073281, 5440.510354068074, 5444.210589464585, 5448.346198456132, 4916.606671466274, 4923.950760492421, 4926.630502712311, 4929.507049295042, 4978.079055374695, 5937.851553711105, 6018.849528761816, 6065.727042283108, 6092.329843717188, 6113.877722445615, 5678.4605462480995, 5853.795117170878, 5855.531557475477, 5857.677827719346, 5872.354041055395, 5991.2510936132985, 5993.130996005468, 6002.729877155626, 6007.339192688713, 6076.848078798065, 5694.345150307768, 5694.658320500783, 5699.715014249188, 5700.201971723879, 5709.571782116441, 5693.971530142323, 5751.166080918327, 5757.97121014409, 5821.854453638693, 5837.474627283565, 5578.776848925998, 5639.407862174413, 5642.351129619982, 5648.0, 5698.401667824819, 5642.407547207648, 5643.35101463337, 5659.122835960433, 5666.206731057738, 5676.545876329967, 5503.422140675171, 5514.172874068761, 5542.861428464321, 5591.965486385032, 5631.0, 5657.886842263049, 5697.487226149667, 5751.194832723339, 5770.307563092456, 5778.797742079007, 5608.298962629671, 5616.803411880564, 5617.775288988395, 5621.325440947113, 5639.210510528447], "unit": "score", "name": "dojo.html", "value": 5329.8285098807255}, {"lowerIsBetter": false, "replicates": [512.1114865707996, 540.9648372855762, 574.5231457889952, 574.9856253593659, 579.3453397660643, 35561.82219088904, 36060.0, 36130.0, 36139.277214455695, 36150.81924590373, 38265.808670956605, 38317.616823831755, 38332.616673833254, 38439.23121537568, 38606.61393386065, 8394.286485648712, 8590.0, 8600.05399406068, 8610.225079742822, 8619.439736417113, 8307.293880020206, 8438.746837594881, 8439.409241353107, 8635.093315201908, 8666.653333866638, 8603.225709686127, 8670.566471676422, 8746.475211487299, 8776.517291548962, 8808.867866982, 8593.441426307301, 8634.093420190853, 8688.956555217215, 8691.47851128928, 8708.433951793113, 8492.83014339716, 8610.53620884451, 8615.0, 8629.65481380744, 8649.870251946226, 38709.22581548381, 38953.0, 39087.41368879469, 39237.41143882844, 39302.80348598267, 3049.237690577356, 3068.6317641882893, 3106.130283520618, 3506.2812123514873, 3593.7484376093685, 28791.712082879112, 29277.70722292771, 29515.852420737974, 29622.0, 30186.0, 3667.963320366789, 3726.664600185969, 3783.081993408558, 3813.4470501777364, 3872.7289089763726, 250560.0, 250594.0, 251085.0, 251435.0, 251486.74256628784, 51819.48180518222, 53026.20460693093, 56561.43438565644, 56729.0, 57015.429845701015, 58469.12296315558, 58499.0, 58564.0, 58566.70716646389, 58818.41181588129, 14690.926545367205, 14783.0, 14873.18197499148, 14879.181645009628, 14896.329665165094, 10934.125269978382, 10941.070009049161, 10957.232993690524, 11009.339439633648, 11014.39420831846, 19806.60386792256, 20107.49731256701, 20294.898525507277, 20320.69518957217, 20430.69353959692, 7446.478746487694, 7588.468807183444, 7667.616619169019, 7785.922140778633, 7795.532268063935, 833.8624127018974, 923.7228831350702, 927.3508544019079, 1047.836901039845, 1112.410422476089, 24788.0, 24951.0, 28307.858460707976, 29000.41999160005, 30209.546856797166, 974.3763991045737, 1012.6708819633501, 1062.7555662197738, 1082.9620963266248, 1122.955081796719, 14017.5093871714, 14205.21871297068, 14464.349104290332, 14545.78181327281, 15159.696806063817, 303308.0, 306437.0, 309462.0, 309776.0, 312955.0, 50723.0, 51329.74335128375, 51407.485925141016, 51429.0, 51648.225276620884, 1324.3113580937859, 1345.7039451320693, 1358.1307962903552, 1365.3173413293352, 1367.1796921846615, 27739.306517337227, 28316.292092697848, 28413.573796393484, 28679.713202868537, 28761.712382875903, 44943.32585011162, 44963.775181123885, 45176.77411612921, 45463.31805022861, 45513.54486455093, 281358.0, 283087.0, 283191.0, 284860.0, 285231.0, 27039.0, 27508.58737118905, 29987.400251995274, 30846.0, 30952.53571196479, 37290.0, 37919.0, 37956.0, 38069.0, 38521.0, 33692.66307336895, 33899.83050084832, 33984.15039624029, 34200.14499637529, 34337.0, 33864.49203261904, 33898.49152262669, 34774.13064673403, 34793.47809782906, 34800.82599586986, 32815.34369312553, 33631.83184084064, 33641.15897102592, 33717.3256534863, 33781.0, 28610.0, 31015.844920775253, 31135.53296700506, 31516.842415787774, 31796.523052153774, 24083.518329633658, 24223.0, 24265.0, 24341.756582433947, 24463.0], "unit": "score", "name": "ext.html", "value": 17822.539331115193}, {"lowerIsBetter": false, "replicates": [332.32040477224075, 332.38508758796246, 332.99167520811983, 333.5080755885069, 334.9966500334999, 11394.772104557904, 11707.414629268545, 16472.341106355747, 16637.334506619736, 17203.65592688147, 16280.592985175346, 16285.511434656979, 16614.0, 16647.1676416179, 16671.24979375931, 5634.0703783875715, 5825.679587622679, 5878.059510478324, 5884.794032208873, 5891.499222566087, 5754.798582049629, 5901.645901245917, 5945.524358051367, 5948.553858460611, 5950.464458198761, 5889.293284805829, 5915.911261331084, 6209.782657606962, 6414.871702565946, 6458.418742313191, 6308.968455157741, 6345.8413539661415, 6417.486601071903, 6513.674316284167, 6824.965875170592, 6516.283208847023, 6516.9674151629415, 6517.120188774549, 6517.217933847968, 6535.967320163416, 21751.78248217529, 22566.51768305485, 22858.885705571367, 23505.52988940229, 23926.64110038351, 2197.835162362829, 2198.164697414988, 2250.3586477853896, 2279.3275983584717, 2280.2589158523547, 14225.502107426191, 14233.359498822578, 14386.35261413239, 14609.78085328721, 14976.550703478913, 1866.5333666583354, 1941.4855063408208, 1945.1635796607454, 1970.2414570390504, 1987.1355960157377, 62919.0, 69048.0, 70124.2987570128, 71834.0, 72321.27678723198, 10160.288779785493, 10242.283040187116, 10354.068133867837, 10418.21863360251, 10422.635207767691, 13249.801252981213, 13267.270300133585, 13399.464021439033, 13407.262600556867, 13441.932790336181, 7333.413326933833, 7370.226126256773, 7496.175420703718, 7555.508891922007, 7691.846163076707, 6931.029655848185, 6944.305569443015, 7002.299770022957, 7033.6483175841, 7033.964830175919, 4423.137488189772, 4494.483134439582, 4525.818967241274, 4534.501204867528, 4545.977270113628, 1812.7915289741584, 1847.4457662701404, 1900.3063881683363, 1901.8573606979533, 1902.0965041605127, 407.2486262845046, 416.0576294692524, 849.2611428057629, 925.708401853414, 1012.5544760305442, 10000.399976001463, 10593.0, 10814.56741730322, 10867.45662716861, 10924.453777311102, 433.55777107350957, 436.86238834767585, 438.7542975933487, 449.26545098763756, 461.16759249554207, 5789.247397838339, 5892.646441213541, 5906.645601263938, 5936.1095835625, 5959.731812068468, 398624.0, 403069.0, 564487.0, 575308.0, 576554.0, 75138.24861751312, 79475.60262198652, 81902.0, 82552.0, 83121.0, 1056.7146870344964, 1089.232091375594, 1096.4736926275432, 1111.5664890692635, 1133.4616057372848, 14548.49080282185, 15428.30572624257, 15534.533963981099, 15699.058056516646, 15725.44960926362, 31637.0, 34324.65675343315, 35200.11999700028, 35305.47041794426, 35415.82292088626, 44533.33200002067, 44685.329720053574, 44887.32669010033, 45450.0, 46072.539274606825, 8587.441816281922, 9160.862587061332, 9196.724098277062, 9200.539973001189, 9210.401323913924, 11398.259113157617, 11493.655190344303, 16606.0079580231, 17822.0, 17933.910330448263, 14140.646483837574, 14360.928195358956, 14671.92664036673, 14783.778243326575, 14986.325615347117, 14135.15189088658, 14216.71566568642, 14454.638634033812, 14483.275836207937, 14932.104073755609, 14279.857201428269, 14398.20809855468, 14650.63373415673, 14816.851831481546, 15041.849581504044, 9258.72223833286, 9308.115729005734, 9483.952580237055, 9489.145976862115, 9567.234621230424, 14431.278436078364, 14568.635784105058, 14675.19286439256, 14768.556943291718, 15160.848391515943], "unit": "score", "name": "jquery.html", "value": 8656.106319617078}, {"lowerIsBetter": false, "replicates": [1251.8560365557964, 1307.8757518035784, 1330.7272009238102, 1727.7235642297235, 1742.3030787684925, 7494.7002119915205, 7533.434992375566, 7645.694172233118, 7665.156832748393, 7680.692772289116, 7580.962095189517, 7656.54060756355, 7706.460547761659, 7722.65248063837, 7732.613369331525, 2214.944626384341, 2240.607893618618, 2244.9887750561224, 2249.302716157996, 2254.921077762279, 2151.677248412735, 2205.757366689671, 2245.0346351069034, 2246.9662955055687, 2250.7861753133425, 2193.473566344074, 2215.4572129828216, 2224.92212772553, 2232.352617740861, 2259.548090381922, 2205.1730601024615, 2218.101668824129, 2222.355516900097, 2236.0, 2238.350878245307, 2200.3179014505554, 2266.150193677371, 2268.9205877794197, 2269.5574362999223, 2281.6691579721014, 7518.586477743722, 7577.696892124309, 7586.203448637869, 7593.0, 7638.885416718754, 4468.374427580141, 4470.173017991682, 4491.528389519119, 4516.706414083074, 4553.066621342617, 2947.1600593830653, 2953.6012638293987, 2975.5536669499534, 3004.9549256760947, 3019.8339091349967, 939.281449690987, 939.4128669581512, 944.7496413450441, 965.9758506037335, 991.2218908157062, 10361.740956476073, 10378.377297362107, 10430.843537346946, 10444.060034596847, 10449.320794148356, 3889.3388124018984, 3926.4895563577124, 3960.7623542587535, 3996.680265578747, 4022.35642297231, 8452.915470845213, 8476.745697629081, 8481.575921203916, 8491.787705307417, 8501.574921254036, 4296.3555466680245, 4300.3549467580115, 4301.139772045603, 4302.3546468030045, 4314.7411155330155, 3956.8219430125714, 3957.881263562098, 3962.890390690611, 4002.2595819772855, 4032.697547683935, 3198.8240646764184, 3201.599800024997, 3205.5351973963643, 3274.6397896231397, 3285.9835700821823, 1024.4979959819784, 1037.2635428845454, 1039.719275795531, 1042.0361165921645, 1043.5617040842865, 957.7701351675547, 960.9855852162223, 1028.3829702178632, 1065.9946700266448, 1308.908376413642, 6842.589444633338, 6933.826654333682, 6947.513674042769, 6953.478489113236, 6959.164900212007, 1072.8980746829038, 1096.5175322857917, 1100.0814320042693, 1100.4002818463796, 1101.4878081692052, 5602.747876345574, 5650.0, 5654.123610840326, 5685.658860468385, 5699.544036477072, 8648.870266946002, 8796.560171991376, 9102.954485227532, 9178.724638260863, 9248.26013918885, 9213.124753148575, 9284.814303714023, 9287.117723816227, 9297.070292970784, 9345.579448924815, 6929.341712537301, 7048.224695283412, 7132.037174981415, 7137.072180616487, 7184.6048467334795, 7108.431325493844, 7139.607321597155, 7179.8564028720175, 7180.3537681608905, 7212.603306818175, 7941.324987375907, 8177.754667359989, 8204.83590328178, 8368.24685778283, 8385.371097167616, 8049.557274349967, 8280.627371768405, 8284.83430331402, 8313.376496762889, 8336.958315208627, 6549.410553050248, 6594.307597702172, 6932.93067069343, 6935.375816176568, 6959.652017399008, 6931.376176144171, 7034.311765176423, 7048.823779405556, 7050.5769653820935, 7057.329553692391, 6592.80221593353, 6863.10779598649, 6864.759733409307, 6934.410575101173, 6952.478564107611, 6302.71637776292, 6350.841228969312, 6368.140301059483, 6440.355964403522, 6467.223933128054, 6415.454686351713, 6429.22849258092, 6455.322191169859, 6461.224653041665, 6463.515236357386, 5808.651480911159, 5864.354920958776, 5992.730327135202, 6000.339962604197, 6023.247094113236, 6065.939340606537, 6091.817245482643, 6106.114613380946, 6115.449609535163, 6190.442860142609], "unit": "score", "name": "mootools.html", "value": 4292.561481815361}, {"lowerIsBetter": false, "replicates": [322.40516247523317, 324.3593902043464, 328.70580830156996, 329.2197491944093, 333.94322965095915, 6247.750089996401, 6293.056041593757, 6295.685215739218, 6302.180716506853, 6461.6446095464735, 6226.40849119333, 6265.968670156654, 6271.780487682932, 6290.119383286332, 6304.684765761705, 4721.787519561628, 4729.432468103832, 4735.4317481902135, 4739.0, 4747.311639812225, 4754.334393184957, 4759.16714574948, 4776.044791041805, 4777.116233496814, 4777.235642297233, 4532.0256144928835, 4658.930116048262, 4659.440867095953, 4663.114008338422, 4727.409073865767, 4627.190241707688, 4651.023285110131, 4653.022865198295, 4654.697444666086, 4655.86032419028, 4038.374052021941, 4052.0882801369753, 4058.269511487931, 4059.04612416082, 4064.837406503766, 5832.912506312408, 5865.178874957509, 5917.52659787216, 5934.940650593482, 5948.0371477412355, 5408.405075441738, 5500.147477141049, 5566.526845218162, 5623.8594035149445, 5670.121131224667, 6608.438282745972, 6613.074169616258, 6616.536842421033, 6663.06717059612, 6663.2337281212795, 4628.375169352128, 4647.442306923191, 4647.907041859177, 4651.5813576778255, 4654.488006319302, 6795.116634837439, 6855.280195579492, 6928.237893831674, 6931.965340173267, 6943.548669336477, 4767.69010014348, 4769.332293478916, 4771.976140119277, 4777.689450185727, 4780.49804770501, 4825.396825396825, 4840.83057093, 4846.491118432585, 4848.7090774553635, 4870.050340183701, 5554.833354999357, 5560.610757247035, 5562.499375056183, 5570.359408667974, 5583.525400340935, 6571.605703657796, 6625.933740662628, 6637.502187335969, 6666.100076489709, 6696.1629796275465, 1677.9664406711797, 1701.821308762562, 1721.1566332496986, 1726.0506721303234, 1729.8616110711114, 1139.5954436175205, 1152.7233463968755, 1158.3281696616111, 1169.6841852699724, 1175.7243390920946, 6162.815115546541, 6171.876562468815, 6218.31598524162, 6242.469390101892, 6273.843153921189, 6733.0, 6737.326267373223, 6745.190577130677, 6748.628825414551, 6753.696083676246, 6094.238220222473, 6188.133661287423, 6205.5345849060595, 6223.253209614784, 6226.750929962841, 3687.520622319081, 3706.6849317808287, 3708.2398108387715, 3716.201016781405, 3723.4600982857332, 7067.116610423697, 7103.289671032855, 7179.748708795167, 7185.065941427581, 7185.856282874418, 6719.697613607399, 6931.306869313028, 6934.549254298455, 6937.618430986243, 6950.617716025566, 7053.329933656294, 7073.115860517435, 7074.540154889915, 7109.8933515997305, 7124.358807707331, 6743.696533656095, 6769.120014398097, 6770.661466926733, 6780.627065511444, 6795.524313298021, 6602.339766023551, 6704.4301234395625, 6732.158480189976, 6733.360330768569, 6737.461003119641, 7052.5063245574365, 7059.682314295766, 7094.574325540484, 7097.077379940574, 7101.964490177723, 4745.098431298043, 4757.881052973703, 4760.214564596941, 4794.880127996828, 4795.136875362468, 6644.036614690939, 6769.627670477974, 6790.388865002174, 6819.249882513019, 6912.619805910723, 6659.733610655713, 6684.866302673822, 6719.865602688016, 6745.93254067453, 6754.12196414463, 6724.630145341857, 6729.461643068641, 6745.325467453215, 6752.7298908045095, 6771.018202360531, 6500.057491663588, 6593.505487088391, 6609.801705948829, 6610.0, 6620.933790662224, 6744.055832183596, 6756.864862702817, 6788.151481064867, 6790.388865002174, 6820.249772525118, 6569.211694596679, 6591.011348297794, 6618.801435956929, 6624.138861947916, 6625.469962403093], "unit": "score", "name": "prototype.html", "value": 4996.493260873277}, {"lowerIsBetter": false, "replicates": [719.8488317453334, 738.9261073892611, 767.3017554025841, 771.3173841150583, 792.9216265878408, 12484.375781210949, 12730.172538784973, 12808.167469114502, 12821.294828784414, 12851.485940562367, 11785.587504437324, 11879.990200832939, 11886.583969561067, 11904.107191960617, 11917.284962902231, 787.3897729259827, 789.4631650477672, 800.0, 802.1176705623825, 803.9236272554098, 804.8551260773058, 805.923437273458, 807.9151689072651, 810.4610434061342, 814.5886327404652, 815.2173913043486, 823.5799742131526, 826.6073615032872, 827.3960009193293, 827.668932427028, 813.3737022492677, 816.6896579299857, 819.1112642782588, 821.6959724901765, 822.1244374740882, 603.5865432178972, 607.6323824086409, 608.6196127420362, 609.7713357490941, 611.9571629985903, 11710.238834475816, 11711.765764684744, 11816.88183118175, 11837.704057398549, 11885.524579016828, 11390.177571588507, 11685.599357999854, 11778.882211177865, 11780.941095294469, 11840.289582624984, 9097.0, 9158.216322184522, 9286.907130928672, 9559.665411710557, 9590.328676992613, 3325.783824051429, 3377.560917080764, 3385.306012267504, 3425.366307233145, 3521.683048525645, 47865.52134478645, 48241.75879120617, 48513.0, 48681.756591216814, 50105.49894501045, 8761.824763504694, 8834.95582522096, 8835.425697329652, 8901.109889011177, 9030.096990300917, 17463.12684365802, 17499.65000699979, 17505.0, 17529.7370539442, 17555.82444175542, 7085.751998680022, 7219.205887352387, 7281.854362912712, 7313.341799238094, 7543.585102819288, 4189.581041895786, 4198.475190601175, 4229.344451610005, 4240.385144154142, 4248.723832950848, 3051.8708078011277, 3072.8617212225504, 3083.676213997498, 3084.0901933929545, 3112.1130477813713, 538.8329617818489, 551.2943432406526, 552.3068548971096, 558.9608727389044, 562.6511562831071, 478.09162591077234, 489.5031542983874, 490.9435414927258, 512.8871648237382, 557.5706705836565, 7191.280871912872, 7704.614769261627, 7750.651220695082, 7785.688572457038, 7826.0608726952, 451.6684990936931, 471.5452828025511, 549.6152693114756, 596.2517041113375, 608.2123649873424, 3760.304343696425, 3861.362875125629, 3884.6503814656253, 4028.6601337935085, 4045.3527435610163, 54121.729391353576, 54931.725341373036, 55417.168742468086, 58620.12069818956, 58997.11504327438, 47472.0, 47640.52359476361, 47746.76126619414, 48597.757011214715, 50013.24980125301, 45133.09733805371, 45255.54744452579, 45517.0, 47126.0, 47354.76322618365, 7839.372850172087, 8314.41799074059, 8451.168364290043, 8511.489310641382, 8667.393282470166, 33336.1665958353, 33823.0, 33916.0, 34614.480782787774, 35161.64838351686, 39530.40704389494, 44732.77633611811, 45137.09725805531, 45175.32237016513, 45306.0, 9924.305298629026, 10107.64623238183, 10222.437765922945, 10278.486075696335, 10328.896711032794, 10449.738756531147, 10906.563737450731, 11279.436028198721, 11381.829272561085, 11495.655130346104, 10155.187584993331, 10391.532381043022, 10447.791044178923, 10671.46642667879, 10855.511501982272, 9831.89198292172, 9995.600175992879, 10067.0, 10326.173906087344, 10414.635487757892, 9152.267818574364, 10191.0, 10202.132818710492, 10213.795724085328, 10280.897191027994, 8579.442336248125, 8664.393492455467, 8677.219050285505, 8796.208341249318, 9075.092490750872, 8016.318612917968, 8129.187081291823, 8505.574721264036, 8554.645322978397, 8655.956720216358], "unit": "score", "name": "yui.html", "value": 5910.655415925957}], "name": "dromaeo_css", "value": 6860.305200265474}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 113.0, 112.0, 123.0, 112.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 153.0, 163.0, 127.0, 155.0, 156.0, 137.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 164.0, 162.0, 167.0, 162.0, 168.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 75.0, 75.0, 74.0, 152.0, 74.0, 71.0, 72.0, 76.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 136.0, 95.0, 95.0, 96.0, 134.0, 96.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 98.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 62.0, 64.0, 62.0, 61.0, 62.0, 71.0, 63.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 62.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [94.0, 89.0, 87.0, 87.0, 86.0, 87.0, 87.0, 88.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 119.0, 127.0, 131.0, 130.0, 136.0, 122.0, 123.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [155.0, 145.0, 157.0, 158.0, 153.0, 141.0, 155.0, 154.0, 146.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 69.0, 71.0, 69.0, 70.0, 72.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1529.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [189.25056775170324], "unit": "score", "name": "DeltaBlue", "value": 349.36751200000015}, {"lowerIsBetter": false, "replicates": [282.2466836014677], "unit": "score", "name": "Encrypt", "value": 943.0792829999996}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1079.8274002157498], "unit": "score", "name": "RayTrace", "value": 685.2845184815186}, {"lowerIsBetter": false, "replicates": [728.0], "unit": "score", "name": "Earley", "value": 915.4711538461537}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [599.5203836930456], "unit": "score", "name": "Splay", "value": 135.92698800000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21283.611304206384}]} 02:06:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21283.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1529.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6860.31"}}} 02:06:43 INFO - Return code: 0 02:06:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:06:43 INFO - # TBPL SUCCESS # 02:06:43 INFO - Running post-action listener: _resource_record_post_action 02:06:43 INFO - Running post-run listener: _resource_record_post_run 02:06:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 559710208; Read time: 0; Write time: 435112 02:06:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238010368; Read time: 0; Write time: 243096 02:06:44 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 320835584; Read time: 0; Write time: 191956 02:06:44 INFO - Running post-run listener: _upload_blobber_files 02:06:44 INFO - Blob upload gear active. 02:06:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:06:44 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 02:06:44 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'] 02:06:44 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 02:06:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:45 INFO - (blobuploader) - INFO - Done attempting. 02:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:46 INFO - (blobuploader) - INFO - Done attempting. 02:06:46 INFO - (blobuploader) - INFO - Iteration through files over. 02:06:46 INFO - Return code: 0 02:06:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:06:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:06:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce38e7175304ff2027f0d577f2a6ab980c9347198dd6e6a476117c286d7f20c8d91ec5645d50e386fe079099744d0a2536e0d7ef0523c6720e0b31566e6cf790", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a761751f68c6b6d0ff0cd6c5090c2a7259b34efa7a735ed1671f4b3c9acf3834a048616af1b5536009d9ce4757e3f057caedf9be7571240cf8e6c56763bae5c"} 02:06:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:06:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:06:46 INFO - Contents: 02:06:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce38e7175304ff2027f0d577f2a6ab980c9347198dd6e6a476117c286d7f20c8d91ec5645d50e386fe079099744d0a2536e0d7ef0523c6720e0b31566e6cf790", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a761751f68c6b6d0ff0cd6c5090c2a7259b34efa7a735ed1671f4b3c9acf3834a048616af1b5536009d9ce4757e3f057caedf9be7571240cf8e6c56763bae5c"} 02:06:46 INFO - Copying logs to upload dir... 02:06:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.725664 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-07 02:06:46.113812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 02:06:46.117487) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce38e7175304ff2027f0d577f2a6ab980c9347198dd6e6a476117c286d7f20c8d91ec5645d50e386fe079099744d0a2536e0d7ef0523c6720e0b31566e6cf790", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a761751f68c6b6d0ff0cd6c5090c2a7259b34efa7a735ed1671f4b3c9acf3834a048616af1b5536009d9ce4757e3f057caedf9be7571240cf8e6c56763bae5c"} build_url:https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/PNqwEVDBQHSGI6CsiWbdMQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce38e7175304ff2027f0d577f2a6ab980c9347198dd6e6a476117c286d7f20c8d91ec5645d50e386fe079099744d0a2536e0d7ef0523c6720e0b31566e6cf790", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a761751f68c6b6d0ff0cd6c5090c2a7259b34efa7a735ed1671f4b3c9acf3834a048616af1b5536009d9ce4757e3f057caedf9be7571240cf8e6c56763bae5c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 02:06:46.142701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 02:06:46.143058) ========= 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=32c5991c409366f7fec8a718000001d2-1452155003.444732-1075185796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 02:06:46.228007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 02:06:46.228332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 02:06:46.228626) ========= ========= Total master_lag: 0.24 =========