builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1452463344.5 results: success (0) buildid: 20160110113006 builduid: 560f6f622d0246da9ef5c05f2004ffca revision: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.501394) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.502344) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.502680) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006205 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.530673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.531000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.587160) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.587446) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003206 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.657891) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.658425) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.658889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.659203) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 14:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-10 14:02:26 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.850030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.850339) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018664 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.918185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-10 14:02:24.918597) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c --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 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c --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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 14:02:26,432 truncating revision to first 12 chars 2016-01-10 14:02:26,432 Setting DEBUG logging. 2016-01-10 14:02:26,432 attempt 1/10 2016-01-10 14:02:26,433 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/993fd6b313af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 14:02:27,182 unpacking tar archive at: fx-team-993fd6b313af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-10 14:02:25.978116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.978449) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.988554) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.988900) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.989588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-10 14:02:25.990278) ========= /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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:27 INFO - MultiFileLogger online at 20160110 14:02:27 in /builds/slave/test-pgo 14:02:27 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 14:02:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:02:27 INFO - {'append_to_log': False, 14:02:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:02:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:02:27 INFO - 'branch': 'Fx-Team', 14:02:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:27 INFO - 'config_files': ('talos/linux_config.py',), 14:02:27 INFO - 'default_actions': ('clobber', 14:02:27 INFO - 'read-buildbot-config', 14:02:27 INFO - 'download-and-extract', 14:02:27 INFO - 'populate-webroot', 14:02:27 INFO - 'create-virtualenv', 14:02:27 INFO - 'install', 14:02:27 INFO - 'run-tests'), 14:02:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:27 INFO - 'download_minidump_stackwalk': True, 14:02:27 INFO - 'download_symbols': 'ondemand', 14:02:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:27 INFO - 'installer_path': 'installer.exe', 14:02:27 INFO - 'log_level': 'info', 14:02:27 INFO - 'log_name': 'talos', 14:02:27 INFO - 'log_to_console': True, 14:02:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:27 INFO - 'opt_config_files': (), 14:02:27 INFO - 'pip_index': False, 14:02:27 INFO - 'sps_profile': False, 14:02:27 INFO - 'sps_profile_interval': 0, 14:02:27 INFO - 'suite': 'dromaeojs-e10s', 14:02:27 INFO - 'system_bits': '32', 14:02:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:27 INFO - 'title': 'talos-linux64-ix-045', 14:02:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:27 INFO - 'use_talos_json': True, 14:02:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:02:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:27 INFO - 'work_dir': 'build'} 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running clobber step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: clobber 14:02:27 INFO - rmtree: /builds/slave/test-pgo/build 14:02:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:02:28 INFO - Running post-action listener: _resource_record_post_action 14:02:28 INFO - ##### 14:02:28 INFO - ##### Running read-buildbot-config step. 14:02:28 INFO - ##### 14:02:28 INFO - Running pre-action listener: _resource_record_pre_action 14:02:28 INFO - Running main action method: read_buildbot_config 14:02:28 INFO - Using buildbot properties: 14:02:28 INFO - { 14:02:28 INFO - "project": "", 14:02:28 INFO - "product": "firefox", 14:02:28 INFO - "script_repo_revision": "production", 14:02:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:02:28 INFO - "repository": "", 14:02:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:02:28 INFO - "buildid": "20160110113006", 14:02:28 INFO - "pgo_build": "True", 14:02:28 INFO - "basedir": "/builds/slave/test-pgo", 14:02:28 INFO - "buildnumber": 436, 14:02:28 INFO - "slavename": "talos-linux64-ix-045", 14:02:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:28 INFO - "platform": "ubuntu64_hw", 14:02:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:28 INFO - "branch": "fx-team", 14:02:28 INFO - "repo_path": "integration/fx-team", 14:02:28 INFO - "revision": "993fd6b313af4b40f4c09f9ab8fa3ea60dac935c", 14:02:28 INFO - "stage_platform": "linux64-pgo", 14:02:28 INFO - "builduid": "560f6f622d0246da9ef5c05f2004ffca", 14:02:28 INFO - "slavebuilddir": "test" 14:02:28 INFO - } 14:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:02:28 INFO - Running post-action listener: _resource_record_post_action 14:02:28 INFO - ##### 14:02:28 INFO - ##### Running download-and-extract step. 14:02:28 INFO - ##### 14:02:28 INFO - Running pre-action listener: _resource_record_pre_action 14:02:28 INFO - Running main action method: download_and_extract 14:02:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:02:28 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')]} 14:02:28 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json 14:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json 14:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:02:32 INFO - Downloaded 1302 bytes. 14:02:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:02:32 INFO - Using the following test package requirements: 14:02:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'jsshell-linux-x86_64.zip'], 14:02:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:32 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')]} 14:02:32 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:36 INFO - Downloaded 24028339 bytes. 14:02:36 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 14:02:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:36 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 14:02:37 INFO - Return code: 0 14:02:37 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 14:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:37 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:53 INFO - Downloaded 24028339 bytes. 14:02:53 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 14:02:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:53 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 14:02:54 INFO - Return code: 0 14:02: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')]} 14:02:54 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:56 INFO - Downloaded 11132285 bytes. 14:02:56 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 14:02:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:56 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 14:02:56 INFO - Return code: 0 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:56 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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 14:02:59 INFO - Downloaded 55917524 bytes. 14:02:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:59 INFO - mkdir: /builds/slave/test-pgo/properties 14:02:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:02:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:02:59 INFO - Contents: 14:02:59 INFO - build_url:https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:59 INFO - Running post-action listener: _resource_record_post_action 14:02:59 INFO - Running post-action listener: set_extra_try_arguments 14:02:59 INFO - ##### 14:02:59 INFO - ##### Running populate-webroot step. 14:02:59 INFO - ##### 14:02:59 INFO - Running pre-action listener: _resource_record_pre_action 14:02:59 INFO - Running main action method: populate_webroot 14:02:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:59 INFO - '--tppagecycles', 14:02:59 INFO - '7'], 14:02:59 INFO - 'tests': ['tsvgm']}}, 14:02:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:02:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'tests': ['damp', 'tps']}, 14:02:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['damp', 'tps']}, 14:02:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:02:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:59 INFO - 'other': {'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'other_l64': {'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'other_nol64': {'tests': ['a11yr', 14:02:59 INFO - 'ts_paint', 14:02:59 INFO - 'tpaint', 14:02:59 INFO - 'sessionrestore', 14:02:59 INFO - 'sessionrestore_no_auto_restore']}, 14:02:59 INFO - 'svgr': {'tests': ['tsvgx', 14:02:59 INFO - 'tsvgr_opacity', 14:02:59 INFO - 'tart', 14:02:59 INFO - 'tscrollx', 14:02:59 INFO - 'cart']}, 14:02:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['tsvgx', 14:02:59 INFO - 'tsvgr_opacity', 14:02:59 INFO - 'tart', 14:02:59 INFO - 'tscrollx', 14:02:59 INFO - 'cart']}, 14:02:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'tests': ['tp5o']}, 14:02:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'talos_options': ['--e10s'], 14:02:59 INFO - 'tests': ['tp5o']}, 14:02:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'talos_options': ['--xperf_path', 14:02:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:59 INFO - 'tests': ['tp5n']}, 14:02:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:59 INFO - 'talos_options': ['--e10s', 14:02:59 INFO - '--xperf_path', 14:02:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:59 INFO - 'tests': ['tp5n']}}, 14:02:59 INFO - 'talos.zip': {'path': '', 14:02:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:59 INFO - Running post-action listener: _resource_record_post_action 14:02:59 INFO - ##### 14:02:59 INFO - ##### Running create-virtualenv step. 14:02:59 INFO - ##### 14:02:59 INFO - Running pre-action listener: _resource_record_pre_action 14:02:59 INFO - Running main action method: create_virtualenv 14:02:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:02:59 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 14:02:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:02:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:59 INFO - Using real prefix '/usr' 14:02:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:03:00 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:02 INFO - Installing pip.................done. 14:03:02 INFO - Return code: 0 14:03:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:03: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')]} 14:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:03:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:03:02 INFO - Using env: {'DISPLAY': ':0', 14:03:02 INFO - 'HOME': '/home/cltbld', 14:03:02 INFO - 'LANG': 'en_US.UTF-8', 14:03:02 INFO - 'LANGUAGE': 'en_US:en', 14:03:02 INFO - 'LOGNAME': 'cltbld', 14:03:02 INFO - 'MAIL': '/var/mail/cltbld', 14:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:02 INFO - 'MOZ_NO_REMOTE': '1', 14:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:02 INFO - 'NO_EM_RESTART': '1', 14:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:02 INFO - 'SHELL': '/bin/bash', 14:03:02 INFO - 'SHLVL': '1', 14:03:02 INFO - 'TERM': 'linux', 14:03:02 INFO - 'TMOUT': '86400', 14:03:02 INFO - 'USER': 'cltbld', 14:03:02 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:02 INFO - '_': '/tools/buildbot/bin/python'} 14:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:02 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 14:03:02 INFO - Cleaning up... 14:03:02 INFO - Return code: 0 14:03:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:03: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')]} 14:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03: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')]} 14:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:03:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:03:02 INFO - Using env: {'DISPLAY': ':0', 14:03:02 INFO - 'HOME': '/home/cltbld', 14:03:02 INFO - 'LANG': 'en_US.UTF-8', 14:03:02 INFO - 'LANGUAGE': 'en_US:en', 14:03:02 INFO - 'LOGNAME': 'cltbld', 14:03:02 INFO - 'MAIL': '/var/mail/cltbld', 14:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:02 INFO - 'MOZ_NO_REMOTE': '1', 14:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:02 INFO - 'NO_EM_RESTART': '1', 14:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:02 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:02 INFO - 'SHELL': '/bin/bash', 14:03:02 INFO - 'SHLVL': '1', 14:03:02 INFO - 'TERM': 'linux', 14:03:02 INFO - 'TMOUT': '86400', 14:03:02 INFO - 'USER': 'cltbld', 14:03:02 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:02 INFO - '_': '/tools/buildbot/bin/python'} 14:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:02 INFO - Downloading/unpacking psutil>=0.7.1 14:03:02 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 14:03:02 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 14:03:02 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 14:03:02 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 14:03:02 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 14:03:02 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 14:03:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:03:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:04 INFO - Installing collected packages: psutil 14:03:04 INFO - Running setup.py install for psutil 14:03:04 INFO - building 'psutil._psutil_linux' extension 14:03:04 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 14:03:04 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 14:03:04 INFO - building 'psutil._psutil_posix' extension 14:03:04 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 14:03:04 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 14:03:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:04 INFO - Successfully installed psutil 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:03:04 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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:04 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 14:03:04 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 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:03:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:03:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:03:06 INFO - Installing collected packages: mozsystemmonitor 14:03:06 INFO - Running setup.py install for mozsystemmonitor 14:03:06 INFO - Successfully installed mozsystemmonitor 14:03:06 INFO - Cleaning up... 14:03:06 INFO - Return code: 0 14:03:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:03:06 INFO - Using env: {'DISPLAY': ':0', 14:03:06 INFO - 'HOME': '/home/cltbld', 14:03:06 INFO - 'LANG': 'en_US.UTF-8', 14:03:06 INFO - 'LANGUAGE': 'en_US:en', 14:03:06 INFO - 'LOGNAME': 'cltbld', 14:03:06 INFO - 'MAIL': '/var/mail/cltbld', 14:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:06 INFO - 'MOZ_NO_REMOTE': '1', 14:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:06 INFO - 'NO_EM_RESTART': '1', 14:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:06 INFO - 'SHELL': '/bin/bash', 14:03:06 INFO - 'SHLVL': '1', 14:03:06 INFO - 'TERM': 'linux', 14:03:06 INFO - 'TMOUT': '86400', 14:03:06 INFO - 'USER': 'cltbld', 14:03:06 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:06 INFO - '_': '/tools/buildbot/bin/python'} 14:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:03:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:08 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 14:03:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:03:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:03:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:09 INFO - Downloading docopt-0.6.1.tar.gz 14:03:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:03:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:09 INFO - Running setup.py install for blobuploader 14:03:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:03:09 INFO - Running setup.py install for requests 14:03:10 INFO - Running setup.py install for docopt 14:03:10 INFO - Successfully installed blobuploader requests docopt 14:03:10 INFO - Cleaning up... 14:03:10 INFO - Return code: 0 14:03:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:10 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')]} 14:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:10 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')]} 14:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:10 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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:10 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 14:03:10 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 14:03:10 INFO - Using env: {'DISPLAY': ':0', 14:03:10 INFO - 'HOME': '/home/cltbld', 14:03:10 INFO - 'LANG': 'en_US.UTF-8', 14:03:10 INFO - 'LANGUAGE': 'en_US:en', 14:03:10 INFO - 'LOGNAME': 'cltbld', 14:03:10 INFO - 'MAIL': '/var/mail/cltbld', 14:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:10 INFO - 'MOZ_NO_REMOTE': '1', 14:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:10 INFO - 'NO_EM_RESTART': '1', 14:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:10 INFO - 'SHELL': '/bin/bash', 14:03:10 INFO - 'SHLVL': '1', 14:03:10 INFO - 'TERM': 'linux', 14:03:10 INFO - 'TMOUT': '86400', 14:03:10 INFO - 'USER': 'cltbld', 14:03:10 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:10 INFO - '_': '/tools/buildbot/bin/python'} 14:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:10 INFO - Running setup.py (path:/tmp/pip-fm2f9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:10 INFO - Running setup.py (path:/tmp/pip-6Flor5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:10 INFO - Running setup.py (path:/tmp/pip-KzDMxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:10 INFO - Running setup.py (path:/tmp/pip-xNvx8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:10 INFO - Running setup.py (path:/tmp/pip-J9GAfs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:10 INFO - Running setup.py (path:/tmp/pip-MJX3Gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:10 INFO - Running setup.py (path:/tmp/pip-NmkfUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:10 INFO - Running setup.py (path:/tmp/pip-bojaWx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:10 INFO - Running setup.py (path:/tmp/pip-ljfF3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:11 INFO - Running setup.py (path:/tmp/pip-BdptCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:11 INFO - Running setup.py (path:/tmp/pip-0nbHsv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:11 INFO - Running setup.py (path:/tmp/pip-uGYXWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:11 INFO - Running setup.py (path:/tmp/pip-LIxjfF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:11 INFO - Running setup.py (path:/tmp/pip-lmXevD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:11 INFO - Running setup.py (path:/tmp/pip-UMSgiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:11 INFO - Running setup.py (path:/tmp/pip-iqufba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:11 INFO - Running setup.py (path:/tmp/pip-MQFdGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:11 INFO - Running setup.py install for manifestparser 14:03:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:03:11 INFO - Running setup.py install for mozcrash 14:03:11 INFO - Running setup.py install for mozdebug 14:03:11 INFO - Running setup.py install for mozdevice 14:03:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozfile 14:03:12 INFO - Running setup.py install for mozhttpd 14:03:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozinfo 14:03:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozInstall 14:03:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozleak 14:03:12 INFO - Running setup.py install for mozlog 14:03:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for moznetwork 14:03:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozprocess 14:03:12 INFO - Running setup.py install for mozprofile 14:03:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:03:12 INFO - Running setup.py install for mozrunner 14:03:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:03:13 INFO - Running setup.py install for mozscreenshot 14:03:13 INFO - Running setup.py install for moztest 14:03:13 INFO - Running setup.py install for mozversion 14:03:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:13 INFO - Cleaning up... 14:03:13 INFO - Return code: 0 14:03:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:13 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 14:03:13 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 14:03:13 INFO - Using env: {'DISPLAY': ':0', 14:03:13 INFO - 'HOME': '/home/cltbld', 14:03:13 INFO - 'LANG': 'en_US.UTF-8', 14:03:13 INFO - 'LANGUAGE': 'en_US:en', 14:03:13 INFO - 'LOGNAME': 'cltbld', 14:03:13 INFO - 'MAIL': '/var/mail/cltbld', 14:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:13 INFO - 'MOZ_NO_REMOTE': '1', 14:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:13 INFO - 'NO_EM_RESTART': '1', 14:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:13 INFO - 'SHELL': '/bin/bash', 14:03:13 INFO - 'SHLVL': '1', 14:03:13 INFO - 'TERM': 'linux', 14:03:13 INFO - 'TMOUT': '86400', 14:03:13 INFO - 'USER': 'cltbld', 14:03:13 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:13 INFO - '_': '/tools/buildbot/bin/python'} 14:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:13 INFO - Running setup.py (path:/tmp/pip-o0sXeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:13 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)) 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:13 INFO - Running setup.py (path:/tmp/pip-aNfsyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:13 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)) 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:13 INFO - Running setup.py (path:/tmp/pip-1mQFUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:13 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)) 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:13 INFO - Running setup.py (path:/tmp/pip-OPvZeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:13 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)) 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:13 INFO - Running setup.py (path:/tmp/pip-A6yutE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:13 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)) 14:03:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:13 INFO - Running setup.py (path:/tmp/pip-C4ORb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:14 INFO - Running setup.py (path:/tmp/pip-6KrN31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:14 INFO - Running setup.py (path:/tmp/pip-0nrNFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:14 INFO - Running setup.py (path:/tmp/pip-ubsDx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:14 INFO - Running setup.py (path:/tmp/pip-35BTPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:14 INFO - Running setup.py (path:/tmp/pip-RNgyvi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:14 INFO - Running setup.py (path:/tmp/pip-hq27Go-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:14 INFO - Running setup.py (path:/tmp/pip-IwmfIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:14 INFO - Running setup.py (path:/tmp/pip-BL3F1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:14 INFO - Running setup.py (path:/tmp/pip-_kD8rg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:14 INFO - Running setup.py (path:/tmp/pip-3p84Z9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:14 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)) 14:03:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:14 INFO - Running setup.py (path:/tmp/pip-FIgEMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:14 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)) 14:03:14 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)) 14:03:14 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)) 14:03:14 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)) 14:03:14 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)) 14:03:14 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)) 14:03:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:16 INFO - Downloading blessings-1.5.1.tar.gz 14:03:16 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 14:03:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:16 INFO - Installing collected packages: blessings 14:03:16 INFO - Running setup.py install for blessings 14:03:16 INFO - Successfully installed blessings 14:03:16 INFO - Cleaning up... 14:03:16 INFO - Return code: 0 14:03:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:17 INFO - Reading from file tmpfile_stdout 14:03:17 INFO - Current package versions: 14:03:17 INFO - argparse == 1.2.1 14:03:17 INFO - blessings == 1.5.1 14:03:17 INFO - blobuploader == 1.2.4 14:03:17 INFO - docopt == 0.6.1 14:03:17 INFO - manifestparser == 1.1 14:03:17 INFO - mozInstall == 1.12 14:03:17 INFO - mozcrash == 0.16 14:03:17 INFO - mozdebug == 0.1 14:03:17 INFO - mozdevice == 0.47 14:03:17 INFO - mozfile == 1.2 14:03:17 INFO - mozhttpd == 0.7 14:03:17 INFO - mozinfo == 0.9 14:03:17 INFO - mozleak == 0.1 14:03:17 INFO - mozlog == 3.1 14:03:17 INFO - moznetwork == 0.27 14:03:17 INFO - mozprocess == 0.22 14:03:17 INFO - mozprofile == 0.28 14:03:17 INFO - mozrunner == 6.11 14:03:17 INFO - mozscreenshot == 0.1 14:03:17 INFO - mozsystemmonitor == 0.0 14:03:17 INFO - moztest == 0.7 14:03:17 INFO - mozversion == 1.4 14:03:17 INFO - psutil == 3.1.1 14:03:17 INFO - requests == 1.2.3 14:03:17 INFO - wsgiref == 0.1.2 14:03:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:03:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:17 INFO - Using env: {'DISPLAY': ':0', 14:03:17 INFO - 'HOME': '/home/cltbld', 14:03:17 INFO - 'LANG': 'en_US.UTF-8', 14:03:17 INFO - 'LANGUAGE': 'en_US:en', 14:03:17 INFO - 'LOGNAME': 'cltbld', 14:03:17 INFO - 'MAIL': '/var/mail/cltbld', 14:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:17 INFO - 'MOZ_NO_REMOTE': '1', 14:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:17 INFO - 'NO_EM_RESTART': '1', 14:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:17 INFO - 'SHELL': '/bin/bash', 14:03:17 INFO - 'SHLVL': '1', 14:03:17 INFO - 'TERM': 'linux', 14:03:17 INFO - 'TMOUT': '86400', 14:03:17 INFO - 'USER': 'cltbld', 14:03:17 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:17 INFO - '_': '/tools/buildbot/bin/python'} 14:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 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)) 14:03:17 INFO - Cleaning up... 14:03:17 INFO - Return code: 0 14:03:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:17 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 14:03:17 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 14:03:17 INFO - Using env: {'DISPLAY': ':0', 14:03:17 INFO - 'HOME': '/home/cltbld', 14:03:17 INFO - 'LANG': 'en_US.UTF-8', 14:03:17 INFO - 'LANGUAGE': 'en_US:en', 14:03:17 INFO - 'LOGNAME': 'cltbld', 14:03:17 INFO - 'MAIL': '/var/mail/cltbld', 14:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:17 INFO - 'MOZ_NO_REMOTE': '1', 14:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:17 INFO - 'NO_EM_RESTART': '1', 14:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:17 INFO - 'SHELL': '/bin/bash', 14:03:17 INFO - 'SHLVL': '1', 14:03:17 INFO - 'TERM': 'linux', 14:03:17 INFO - 'TMOUT': '86400', 14:03:17 INFO - 'USER': 'cltbld', 14:03:17 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:17 INFO - '_': '/tools/buildbot/bin/python'} 14:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:17 INFO - Downloading/unpacking jsonschema 14:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:03:19 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:03:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:19 INFO - warning: no files found matching '*.txt' 14:03:19 INFO - no previously-included directories found matching 'build' 14:03:19 INFO - no previously-included directories found matching 'dist' 14:03:19 INFO - no previously-included directories found matching '.git*' 14:03:19 INFO - Installing collected packages: jsonschema, functools32 14:03:19 INFO - Running setup.py install for functools32 14:03:19 INFO - warning: no files found matching '*.txt' 14:03:19 INFO - no previously-included directories found matching 'build' 14:03:19 INFO - no previously-included directories found matching 'dist' 14:03:19 INFO - no previously-included directories found matching '.git*' 14:03:19 INFO - Successfully installed jsonschema functools32 14:03:19 INFO - Cleaning up... 14:03:19 INFO - Return code: 0 14:03:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03:19 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')]} 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:19 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')]} 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:19 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 0x7f92dba91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, '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': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', '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 14:03:19 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 14:03:19 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 14:03:19 INFO - Using env: {'DISPLAY': ':0', 14:03:19 INFO - 'HOME': '/home/cltbld', 14:03:19 INFO - 'LANG': 'en_US.UTF-8', 14:03:19 INFO - 'LANGUAGE': 'en_US:en', 14:03:19 INFO - 'LOGNAME': 'cltbld', 14:03:19 INFO - 'MAIL': '/var/mail/cltbld', 14:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:19 INFO - 'MOZ_NO_REMOTE': '1', 14:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:19 INFO - 'NO_EM_RESTART': '1', 14:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:19 INFO - 'SHELL': '/bin/bash', 14:03:19 INFO - 'SHLVL': '1', 14:03:19 INFO - 'TERM': 'linux', 14:03:19 INFO - 'TMOUT': '86400', 14:03:19 INFO - 'USER': 'cltbld', 14:03:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:19 INFO - '_': '/tools/buildbot/bin/python'} 14:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:19 INFO - Downloading/unpacking flake8 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:21 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 14:03:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:21 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 14:03:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:21 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 14:03:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:03:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:22 INFO - no previously-included directories found matching 'docs/_build' 14:03:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:22 INFO - Running setup.py install for pep8 14:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:22 INFO - no previously-included directories found matching 'docs/_build' 14:03:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:22 INFO - Cleaning up... 14:03:22 INFO - Return code: 0 14:03:22 INFO - Running post-action listener: _resource_record_post_action 14:03:22 INFO - Running post-action listener: _start_resource_monitoring 14:03:22 INFO - Starting resource monitoring. 14:03:22 INFO - ##### 14:03:22 INFO - ##### Running install step. 14:03:22 INFO - ##### 14:03:22 INFO - Running pre-action listener: _resource_record_pre_action 14:03:22 INFO - Running main action method: install 14:03:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:22 INFO - Reading from file tmpfile_stdout 14:03:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:22 INFO - Reading from file tmpfile_stdout 14:03:22 INFO - Output received: 14:03:22 INFO - Usage: mozinstall [options] installer 14:03:22 INFO - Options: 14:03:22 INFO - -h, --help show this help message and exit 14:03:22 INFO - -d DEST, --destination=DEST 14:03:22 INFO - Directory to install application into. [default: 14:03:22 INFO - "/builds/slave/test-pgo"] 14:03:22 INFO - --app=APP Application being installed. [default: firefox] 14:03:22 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:22 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'] 14:03:22 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 14:03:38 INFO - Reading from file tmpfile_stdout 14:03:38 INFO - Output received: 14:03:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:03:38 INFO - Running post-action listener: _resource_record_post_action 14:03:38 INFO - ##### 14:03:38 INFO - ##### Running run-tests step. 14:03:38 INFO - ##### 14:03:38 INFO - Running pre-action listener: _resource_record_pre_action 14:03:38 INFO - Running main action method: run_tests 14:03:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:03:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:03:38 INFO - Python 2.7.3 14:03:38 INFO - Return code: 0 14:03:38 INFO - grabbing minidump binary from tooltool 14:03:38 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')]} 14:03:38 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 0x25253f0>, '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 0x25b7560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b7a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:03:38 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 14:03:38 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 14:03:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:38 INFO - Return code: 0 14:03:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:03:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:03:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:03:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:03:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:03:39 INFO - Return code: 0 14:03:39 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:03:39 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 14:03:39 INFO - Using env: {'DISPLAY': ':0', 14:03:39 INFO - 'HOME': '/home/cltbld', 14:03:39 INFO - 'LANG': 'en_US.UTF-8', 14:03:39 INFO - 'LANGUAGE': 'en_US:en', 14:03:39 INFO - 'LOGNAME': 'cltbld', 14:03:39 INFO - 'MAIL': '/var/mail/cltbld', 14:03:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:39 INFO - 'MOZ_NO_REMOTE': '1', 14:03:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:39 INFO - 'NO_EM_RESTART': '1', 14:03:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:39 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:03:39 INFO - 'SHELL': '/bin/bash', 14:03:39 INFO - 'SHLVL': '1', 14:03:39 INFO - 'TERM': 'linux', 14:03:39 INFO - 'TMOUT': '86400', 14:03:39 INFO - 'USER': 'cltbld', 14:03:39 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691', 14:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:39 INFO - '_': '/tools/buildbot/bin/python'} 14:03:39 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:03:40 INFO - mozversion application_buildid: 20160110113006 14:03:40 INFO - mozversion application_changeset: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c 14:03:40 INFO - mozversion application_display_name: Nightly 14:03:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:40 INFO - mozversion application_name: Firefox 14:03:40 INFO - mozversion application_remotingname: firefox 14:03:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:40 INFO - mozversion application_vendor: Mozilla 14:03:40 INFO - mozversion application_version: 46.0a1 14:03:40 INFO - mozversion platform_buildid: 20160110113006 14:03:40 INFO - mozversion platform_changeset: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c 14:03:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:40 INFO - mozversion platform_version: 46.0a1 14:03:40 INFO - using testdate: 1452463420 14:03:40 INFO - actual date: 1452463420 14:03:40 INFO - starting webserver on 'localhost:55594' 14:03:40 INFO - SUITE-START | Running 3 tests 14:03:40 INFO - TEST-START | dromaeo_css 14:03:40 INFO - operating with platform_type : linux_ 14:03:40 INFO - Initialising browser for dromaeo_css test... 14:03:40 INFO - TEST-INFO | started process 23609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKp9lL8/profile http://localhost:55594/getInfo.html) 14:03:43 INFO - PROCESS | 23609 | 14:03:43 INFO - PROCESS | 23609 | (process:23692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:43 INFO - PROCESS | 23609 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:03:44 INFO - PROCESS | 23609 | __metrics Screen width/height:1600/1200 14:03:44 INFO - PROCESS | 23609 | colorDepth:24 14:03:44 INFO - PROCESS | 23609 | Browser inner width/height: 1024/697 14:03:44 INFO - PROCESS | 23609 | __metrics 14:03:44 INFO - PROCESS | 23609 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:03:44 INFO - TEST-INFO | 23609: exit 0 14:03:44 INFO - Browser initialized. 14:03:44 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:44 INFO - TEST-INFO | started process 23741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKp9lL8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:46 INFO - PROCESS | 23741 | 14:03:46 INFO - PROCESS | 23741 | (process:23798): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:03:56 INFO - PROCESS | 23741 | RSS: Main: 150765568 14:03:56 INFO - PROCESS | 23741 | 14:04:46 INFO - PROCESS | 23741 | 1452463486407 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] 14:06:55 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55594/tests/dromaeo/cssquery-ext.html) 14:06:56 INFO - PROCESS | 23741 | RSS: Main: 156602368 14:06:56 INFO - PROCESS | 23741 | 14:09:58 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-ext.html (next: http://localhost:55594/tests/dromaeo/cssquery-jquery.html) 14:09:59 INFO - PROCESS | 23741 | RSS: Main: 153329664 14:09:59 INFO - PROCESS | 23741 | 14:13:00 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55594/tests/dromaeo/cssquery-mootools.html) 14:13:01 INFO - PROCESS | 23741 | RSS: Main: 153620480 14:13:01 INFO - PROCESS | 23741 | 14:16:03 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55594/tests/dromaeo/cssquery-prototype.html) 14:16:03 INFO - PROCESS | 23741 | RSS: Main: 152395776 14:16:03 INFO - PROCESS | 23741 | 14:19:06 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55594/tests/dromaeo/cssquery-yui.html) 14:19:06 INFO - PROCESS | 23741 | RSS: Main: 153972736 14:19:06 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:55594/tests/dromaeo/cssquery-yui.html (next: http://localhost:55594/tests/dromaeo/cssquery-dojo.html) 14:22:09 INFO - PROCESS | 23741 | RSS: Main: 155475968 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | __start_tp_report 14:22:09 INFO - PROCESS | 23741 | _x_x_mozilla_page_load 14:22:09 INFO - PROCESS | 23741 | _x_x_mozilla_page_load_details 14:22:09 INFO - PROCESS | 23741 | |i|pagename|runs| 14:22:09 INFO - PROCESS | 23741 | |0;dojo.html;3147.9842600786997;3186.0760379489934;3210.759193060521;3227.661095584963;3230.4185246655593;5196.922046169301;5323.840284791453;5329.120695085311;5330.7867685292595;5340.839774806757;5196.090684130281;5258.395284542279;5262.710550919698;5365.919511207335;5410.026195284847;4766.356541866856;4830.3237546743485;4869.975650121744;4901.730404827733;4957.182064959277;4848.6848354857;4911.582515486188;4947.060058588857;4979.228219625964;5038.168702164138;4772.73749943753;4878.487758785312;4892.6575139740235;4914.434839993411;4983.975080124595;4775.474697783241;4866.537678920532;4881.194602890519;4882.170031094723;4903.901921961577;4775.9761201194115;4793.976030119827;4795.0409918016185;4804.855854324341;4816.56650901417;5062.645614806965;5085.466026067246;5126.282320475137;5159.613029022838;5163.3545806774155;5686;5698.544116470673;5701.116326969285;5705.971470142623;5706.201131841545;5732.541396688297;5739.483446489794;5743.310802703702;5743.798967036134;5752.194692743019;5183.45573714762;5240.213967904807;5270.6047046471285;5340.973295133538;5379.273798037293;5793.623414478046;5800.216970708901;5803.9419605803405;5807.128930660435;5808.273965754281;5557.277553917965;5574.16387541872;5579.358373786985;5580.386157522669;5581.134924086773;5554.50009499147;5626.606137570331;5682.204491371212;5682.829515114553;5690.2887139107615;5576.135698966586;5576.693281869455;5720.313562372542;5786.537077033827;5833.7374818133285;5653;5697.430256974352;5705.058665320259;5708.942910570924;5709.971450142806;4297.763623000765;4433.844815431445;4435.379046933432;4441.311596702516;4462.821487140543;3900.941485877714;3958.050067983721;3959.247742928834;3979.184267225212;3994.6604538614542;5289.788408463618;5343.171808369709;5344.198370244417;5349.491798279158;5366.731663416814;5566.916496252559;5688.544916406678;5703.686297253691;5757.453041961007;5762.423757624288;5317.867053323621;5334.413214546396;5379.246905433242;5384.730763461811;5426.810061647902;4802.519748025239;4824.445188803263;4831.903361932742;4839.056384005085;4868.02639472107;5735.713214339266;5853.356130825606;5871.794487193013;5872.383399743051;5876.147958546072;5692.715364231689;5700.059490184073;5723.914141287801;5731.283589551306;5748;5839.036558967723;5850;5855.853603659943;5857.00430926752;5906.940930590639;5500.339959204921;5585.1901474286815;5591.776328946959;5638.85902852432;5656.632318899423;5597.104463286018;5629.605927585029;5641;5660.15097735343;5677.74450149736;5457.454254574511;5492.588055895744;5497.312835895513;5504.284443022381;5512.586556008396;5482.972585137049;5493.313335833021;5504.146857237135;5581.274434323512;5625.915611265917;5480.6437581557075;5496.7526461308535;5508.752106155152;5510.3938566758425;5517.117261238182;5576.749046292845;5614.129809879475;5617.606767526398;5629.930313240471;5632.831015069554;5353.544948679406;5479.095949168502;5486.561075114061;5550.417206193291;5587.720613969366 14:22:09 INFO - PROCESS | 23741 | |1;ext.html;515.1320025756598;520.3859445853892;537.981170659027;545.3973359437821;548.3392512023013;35334.64665353349;36046.2790744185;36104;36496.635033649654;36532.817335913314;39884;40478.19043619126;40522.79738601303;40549;40618.59381406185;8459.788505287386;8591.656333746674;8608.913910860905;8662.6101825418;8689.913100869006;8322.62548185333;8491.448055876379;8492.575371231414;8615.138486151365;8662;8676.566171691422;8692.087330830267;8764.56177191141;8776.64893404263;8793.340499462534;8563.44337618056;8569.35729820266;8642.178992995656;8659.69691060813;8661;8487.363447741443;8620.310375169971;8630.697925572575;8635.52504612246;8663.480191188486;39038.80480597607;39083.21833563341;39503.802480987695;39561.60438395608;39596.20807583861;3091.8763249469994;3152.2892454531525;3256.2313060817546;3266.248762784549;3995.300822356105;29503.40993180146;30089.398212035856;30168.24579385511;30389.392212155853;31270.530942035886;3238.1742655622666;3247.0745837436216;3265.9346813063844;3335.8832440864453;3368.4778859276853;200024;200200;201586;201714;202296.99999999852;52911.20633190505;53276.467235327924;59199.40800591939;59257.111143332884;59336.10995835066;62382.37617623856;62790.37209627845;65072;65345.346546533925;65352.34647653463;14410.495632652806;14539.27303634814;14591.635209119644;14596.197209153599;14598.197099159435;10800.08199303068;10929.125669946545;10934.289271197347;10939.83590246147;10940.726481838017;18945.621087578173;19057.714134287995;19167.424977250706;19226.32707855218;19275.51811204731;7774.727884524128;7913.366930645535;8055;8069.394795390252;8108.959455202804;915.1306259053925;980.352967041749;1023.4729114506035;1078.8921107889148;1080.394978811852;25718.6142207867;25984.610230846552;26468.073617423684;26558.070467533544;27162.864185678944;1026.43033116621;1026.9127124194379;1049.4070849969742;1062.583169477039;1089.1069323155095;14510.854891451161;14575.271236438135;14589.781153282709;14754.336054877556;15000.774988375184;353921;356554;357822;358970;359715;53950.73024634852;54139.72930135324;54720.72639636776;54878;54889.72555137199;1315.3883444198493;1321.4582021371384;1324.251797734277;1338.852726200117;1344.327836081959;25248.368790780376;27302.453950921266;27388.315292117855;27650.86174569114;30986.845065774527;45511;45703;45994.54005459903;46075.76962115168;46086.769566151954;274497;275417;275689;277025;277193;41253.79373103115;44370;44545.331820022075;45012.77493612511;45304;39345.80327098346;39725.60274397219;40023.79988100041;40118.398224027245;40397.1920561593;35524.822375887954;35598.28803423969;35952;36029.45955810612;36864.26271474609;36668.44997324989;37099.25801484009;37919.241615168095;38063;38348;35496.64503355037;35583.11042223965;35818.82090589531;35938.46092308565;36061.27877442489;33090.17274568155;33834.154146145556;34059.318813624086;34220.802271920365;34339.82830085834;24740.25779226626;24928.218731682144;25312.240632781046;25314.240572782845;25579.744202557737 14:22:09 INFO - PROCESS | 23741 | |2;jquery.html;355.7029880050158;356.16834690996524;356.5436241610738;359.7086360048361;360.21832623207644;16026.278817453214;16303;16345.427910023152;16967.660646787055;17633.559161020963;15839.524814255561;15904.045757254573;15930.601734956632;16281.918590407062;16398.508044758677;4844.394450693672;4972.105021096201;5027.824026159085;5028.647994640377;5044.293798868143;4805.255185446262;4919.065377578267;4965.900681986358;4969.055879382924;5011.448740638527;5003.574696150831;5004.649674522785;5005.199168133099;5272.973635131838;5477.534409575191;5290.735463226862;5322.2282768998275;5322.361316641989;5342.065138600729;5383.650062745909;5014.172661510846;5265.605079619006;5266.710330931797;5270.7628156733035;5289.259503669489;12187.573434929824;12320.876791232062;17088.2310296037;19642.607147857107;19775.703364449546;2025.9898700506403;2057.855950083495;2146.950603207488;2196.615592271346;2246.764089770567;9668.75828104296;9676.806463870753;12450.937745311307;12620;12995.740085198244;1812.9818701812944;1834.367143335547;1835.8623103267175;1853.091984927376;1856.7771867376002;48565.514344856805;50590.494095058944;50972;51160.23259651071;51459;9635.855462168072;9778.16885564735;9820.901790982;9864.95067524672;9916.900830991597;12595.181313214794;12612.306323152132;12641.557545485864;12698.047646426556;12698.873011269769;7032.789016329519;7316.195218525958;7332.230115837867;7361.558306501627;7397.8150546236775;7035.613041282779;7066.57600543969;7094.6097964612445;7107.715691372287;7113.288671132846;4249.532551419341;4279.807408666556;4289.957100429018;4292.291771857671;4301.763403012865;1785.1788177438264;1785.4822101590394;1790.7492950986873;1792.1487293535727;1792.97310540342;435.4817766857493;438.48040072514175;440.58144762475774;458.5048148000152;923.8798956135794;10449.529771160316;10499.107575855985;10603.975497185469;10615.31000484966;10864.239503234856;429.6927696696814;429.93980842681424;434.54372908446004;437.7701706604058;448.7397309560447;5878.617889837147;5912.9113063304085;5913.49735272498;5995.2206213192;6017.157597936292;469157;481965;486266;487301;496703;71095.2890471099;72080.27919720841;72138.63930680313;72697;73500.63249683718;477.90680817240303;479.89922116355956;483.2702619045267;485.10498130948343;488.25297295139205;9767.365121267096;10060.295779295378;10097.749170431482;10189.184865210616;10191.439470829175;28965.42069158563;30095.69904300929;30942.845285773426;31575.21061973469;31641.20896977502;41642.16715665609;42144.578554214066;43484.130317394105;43547;43581.78209109061;6749.392554670103;6893.345132212632;7263.128424589083;7274.981502589536;7303.561786292839;10804.67585972422;11113.499892504695;11168.66494005181;11215.214934954474;11289.20975531705;9234.815303694022;9256.629734810802;9559.569819358285;9609.759756005877;9858.112769850748;9236.353455258068;9693.176080033276;9757.853632195382;9804.803903921738;10043.899561004297;9490.098440648128;9631.181349585364;9675.080867317594;9706.75733106678;9844.556994935101;7222.855542889218;7284.125904891447;7354.301341372561;7414.851702965802;7436.814079648052;8756.693515726918;9435.952820235854;9519.762005949906;9599.136077753035;9653.855192171983 14:22:09 INFO - PROCESS | 23741 | |3;mootools.html;1419.16978567538;1427.3148888533508;1568.2315665323988;1697.702901992151;1721.0964243772025;7160.212376638566;7312.341889229968;7330.816729581763;7372.74195403161;7502.024736784224;7386.446016548767;7423.703051877932;7462.40300775938;7522.322990930815;7525.887111693315;2283.794458498731;2310.849794763343;2313.5141620259683;2314.1553333033407;2316.293530473205;2291.2209848651455;2296.2537175418056;2309.8383113182085;2330;2337.2871274261342;2189.277538412328;2240.5854916840353;2242.9439264018365;2256.199049337486;2258.3337915315024;2238.697775800262;2250.088714070804;2261.943451413728;2269.5120549081944;2278.3165050484954;2287.8103386239063;2291.988540057289;2293.38078718745;2293.816494680422;2299.0688771047753;7228.277172282782;7267.89098163528;7272.0546328977425;7280.599567023812;7289.671964761598;4502.774861256957;4595.195840727859;4611.700239484423;4614.515475875019;4647.6281897448125;2910.563415487694;2954.847609432323;2988.6861879502776;2997.835119068472;3027.7275045246033;983.1250187333208;992.1071036067597;1028.8713910761155;1032.8554002439664;1038.859753933217;9722.076402741728;9852.408855468622;9877.703668889944;9885.308028438012;9908.554115064839;3933.527976642764;4053.108316170438;4092.672586193157;4094.3244364679495;4096.795160241976;8017.078036025815;8113;8134.389920755967;8151.79620509492;8179.386546009073;4539.978504836386;4541.591256786905;4558.430196225472;4561.749103799323;4562.749048802281;4157.875263742093;4199;4199.643030342394;4204.66362690984;4228.492580890313;3234.6118465783784;3240.756943229267;3291.1607540077125;3292.160499072721;3303.702666760003;995.233670074039;998.8751406074241;1003.6587560229557;1004.0963133180196;1005.261133067195;1034.5965073621294;1035.2649618770606;1084.924055316136;1173.2725710059647;1325.4300650720284;6726.764563240263;6733.595984240863;6773.221079575912;6785.8642827143185;6818.897716534256;1113.3264375053138;1125.1167833251022;1127.2165844737829;1129.780270688976;1135.4833550734395;5303.071962406563;5332.9466705333225;5348.812791552355;5385.973070134624;5443.2107344434835;8421.831563368822;8568.271696905833;8675;8743.562821859008;8955.298493286255;8394.160583941557;8468.957655211685;8489.363297752694;8508.532030738368;8537.74386768398;6722.361375669304;6862.691178896962;6931.861362772817;6953.339432753779;7006.124234470692;6797.218319893078;6826.692798823966;6835.4189893859575;6874.828129296608;6899.862002759816;7677.961610191914;7814.33578145864;7818.921810782047;7837.686492540234;7856.057273127033;7895.131535531202;7982.922305488684;8003.159668234985;8014.679412823655;8138.83722325562;6549.115869357575;6605.702743376463;6653.367930046637;6664.266930637723;6683.3984941353565;7076.893846592408;7082.822929426806;7168.784936451915;7171.49799514029;7188.5327453715345;6069.3354524685665;6745.12313399255;6888.655567221719;7010.053642758367;7044.859102818017;6389.073584330339;6602;6756.45948324123;6773.525853190229;6867.484938629723;6724;6755.7973260802255;6798.252192258748;6809.863802724017;6815.556988795713;6023.66869822164;6072.362401947732;6114.541409394402;6116.66358350295;6127.20346354971;6181.227346581677;6243.157173781481;6307.306196318493;6307.495400368051;6386.201724784402 14:22:09 INFO - PROCESS | 23741 | |4;prototype.html;325.79312136793135;329.9521569372441;333.45646596048437;336.6297073219459;337.1419736769921;6294.559380843331;6335.80992570223;6342.746290148389;6356.745730170794;6398.520110991671;6221.968890155543;6267.717952692128;6274.341194174614;6280;6373.681315934196;4698.530146985299;4729.716217026972;4730.645201609876;4732.574068333849;4733.64497662675;4717.551832575899;4725.149473094842;4727.22000869856;4734.4081989751285;4737.076270127326;4619.145458090247;4691.085238378518;4709.175894218515;4711.4346278446465;4715.740634265114;4614.192516309649;4662.7668616569035;4674.158651442739;4692.624590032806;4696.647751418657;4040.333344998072;4050.594940505926;4052.837886484537;4057.411675307064;4061.4923134608175;5955.642661440327;5991.6405015698765;5994.97002514989;5998.700064996777;6018.608790428608;5353.812616558402;5409.107497262947;5440.075187218143;5473.945260547383;5479.479449452296;6623.4701223901975;6640.833979150511;6658;6675.632840193787;6695.765648202289;4469.642428605736;4484.596386325246;4488.483824360175;4494.528074552158;4495.617872480811;6906.723731050752;6915.585064896072;6964;6991.440684745259;7030.753923612649;4519.887002824956;4537.115262523842;4571.879889427045;4578.221702310549;4591.724496530219;4609.792559334838;4634.073185362941;4641.350210970467;4641.489436162019;4642.814287428465;5375.408705042442;5436.130219164915;5447.12845944647;5457.863553411196;5458.2904222450825;6592.373724496165;6710.765123220762;6716.496262780311;6717.56335838169;6744.932550674431;1591.2123498868134;1615.7899473068426;1651.1909164509543;1657.4861792844015;1658.2372108830073;1057.4871187474068;1071.3678929431517;1080.9189310801721;1100.3068067117665;1105.5688281570194;6265.780697675559;6288.5598008138995;6298.149749783721;6304.148939893055;6306.8423289417215;6784.694688739019;6788.389044985975;6802.863942721118;6848.7260509579055;6853.348931851466;6078.331383547807;6272.372762723782;6273.372662733781;6285.9057114143325;6292.370762923671;3703.666669999659;3711.0165806061414;3717.9218026772473;3718.1076541630355;3729.6083911188935;7096.964515177494;7107.6446177690905;7150.3922166615375;7159.498835081598;7160.248173941765;6918.06606108179;6955.582665040114;6995.475339349569;6999.880019196904;7006.4044556212275;7320.194778574246;7347.228541003225;7351.926480735231;7369.373603243785;7392.1499027611435;6922.169339679271;6948.478864085315;6996.755113571001;6997.930020699728;7016.789496315118;6808.080909077211;6896.413804826646;6933.237343892067;6954.513184077268;6958.547694399847;7331.266873312626;7344.265573442613;7360.116785985716;7364.5581265124265;7383.483156179016;4555.134524440346;4609.446866376056;4629.907401851877;4635.3278774578175;4647.65142614312;6878.209005964378;6931.618760967994;6991.580505169502;6997.860042799217;7005.05431766705;6797.966010169917;6807.149106361705;6818.318168183142;6824.283450237654;6852.0749698792015;6771.3905748482875;6786.321367863175;6790.219124800711;6798.694058767466;6814.2163651180745;6528.347165283433;6650.600963942179;6669.899951500634;6671.33286671329;6671.39957403836;6826;6827.795166145023;6838.521303508706;6851.48613853953;6853.074834897225;6630.336966303331;6655.767048153291;6658.467322614082;6664.033715111184;6692.196936367667 14:22:09 INFO - PROCESS | 23741 | |5;yui.html;744.4044764188648;798.832245228502;823.1110400767172;832.7006198111287;847.3771777743359;12704.61886143416;12759.17065390749;12789.872101278985;12820.615381538557;12837.358132093394;12684.682882927931;13735.58793236202;14011.719765604681;14012;14143;794.900637420324;804.0391731880405;804.7062822069931;805.3919290935336;813.4671789977574;808.6320724070533;811.1280373598375;812.715549557656;814.5072231300067;816.779469543223;835.7952301686096;841.1126261793805;842.7724514381114;842.9662813487483;843.2874221283037;834.0116961400729;837.8324335132937;838.0488145954325;838.266516797802;841.6759547574197;617.0158597037718;618.2148671187566;618.7215752911208;620.3517324395972;620.4292051312804;13533;13535.45858165682;13541.796873046913;13566.593002209851;13577.524786632519;11445.828312575319;12132.332721700302;12200.572979945659;12818.743625127445;13000.28498432586;10201.285909986304;10309.53607087683;10356.741081472948;10395.84406233907;10543.73640658982;3544.3088597723454;3590.8922732318074;3649.124210189562;3659.14010207601;3775.7734535927934;43629.56370436287;43674.56325436737;44184.779076104736;44329.55670443254;44561.77719111416;9553.235741140692;9698.030196980246;9835.409875407498;9853.113219810251;9935.254855885838;16284.185790710417;16541.25564349607;16603.833961660228;16627.916860415862;17191.914040429718;7294.234105418961;7416.369608583331;7474.551526908403;7637.732679356196;7778.338841198562;4078.6940979426663;4089.1617218470737;4090.1410703752545;4092.4066010428323;4166.437530933285;2821.0408461122906;2824.8870045197964;2835.957460638092;2838.44650293195;2858.8713507892194;517.4721783780523;529.1507131054678;535.0556268186654;535.3602445078172;538.3620409814382;533.6397931396292;541.4342012596845;552.7927027364739;653.369498434004;689.899964505154;8255.669773209125;8265.256126948603;8363.330933525425;8494.362922780692;8562.100979397199;522.12323498027;608.8203979825962;613.6594190224469;630.8265227062594;647.6049609738056;3934.940975885364;4015.156817068448;4019.0957034666967;4048.817803198863;4114.614267390042;53083.46916530863;54057;54141.58584141633;54294;54305.72847135739;46360.304595431095;47652;47817;47858;48096.7595162022;42985.14029719388;43025.78487107545;43051.35422968658;43207.35188972168;43698.12603747907;7753.147153812964;7859.764207073568;7937.496574369836;8168;8232.547209903512;32766.34467310688;32810.343793123524;33363;33364.66635333616;33367.662203913336;38568.6143138565;38792.80603596964;42105.78947105245;42510;42828.5717142837;9872.901270987199;9925.602975880884;9960.701178964642;10229.539670714687;10379.273450858367;12741.745165096461;13018.739625207632;13072.346382680638;13100.737985240052;13449.955272835625;11148.275362101438;11596.246243994114;12064.914157725847;12218.51125954952;12669.493220271086;11528.308301501937;11530.76938461243;11712.824307635563;11826.053915686896;12171.2697238166;11824.99487543534;11839.704007399883;11869.762604747684;11883.702907427038;12231.327276999495;9483.193928516153;9628.229741620793;9776;9835.16401105914;9874.654387096705;9506.572204250964;10034.949825250827;10063.849042264226;10188.592456301665;10235.7441063974 14:22:09 INFO - PROCESS | 23741 | __end_tp_report 14:22:09 INFO - PROCESS | 23741 | __start_cc_report 14:22:09 INFO - PROCESS | 23741 | _x_x_mozilla_cycle_collect,317 14:22:09 INFO - PROCESS | 23741 | __end_cc_report 14:22:09 INFO - PROCESS | 23741 | __startTimestamp1452464529397__endTimestamp 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | ------- Summary: start ------- 14:22:09 INFO - PROCESS | 23741 | Number of tests: 6 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#0] dojo.html Cycles:165 Average:5282.71 Median:5493.31 stddev:573.24 (10.4%) stddev-sans-first:549.99 14:22:09 INFO - PROCESS | 23741 | Values: 3148.0 3186.1 3210.8 3227.7 3230.4 5196.9 5323.8 5329.1 5330.8 5340.8 5196.1 5258.4 5262.7 5365.9 5410.0 4766.4 4830.3 4870.0 4901.7 4957.2 4848.7 4911.6 4947.1 4979.2 5038.2 4772.7 4878.5 4892.7 4914.4 4984.0 4775.5 4866.5 4881.2 4882.2 4903.9 4776.0 4794.0 4795.0 4804.9 4816.6 5062.6 5085.5 5126.3 5159.6 5163.4 5686.0 5698.5 5701.1 5706.0 5706.2 5732.5 5739.5 5743.3 5743.8 5752.2 5183.5 5240.2 5270.6 5341.0 5379.3 5793.6 5800.2 5803.9 5807.1 5808.3 5557.3 5574.2 5579.4 5580.4 5581.1 5554.5 5626.6 5682.2 5682.8 5690.3 5576.1 5576.7 5720.3 5786.5 5833.7 5653.0 5697.4 5705.1 5708.9 5710.0 4297.8 4433.8 4435.4 4441.3 4462.8 3900.9 3958.1 3959.2 3979.2 3994.7 5289.8 5343.2 5344.2 5349.5 5366.7 5566.9 5688.5 5703.7 5757.5 5762.4 5317.9 5334.4 5379.2 5384.7 5426.8 4802.5 4824.4 4831.9 4839.1 4868.0 5735.7 5853.4 5871.8 5872.4 5876.1 5692.7 5700.1 5723.9 5731.3 5748.0 5839.0 5850.0 5855.9 5857.0 5906.9 5500.3 5585.2 5591.8 5638.9 5656.6 5597.1 5629.6 5641.0 5660.2 5677.7 5457.5 5492.6 5497.3 5504.3 5512.6 5483.0 5493.3 5504.1 5581.3 5625.9 5480.6 5496.8 5508.8 5510.4 5517.1 5576.7 5614.1 5617.6 5629.9 5632.8 5353.5 5479.1 5486.6 5550.4 5587.7 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#1] ext.html Cycles:180 Average:45265.65 Median:36037.87 stddev:74854.15 (207.7%) stddev-sans-first:74988.72 14:22:09 INFO - PROCESS | 23741 | Values: 515.1 520.4 538.0 545.4 548.3 35334.6 36046.3 36104.0 36496.6 36532.8 39884.0 40478.2 40522.8 40549.0 40618.6 8459.8 8591.7 8608.9 8662.6 8689.9 8322.6 8491.4 8492.6 8615.1 8662.0 8676.6 8692.1 8764.6 8776.6 8793.3 8563.4 8569.4 8642.2 8659.7 8661.0 8487.4 8620.3 8630.7 8635.5 8663.5 39038.8 39083.2 39503.8 39561.6 39596.2 3091.9 3152.3 3256.2 3266.2 3995.3 29503.4 30089.4 30168.2 30389.4 31270.5 3238.2 3247.1 3265.9 3335.9 3368.5 200024.0 200200.0 201586.0 201714.0 202297.0 52911.2 53276.5 59199.4 59257.1 59336.1 62382.4 62790.4 65072.0 65345.3 65352.3 14410.5 14539.3 14591.6 14596.2 14598.2 10800.1 10929.1 10934.3 10939.8 10940.7 18945.6 19057.7 19167.4 19226.3 19275.5 7774.7 7913.4 8055.0 8069.4 8109.0 915.1 980.4 1023.5 1078.9 1080.4 25718.6 25984.6 26468.1 26558.1 27162.9 1026.4 1026.9 1049.4 1062.6 1089.1 14510.9 14575.3 14589.8 14754.3 15000.8 353921.0 356554.0 357822.0 358970.0 359715.0 53950.7 54139.7 54720.7 54878.0 54889.7 1315.4 1321.5 1324.3 1338.9 1344.3 25248.4 27302.5 27388.3 27650.9 30986.8 45511.0 45703.0 45994.5 46075.8 46086.8 274497.0 275417.0 275689.0 277025.0 277193.0 41253.8 44370.0 44545.3 45012.8 45304.0 39345.8 39725.6 40023.8 40118.4 40397.2 35524.8 35598.3 35952.0 36029.5 36864.3 36668.4 37099.3 37919.2 38063.0 38348.0 35496.6 35583.1 35818.8 35938.5 36061.3 33090.2 33834.2 34059.3 34220.8 34339.8 24740.3 24928.2 25312.2 25314.2 25579.7 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#2] jquery.html Cycles:180 Average:25161.61 Median:267415.76 stddev:79222.28 (29.6%) stddev-sans-first:79422.62 14:22:09 INFO - PROCESS | 23741 | Values: 355.7 356.2 356.5 359.7 360.2 16026.3 16303.0 16345.4 16967.7 17633.6 15839.5 15904.0 15930.6 16281.9 16398.5 4844.4 4972.1 5027.8 5028.6 5044.3 4805.3 4919.1 4965.9 4969.1 5011.4 5003.6 5004.6 5005.2 5273.0 5477.5 5290.7 5322.2 5322.4 5342.1 5383.7 5014.2 5265.6 5266.7 5270.8 5289.3 12187.6 12320.9 17088.2 19642.6 19775.7 2026.0 2057.9 2147.0 2196.6 2246.8 9668.8 9676.8 12450.9 12620.0 12995.7 1813.0 1834.4 1835.9 1853.1 1856.8 48565.5 50590.5 50972.0 51160.2 51459.0 9635.9 9778.2 9820.9 9865.0 9916.9 12595.2 12612.3 12641.6 12698.0 12698.9 7032.8 7316.2 7332.2 7361.6 7397.8 7035.6 7066.6 7094.6 7107.7 7113.3 4249.5 4279.8 4290.0 4292.3 4301.8 1785.2 1785.5 1790.7 1792.1 1793.0 435.5 438.5 440.6 458.5 923.9 10449.5 10499.1 10604.0 10615.3 10864.2 429.7 429.9 434.5 437.8 448.7 5878.6 5912.9 5913.5 5995.2 6017.2 469157.0 481965.0 486266.0 487301.0 496703.0 71095.3 72080.3 72138.6 72697.0 73500.6 477.9 479.9 483.3 485.1 488.3 9767.4 10060.3 10097.7 10189.2 10191.4 28965.4 30095.7 30942.8 31575.2 31641.2 41642.2 42144.6 43484.1 43547.0 43581.8 6749.4 6893.3 7263.1 7275.0 7303.6 10804.7 11113.5 11168.7 11215.2 11289.2 9234.8 9256.6 9559.6 9609.8 9858.1 9236.4 9693.2 9757.9 9804.8 10043.9 9490.1 9631.2 9675.1 9706.8 9844.6 7222.9 7284.1 7354.3 7414.9 7436.8 8756.7 9436.0 9519.8 9599.1 9653.9 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#3] mootools.html Cycles:180 Average:5170.07 Median:6346.85 stddev:2592.34 (40.8%) stddev-sans-first:2584.28 14:22:09 INFO - PROCESS | 23741 | Values: 1419.2 1427.3 1568.2 1697.7 1721.1 7160.2 7312.3 7330.8 7372.7 7502.0 7386.4 7423.7 7462.4 7522.3 7525.9 2283.8 2310.8 2313.5 2314.2 2316.3 2291.2 2296.3 2309.8 2330.0 2337.3 2189.3 2240.6 2242.9 2256.2 2258.3 2238.7 2250.1 2261.9 2269.5 2278.3 2287.8 2292.0 2293.4 2293.8 2299.1 7228.3 7267.9 7272.1 7280.6 7289.7 4502.8 4595.2 4611.7 4614.5 4647.6 2910.6 2954.8 2988.7 2997.8 3027.7 983.1 992.1 1028.9 1032.9 1038.9 9722.1 9852.4 9877.7 9885.3 9908.6 3933.5 4053.1 4092.7 4094.3 4096.8 8017.1 8113.0 8134.4 8151.8 8179.4 4540.0 4541.6 4558.4 4561.7 4562.7 4157.9 4199.0 4199.6 4204.7 4228.5 3234.6 3240.8 3291.2 3292.2 3303.7 995.2 998.9 1003.7 1004.1 1005.3 1034.6 1035.3 1084.9 1173.3 1325.4 6726.8 6733.6 6773.2 6785.9 6818.9 1113.3 1125.1 1127.2 1129.8 1135.5 5303.1 5332.9 5348.8 5386.0 5443.2 8421.8 8568.3 8675.0 8743.6 8955.3 8394.2 8469.0 8489.4 8508.5 8537.7 6722.4 6862.7 6931.9 6953.3 7006.1 6797.2 6826.7 6835.4 6874.8 6899.9 7678.0 7814.3 7818.9 7837.7 7856.1 7895.1 7982.9 8003.2 8014.7 8138.8 6549.1 6605.7 6653.4 6664.3 6683.4 7076.9 7082.8 7168.8 7171.5 7188.5 6069.3 6745.1 6888.7 7010.1 7044.9 6389.1 6602.0 6756.5 6773.5 6867.5 6724.0 6755.8 6798.3 6809.9 6815.6 6023.7 6072.4 6114.5 6116.7 6127.2 6181.2 6243.2 6307.3 6307.5 6386.2 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#4] prototype.html Cycles:180 Average:5569.41 Median:6293.47 stddev:1733.45 (27.5%) stddev-sans-first:1693.04 14:22:09 INFO - PROCESS | 23741 | Values: 325.8 330.0 333.5 336.6 337.1 6294.6 6335.8 6342.7 6356.7 6398.5 6222.0 6267.7 6274.3 6280.0 6373.7 4698.5 4729.7 4730.6 4732.6 4733.6 4717.6 4725.1 4727.2 4734.4 4737.1 4619.1 4691.1 4709.2 4711.4 4715.7 4614.2 4662.8 4674.2 4692.6 4696.6 4040.3 4050.6 4052.8 4057.4 4061.5 5955.6 5991.6 5995.0 5998.7 6018.6 5353.8 5409.1 5440.1 5473.9 5479.5 6623.5 6640.8 6658.0 6675.6 6695.8 4469.6 4484.6 4488.5 4494.5 4495.6 6906.7 6915.6 6964.0 6991.4 7030.8 4519.9 4537.1 4571.9 4578.2 4591.7 4609.8 4634.1 4641.4 4641.5 4642.8 5375.4 5436.1 5447.1 5457.9 5458.3 6592.4 6710.8 6716.5 6717.6 6744.9 1591.2 1615.8 1651.2 1657.5 1658.2 1057.5 1071.4 1080.9 1100.3 1105.6 6265.8 6288.6 6298.1 6304.1 6306.8 6784.7 6788.4 6802.9 6848.7 6853.3 6078.3 6272.4 6273.4 6285.9 6292.4 3703.7 3711.0 3717.9 3718.1 3729.6 7097.0 7107.6 7150.4 7159.5 7160.2 6918.1 6955.6 6995.5 6999.9 7006.4 7320.2 7347.2 7351.9 7369.4 7392.1 6922.2 6948.5 6996.8 6997.9 7016.8 6808.1 6896.4 6933.2 6954.5 6958.5 7331.3 7344.3 7360.1 7364.6 7383.5 4555.1 4609.4 4629.9 4635.3 4647.7 6878.2 6931.6 6991.6 6997.9 7005.1 6798.0 6807.1 6818.3 6824.3 6852.1 6771.4 6786.3 6790.2 6798.7 6814.2 6528.3 6650.6 6669.9 6671.3 6671.4 6826.0 6827.8 6838.5 6851.5 6853.1 6630.3 6655.8 6658.5 6664.0 6692.2 14:22:09 INFO - PROCESS | 23741 | 14:22:09 INFO - PROCESS | 23741 | [#5] yui.html Cycles:180 Average:13208.79 Median:43652.06 stddev:14752.12 (33.8%) stddev-sans-first:14763.80 14:22:09 INFO - PROCESS | 23741 | Values: 744.4 798.8 823.1 832.7 847.4 12704.6 12759.2 12789.9 12820.6 12837.4 12684.7 13735.6 14011.7 14012.0 14143.0 794.9 804.0 804.7 805.4 813.5 808.6 811.1 812.7 814.5 816.8 835.8 841.1 842.8 843.0 843.3 834.0 837.8 838.0 838.3 841.7 617.0 618.2 618.7 620.4 620.4 13533.0 13535.5 13541.8 13566.6 13577.5 11445.8 12132.3 12200.6 12818.7 13000.3 10201.3 10309.5 10356.7 10395.8 10543.7 3544.3 3590.9 3649.1 3659.1 3775.8 43629.6 43674.6 44184.8 44329.6 44561.8 9553.2 9698.0 9835.4 9853.1 9935.3 16284.2 16541.3 16603.8 16627.9 17191.9 7294.2 7416.4 7474.6 7637.7 7778.3 4078.7 4089.2 4090.1 4092.4 4166.4 2821.0 2824.9 2836.0 2838.4 2858.9 517.5 529.2 535.1 535.4 538.4 533.6 541.4 552.8 653.4 689.9 8255.7 8265.3 8363.3 8494.4 8562.1 522.1 608.8 613.7 630.8 647.6 3934.9 4015.2 4019.1 4048.8 4114.6 53083.5 54057.0 54141.6 54294.0 54305.7 46360.3 47652.0 47817.0 47858.0 48096.8 42985.1 43025.8 43051.4 43207.4 43698.1 7753.1 7859.8 7937.5 8168.0 8232.5 32766.3 32810.3 33363.0 33364.7 33367.7 38568.6 38792.8 42105.8 42510.0 42828.6 9872.9 9925.6 9960.7 10229.5 10379.3 12741.7 13018.7 13072.3 13100.7 13450.0 11148.3 11596.2 12064.9 12218.5 12669.5 11528.3 11530.8 11712.8 11826.1 12171.3 11825.0 11839.7 11869.8 11883.7 12231.3 9483.2 9628.2 9776.0 9835.2 9874.7 9506.6 10034.9 10063.8 10188.6 10235.7 14:22:09 INFO - PROCESS | 23741 | -------- Summary: end -------- 14:22:09 INFO - PROCESS | 23741 | 14:22:10 INFO - TEST-INFO | 23741: exit 0 14:22:10 INFO - TEST-OK | dromaeo_css | took 1109978ms 14:22:10 INFO - TEST-START | kraken 14:22:10 INFO - operating with platform_type : linux_ 14:22:10 INFO - Initialising browser for kraken test... 14:22:10 INFO - TEST-INFO | started process 23978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjoGTOO/profile http://localhost:55594/getInfo.html) 14:22:13 INFO - PROCESS | 23978 | 14:22:13 INFO - PROCESS | 23978 | (process:24050): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:22:13 INFO - PROCESS | 23978 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:22:14 INFO - PROCESS | 23978 | __metrics Screen width/height:1600/1200 14:22:14 INFO - PROCESS | 23978 | colorDepth:24 14:22:14 INFO - PROCESS | 23978 | Browser inner width/height: 1024/697 14:22:14 INFO - PROCESS | 23978 | __metrics 14:22:14 INFO - PROCESS | 23978 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:14 INFO - TEST-INFO | 23978: exit 0 14:22:14 INFO - Browser initialized. 14:22:14 INFO - Running cycle 1/1 for kraken test... 14:22:14 INFO - TEST-INFO | started process 24099 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjoGTOO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:16 INFO - PROCESS | 24099 | 14:22:16 INFO - PROCESS | 24099 | (process:24156): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:22:26 INFO - PROCESS | 24099 | RSS: Main: 150478848 14:22:26 INFO - PROCESS | 24099 | 14:22:29 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55594/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:29 INFO - PROCESS | 24099 | RSS: Main: 151605248 14:22:29 INFO - PROCESS | 24099 | 14:22:32 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55594/tests/kraken/driver.html?testName=audio-dft) 14:22:33 INFO - PROCESS | 24099 | RSS: Main: 151855104 14:22:33 INFO - PROCESS | 24099 | 14:22:35 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55594/tests/kraken/driver.html?testName=audio-fft) 14:22:36 INFO - PROCESS | 24099 | RSS: Main: 146128896 14:22:36 INFO - PROCESS | 24099 | 14:22:38 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55594/tests/kraken/driver.html?testName=audio-oscillator) 14:22:39 INFO - PROCESS | 24099 | RSS: Main: 147533824 14:22:39 INFO - PROCESS | 24099 | 14:22:41 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:42 INFO - PROCESS | 24099 | RSS: Main: 147660800 14:22:42 INFO - PROCESS | 24099 | 14:22:45 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55594/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:45 INFO - PROCESS | 24099 | RSS: Main: 146227200 14:22:45 INFO - PROCESS | 24099 | 14:22:49 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55594/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:49 INFO - PROCESS | 24099 | RSS: Main: 147374080 14:22:49 INFO - PROCESS | 24099 | 14:22:52 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55594/tests/kraken/driver.html?testName=json-parse-financial) 14:22:53 INFO - PROCESS | 24099 | RSS: Main: 147955712 14:22:53 INFO - PROCESS | 24099 | 14:22:54 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:55 INFO - PROCESS | 24099 | RSS: Main: 149450752 14:22:55 INFO - PROCESS | 24099 | 14:22:57 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:57 INFO - PROCESS | 24099 | RSS: Main: 149270528 14:22:57 INFO - PROCESS | 24099 | 14:22:59 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:00 INFO - PROCESS | 24099 | RSS: Main: 149618688 14:23:00 INFO - PROCESS | 24099 | 14:23:02 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:03 INFO - PROCESS | 24099 | RSS: Main: 149024768 14:23:03 INFO - PROCESS | 24099 | 14:23:06 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:06 INFO - PROCESS | 24099 | RSS: Main: 149049344 14:23:06 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | Cycle 1(1): loaded http://localhost:55594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55594/tests/kraken/driver.html?testName=ai-astar) 14:23:08 INFO - PROCESS | 24099 | RSS: Main: 148824064 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | __start_tp_report 14:23:08 INFO - PROCESS | 24099 | _x_x_mozilla_page_load 14:23:08 INFO - PROCESS | 24099 | _x_x_mozilla_page_load_details 14:23:08 INFO - PROCESS | 24099 | |i|pagename|runs| 14:23:08 INFO - PROCESS | 24099 | |0;ai-astar;113;109;112;112;114;124;114;114;114;113 14:23:08 INFO - PROCESS | 24099 | |1;audio-beat-detection;159;128;150;159;136;153;147;133;162;128 14:23:08 INFO - PROCESS | 24099 | |2;audio-dft;162;161;168;164;162;161;166;168;164;163 14:23:08 INFO - PROCESS | 24099 | |3;audio-fft;71;74;75;73;72;72;72;149;71;74 14:23:08 INFO - PROCESS | 24099 | |4;audio-oscillator;96;98;145;97;96;97;138;95;97;147 14:23:08 INFO - PROCESS | 24099 | |5;imaging-gaussian-blur;109;111;110;109;109;109;109;111;110;109 14:23:08 INFO - PROCESS | 24099 | |6;imaging-darkroom;147;146;146;147;147;148;146;147;147;147 14:23:08 INFO - PROCESS | 24099 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;97 14:23:08 INFO - PROCESS | 24099 | |8;json-parse-financial;56;57;57;56;56;58;57;58;57;57 14:23:08 INFO - PROCESS | 24099 | |9;json-stringify-tinderbox;67;67;67;68;67;69;67;68;67;68 14:23:08 INFO - PROCESS | 24099 | |10;stanford-crypto-aes;86;94;87;88;87;87;87;86;87;86 14:23:08 INFO - PROCESS | 24099 | |11;stanford-crypto-ccm;123;125;140;124;122;123;116;124;133;123 14:23:08 INFO - PROCESS | 24099 | |12;stanford-crypto-pbkdf2;141;153;153;152;153;149;156;153;160;149 14:23:08 INFO - PROCESS | 24099 | |13;stanford-crypto-sha256-iterative;70;68;69;71;69;72;71;72;68;68 14:23:08 INFO - PROCESS | 24099 | __end_tp_report 14:23:08 INFO - PROCESS | 24099 | __start_cc_report 14:23:08 INFO - PROCESS | 24099 | _x_x_mozilla_cycle_collect,734 14:23:08 INFO - PROCESS | 24099 | __end_cc_report 14:23:08 INFO - PROCESS | 24099 | __startTimestamp1452464588677__endTimestamp 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | ------- Summary: start ------- 14:23:08 INFO - PROCESS | 24099 | Number of tests: 14 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:3.87 (3.4%) stddev-sans-first:4.09 14:23:08 INFO - PROCESS | 24099 | Values: 113.0 109.0 112.0 112.0 114.0 124.0 114.0 114.0 114.0 113.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.50 stddev:13.23 (8.7%) stddev-sans-first:13.10 14:23:08 INFO - PROCESS | 24099 | Values: 159.0 128.0 150.0 159.0 136.0 153.0 147.0 133.0 162.0 128.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.64 (1.6%) stddev-sans-first:2.71 14:23:08 INFO - PROCESS | 24099 | Values: 162.0 161.0 168.0 164.0 162.0 161.0 166.0 168.0 164.0 163.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:24.18 (33.3%) stddev-sans-first:25.41 14:23:08 INFO - PROCESS | 24099 | Values: 71.0 74.0 75.0 73.0 72.0 72.0 72.0 149.0 71.0 74.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:22.71 (23.5%) stddev-sans-first:23.47 14:23:08 INFO - PROCESS | 24099 | Values: 96.0 98.0 145.0 97.0 96.0 97.0 138.0 95.0 97.0 147.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 14:23:08 INFO - PROCESS | 24099 | Values: 109.0 111.0 110.0 109.0 109.0 109.0 109.0 111.0 110.0 109.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:23:08 INFO - PROCESS | 24099 | Values: 147.0 146.0 146.0 147.0 147.0 148.0 146.0 147.0 147.0 147.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:23:08 INFO - PROCESS | 24099 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 14:23:08 INFO - PROCESS | 24099 | Values: 56.0 57.0 57.0 56.0 56.0 58.0 57.0 58.0 57.0 57.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 14:23:08 INFO - PROCESS | 24099 | Values: 67.0 67.0 67.0 68.0 67.0 69.0 67.0 68.0 67.0 68.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:2.37 (2.7%) stddev-sans-first:2.45 14:23:08 INFO - PROCESS | 24099 | Values: 86.0 94.0 87.0 88.0 87.0 87.0 87.0 86.0 87.0 86.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:124.00 stddev:6.60 (5.3%) stddev-sans-first:6.95 14:23:08 INFO - PROCESS | 24099 | Values: 123.0 125.0 140.0 124.0 122.0 123.0 116.0 124.0 133.0 123.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:4.98 (3.3%) stddev-sans-first:3.37 14:23:08 INFO - PROCESS | 24099 | Values: 141.0 153.0 153.0 152.0 153.0 149.0 156.0 153.0 160.0 149.0 14:23:08 INFO - PROCESS | 24099 | 14:23:08 INFO - PROCESS | 24099 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:1.62 (2.3%) stddev-sans-first:1.72 14:23:08 INFO - PROCESS | 24099 | Values: 70.0 68.0 69.0 71.0 69.0 72.0 71.0 72.0 68.0 68.0 14:23:08 INFO - PROCESS | 24099 | -------- Summary: end -------- 14:23:08 INFO - PROCESS | 24099 | 14:23:09 INFO - TEST-INFO | 24099: exit 0 14:23:09 INFO - TEST-OK | kraken | took 59504ms 14:23:09 INFO - TEST-START | v8_7 14:23:09 INFO - operating with platform_type : linux_ 14:23:09 INFO - Initialising browser for v8_7 test... 14:23:09 INFO - TEST-INFO | started process 24385 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdPsjSe/profile http://localhost:55594/getInfo.html) 14:23:12 INFO - PROCESS | 24385 | 14:23:12 INFO - PROCESS | 24385 | (process:24456): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:23:12 INFO - PROCESS | 24385 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:23:13 INFO - PROCESS | 24385 | __metrics Screen width/height:1600/1200 14:23:13 INFO - PROCESS | 24385 | colorDepth:24 14:23:13 INFO - PROCESS | 24385 | Browser inner width/height: 1024/697 14:23:13 INFO - PROCESS | 24385 | __metrics 14:23:13 INFO - PROCESS | 24385 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:14 INFO - TEST-INFO | 24385: exit 0 14:23:14 INFO - Browser initialized. 14:23:14 INFO - Running cycle 1/1 for v8_7 test... 14:23:14 INFO - TEST-INFO | started process 24505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdPsjSe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:15 INFO - PROCESS | 24505 | 14:23:15 INFO - PROCESS | 24505 | (process:24566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:23:26 INFO - PROCESS | 24505 | RSS: Main: 150532096 14:23:26 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | Cycle 1(1): loaded http://localhost:55594/tests/v8_7/run.html (next: http://localhost:55594/tests/v8_7/run.html) 14:23:48 INFO - PROCESS | 24505 | RSS: Main: 146051072 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | __start_tp_report 14:23:48 INFO - PROCESS | 24505 | _x_x_mozilla_page_load 14:23:48 INFO - PROCESS | 24505 | _x_x_mozilla_page_load_details 14:23:48 INFO - PROCESS | 24505 | |i|pagename|runs| 14:23:48 INFO - PROCESS | 24505 | |0;Richards;166.88918558077435 14:23:48 INFO - PROCESS | 24505 | |1;DeltaBlue;190.8761213972132 14:23:48 INFO - PROCESS | 24505 | |2;Encrypt;280.3476310625175 14:23:48 INFO - PROCESS | 24505 | |3;Decrypt;5218.75 14:23:48 INFO - PROCESS | 24505 | |4;RayTrace;1053.740779768177 14:23:48 INFO - PROCESS | 24505 | |5;Earley;721.5007215007215 14:23:48 INFO - PROCESS | 24505 | |6;Boyer;12231.707317073171 14:23:48 INFO - PROCESS | 24505 | |7;RegExp;40800 14:23:48 INFO - PROCESS | 24505 | |8;Splay;574.2857142857143 14:23:48 INFO - PROCESS | 24505 | |9;NavierStokes;4887.804878048781 14:23:48 INFO - PROCESS | 24505 | __end_tp_report 14:23:48 INFO - PROCESS | 24505 | __startTimestamp1452464628963__endTimestamp 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | ------- Summary: start ------- 14:23:48 INFO - PROCESS | 24505 | Number of tests: 10 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 166.9 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#1] DeltaBlue Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 190.9 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 280.3 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 5218.8 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 1053.7 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#5] Earley Cycles:1 Average:721.50 Median:721.50 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 721.5 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 12231.7 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#7] RegExp Cycles:1 Average:40800.00 Median:40800.00 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 40800.0 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#8] Splay Cycles:1 Average:574.29 Median:574.29 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 574.3 14:23:48 INFO - PROCESS | 24505 | 14:23:48 INFO - PROCESS | 24505 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 14:23:48 INFO - PROCESS | 24505 | Values: 4887.8 14:23:48 INFO - PROCESS | 24505 | -------- Summary: end -------- 14:23:48 INFO - PROCESS | 24505 | 14:23:49 INFO - TEST-INFO | 24505: exit 0 14:23:49 INFO - TEST-OK | v8_7 | took 40282ms 14:23:49 INFO - SUITE-END | took 1209s 14:23:49 INFO - Completed test suite (00:20:09) 14:23:49 INFO - Working with test: dromaeo_css 14:23:49 INFO - Generating results file: dromaeo_css 14:23:49 INFO - Working with test: kraken 14:23:49 INFO - Generating results file: kraken 14:23:49 INFO - javascript benchmark 14:23:49 INFO - Working with test: v8_7 14:23:49 INFO - Generating results file: v8_7 14:23:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:23:50 INFO - process_Request line: dromaeo_css 6715.59 graph.html#tests=[[72,64,43]] 14:23:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:50 INFO - process_Request line: kraken 1525.70 graph.html#tests=[[232,64,43]] 14:23:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:50 INFO - process_Request line: v8_7 20440.85 graph.html#tests=[[230,64,43]] 14:23:50 INFO - RETURN: dromaeo_css: 6715.59 14:23:50 INFO - RETURN: kraken: 1525.70 14:23:50 INFO - RETURN: v8_7: 20440.85 14:23:50 INFO - javascript benchmark 14:23:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.9842600786997, 3186.0760379489934, 3210.759193060521, 3227.661095584963, 3230.4185246655593, 5196.922046169301, 5323.840284791453, 5329.120695085311, 5330.7867685292595, 5340.839774806757, 5196.090684130281, 5258.395284542279, 5262.710550919698, 5365.919511207335, 5410.026195284847, 4766.356541866856, 4830.3237546743485, 4869.975650121744, 4901.730404827733, 4957.182064959277, 4848.6848354857, 4911.582515486188, 4947.060058588857, 4979.228219625964, 5038.168702164138, 4772.73749943753, 4878.487758785312, 4892.6575139740235, 4914.434839993411, 4983.975080124595, 4775.474697783241, 4866.537678920532, 4881.194602890519, 4882.170031094723, 4903.901921961577, 4775.9761201194115, 4793.976030119827, 4795.0409918016185, 4804.855854324341, 4816.56650901417, 5062.645614806965, 5085.466026067246, 5126.282320475137, 5159.613029022838, 5163.3545806774155, 5686.0, 5698.544116470673, 5701.116326969285, 5705.971470142623, 5706.201131841545, 5732.541396688297, 5739.483446489794, 5743.310802703702, 5743.798967036134, 5752.194692743019, 5183.45573714762, 5240.213967904807, 5270.6047046471285, 5340.973295133538, 5379.273798037293, 5793.623414478046, 5800.216970708901, 5803.9419605803405, 5807.128930660435, 5808.273965754281, 5557.277553917965, 5574.16387541872, 5579.358373786985, 5580.386157522669, 5581.134924086773, 5554.50009499147, 5626.606137570331, 5682.204491371212, 5682.829515114553, 5690.2887139107615, 5576.135698966586, 5576.693281869455, 5720.313562372542, 5786.537077033827, 5833.7374818133285, 5653.0, 5697.430256974352, 5705.058665320259, 5708.942910570924, 5709.971450142806, 4297.763623000765, 4433.844815431445, 4435.379046933432, 4441.311596702516, 4462.821487140543, 3900.941485877714, 3958.050067983721, 3959.247742928834, 3979.184267225212, 3994.6604538614542, 5289.788408463618, 5343.171808369709, 5344.198370244417, 5349.491798279158, 5366.731663416814, 5566.916496252559, 5688.544916406678, 5703.686297253691, 5757.453041961007, 5762.423757624288, 5317.867053323621, 5334.413214546396, 5379.246905433242, 5384.730763461811, 5426.810061647902, 4802.519748025239, 4824.445188803263, 4831.903361932742, 4839.056384005085, 4868.02639472107, 5735.713214339266, 5853.356130825606, 5871.794487193013, 5872.383399743051, 5876.147958546072, 5692.715364231689, 5700.059490184073, 5723.914141287801, 5731.283589551306, 5748.0, 5839.036558967723, 5850.0, 5855.853603659943, 5857.00430926752, 5906.940930590639, 5500.339959204921, 5585.1901474286815, 5591.776328946959, 5638.85902852432, 5656.632318899423, 5597.104463286018, 5629.605927585029, 5641.0, 5660.15097735343, 5677.74450149736, 5457.454254574511, 5492.588055895744, 5497.312835895513, 5504.284443022381, 5512.586556008396, 5482.972585137049, 5493.313335833021, 5504.146857237135, 5581.274434323512, 5625.915611265917, 5480.6437581557075, 5496.7526461308535, 5508.752106155152, 5510.3938566758425, 5517.117261238182, 5576.749046292845, 5614.129809879475, 5617.606767526398, 5629.930313240471, 5632.831015069554, 5353.544948679406, 5479.095949168502, 5486.561075114061, 5550.417206193291, 5587.720613969366], "unit": "score", "name": "dojo.html", "value": 5246.389339996039}, {"lowerIsBetter": false, "replicates": [515.1320025756598, 520.3859445853892, 537.981170659027, 545.3973359437821, 548.3392512023013, 35334.64665353349, 36046.2790744185, 36104.0, 36496.635033649654, 36532.817335913314, 39884.0, 40478.19043619126, 40522.79738601303, 40549.0, 40618.59381406185, 8459.788505287386, 8591.656333746674, 8608.913910860905, 8662.6101825418, 8689.913100869006, 8322.62548185333, 8491.448055876379, 8492.575371231414, 8615.138486151365, 8662.0, 8676.566171691422, 8692.087330830267, 8764.56177191141, 8776.64893404263, 8793.340499462534, 8563.44337618056, 8569.35729820266, 8642.178992995656, 8659.69691060813, 8661.0, 8487.363447741443, 8620.310375169971, 8630.697925572575, 8635.52504612246, 8663.480191188486, 39038.80480597607, 39083.21833563341, 39503.802480987695, 39561.60438395608, 39596.20807583861, 3091.8763249469994, 3152.2892454531525, 3256.2313060817546, 3266.248762784549, 3995.300822356105, 29503.40993180146, 30089.398212035856, 30168.24579385511, 30389.392212155853, 31270.530942035886, 3238.1742655622666, 3247.0745837436216, 3265.9346813063844, 3335.8832440864453, 3368.4778859276853, 200024.0, 200200.0, 201586.0, 201714.0, 202296.99999999852, 52911.20633190505, 53276.467235327924, 59199.40800591939, 59257.111143332884, 59336.10995835066, 62382.37617623856, 62790.37209627845, 65072.0, 65345.346546533925, 65352.34647653463, 14410.495632652806, 14539.27303634814, 14591.635209119644, 14596.197209153599, 14598.197099159435, 10800.08199303068, 10929.125669946545, 10934.289271197347, 10939.83590246147, 10940.726481838017, 18945.621087578173, 19057.714134287995, 19167.424977250706, 19226.32707855218, 19275.51811204731, 7774.727884524128, 7913.366930645535, 8055.0, 8069.394795390252, 8108.959455202804, 915.1306259053925, 980.352967041749, 1023.4729114506035, 1078.8921107889148, 1080.394978811852, 25718.6142207867, 25984.610230846552, 26468.073617423684, 26558.070467533544, 27162.864185678944, 1026.43033116621, 1026.9127124194379, 1049.4070849969742, 1062.583169477039, 1089.1069323155095, 14510.854891451161, 14575.271236438135, 14589.781153282709, 14754.336054877556, 15000.774988375184, 353921.0, 356554.0, 357822.0, 358970.0, 359715.0, 53950.73024634852, 54139.72930135324, 54720.72639636776, 54878.0, 54889.72555137199, 1315.3883444198493, 1321.4582021371384, 1324.251797734277, 1338.852726200117, 1344.327836081959, 25248.368790780376, 27302.453950921266, 27388.315292117855, 27650.86174569114, 30986.845065774527, 45511.0, 45703.0, 45994.54005459903, 46075.76962115168, 46086.769566151954, 274497.0, 275417.0, 275689.0, 277025.0, 277193.0, 41253.79373103115, 44370.0, 44545.331820022075, 45012.77493612511, 45304.0, 39345.80327098346, 39725.60274397219, 40023.79988100041, 40118.398224027245, 40397.1920561593, 35524.822375887954, 35598.28803423969, 35952.0, 36029.45955810612, 36864.26271474609, 36668.44997324989, 37099.25801484009, 37919.241615168095, 38063.0, 38348.0, 35496.64503355037, 35583.11042223965, 35818.82090589531, 35938.46092308565, 36061.27877442489, 33090.17274568155, 33834.154146145556, 34059.318813624086, 34220.802271920365, 34339.82830085834, 24740.25779226626, 24928.218731682144, 25312.240632781046, 25314.240572782845, 25579.744202557737], "unit": "score", "name": "ext.html", "value": 18215.327253235464}, {"lowerIsBetter": false, "replicates": [355.7029880050158, 356.16834690996524, 356.5436241610738, 359.7086360048361, 360.21832623207644, 16026.278817453214, 16303.0, 16345.427910023152, 16967.660646787055, 17633.559161020963, 15839.524814255561, 15904.045757254573, 15930.601734956632, 16281.918590407062, 16398.508044758677, 4844.394450693672, 4972.105021096201, 5027.824026159085, 5028.647994640377, 5044.293798868143, 4805.255185446262, 4919.065377578267, 4965.900681986358, 4969.055879382924, 5011.448740638527, 5003.574696150831, 5004.649674522785, 5005.199168133099, 5272.973635131838, 5477.534409575191, 5290.735463226862, 5322.2282768998275, 5322.361316641989, 5342.065138600729, 5383.650062745909, 5014.172661510846, 5265.605079619006, 5266.710330931797, 5270.7628156733035, 5289.259503669489, 12187.573434929824, 12320.876791232062, 17088.2310296037, 19642.607147857107, 19775.703364449546, 2025.9898700506403, 2057.855950083495, 2146.950603207488, 2196.615592271346, 2246.764089770567, 9668.75828104296, 9676.806463870753, 12450.937745311307, 12620.0, 12995.740085198244, 1812.9818701812944, 1834.367143335547, 1835.8623103267175, 1853.091984927376, 1856.7771867376002, 48565.514344856805, 50590.494095058944, 50972.0, 51160.23259651071, 51459.0, 9635.855462168072, 9778.16885564735, 9820.901790982, 9864.95067524672, 9916.900830991597, 12595.181313214794, 12612.306323152132, 12641.557545485864, 12698.047646426556, 12698.873011269769, 7032.789016329519, 7316.195218525958, 7332.230115837867, 7361.558306501627, 7397.8150546236775, 7035.613041282779, 7066.57600543969, 7094.6097964612445, 7107.715691372287, 7113.288671132846, 4249.532551419341, 4279.807408666556, 4289.957100429018, 4292.291771857671, 4301.763403012865, 1785.1788177438264, 1785.4822101590394, 1790.7492950986873, 1792.1487293535727, 1792.97310540342, 435.4817766857493, 438.48040072514175, 440.58144762475774, 458.5048148000152, 923.8798956135794, 10449.529771160316, 10499.107575855985, 10603.975497185469, 10615.31000484966, 10864.239503234856, 429.6927696696814, 429.93980842681424, 434.54372908446004, 437.7701706604058, 448.7397309560447, 5878.617889837147, 5912.9113063304085, 5913.49735272498, 5995.2206213192, 6017.157597936292, 469157.0, 481965.0, 486266.0, 487301.0, 496703.0, 71095.2890471099, 72080.27919720841, 72138.63930680313, 72697.0, 73500.63249683718, 477.90680817240303, 479.89922116355956, 483.2702619045267, 485.10498130948343, 488.25297295139205, 9767.365121267096, 10060.295779295378, 10097.749170431482, 10189.184865210616, 10191.439470829175, 28965.42069158563, 30095.69904300929, 30942.845285773426, 31575.21061973469, 31641.20896977502, 41642.16715665609, 42144.578554214066, 43484.130317394105, 43547.0, 43581.78209109061, 6749.392554670103, 6893.345132212632, 7263.128424589083, 7274.981502589536, 7303.561786292839, 10804.67585972422, 11113.499892504695, 11168.66494005181, 11215.214934954474, 11289.20975531705, 9234.815303694022, 9256.629734810802, 9559.569819358285, 9609.759756005877, 9858.112769850748, 9236.353455258068, 9693.176080033276, 9757.853632195382, 9804.803903921738, 10043.899561004297, 9490.098440648128, 9631.181349585364, 9675.080867317594, 9706.75733106678, 9844.556994935101, 7222.855542889218, 7284.125904891447, 7354.301341372561, 7414.851702965802, 7436.814079648052, 8756.693515726918, 9435.952820235854, 9519.762005949906, 9599.136077753035, 9653.855192171983], "unit": "score", "name": "jquery.html", "value": 7261.478098822565}, {"lowerIsBetter": false, "replicates": [1419.16978567538, 1427.3148888533508, 1568.2315665323988, 1697.702901992151, 1721.0964243772025, 7160.212376638566, 7312.341889229968, 7330.816729581763, 7372.74195403161, 7502.024736784224, 7386.446016548767, 7423.703051877932, 7462.40300775938, 7522.322990930815, 7525.887111693315, 2283.794458498731, 2310.849794763343, 2313.5141620259683, 2314.1553333033407, 2316.293530473205, 2291.2209848651455, 2296.2537175418056, 2309.8383113182085, 2330.0, 2337.2871274261342, 2189.277538412328, 2240.5854916840353, 2242.9439264018365, 2256.199049337486, 2258.3337915315024, 2238.697775800262, 2250.088714070804, 2261.943451413728, 2269.5120549081944, 2278.3165050484954, 2287.8103386239063, 2291.988540057289, 2293.38078718745, 2293.816494680422, 2299.0688771047753, 7228.277172282782, 7267.89098163528, 7272.0546328977425, 7280.599567023812, 7289.671964761598, 4502.774861256957, 4595.195840727859, 4611.700239484423, 4614.515475875019, 4647.6281897448125, 2910.563415487694, 2954.847609432323, 2988.6861879502776, 2997.835119068472, 3027.7275045246033, 983.1250187333208, 992.1071036067597, 1028.8713910761155, 1032.8554002439664, 1038.859753933217, 9722.076402741728, 9852.408855468622, 9877.703668889944, 9885.308028438012, 9908.554115064839, 3933.527976642764, 4053.108316170438, 4092.672586193157, 4094.3244364679495, 4096.795160241976, 8017.078036025815, 8113.0, 8134.389920755967, 8151.79620509492, 8179.386546009073, 4539.978504836386, 4541.591256786905, 4558.430196225472, 4561.749103799323, 4562.749048802281, 4157.875263742093, 4199.0, 4199.643030342394, 4204.66362690984, 4228.492580890313, 3234.6118465783784, 3240.756943229267, 3291.1607540077125, 3292.160499072721, 3303.702666760003, 995.233670074039, 998.8751406074241, 1003.6587560229557, 1004.0963133180196, 1005.261133067195, 1034.5965073621294, 1035.2649618770606, 1084.924055316136, 1173.2725710059647, 1325.4300650720284, 6726.764563240263, 6733.595984240863, 6773.221079575912, 6785.8642827143185, 6818.897716534256, 1113.3264375053138, 1125.1167833251022, 1127.2165844737829, 1129.780270688976, 1135.4833550734395, 5303.071962406563, 5332.9466705333225, 5348.812791552355, 5385.973070134624, 5443.2107344434835, 8421.831563368822, 8568.271696905833, 8675.0, 8743.562821859008, 8955.298493286255, 8394.160583941557, 8468.957655211685, 8489.363297752694, 8508.532030738368, 8537.74386768398, 6722.361375669304, 6862.691178896962, 6931.861362772817, 6953.339432753779, 7006.124234470692, 6797.218319893078, 6826.692798823966, 6835.4189893859575, 6874.828129296608, 6899.862002759816, 7677.961610191914, 7814.33578145864, 7818.921810782047, 7837.686492540234, 7856.057273127033, 7895.131535531202, 7982.922305488684, 8003.159668234985, 8014.679412823655, 8138.83722325562, 6549.115869357575, 6605.702743376463, 6653.367930046637, 6664.266930637723, 6683.3984941353565, 7076.893846592408, 7082.822929426806, 7168.784936451915, 7171.49799514029, 7188.5327453715345, 6069.3354524685665, 6745.12313399255, 6888.655567221719, 7010.053642758367, 7044.859102818017, 6389.073584330339, 6602.0, 6756.45948324123, 6773.525853190229, 6867.484938629723, 6724.0, 6755.7973260802255, 6798.252192258748, 6809.863802724017, 6815.556988795713, 6023.66869822164, 6072.362401947732, 6114.541409394402, 6116.66358350295, 6127.20346354971, 6181.227346581677, 6243.157173781481, 6307.306196318493, 6307.495400368051, 6386.201724784402], "unit": "score", "name": "mootools.html", "value": 4293.704056680885}, {"lowerIsBetter": false, "replicates": [325.79312136793135, 329.9521569372441, 333.45646596048437, 336.6297073219459, 337.1419736769921, 6294.559380843331, 6335.80992570223, 6342.746290148389, 6356.745730170794, 6398.520110991671, 6221.968890155543, 6267.717952692128, 6274.341194174614, 6280.0, 6373.681315934196, 4698.530146985299, 4729.716217026972, 4730.645201609876, 4732.574068333849, 4733.64497662675, 4717.551832575899, 4725.149473094842, 4727.22000869856, 4734.4081989751285, 4737.076270127326, 4619.145458090247, 4691.085238378518, 4709.175894218515, 4711.4346278446465, 4715.740634265114, 4614.192516309649, 4662.7668616569035, 4674.158651442739, 4692.624590032806, 4696.647751418657, 4040.333344998072, 4050.594940505926, 4052.837886484537, 4057.411675307064, 4061.4923134608175, 5955.642661440327, 5991.6405015698765, 5994.97002514989, 5998.700064996777, 6018.608790428608, 5353.812616558402, 5409.107497262947, 5440.075187218143, 5473.945260547383, 5479.479449452296, 6623.4701223901975, 6640.833979150511, 6658.0, 6675.632840193787, 6695.765648202289, 4469.642428605736, 4484.596386325246, 4488.483824360175, 4494.528074552158, 4495.617872480811, 6906.723731050752, 6915.585064896072, 6964.0, 6991.440684745259, 7030.753923612649, 4519.887002824956, 4537.115262523842, 4571.879889427045, 4578.221702310549, 4591.724496530219, 4609.792559334838, 4634.073185362941, 4641.350210970467, 4641.489436162019, 4642.814287428465, 5375.408705042442, 5436.130219164915, 5447.12845944647, 5457.863553411196, 5458.2904222450825, 6592.373724496165, 6710.765123220762, 6716.496262780311, 6717.56335838169, 6744.932550674431, 1591.2123498868134, 1615.7899473068426, 1651.1909164509543, 1657.4861792844015, 1658.2372108830073, 1057.4871187474068, 1071.3678929431517, 1080.9189310801721, 1100.3068067117665, 1105.5688281570194, 6265.780697675559, 6288.5598008138995, 6298.149749783721, 6304.148939893055, 6306.8423289417215, 6784.694688739019, 6788.389044985975, 6802.863942721118, 6848.7260509579055, 6853.348931851466, 6078.331383547807, 6272.372762723782, 6273.372662733781, 6285.9057114143325, 6292.370762923671, 3703.666669999659, 3711.0165806061414, 3717.9218026772473, 3718.1076541630355, 3729.6083911188935, 7096.964515177494, 7107.6446177690905, 7150.3922166615375, 7159.498835081598, 7160.248173941765, 6918.06606108179, 6955.582665040114, 6995.475339349569, 6999.880019196904, 7006.4044556212275, 7320.194778574246, 7347.228541003225, 7351.926480735231, 7369.373603243785, 7392.1499027611435, 6922.169339679271, 6948.478864085315, 6996.755113571001, 6997.930020699728, 7016.789496315118, 6808.080909077211, 6896.413804826646, 6933.237343892067, 6954.513184077268, 6958.547694399847, 7331.266873312626, 7344.265573442613, 7360.116785985716, 7364.5581265124265, 7383.483156179016, 4555.134524440346, 4609.446866376056, 4629.907401851877, 4635.3278774578175, 4647.65142614312, 6878.209005964378, 6931.618760967994, 6991.580505169502, 6997.860042799217, 7005.05431766705, 6797.966010169917, 6807.149106361705, 6818.318168183142, 6824.283450237654, 6852.0749698792015, 6771.3905748482875, 6786.321367863175, 6790.219124800711, 6798.694058767466, 6814.2163651180745, 6528.347165283433, 6650.600963942179, 6669.899951500634, 6671.33286671329, 6671.39957403836, 6826.0, 6827.795166145023, 6838.521303508706, 6851.48613853953, 6853.074834897225, 6630.336966303331, 6655.767048153291, 6658.467322614082, 6664.033715111184, 6692.196936367667], "unit": "score", "name": "prototype.html", "value": 4995.818473074694}, {"lowerIsBetter": false, "replicates": [744.4044764188648, 798.832245228502, 823.1110400767172, 832.7006198111287, 847.3771777743359, 12704.61886143416, 12759.17065390749, 12789.872101278985, 12820.615381538557, 12837.358132093394, 12684.682882927931, 13735.58793236202, 14011.719765604681, 14012.0, 14143.0, 794.900637420324, 804.0391731880405, 804.7062822069931, 805.3919290935336, 813.4671789977574, 808.6320724070533, 811.1280373598375, 812.715549557656, 814.5072231300067, 816.779469543223, 835.7952301686096, 841.1126261793805, 842.7724514381114, 842.9662813487483, 843.2874221283037, 834.0116961400729, 837.8324335132937, 838.0488145954325, 838.266516797802, 841.6759547574197, 617.0158597037718, 618.2148671187566, 618.7215752911208, 620.3517324395972, 620.4292051312804, 13533.0, 13535.45858165682, 13541.796873046913, 13566.593002209851, 13577.524786632519, 11445.828312575319, 12132.332721700302, 12200.572979945659, 12818.743625127445, 13000.28498432586, 10201.285909986304, 10309.53607087683, 10356.741081472948, 10395.84406233907, 10543.73640658982, 3544.3088597723454, 3590.8922732318074, 3649.124210189562, 3659.14010207601, 3775.7734535927934, 43629.56370436287, 43674.56325436737, 44184.779076104736, 44329.55670443254, 44561.77719111416, 9553.235741140692, 9698.030196980246, 9835.409875407498, 9853.113219810251, 9935.254855885838, 16284.185790710417, 16541.25564349607, 16603.833961660228, 16627.916860415862, 17191.914040429718, 7294.234105418961, 7416.369608583331, 7474.551526908403, 7637.732679356196, 7778.338841198562, 4078.6940979426663, 4089.1617218470737, 4090.1410703752545, 4092.4066010428323, 4166.437530933285, 2821.0408461122906, 2824.8870045197964, 2835.957460638092, 2838.44650293195, 2858.8713507892194, 517.4721783780523, 529.1507131054678, 535.0556268186654, 535.3602445078172, 538.3620409814382, 533.6397931396292, 541.4342012596845, 552.7927027364739, 653.369498434004, 689.899964505154, 8255.669773209125, 8265.256126948603, 8363.330933525425, 8494.362922780692, 8562.100979397199, 522.12323498027, 608.8203979825962, 613.6594190224469, 630.8265227062594, 647.6049609738056, 3934.940975885364, 4015.156817068448, 4019.0957034666967, 4048.817803198863, 4114.614267390042, 53083.46916530863, 54057.0, 54141.58584141633, 54294.0, 54305.72847135739, 46360.304595431095, 47652.0, 47817.0, 47858.0, 48096.7595162022, 42985.14029719388, 43025.78487107545, 43051.35422968658, 43207.35188972168, 43698.12603747907, 7753.147153812964, 7859.764207073568, 7937.496574369836, 8168.0, 8232.547209903512, 32766.34467310688, 32810.343793123524, 33363.0, 33364.66635333616, 33367.662203913336, 38568.6143138565, 38792.80603596964, 42105.78947105245, 42510.0, 42828.5717142837, 9872.901270987199, 9925.602975880884, 9960.701178964642, 10229.539670714687, 10379.273450858367, 12741.745165096461, 13018.739625207632, 13072.346382680638, 13100.737985240052, 13449.955272835625, 11148.275362101438, 11596.246243994114, 12064.914157725847, 12218.51125954952, 12669.493220271086, 11528.308301501937, 11530.76938461243, 11712.824307635563, 11826.053915686896, 12171.2697238166, 11824.99487543534, 11839.704007399883, 11869.762604747684, 11883.702907427038, 12231.327276999495, 9483.193928516153, 9628.229741620793, 9776.0, 9835.16401105914, 9874.654387096705, 9506.572204250964, 10034.949825250827, 10063.849042264226, 10188.592456301665, 10235.7441063974], "unit": "score", "name": "yui.html", "value": 6161.802677275421}], "name": "dromaeo_css", "value": 6715.592552984444}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 112.0, 114.0, 124.0, 114.0, 114.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 150.0, 159.0, 136.0, 153.0, 147.0, 133.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 168.0, 164.0, 162.0, 161.0, 166.0, 168.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 75.0, 73.0, 72.0, 72.0, 72.0, 149.0, 71.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 145.0, 97.0, 96.0, 97.0, 138.0, 95.0, 97.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 109.0, 109.0, 109.0, 109.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 56.0, 56.0, 58.0, 57.0, 58.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 69.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [86.0, 94.0, 87.0, 88.0, 87.0, 87.0, 87.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 140.0, 124.0, 122.0, 123.0, 116.0, 124.0, 133.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 153.0, 152.0, 153.0, 149.0, 156.0, 153.0, 160.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 71.0, 69.0, 72.0, 71.0, 72.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1525.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [190.8761213972132], "unit": "score", "name": "DeltaBlue", "value": 346.39220200000005}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [721.5007215007215], "unit": "score", "name": "Earley", "value": 923.7177179999996}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [40800.0], "unit": "score", "name": "RegExp", "value": 22.328063725490182}, {"lowerIsBetter": false, "replicates": [574.2857142857143], "unit": "score", "name": "Splay", "value": 141.89975124378108}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 20440.84969002071}]} 14:23:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20440.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1525.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6715.59"}}} 14:23:50 INFO - Return code: 0 14:23:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:50 INFO - # TBPL SUCCESS # 14:23:50 INFO - Running post-action listener: _resource_record_post_action 14:23:50 INFO - Running post-run listener: _resource_record_post_run 14:23:51 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 564477952; Read time: 0; Write time: 463024 14:23:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245903360; Read time: 0; Write time: 262972 14:23:51 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 318574592; Read time: 0; Write time: 200052 14:23:51 INFO - Running post-run listener: _upload_blobber_files 14:23:51 INFO - Blob upload gear active. 14:23:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:23:51 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 14:23:51 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'] 14:23:51 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 14:23:51 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:52 INFO - (blobuploader) - INFO - Done attempting. 14:23:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:23:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:53 INFO - (blobuploader) - INFO - Done attempting. 14:23:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:53 INFO - Return code: 0 14:23:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:23:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e408297ba5244d9774360d5f43b49463427b3f34104ce9442ed13323a35c8fe46775f10744d7517c12420b355688226fa055fadd91cdcda4de10b5cb1df5af73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cc1583153db292f4a9a709c495b56489878a123fb3e560061f4e228febf6bf283efbae56c4de8a0e1cf13b27820b0ee8944350157cb94208e15c54f95e5b3e2"} 14:23:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:23:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:23:53 INFO - Contents: 14:23:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e408297ba5244d9774360d5f43b49463427b3f34104ce9442ed13323a35c8fe46775f10744d7517c12420b355688226fa055fadd91cdcda4de10b5cb1df5af73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cc1583153db292f4a9a709c495b56489878a123fb3e560061f4e228febf6bf283efbae56c4de8a0e1cf13b27820b0ee8944350157cb94208e15c54f95e5b3e2"} 14:23:53 INFO - Copying logs to upload dir... 14:23:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1285.978815 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-10 14:23:51.991234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:51.995221) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 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/e408297ba5244d9774360d5f43b49463427b3f34104ce9442ed13323a35c8fe46775f10744d7517c12420b355688226fa055fadd91cdcda4de10b5cb1df5af73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cc1583153db292f4a9a709c495b56489878a123fb3e560061f4e228febf6bf283efbae56c4de8a0e1cf13b27820b0ee8944350157cb94208e15c54f95e5b3e2"} build_url:https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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/e408297ba5244d9774360d5f43b49463427b3f34104ce9442ed13323a35c8fe46775f10744d7517c12420b355688226fa055fadd91cdcda4de10b5cb1df5af73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4cc1583153db292f4a9a709c495b56489878a123fb3e560061f4e228febf6bf283efbae56c4de8a0e1cf13b27820b0ee8944350157cb94208e15c54f95e5b3e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:52.025439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:52.026158) ========= 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=1b9da9da7504fe468691862d000001b9-1452455402.203897-919832691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:52.107897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 14:23:52.108592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 14:23:52.109257) ========= ========= Total master_lag: 0.30 =========