builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1450756709.7 results: success (0) buildid: 20151221173004 builduid: bdf4ecaafe9e45f0bb1bba276577c459 revision: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.700256) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.700763) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.701060) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006276 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.725677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.726031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.741205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.741770) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.791662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.791989) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.792450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.792783) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 19:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-21 19:58:30 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.948972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.949316) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022179 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.999451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:29.999827) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 69b5cacf1cbbdb7f47dc775c17db96482d5123eb --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 69b5cacf1cbbdb7f47dc775c17db96482d5123eb --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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 19:58:30,252 truncating revision to first 12 chars 2015-12-21 19:58:30,252 Setting DEBUG logging. 2015-12-21 19:58:30,252 attempt 1/10 2015-12-21 19:58:30,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/69b5cacf1cbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 19:58:30,496 unpacking tar archive at: fx-team-69b5cacf1cbb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:30.524131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:30.524411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:30.537408) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:30.537647) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 19:58:30.538021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 19:58:30.538344) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:30 INFO - MultiFileLogger online at 20151221 19:58:30 in /builds/slave/test-pgo 19:58:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:58:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:58:30 INFO - {'append_to_log': False, 19:58:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:58:30 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:58:30 INFO - 'branch': 'Fx-Team', 19:58:30 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:30 INFO - 'config_files': ('talos/linux_config.py',), 19:58:30 INFO - 'default_actions': ('clobber', 19:58:30 INFO - 'read-buildbot-config', 19:58:30 INFO - 'download-and-extract', 19:58:30 INFO - 'populate-webroot', 19:58:30 INFO - 'create-virtualenv', 19:58:30 INFO - 'install', 19:58:30 INFO - 'run-tests'), 19:58:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:30 INFO - 'download_minidump_stackwalk': True, 19:58:30 INFO - 'download_symbols': 'ondemand', 19:58:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:30 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:30 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:30 INFO - 'installer_path': 'installer.exe', 19:58:30 INFO - 'log_level': 'info', 19:58:30 INFO - 'log_name': 'talos', 19:58:30 INFO - 'log_to_console': True, 19:58:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:30 INFO - 'opt_config_files': (), 19:58:30 INFO - 'pip_index': False, 19:58:30 INFO - 'sps_profile': False, 19:58:30 INFO - 'sps_profile_interval': 0, 19:58:30 INFO - 'suite': 'dromaeojs', 19:58:30 INFO - 'system_bits': '64', 19:58:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:30 INFO - 'title': 'talos-linux64-ix-014', 19:58:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:30 INFO - 'use_talos_json': True, 19:58:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:58:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:30 INFO - 'work_dir': 'build'} 19:58:30 INFO - ##### 19:58:30 INFO - ##### Running clobber step. 19:58:30 INFO - ##### 19:58:30 INFO - Running pre-action listener: _resource_record_pre_action 19:58:30 INFO - Running main action method: clobber 19:58:30 INFO - rmtree: /builds/slave/test-pgo/build 19:58:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:58:31 INFO - Running post-action listener: _resource_record_post_action 19:58:31 INFO - ##### 19:58:31 INFO - ##### Running read-buildbot-config step. 19:58:31 INFO - ##### 19:58:31 INFO - Running pre-action listener: _resource_record_pre_action 19:58:31 INFO - Running main action method: read_buildbot_config 19:58:31 INFO - Using buildbot properties: 19:58:31 INFO - { 19:58:31 INFO - "project": "", 19:58:31 INFO - "product": "firefox", 19:58:31 INFO - "script_repo_revision": "production", 19:58:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:31 INFO - "repository": "", 19:58:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:58:31 INFO - "buildid": "20151221173004", 19:58:31 INFO - "pgo_build": "True", 19:58:31 INFO - "basedir": "/builds/slave/test-pgo", 19:58:31 INFO - "buildnumber": 381, 19:58:31 INFO - "slavename": "talos-linux64-ix-014", 19:58:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:58:31 INFO - "platform": "ubuntu64_hw", 19:58:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:31 INFO - "branch": "fx-team", 19:58:31 INFO - "repo_path": "integration/fx-team", 19:58:31 INFO - "revision": "69b5cacf1cbbdb7f47dc775c17db96482d5123eb", 19:58:31 INFO - "stage_platform": "linux64-pgo", 19:58:31 INFO - "builduid": "bdf4ecaafe9e45f0bb1bba276577c459", 19:58:31 INFO - "slavebuilddir": "test" 19:58:31 INFO - } 19:58:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:58:31 INFO - Running post-action listener: _resource_record_post_action 19:58:31 INFO - ##### 19:58:31 INFO - ##### Running download-and-extract step. 19:58:31 INFO - ##### 19:58:31 INFO - Running pre-action listener: _resource_record_pre_action 19:58:31 INFO - Running main action method: download_and_extract 19:58:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:31 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json 19:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json 19:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:58:32 INFO - Downloaded 1302 bytes. 19:58:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:58:32 INFO - Using the following test package requirements: 19:58:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'jsshell-linux-x86_64.zip'], 19:58:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58: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')]} 19:58:32 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:34 INFO - Downloaded 23175441 bytes. 19:58:34 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 19:58:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:34 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 19:58:35 INFO - Return code: 0 19:58:35 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 19:58:35 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')]} 19:58:35 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:37 INFO - Downloaded 23175441 bytes. 19:58:37 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 19:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:58:37 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 19:58:38 INFO - Return code: 0 19:58: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')]} 19:58:38 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:40 INFO - Downloaded 11132277 bytes. 19:58:40 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 19:58:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:40 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 19:58:40 INFO - Return code: 0 19:58:40 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')]} 19:58:40 INFO - https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/7baXyc9xSnG_pwLNqXq5iw/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 19:58:42 INFO - Downloaded 54880087 bytes. 19:58:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:42 INFO - mkdir: /builds/slave/test-pgo/properties 19:58:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:58:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:58:42 INFO - Contents: 19:58:42 INFO - build_url:https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:58:42 INFO - Running post-action listener: _resource_record_post_action 19:58:42 INFO - Running post-action listener: set_extra_try_arguments 19:58:42 INFO - ##### 19:58:42 INFO - ##### Running populate-webroot step. 19:58:42 INFO - ##### 19:58:42 INFO - Running pre-action listener: _resource_record_pre_action 19:58:42 INFO - Running main action method: populate_webroot 19:58:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:42 INFO - '--tppagecycles', 19:58:42 INFO - '7'], 19:58:42 INFO - 'tests': ['tsvgm']}}, 19:58:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:58:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'tests': ['damp', 'tps']}, 19:58:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['damp', 'tps']}, 19:58:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:42 INFO - 'other': {'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'other_l64': {'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:42 INFO - 'ts_paint', 19:58:42 INFO - 'tpaint', 19:58:42 INFO - 'sessionrestore', 19:58:42 INFO - 'sessionrestore_no_auto_restore']}, 19:58:42 INFO - 'svgr': {'tests': ['tsvgx', 19:58:42 INFO - 'tsvgr_opacity', 19:58:42 INFO - 'tart', 19:58:42 INFO - 'tscrollx', 19:58:42 INFO - 'cart']}, 19:58:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['tsvgx', 19:58:42 INFO - 'tsvgr_opacity', 19:58:42 INFO - 'tart', 19:58:42 INFO - 'tscrollx', 19:58:42 INFO - 'cart']}, 19:58:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'tests': ['tp5o']}, 19:58:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'talos_options': ['--e10s'], 19:58:42 INFO - 'tests': ['tp5o']}, 19:58:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'talos_options': ['--xperf_path', 19:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:42 INFO - 'tests': ['tp5n']}, 19:58:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:42 INFO - 'talos_options': ['--e10s', 19:58:42 INFO - '--xperf_path', 19:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:42 INFO - 'tests': ['tp5n']}}, 19:58:42 INFO - 'talos.zip': {'path': '', 19:58:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:42 INFO - Running post-action listener: _resource_record_post_action 19:58:42 INFO - ##### 19:58:42 INFO - ##### Running create-virtualenv step. 19:58:42 INFO - ##### 19:58:42 INFO - Running pre-action listener: _resource_record_pre_action 19:58:42 INFO - Running main action method: create_virtualenv 19:58:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:58:42 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 19:58:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:58:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:42 INFO - Using real prefix '/usr' 19:58:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:58:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:44 INFO - Installing pip.................done. 19:58:44 INFO - Return code: 0 19:58:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:58:44 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')]} 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 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')]} 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:44 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 19:58:44 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 19:58:44 INFO - Using env: {'DISPLAY': ':0', 19:58:44 INFO - 'HOME': '/home/cltbld', 19:58:44 INFO - 'LANG': 'en_US.UTF-8', 19:58:44 INFO - 'LANGUAGE': 'en_US:en', 19:58:44 INFO - 'LOGNAME': 'cltbld', 19:58:44 INFO - 'MAIL': '/var/mail/cltbld', 19:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:44 INFO - 'MOZ_NO_REMOTE': '1', 19:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:44 INFO - 'NO_EM_RESTART': '1', 19:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:44 INFO - 'SHELL': '/bin/bash', 19:58:44 INFO - 'SHLVL': '1', 19:58:44 INFO - 'TERM': 'linux', 19:58:44 INFO - 'TMOUT': '86400', 19:58:44 INFO - 'USER': 'cltbld', 19:58:44 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:44 INFO - '_': '/tools/buildbot/bin/python'} 19:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:44 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 19:58:44 INFO - Cleaning up... 19:58:44 INFO - Return code: 0 19:58:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:58:44 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')]} 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 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')]} 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:44 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 19:58:44 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 19:58:44 INFO - Using env: {'DISPLAY': ':0', 19:58:44 INFO - 'HOME': '/home/cltbld', 19:58:44 INFO - 'LANG': 'en_US.UTF-8', 19:58:44 INFO - 'LANGUAGE': 'en_US:en', 19:58:44 INFO - 'LOGNAME': 'cltbld', 19:58:44 INFO - 'MAIL': '/var/mail/cltbld', 19:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:44 INFO - 'MOZ_NO_REMOTE': '1', 19:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:44 INFO - 'NO_EM_RESTART': '1', 19:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:44 INFO - 'SHELL': '/bin/bash', 19:58:44 INFO - 'SHLVL': '1', 19:58:44 INFO - 'TERM': 'linux', 19:58:44 INFO - 'TMOUT': '86400', 19:58:44 INFO - 'USER': 'cltbld', 19:58:44 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:44 INFO - '_': '/tools/buildbot/bin/python'} 19:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:45 INFO - Downloading/unpacking psutil>=0.7.1 19:58:45 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 19:58:45 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 19:58:45 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 19:58:45 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 19:58:45 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 19:58:45 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 19:58:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:46 INFO - Installing collected packages: psutil 19:58:46 INFO - Running setup.py install for psutil 19:58:47 INFO - building 'psutil._psutil_linux' extension 19:58:47 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 19:58:47 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 19:58:47 INFO - building 'psutil._psutil_posix' extension 19:58:47 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 19:58:47 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 19:58:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:47 INFO - Successfully installed psutil 19:58:47 INFO - Cleaning up... 19:58:47 INFO - Return code: 0 19:58:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:58:47 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')]} 19:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 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')]} 19:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:47 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 19:58:47 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 19:58:47 INFO - Using env: {'DISPLAY': ':0', 19:58:47 INFO - 'HOME': '/home/cltbld', 19:58:47 INFO - 'LANG': 'en_US.UTF-8', 19:58:47 INFO - 'LANGUAGE': 'en_US:en', 19:58:47 INFO - 'LOGNAME': 'cltbld', 19:58:47 INFO - 'MAIL': '/var/mail/cltbld', 19:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:47 INFO - 'MOZ_NO_REMOTE': '1', 19:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:47 INFO - 'NO_EM_RESTART': '1', 19:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:47 INFO - 'SHELL': '/bin/bash', 19:58:47 INFO - 'SHLVL': '1', 19:58:47 INFO - 'TERM': 'linux', 19:58:47 INFO - 'TMOUT': '86400', 19:58:47 INFO - 'USER': 'cltbld', 19:58:47 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:47 INFO - '_': '/tools/buildbot/bin/python'} 19:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:58:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:58:49 INFO - Installing collected packages: mozsystemmonitor 19:58:49 INFO - Running setup.py install for mozsystemmonitor 19:58:49 INFO - Successfully installed mozsystemmonitor 19:58:49 INFO - Cleaning up... 19:58:49 INFO - Return code: 0 19:58:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:49 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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:49 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 19:58:49 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 19:58:49 INFO - Using env: {'DISPLAY': ':0', 19:58:49 INFO - 'HOME': '/home/cltbld', 19:58:49 INFO - 'LANG': 'en_US.UTF-8', 19:58:49 INFO - 'LANGUAGE': 'en_US:en', 19:58:49 INFO - 'LOGNAME': 'cltbld', 19:58:49 INFO - 'MAIL': '/var/mail/cltbld', 19:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:49 INFO - 'MOZ_NO_REMOTE': '1', 19:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:49 INFO - 'NO_EM_RESTART': '1', 19:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:49 INFO - 'SHELL': '/bin/bash', 19:58:49 INFO - 'SHLVL': '1', 19:58:49 INFO - 'TERM': 'linux', 19:58:49 INFO - 'TMOUT': '86400', 19:58:49 INFO - 'USER': 'cltbld', 19:58:49 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:49 INFO - '_': '/tools/buildbot/bin/python'} 19:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:49 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 19:58:49 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 19:58:49 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 19:58:49 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 19:58:49 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 19:58:49 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 19:58:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:58:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:51 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 19:58:52 INFO - Downloading docopt-0.6.1.tar.gz 19:58:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:52 INFO - Running setup.py install for blobuploader 19:58:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:58:52 INFO - Running setup.py install for requests 19:58:52 INFO - Running setup.py install for docopt 19:58:52 INFO - Successfully installed blobuploader requests docopt 19:58:52 INFO - Cleaning up... 19:58:52 INFO - Return code: 0 19:58:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:52 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')]} 19:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:52 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')]} 19:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:52 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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:52 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 19:58:52 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 19:58:52 INFO - Using env: {'DISPLAY': ':0', 19:58:52 INFO - 'HOME': '/home/cltbld', 19:58:52 INFO - 'LANG': 'en_US.UTF-8', 19:58:52 INFO - 'LANGUAGE': 'en_US:en', 19:58:52 INFO - 'LOGNAME': 'cltbld', 19:58:52 INFO - 'MAIL': '/var/mail/cltbld', 19:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:52 INFO - 'MOZ_NO_REMOTE': '1', 19:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:52 INFO - 'NO_EM_RESTART': '1', 19:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:52 INFO - 'SHELL': '/bin/bash', 19:58:52 INFO - 'SHLVL': '1', 19:58:52 INFO - 'TERM': 'linux', 19:58:52 INFO - 'TMOUT': '86400', 19:58:52 INFO - 'USER': 'cltbld', 19:58:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:52 INFO - '_': '/tools/buildbot/bin/python'} 19:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:53 INFO - Running setup.py (path:/tmp/pip-XmmQs_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:53 INFO - Running setup.py (path:/tmp/pip-OnLMa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:53 INFO - Running setup.py (path:/tmp/pip-2XvTk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:53 INFO - Running setup.py (path:/tmp/pip-OW2RAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:53 INFO - Running setup.py (path:/tmp/pip-el0BB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:53 INFO - Running setup.py (path:/tmp/pip-hyIcZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:53 INFO - Running setup.py (path:/tmp/pip-5QWMMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:53 INFO - Running setup.py (path:/tmp/pip-Va8JqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:53 INFO - Running setup.py (path:/tmp/pip-dEcpyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:53 INFO - Running setup.py (path:/tmp/pip-DjrNlu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:53 INFO - Running setup.py (path:/tmp/pip-D1NEbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:53 INFO - Running setup.py (path:/tmp/pip-EbddXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:53 INFO - Running setup.py (path:/tmp/pip-ot6CmP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:53 INFO - Running setup.py (path:/tmp/pip-ZozbY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:54 INFO - Running setup.py (path:/tmp/pip-foQUo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:54 INFO - Running setup.py (path:/tmp/pip-aLa_xx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:54 INFO - Running setup.py (path:/tmp/pip-6pq4OC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:54 INFO - Running setup.py install for manifestparser 19:58:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:58:54 INFO - Running setup.py install for mozcrash 19:58:54 INFO - Running setup.py install for mozdebug 19:58:54 INFO - Running setup.py install for mozdevice 19:58:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:58:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:58:54 INFO - Running setup.py install for mozfile 19:58:54 INFO - Running setup.py install for mozhttpd 19:58:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:58:54 INFO - Running setup.py install for mozinfo 19:58:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:58:54 INFO - Running setup.py install for mozInstall 19:58:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Running setup.py install for mozleak 19:58:55 INFO - Running setup.py install for mozlog 19:58:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Running setup.py install for moznetwork 19:58:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Running setup.py install for mozprocess 19:58:55 INFO - Running setup.py install for mozprofile 19:58:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Running setup.py install for mozrunner 19:58:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:58:55 INFO - Running setup.py install for mozscreenshot 19:58:55 INFO - Running setup.py install for moztest 19:58:55 INFO - Running setup.py install for mozversion 19:58:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:58:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:56 INFO - Cleaning up... 19:58:56 INFO - Return code: 0 19:58:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58: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')]} 19:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:56 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 19:58:56 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 19:58:56 INFO - Using env: {'DISPLAY': ':0', 19:58:56 INFO - 'HOME': '/home/cltbld', 19:58:56 INFO - 'LANG': 'en_US.UTF-8', 19:58:56 INFO - 'LANGUAGE': 'en_US:en', 19:58:56 INFO - 'LOGNAME': 'cltbld', 19:58:56 INFO - 'MAIL': '/var/mail/cltbld', 19:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:56 INFO - 'MOZ_NO_REMOTE': '1', 19:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:56 INFO - 'NO_EM_RESTART': '1', 19:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:56 INFO - 'SHELL': '/bin/bash', 19:58:56 INFO - 'SHLVL': '1', 19:58:56 INFO - 'TERM': 'linux', 19:58:56 INFO - 'TMOUT': '86400', 19:58:56 INFO - 'USER': 'cltbld', 19:58:56 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:56 INFO - '_': '/tools/buildbot/bin/python'} 19:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:56 INFO - Running setup.py (path:/tmp/pip-hyfjyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:56 INFO - Running setup.py (path:/tmp/pip-9J4sHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:56 INFO - Running setup.py (path:/tmp/pip-LVY4oQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:56 INFO - Running setup.py (path:/tmp/pip-oucgN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:56 INFO - Running setup.py (path:/tmp/pip-2s_l7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:56 INFO - Running setup.py (path:/tmp/pip-FqNGE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:56 INFO - Running setup.py (path:/tmp/pip-0sFiAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:56 INFO - Running setup.py (path:/tmp/pip-O8BmPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:56 INFO - Running setup.py (path:/tmp/pip-MEM07P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:56 INFO - Running setup.py (path:/tmp/pip-RjE3An-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:56 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)) 19:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:56 INFO - Running setup.py (path:/tmp/pip-wGhEkb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:57 INFO - Running setup.py (path:/tmp/pip-cESeYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:57 INFO - Running setup.py (path:/tmp/pip-8UFRPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:57 INFO - Running setup.py (path:/tmp/pip-qkkk7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:57 INFO - Running setup.py (path:/tmp/pip-WVC7nt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:57 INFO - Running setup.py (path:/tmp/pip-w0cgKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:57 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)) 19:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:57 INFO - Running setup.py (path:/tmp/pip-P1xeUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:57 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)) 19:58:57 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)) 19:58:57 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)) 19:58:57 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)) 19:58:57 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)) 19:58:57 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)) 19:58:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:59 INFO - Downloading blessings-1.5.1.tar.gz 19:58:59 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 19:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:59 INFO - Installing collected packages: blessings 19:58:59 INFO - Running setup.py install for blessings 19:58:59 INFO - Successfully installed blessings 19:58:59 INFO - Cleaning up... 19:58:59 INFO - Return code: 0 19:58:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:59 INFO - Reading from file tmpfile_stdout 19:58:59 INFO - Current package versions: 19:58:59 INFO - argparse == 1.2.1 19:58:59 INFO - blessings == 1.5.1 19:58:59 INFO - blobuploader == 1.2.4 19:58:59 INFO - docopt == 0.6.1 19:58:59 INFO - manifestparser == 1.1 19:58:59 INFO - mozInstall == 1.12 19:58:59 INFO - mozcrash == 0.16 19:58:59 INFO - mozdebug == 0.1 19:58:59 INFO - mozdevice == 0.47 19:58:59 INFO - mozfile == 1.2 19:58:59 INFO - mozhttpd == 0.7 19:58:59 INFO - mozinfo == 0.9 19:58:59 INFO - mozleak == 0.1 19:58:59 INFO - mozlog == 3.1 19:58:59 INFO - moznetwork == 0.27 19:58:59 INFO - mozprocess == 0.22 19:58:59 INFO - mozprofile == 0.28 19:58:59 INFO - mozrunner == 6.11 19:58:59 INFO - mozscreenshot == 0.1 19:58:59 INFO - mozsystemmonitor == 0.0 19:58:59 INFO - moztest == 0.7 19:58:59 INFO - mozversion == 1.4 19:58:59 INFO - psutil == 3.1.1 19:58:59 INFO - requests == 1.2.3 19:58:59 INFO - wsgiref == 0.1.2 19:58:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:59 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 19:58:59 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 19:58:59 INFO - Using env: {'DISPLAY': ':0', 19:58:59 INFO - 'HOME': '/home/cltbld', 19:58:59 INFO - 'LANG': 'en_US.UTF-8', 19:58:59 INFO - 'LANGUAGE': 'en_US:en', 19:58:59 INFO - 'LOGNAME': 'cltbld', 19:58:59 INFO - 'MAIL': '/var/mail/cltbld', 19:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:59 INFO - 'MOZ_NO_REMOTE': '1', 19:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:59 INFO - 'NO_EM_RESTART': '1', 19:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:59 INFO - 'SHELL': '/bin/bash', 19:58:59 INFO - 'SHLVL': '1', 19:58:59 INFO - 'TERM': 'linux', 19:58:59 INFO - 'TMOUT': '86400', 19:58:59 INFO - 'USER': 'cltbld', 19:58:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:59 INFO - '_': '/tools/buildbot/bin/python'} 19:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 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)) 19:58:59 INFO - Cleaning up... 19:58:59 INFO - Return code: 0 19:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:58:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:58:59 INFO - Using env: {'DISPLAY': ':0', 19:58:59 INFO - 'HOME': '/home/cltbld', 19:58:59 INFO - 'LANG': 'en_US.UTF-8', 19:58:59 INFO - 'LANGUAGE': 'en_US:en', 19:58:59 INFO - 'LOGNAME': 'cltbld', 19:58:59 INFO - 'MAIL': '/var/mail/cltbld', 19:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:59 INFO - 'MOZ_NO_REMOTE': '1', 19:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:59 INFO - 'NO_EM_RESTART': '1', 19:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:59 INFO - 'SHELL': '/bin/bash', 19:58:59 INFO - 'SHLVL': '1', 19:58:59 INFO - 'TERM': 'linux', 19:58:59 INFO - 'TMOUT': '86400', 19:58:59 INFO - 'USER': 'cltbld', 19:58:59 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:59 INFO - '_': '/tools/buildbot/bin/python'} 19:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:00 INFO - Downloading/unpacking jsonschema 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:01 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 19:59:01 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:01 INFO - warning: no files found matching '*.txt' 19:59:01 INFO - no previously-included directories found matching 'build' 19:59:01 INFO - no previously-included directories found matching 'dist' 19:59:01 INFO - no previously-included directories found matching '.git*' 19:59:02 INFO - Installing collected packages: jsonschema, functools32 19:59:02 INFO - Running setup.py install for functools32 19:59:02 INFO - warning: no files found matching '*.txt' 19:59:02 INFO - no previously-included directories found matching 'build' 19:59:02 INFO - no previously-included directories found matching 'dist' 19:59:02 INFO - no previously-included directories found matching '.git*' 19:59:02 INFO - Successfully installed jsonschema functools32 19:59:02 INFO - Cleaning up... 19:59:02 INFO - Return code: 0 19:59:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd5df9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bac480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, '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': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', '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 19:59: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', 'flake8'] in /builds/slave/test-pgo/build 19:59: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 flake8 19:59:02 INFO - Using env: {'DISPLAY': ':0', 19:59:02 INFO - 'HOME': '/home/cltbld', 19:59:02 INFO - 'LANG': 'en_US.UTF-8', 19:59:02 INFO - 'LANGUAGE': 'en_US:en', 19:59:02 INFO - 'LOGNAME': 'cltbld', 19:59:02 INFO - 'MAIL': '/var/mail/cltbld', 19:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:02 INFO - 'MOZ_NO_REMOTE': '1', 19:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:02 INFO - 'NO_EM_RESTART': '1', 19:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:02 INFO - 'SHELL': '/bin/bash', 19:59:02 INFO - 'SHLVL': '1', 19:59:02 INFO - 'TERM': 'linux', 19:59:02 INFO - 'TMOUT': '86400', 19:59:02 INFO - 'USER': 'cltbld', 19:59:02 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:02 INFO - '_': '/tools/buildbot/bin/python'} 19:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:02 INFO - Downloading/unpacking flake8 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:04 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 19:59:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:04 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 19:59:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 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 19:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:04 INFO - no previously-included directories found matching 'docs/_build' 19:59:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:04 INFO - Running setup.py install for pep8 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:04 INFO - no previously-included directories found matching 'docs/_build' 19:59:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:59:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:04 INFO - Cleaning up... 19:59:05 INFO - Return code: 0 19:59:05 INFO - Running post-action listener: _resource_record_post_action 19:59:05 INFO - Running post-action listener: _start_resource_monitoring 19:59:05 INFO - Starting resource monitoring. 19:59:05 INFO - ##### 19:59:05 INFO - ##### Running install step. 19:59:05 INFO - ##### 19:59:05 INFO - Running pre-action listener: _resource_record_pre_action 19:59:05 INFO - Running main action method: install 19:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:59:05 INFO - Reading from file tmpfile_stdout 19:59:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:59:05 INFO - Reading from file tmpfile_stdout 19:59:05 INFO - Output received: 19:59:05 INFO - Usage: mozinstall [options] installer 19:59:05 INFO - Options: 19:59:05 INFO - -h, --help show this help message and exit 19:59:05 INFO - -d DEST, --destination=DEST 19:59:05 INFO - Directory to install application into. [default: 19:59:05 INFO - "/builds/slave/test-pgo"] 19:59:05 INFO - --app=APP Application being installed. [default: firefox] 19:59:05 INFO - mkdir: /builds/slave/test-pgo/build/application 19:59:05 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'] 19:59:05 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 19:59:21 INFO - Reading from file tmpfile_stdout 19:59:21 INFO - Output received: 19:59:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:59:21 INFO - Running post-action listener: _resource_record_post_action 19:59:21 INFO - ##### 19:59:21 INFO - ##### Running run-tests step. 19:59:21 INFO - ##### 19:59:21 INFO - Running pre-action listener: _resource_record_pre_action 19:59:21 INFO - Running main action method: run_tests 19:59:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:59:21 INFO - Python 2.7.3 19:59:21 INFO - Return code: 0 19:59:21 INFO - grabbing minidump binary from tooltool 19:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:21 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 0x2c3b660>, '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 0x2c3c560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ca10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:59:21 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 19:59:21 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 19:59:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:21 INFO - Return code: 0 19:59:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:59:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:59:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:59:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:59:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:59:22 INFO - Return code: 0 19:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:59:22 INFO - Using env: {'DISPLAY': ':0', 19:59:22 INFO - 'HOME': '/home/cltbld', 19:59:22 INFO - 'LANG': 'en_US.UTF-8', 19:59:22 INFO - 'LANGUAGE': 'en_US:en', 19:59:22 INFO - 'LOGNAME': 'cltbld', 19:59:22 INFO - 'MAIL': '/var/mail/cltbld', 19:59:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:22 INFO - 'MOZ_NO_REMOTE': '1', 19:59:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:22 INFO - 'NO_EM_RESTART': '1', 19:59:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:59:22 INFO - 'SHELL': '/bin/bash', 19:59:22 INFO - 'SHLVL': '1', 19:59:22 INFO - 'TERM': 'linux', 19:59:22 INFO - 'TMOUT': '86400', 19:59:22 INFO - 'USER': 'cltbld', 19:59:22 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682', 19:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:22 INFO - '_': '/tools/buildbot/bin/python'} 19:59:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:59:22 INFO - mozversion application_buildid: 20151221173004 19:59:22 INFO - mozversion application_changeset: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb 19:59:22 INFO - mozversion application_display_name: Nightly 19:59:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:22 INFO - mozversion application_name: Firefox 19:59:22 INFO - mozversion application_remotingname: firefox 19:59:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:22 INFO - mozversion application_vendor: Mozilla 19:59:22 INFO - mozversion application_version: 46.0a1 19:59:22 INFO - mozversion platform_buildid: 20151221173004 19:59:22 INFO - mozversion platform_changeset: 69b5cacf1cbbdb7f47dc775c17db96482d5123eb 19:59:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:22 INFO - mozversion platform_version: 46.0a1 19:59:22 INFO - using testdate: 1450756762 19:59:22 INFO - actual date: 1450756762 19:59:22 INFO - starting webserver on 'localhost:56384' 19:59:22 INFO - SUITE-START | Running 3 tests 19:59:22 INFO - TEST-START | dromaeo_css 19:59:22 INFO - operating with platform_type : linux_ 19:59:22 INFO - Initialising browser for dromaeo_css test... 19:59:22 INFO - TEST-INFO | started process 23670 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCHbSB6/profile http://localhost:56384/getInfo.html) 19:59:26 INFO - PROCESS | 23670 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 19:59:26 INFO - PROCESS | 23670 | __metrics Screen width/height:1600/1200 19:59:26 INFO - PROCESS | 23670 | colorDepth:24 19:59:26 INFO - PROCESS | 23670 | Browser inner width/height: 1024/697 19:59:26 INFO - PROCESS | 23670 | __metrics 19:59:27 INFO - PROCESS | 23670 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:59:27 INFO - PROCESS | 23670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:59:27 INFO - TEST-INFO | 23670: exit 0 19:59:27 INFO - Browser initialized. 19:59:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:27 INFO - TEST-INFO | started process 23765 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCHbSB6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:39 INFO - PROCESS | 23765 | RSS: Main: 150122496 19:59:39 INFO - PROCESS | 23765 | 20:00:31 INFO - PROCESS | 23765 | 1450756831210 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] 20:02:39 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56384/tests/dromaeo/cssquery-ext.html) 20:02:41 INFO - PROCESS | 23765 | RSS: Main: 332419072 20:02:41 INFO - PROCESS | 23765 | 20:05:43 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-ext.html (next: http://localhost:56384/tests/dromaeo/cssquery-jquery.html) 20:05:44 INFO - PROCESS | 23765 | RSS: Main: 234061824 20:05:44 INFO - PROCESS | 23765 | 20:08:46 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56384/tests/dromaeo/cssquery-mootools.html) 20:08:47 INFO - PROCESS | 23765 | RSS: Main: 224047104 20:08:47 INFO - PROCESS | 23765 | 20:11:48 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56384/tests/dromaeo/cssquery-prototype.html) 20:11:49 INFO - PROCESS | 23765 | RSS: Main: 212107264 20:11:49 INFO - PROCESS | 23765 | 20:14:51 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56384/tests/dromaeo/cssquery-yui.html) 20:14:52 INFO - PROCESS | 23765 | RSS: Main: 214753280 20:14:52 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | Cycle 1(1): loaded http://localhost:56384/tests/dromaeo/cssquery-yui.html (next: http://localhost:56384/tests/dromaeo/cssquery-dojo.html) 20:17:55 INFO - PROCESS | 23765 | RSS: Main: 237969408 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | __start_tp_report 20:17:55 INFO - PROCESS | 23765 | _x_x_mozilla_page_load 20:17:55 INFO - PROCESS | 23765 | _x_x_mozilla_page_load_details 20:17:55 INFO - PROCESS | 23765 | |i|pagename|runs| 20:17:55 INFO - PROCESS | 23765 | |0;dojo.html;3114.454970380183;3218.5333126696614;3249.837508124593;3254.9837250813757;3283.589551306087;5153.845384638457;5270.947290527093;5392.2990011298525;5418.91871621926;5490.121580547113;5258.526732594066;5361.356637203541;5378.354597448311;5414.133738601825;5416.945830541703;4924.753762311897;4927.384076990376;4939.8024079036795;4976.726280054596;5025.874353141183;4784.330193772875;5076.492350764931;5091.389033316007;5119.872003199931;5133.1786914093755;4824.831130910401;4906.092372911023;4919.581835543983;4929.088118698034;4967.3542439482635;4907.092187945242;4916.70499770015;4942.135126352874;4942.827001054946;4985.551300382983;4736.431628204603;4887.902241955177;4903.779329930162;4915.655904086715;4981.053599816023;5195.68825870449;5201.505856943584;5304.840854774363;5315.627906046579;5317.973410132963;5777.335606405275;5777.7977770777825;5788.160716696098;5801.158831969383;5810.4189581041555;5806.506446951972;5808.07070868659;5827.184194212814;5827.592068555203;5827.679477628729;5250.238715386286;5348.839534813962;5349.7057661828585;5381.89671117416;5458.617896747269;6012.6392416455155;6030.879382412415;6038.365971573009;6039.7282122304605;6043.184170137063;5715.828525144252;5813.215215945793;5821.592488525763;5827.737751801179;5867;5487.5609951203805;5615.719214039364;5782.3639399666;5900.1739756434135;5911.113332999998;5788;5789.94210057894;5793.131030345482;5797.971010145006;5823.621464604787;5770.826875193751;5777.537796976232;5779.682117483579;5787.016207244778;5788.131780232915;4345.956540434619;4444.933326000048;4447.644188464979;4450.5549445055885;4467.419235499429;3914.451976723261;3924.4898163238595;3964.940525892114;3987.0829709166474;4012.4181993610764;5423.454315520058;5482.698451585201;5485.341758988947;5486.533644640251;5493.945060549423;5852.736626851802;5857.414258574108;5858.150568167677;5859.384764599741;5860.120981852756;5347.732613369316;5356.7321633918145;5465.808696695596;5475;5481.123020316731;5082;5083.491650834961;5089.745512724349;5112.923306150411;5126.87182820425;5865.765369385262;5919.141724450017;5925.496332811759;5925.525957923356;5986.102084687244;5691.117876729114;5773.451522105393;5817.272840894888;5822.155787410887;5960.612560183574;5914.260717410324;5923.259592550931;5925.4370834770625;5926.051831706906;5947.851303717442;5760.135979603093;5768.221290125779;5769.538436924952;5771.769129234784;5772.422757724194;5661.858453538694;5780.913286300793;5781.335146458211;5785.623934444247;5791.652500849962;5551.666899986014;5619.2133101365025;5625.46558076982;5628.155776633538;5629.577781666309;5574.5261652758345;5616.326040875121;5624.690642014729;5625.662460252398;5626.381098079126;5535.944640553543;5595.048841697003;5702.5437964961875;5704.8003319885265;5712.885742285214;5763.221965034834;5831.7375718091935;5833.241678581757;5839.211706419579;5890.646561206341;5707.143928410772;5710.229119068873;5710.885782284414;5712.314522257356;5716.857078573069 20:17:55 INFO - PROCESS | 23765 | |1;ext.html;564.1380083313097;607.2409488139825;609.7012463892693;615.3139249736545;618.2982315072392;29716.10851674448;38247;38490.4226436603;38501.80749096258;38518.614813851855;42561;43066.569334306645;43183.3522497162;43208.78395608017;43233.135337293235;7634.656440460192;7735.922640773577;7739.458237923348;8636.69771557994;8822.514761688104;7687.308142267195;9979.650712225073;10166.59333626654;10183.388996660187;10187.694369168938;10095.545700443461;10165.390076595428;10181.28730988831;10185.388876667386;10202.081812636861;7843.294103530652;8037.7588672339925;10279.229057820656;10393.22050846182;10403.167746580293;10337.276390652658;10602.469876506144;10607.893921060768;10613.9469302653;10617;39784.40323395151;40235;40289.19421611581;40401.191976160604;40407.19185616301;3241.724453421462;3329.7336213103135;3391.7286617070577;3446.1212390840174;3612.9999999999736;29696.406071878657;30208.09375718732;30561.69438305633;30563.08310750681;30639.540406893913;3791.696664266852;3944.644981951609;3987.6610488108545;4020.0954785173103;4036.0515278909434;254109;255081;255221;255243;255414;52449.475505245224;53288;58579.70710146507;58857;58949.41050589439;69910.85401156961;70961.64519177475;71332;71347;71410.64294678494;13547.525836595672;13742.106763060368;13774.586762397144;13776.724465510633;13801.792973105412;10297.279190456746;10353.74115647115;10359.689209323733;10375.27373083877;10376.066154046172;19951.401457956286;20235.08942097609;20303.796962030487;20308.898455507628;20384.592308153755;8061.879071813927;8070.798230044178;8142.7557173284895;8146.633401496947;8203.343732501386;846.4921047371528;882.3162049411757;975.8048390321964;991.0683957080465;1065.2915810985608;27961.720382795913;27964;28202.15393538197;28208.71791282102;28453.146405607866;994.7115336552464;1021.5556233038652;1154.2670404293167;1188.3761025461702;1188.5245901639414;14796.485959302188;14893.77659335111;14950.327235274439;15036.924815375853;15057.94594378383;307455;311192;311569;312144;312187;49765.25352119721;50145.49854501408;50256.497435025914;50417.49582504128;50419.74790126099;1307.3985966455537;1311.6196303072193;1313.0021183900305;1313.1530163044974;1314.4019471140607;24638;26669.59995600029;27635.447291053664;27866.44267114687;28055.298617534725;41015;41350;41409.1718165629;41417.58582414258;41444;248068;248775;249793;249806;250029;31382.372352553277;31416.52875206828;31506.52740208853;31682.524762129047;31697.683023170397;42679.57320426756;42817.14365712606;42890;43659.345109822745;43933.121337573706;36549.634503654626;36860.81569592135;37457.25085498329;37560.43659345167;37812.62187378091;36211.09472263109;36696;36958.8152059238;37229.62770372262;41238.79380603078;35349.82325088461;36336.818315908255;36371;36401.817990909876;36416.27167456689;31338;32771.50842737313;33469;33501.49747753737;33605.49591756175;25231.495370092864;25469.87265063663;25532.617010745224;25616.743832561435;25966.09118680837 20:17:55 INFO - PROCESS | 23765 | |2;jquery.html;359.05031192495863;363.07959323115904;363.29520729784207;365.344207148169;369.35547469665437;13385.866141338583;13407.932960335209;16081.678366432665;16631.501054968354;16918.40785572505;11512.13658975576;12164.513419463234;12620.93689531551;14672.413103475848;15547.92226038871;4989.700617962925;5122.129238029525;5152.665076770017;5155.613329000321;5157.922631160535;3630.818459077049;3749.325121478133;5075.898482030358;5089.389273287211;5094.2103973884105;5321.3348331458565;5432.266644003068;5475.23346731456;5486.945130548684;5487.5609951203805;5451.809186678447;5454.990826697054;5456.945430545684;5647.237622920894;5956.851078723023;5294.285271488377;5296.179092240709;5301.310829592167;5318.468153184689;5320.414754377015;13011.893989010945;15163.469278575198;16665.583360415967;20509.794902051086;20559.691604625943;2067.5348046689523;2068.617305798432;2096.5702031083592;2200.680901269323;2314.6990891184205;12290.385480725929;13108.2135071896;13376.598702038955;13593.320333983262;13754.31228438574;1778.1909231299728;1794.443722446046;1823.8085001074828;1829.0488945748136;1840.944771656839;58673.413265867224;58971.41028589702;59395;60529.394706052815;62602.99999999954;10410.68767936963;10479.21405894561;10504.159667226604;10528.736781580368;10536.157107431387;13587.45650173982;13592.796108058386;13603.183808971295;13610.251436171106;13623;6773.085633439521;6822.11312529368;6907.447404207752;7168.103987001625;7227.27727227273;6323.557350985387;6389.616623002542;6674.466042716668;6720.798376048726;6737.056812046318;4499.505054444008;4534.478534968521;4550.362949187116;4566.292224705176;4591.03588246472;1734.8612111031086;1814.2039381012703;1816.0465755478479;1896.3268039845932;1909.789923108457;413.6339339684401;419.3646625362578;436.8733067410479;833.1959658929042;843.9029511606121;10741.409222492837;11166.106711463064;11299.661010169708;16455.83544164543;17793.911030444764;784.8626490364163;860.8966923969039;864.464032299978;880.1682410122501;882.179572997106;9550.761230969281;9893.307468477138;9906.257030722725;9967.850482242773;10048.196144308438;401679;404135;407935;550716;559270;69477;80916.19083809087;82060.17939820644;82227;82824.58587707144;1114.5374669512223;1121.147927575049;1125.2235957189514;1145.524607287983;1156.6125348008343;15216.695666086838;15262.3895044197;15598.766018509505;15752.684946301239;15772.605684857512;31755.682443175272;32404.35191296208;32686.83656581702;34357;35112.82443587766;43785.56214437815;44262.336064959694;46677.76661116673;47756.7612161937;48354.54936351915;9260.675876344296;9802.509874506104;9876.604935802487;9888.950555247466;9895;16296.42962496307;16786.66426671484;17042.147892605073;17067.658646827244;17127.400540981005;14263.786043209568;14355.425782968981;14610.342534585756;14624.122552646875;14638.853611463748;14058.789118163031;14199.503017394341;14295.857041429868;14395.064320819114;14493.4927277549;11603.593874214363;14859.554213373616;15077.321520531383;15323.387064517294;15445.691086178438;9242.445453272825;9391.29565282593;9565.378250413702;9714.222862171151;9746;10162.339447935861;11521.308721476738;14015.089019213718;14373.568792936228;14855.331510081856 20:17:55 INFO - PROCESS | 23765 | |3;mootools.html;1358.130796290375;1708.2995971651621;1730.9653806923861;1757.1302205408322;1779.4038996936033;6433.35666433357;7108.18255900571;7266.237045110267;7282.126144862611;7282.599457029861;7199.856002879939;7277.5269607475475;7347.559146451216;7353.191148973622;7359.7056117755355;1918.5299601597558;1951.804819518051;1954.0522846419476;2233.21837356925;2275.397019789757;2222.544378402432;2256.5261295128043;2265.716785401825;2271.0121097322717;2271.4434963433982;2182.3671135370723;2214.5903007943502;2246.921357752479;2248.15694114707;2249.0441562336023;2202.592520383734;2237.9104835806547;2267.138487374795;2273.874936878471;2295.885205739723;2232.5869714102782;2267.7051983242236;2299.356180269527;2300.827437942161;2303.7235531736133;7252.274772522758;7341.412686985029;7347.853042939165;7361.263873612649;7367.963160184218;4431.756253406062;4507.661925355578;4528.569785870337;4538.478075021349;4543.136804007228;2963.836988965606;3025.7276845084048;3069.1406406206297;3072.892448764305;3084.98457507711;961.8124465729186;964.9035096490366;969.6993931881069;985.3447457440793;1021.7752094539189;9793.51032448382;9856.260780441495;9862.605495780232;9865.852012219822;9888.060634239735;4054.1283624020975;4082.5509193988637;4129.504459464823;4150.792460376969;4154.50145982484;8569.742907712778;8574.657013719381;8580.056193818675;8581.914180858237;8586;4540.091981603627;4546.909061818745;4568.246239370533;4574.199515084847;4575.5424457554645;4126.731762435432;4143.751374917515;4163.916721665611;4169.437125988014;4174.352975288835;3339.3488269787645;3385.8645654173556;3483.8606455741487;3541;3623.80069096197;1125.319181894958;1126.6507382711222;1132.592266783957;1133.8469306643663;1140.9429528523706;995.4127065031666;995.6067353395368;1066.4347895615335;1118.904893084097;1329.8869596084442;6683.565568238049;6691.230508491489;6746.257911629717;6753.628550429774;6753.763618273435;1101.493313075978;1124.505217704224;1141.2410746853416;1201.8497687789027;1212.8665846756849;5541.33503979525;5581.162825576115;5587.74855131512;5593.972030139823;5594.412586678422;8498.107698691672;8792.692255771017;8846.513441760764;8948.284137269004;8948.373613847098;8757.956210218908;8771.956140219258;8860.601272942733;8869.600867960957;8877.822443551093;6874.587524748431;6923.896141557881;6960.582365058112;7039.9296007039275;7044.577325360392;6604.174478190226;6613.900791488228;6623.238327592196;6626.039224312544;6635.402813746786;7655.846883062419;7797.064352277763;7847.568383738949;7969.3226075784205;7971.481853679492;7950;8269.173082691683;8272.875906861282;8274.875876861972;8298.170182981654;6320.905186422116;6331.050342448485;6397.392247736458;6520.054592084027;6534.052562378523;6217.96891015542;6504.869902602016;6603.9009414859775;6780.525363224724;6934.375906168469;6599.9010014848855;6659.2008958925235;6724.7646332378135;6749.628770417674;6751.86496270062;6591.307912669101;6602.66986650656;6661.933380666132;6713.899291510729;6743.696533656095;6429.903551446639;6439.45264652491;6466.385693359123;6476.773312934025;6486.2216534016225;5964.493018093511;6010.7295171716505;6016.909746353896;6038.9396106038375;6039.335673076046;5666.263385759825;5892.616979896293;5933.2880054393745;5940.1683764272175;5944.464998150014 20:17:55 INFO - PROCESS | 23765 | |4;prototype.html;337.22774845603567;342.8268724294231;346.47509023828917;348;350.85264189040583;5914.497267732242;5917.408259174081;5941.5246780257585;5948.196993405894;5971.402859714021;5654.434556544344;5721.942780572193;5785.27684039495;5871.178035075093;5907.970460147704;4625.606823420013;4641.582257596816;4642.953570464286;4652.162610730075;4652.209124448852;4354;4644.164050470914;4650.325702773096;4650.837220697276;4658.114958157956;4405.779711014453;4435.268180750172;4502.167099086663;4509.887252818673;4527.071950250207;4525.954740452619;4528.97735511322;4540.682152249344;4543.659225558096;4560.338750881104;3957.584453632385;3981.820818063165;3995.720299579031;3996.760194388346;4005.5794141615293;5564.8052318169075;5581.49766521015;5593.32880054392;5599.188117722907;5622.044252477089;5305.151175811851;5305.44292849253;5314.92027619586;5319.17552779316;5320.547753440924;6300;6304.401081897213;6304.464120549759;6308.3060863305;6308.873822523569;4434.623057040156;4439.223135951228;4441.378207051015;4442;4464.17412778637;6424.293327733945;6572.737090516373;6574.145361103074;6574.342565743435;6577.24361698406;4534.047849951481;4535.319702044654;4536.931946020813;4537.773111344485;4538.704984176084;4590.403247577793;4591.311303304465;4597.241455159861;4598.747068911175;4603.516630753789;5289.656172348785;5294.629375943724;5295.126304159848;5302.708351040653;5310.787568497217;6156.29202641693;6353.174087368612;6384.776532821329;6394.296627370985;6401.295857455676;1602.9118398488195;1614.4430171590782;1614.8465895740121;1615.539571222196;1615.9353625854835;1071.724647669271;1083.8482612434266;1085.218642577343;1089.553283153919;1104.2435931386865;6127.5404344674325;6130.724117414727;6135.570510064253;6135.7852475164045;6141.324454310023;6527.836804079936;6531.836704082436;6533.869322613521;6535.150430444012;6538.673066346759;5959.523238140939;6086.726097325631;6092.329843717188;6095.725692343855;6102.633841969496;3488.89533314001;3559.359315323267;3569.7679650822615;3582.1044738815294;3601.8019008954757;6707.865842683119;6720.731170753115;6724.193096828314;6724.3948044675235;6736.090627765189;6658.800235992928;6774.288699686462;6787.6266805325195;6792.728290868409;6794.524383293122;6681.465482761368;6705.720055181262;6709.496787740939;6719.42884854783;6724.865502690017;6560.507961902972;6564.671766411565;6599.307072757291;6634.137562116894;6636.568623039487;6383.2978372378075;6539.182602174728;6540.149780528501;6547.345265473415;6551.50863685216;6661.666916654051;6664.633445160563;6667.166604174478;6673.366030227315;6688;4557.339185818104;4583.289590113538;4583.49581546023;4584.564466375689;4590.632749380108;6409.359064093554;6592.340765923369;6602.019394181631;6603;6650.501212408992;6426.485881129592;6436;6443.452306553995;6446.161998940108;6468.3855033771715;6415.230172379344;6428.8071357859335;6439.871202576016;6446.194225721785;6452.322506136788;6105.664188469676;6286.371362863677;6303.936960630335;6312.368763123651;6312.7159277833525;6454.612723236621;6461.903071454026;6462.289148193789;6473.967630161819;6484.773032943825;6181.072839074175;6307.274663413583;6318.494520438262;6327.303996560283;6327.620342779448 20:17:55 INFO - PROCESS | 23765 | |5;yui.html;750.7897788619186;775.6393277126135;813.5444151275286;866.5104216117896;870.30810505648;12911.225326480419;12982.805257921138;13012.674683132926;13021;13059.151155174906;12453.937730311358;12721.42753576089;12723.491060357597;12724.236545807235;12725.363731813395;675.0245894682187;687.2131409536078;829.4649950781742;842.1241908415241;845.9365547583956;833.6540335760652;834.70785225171;841.1042240014395;842.7219017724167;842.8904242448473;824.7855557555049;865.0700496965787;873.5195642396689;876.0101085773067;876.5529579914257;704.2992222738383;712.7113519024778;853.6585365853678;873.724776695339;874.9212570868589;646.5054233511368;648.8864448721455;649.2695717318018;649.6102338596851;649.8310439285773;13068.411921463558;13433.261170635611;13463.596092117252;13472.393742281622;13494.86505134946;11571.594994175164;12226.266424014588;12764.936175319064;12778.552750653682;12828.35858207086;10393.9480302598;10439.37363758177;10468.267221294513;10581.894181058167;10602.628907988183;3560.1989552350774;3568.1628433983924;3590.6409359064146;3600.315939971423;3701.0932321581117;44019.77990110061;45351.546484535065;45352.77323613394;45465.54534454646;45489.77255113703;9217.907820921839;9337.253019758404;9362.812743745088;9451.621935122655;9500.904990950141;18734.25062997465;18749.7187542187;18764.15561299745;18809.247630094917;18832.811671883104;7539.132999704994;7603.885941710879;7764.06831180262;7853.253940875607;7933.880991785128;3791.2227993261317;3920.8039598019986;3924.9018774530864;3936.193080418507;3936.4488971544006;3032.6815684352823;3066.9386612268077;3069.524223745323;3070.5240687693445;3073.4467795796522;537.771447134966;549.0583649041912;558.5057224356474;558.7290164270407;560.6832139840977;603.4542553929375;647.7052940911874;656.0978654350268;661.8014595621295;690.7325058517677;7885.44801863864;8097.716579919675;8342.416030877901;8374.706885258987;8468.661253549912;548.25984920358;580.9448102430263;640.1517988664945;660.9900851487232;677.6036018928884;3660.249648821985;3684.3552378333684;3905.628965248297;4010.057636455431;4068.349064149722;51613.22580161301;51941.22088168681;52018;52394.73802630963;52896.471035289156;46298.30552541715;47219.5278047222;47259.29111063337;47261.29108063382;47307.290390644164;43702.56297436985;43723.56276437258;44128.558714413084;44166;44322;7789.298963093349;7872.094709108525;8034.879476807736;8064.475809072392;8082.87875681877;32116.357672845945;32684.50973235451;32856.178595535304;32906.17734556655;33054.66945330612;39038.4144237831;39171.2165756689;41322.380164296956;42709;43187.136257275306;9506.95246523763;9730.207433445472;9917.404955702681;9959.253056020683;10125.59497620087;10395.584176633152;11056.060234880126;11120.44397780124;11257.831132532854;11310.547578096784;9657.46883921391;9765.316427849983;9846.458444785605;10009.349392289478;10209.285350025428;10440.40974358694;10513.789724205626;10612.84080738805;10744.51649675751;10817.026467617638;9846.163076138608;9874.703758887244;10039.096481316716;10463.267571269938;10486.423246721504;9409.435433873989;9589.90410095918;9769.071938165864;9808.921018687795;9830.655927042519;8163.1836816320265;8603.182697643713;8710.564471776259;8790.296776258012;9406.482643454676 20:17:55 INFO - PROCESS | 23765 | __end_tp_report 20:17:55 INFO - PROCESS | 23765 | __start_cc_report 20:17:55 INFO - PROCESS | 23765 | _x_x_mozilla_cycle_collect,1419 20:17:55 INFO - PROCESS | 23765 | __end_cc_report 20:17:55 INFO - PROCESS | 23765 | __startTimestamp1450757875505__endTimestamp 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | ------- Summary: start ------- 20:17:55 INFO - PROCESS | 23765 | Number of tests: 6 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#0] dojo.html Cycles:165 Average:5391.63 Median:5619.21 stddev:604.06 (10.7%) stddev-sans-first:578.89 20:17:55 INFO - PROCESS | 23765 | Values: 3114.5 3218.5 3249.8 3255.0 3283.6 5153.8 5270.9 5392.3 5418.9 5490.1 5258.5 5361.4 5378.4 5414.1 5416.9 4924.8 4927.4 4939.8 4976.7 5025.9 4784.3 5076.5 5091.4 5119.9 5133.2 4824.8 4906.1 4919.6 4929.1 4967.4 4907.1 4916.7 4942.1 4942.8 4985.6 4736.4 4887.9 4903.8 4915.7 4981.1 5195.7 5201.5 5304.8 5315.6 5318.0 5777.3 5777.8 5788.2 5801.2 5810.4 5806.5 5808.1 5827.2 5827.6 5827.7 5250.2 5348.8 5349.7 5381.9 5458.6 6012.6 6030.9 6038.4 6039.7 6043.2 5715.8 5813.2 5821.6 5827.7 5867.0 5487.6 5615.7 5782.4 5900.2 5911.1 5788.0 5789.9 5793.1 5798.0 5823.6 5770.8 5777.5 5779.7 5787.0 5788.1 4346.0 4444.9 4447.6 4450.6 4467.4 3914.5 3924.5 3964.9 3987.1 4012.4 5423.5 5482.7 5485.3 5486.5 5493.9 5852.7 5857.4 5858.2 5859.4 5860.1 5347.7 5356.7 5465.8 5475.0 5481.1 5082.0 5083.5 5089.7 5112.9 5126.9 5865.8 5919.1 5925.5 5925.5 5986.1 5691.1 5773.5 5817.3 5822.2 5960.6 5914.3 5923.3 5925.4 5926.1 5947.9 5760.1 5768.2 5769.5 5771.8 5772.4 5661.9 5780.9 5781.3 5785.6 5791.7 5551.7 5619.2 5625.5 5628.2 5629.6 5574.5 5616.3 5624.7 5625.7 5626.4 5535.9 5595.0 5702.5 5704.8 5712.9 5763.2 5831.7 5833.2 5839.2 5890.6 5707.1 5710.2 5710.9 5712.3 5716.9 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#1] ext.html Cycles:180 Average:44736.50 Median:18399.37 stddev:71250.07 (387.2%) stddev-sans-first:71372.75 20:17:55 INFO - PROCESS | 23765 | Values: 564.1 607.2 609.7 615.3 618.3 29716.1 38247.0 38490.4 38501.8 38518.6 42561.0 43066.6 43183.4 43208.8 43233.1 7634.7 7735.9 7739.5 8636.7 8822.5 7687.3 9979.7 10166.6 10183.4 10187.7 10095.5 10165.4 10181.3 10185.4 10202.1 7843.3 8037.8 10279.2 10393.2 10403.2 10337.3 10602.5 10607.9 10613.9 10617.0 39784.4 40235.0 40289.2 40401.2 40407.2 3241.7 3329.7 3391.7 3446.1 3613.0 29696.4 30208.1 30561.7 30563.1 30639.5 3791.7 3944.6 3987.7 4020.1 4036.1 254109.0 255081.0 255221.0 255243.0 255414.0 52449.5 53288.0 58579.7 58857.0 58949.4 69910.9 70961.6 71332.0 71347.0 71410.6 13547.5 13742.1 13774.6 13776.7 13801.8 10297.3 10353.7 10359.7 10375.3 10376.1 19951.4 20235.1 20303.8 20308.9 20384.6 8061.9 8070.8 8142.8 8146.6 8203.3 846.5 882.3 975.8 991.1 1065.3 27961.7 27964.0 28202.2 28208.7 28453.1 994.7 1021.6 1154.3 1188.4 1188.5 14796.5 14893.8 14950.3 15036.9 15057.9 307455.0 311192.0 311569.0 312144.0 312187.0 49765.3 50145.5 50256.5 50417.5 50419.7 1307.4 1311.6 1313.0 1313.2 1314.4 24638.0 26669.6 27635.4 27866.4 28055.3 41015.0 41350.0 41409.2 41417.6 41444.0 248068.0 248775.0 249793.0 249806.0 250029.0 31382.4 31416.5 31506.5 31682.5 31697.7 42679.6 42817.1 42890.0 43659.3 43933.1 36549.6 36860.8 37457.3 37560.4 37812.6 36211.1 36696.0 36958.8 37229.6 41238.8 35349.8 36336.8 36371.0 36401.8 36416.3 31338.0 32771.5 33469.0 33501.5 33605.5 25231.5 25469.9 25532.6 25616.7 25966.1 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#2] jquery.html Cycles:180 Average:26413.41 Median:17735.94 stddev:77090.87 (434.7%) stddev-sans-first:77282.30 20:17:55 INFO - PROCESS | 23765 | Values: 359.1 363.1 363.3 365.3 369.4 13385.9 13407.9 16081.7 16631.5 16918.4 11512.1 12164.5 12620.9 14672.4 15547.9 4989.7 5122.1 5152.7 5155.6 5157.9 3630.8 3749.3 5075.9 5089.4 5094.2 5321.3 5432.3 5475.2 5486.9 5487.6 5451.8 5455.0 5456.9 5647.2 5956.9 5294.3 5296.2 5301.3 5318.5 5320.4 13011.9 15163.5 16665.6 20509.8 20559.7 2067.5 2068.6 2096.6 2200.7 2314.7 12290.4 13108.2 13376.6 13593.3 13754.3 1778.2 1794.4 1823.8 1829.0 1840.9 58673.4 58971.4 59395.0 60529.4 62603.0 10410.7 10479.2 10504.2 10528.7 10536.2 13587.5 13592.8 13603.2 13610.3 13623.0 6773.1 6822.1 6907.4 7168.1 7227.3 6323.6 6389.6 6674.5 6720.8 6737.1 4499.5 4534.5 4550.4 4566.3 4591.0 1734.9 1814.2 1816.0 1896.3 1909.8 413.6 419.4 436.9 833.2 843.9 10741.4 11166.1 11299.7 16455.8 17793.9 784.9 860.9 864.5 880.2 882.2 9550.8 9893.3 9906.3 9967.9 10048.2 401679.0 404135.0 407935.0 550716.0 559270.0 69477.0 80916.2 82060.2 82227.0 82824.6 1114.5 1121.1 1125.2 1145.5 1156.6 15216.7 15262.4 15598.8 15752.7 15772.6 31755.7 32404.4 32686.8 34357.0 35112.8 43785.6 44262.3 46677.8 47756.8 48354.5 9260.7 9802.5 9876.6 9889.0 9895.0 16296.4 16786.7 17042.1 17067.7 17127.4 14263.8 14355.4 14610.3 14624.1 14638.9 14058.8 14199.5 14295.9 14395.1 14493.5 11603.6 14859.6 15077.3 15323.4 15445.7 9242.4 9391.3 9565.4 9714.2 9746.0 10162.3 11521.3 14015.1 14373.6 14855.3 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#3] mootools.html Cycles:180 Average:5151.69 Median:6325.98 stddev:2597.55 (41.1%) stddev-sans-first:2589.19 20:17:55 INFO - PROCESS | 23765 | Values: 1358.1 1708.3 1731.0 1757.1 1779.4 6433.4 7108.2 7266.2 7282.1 7282.6 7199.9 7277.5 7347.6 7353.2 7359.7 1918.5 1951.8 1954.1 2233.2 2275.4 2222.5 2256.5 2265.7 2271.0 2271.4 2182.4 2214.6 2246.9 2248.2 2249.0 2202.6 2237.9 2267.1 2273.9 2295.9 2232.6 2267.7 2299.4 2300.8 2303.7 7252.3 7341.4 7347.9 7361.3 7368.0 4431.8 4507.7 4528.6 4538.5 4543.1 2963.8 3025.7 3069.1 3072.9 3085.0 961.8 964.9 969.7 985.3 1021.8 9793.5 9856.3 9862.6 9865.9 9888.1 4054.1 4082.6 4129.5 4150.8 4154.5 8569.7 8574.7 8580.1 8581.9 8586.0 4540.1 4546.9 4568.2 4574.2 4575.5 4126.7 4143.8 4163.9 4169.4 4174.4 3339.3 3385.9 3483.9 3541.0 3623.8 1125.3 1126.7 1132.6 1133.8 1140.9 995.4 995.6 1066.4 1118.9 1329.9 6683.6 6691.2 6746.3 6753.6 6753.8 1101.5 1124.5 1141.2 1201.8 1212.9 5541.3 5581.2 5587.7 5594.0 5594.4 8498.1 8792.7 8846.5 8948.3 8948.4 8758.0 8772.0 8860.6 8869.6 8877.8 6874.6 6923.9 6960.6 7039.9 7044.6 6604.2 6613.9 6623.2 6626.0 6635.4 7655.8 7797.1 7847.6 7969.3 7971.5 7950.0 8269.2 8272.9 8274.9 8298.2 6320.9 6331.1 6397.4 6520.1 6534.1 6218.0 6504.9 6603.9 6780.5 6934.4 6599.9 6659.2 6724.8 6749.6 6751.9 6591.3 6602.7 6661.9 6713.9 6743.7 6429.9 6439.5 6466.4 6476.8 6486.2 5964.5 6010.7 6016.9 6038.9 6039.3 5666.3 5892.6 5933.3 5940.2 5944.5 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#4] prototype.html Cycles:180 Average:5314.00 Median:6029.06 stddev:1595.00 (26.5%) stddev-sans-first:1555.12 20:17:55 INFO - PROCESS | 23765 | Values: 337.2 342.8 346.5 348.0 350.9 5914.5 5917.4 5941.5 5948.2 5971.4 5654.4 5721.9 5785.3 5871.2 5908.0 4625.6 4641.6 4643.0 4652.2 4652.2 4354.0 4644.2 4650.3 4650.8 4658.1 4405.8 4435.3 4502.2 4509.9 4527.1 4526.0 4529.0 4540.7 4543.7 4560.3 3957.6 3981.8 3995.7 3996.8 4005.6 5564.8 5581.5 5593.3 5599.2 5622.0 5305.2 5305.4 5314.9 5319.2 5320.5 6300.0 6304.4 6304.5 6308.3 6308.9 4434.6 4439.2 4441.4 4442.0 4464.2 6424.3 6572.7 6574.1 6574.3 6577.2 4534.0 4535.3 4536.9 4537.8 4538.7 4590.4 4591.3 4597.2 4598.7 4603.5 5289.7 5294.6 5295.1 5302.7 5310.8 6156.3 6353.2 6384.8 6394.3 6401.3 1602.9 1614.4 1614.8 1615.5 1615.9 1071.7 1083.8 1085.2 1089.6 1104.2 6127.5 6130.7 6135.6 6135.8 6141.3 6527.8 6531.8 6533.9 6535.2 6538.7 5959.5 6086.7 6092.3 6095.7 6102.6 3488.9 3559.4 3569.8 3582.1 3601.8 6707.9 6720.7 6724.2 6724.4 6736.1 6658.8 6774.3 6787.6 6792.7 6794.5 6681.5 6705.7 6709.5 6719.4 6724.9 6560.5 6564.7 6599.3 6634.1 6636.6 6383.3 6539.2 6540.1 6547.3 6551.5 6661.7 6664.6 6667.2 6673.4 6688.0 4557.3 4583.3 4583.5 4584.6 4590.6 6409.4 6592.3 6602.0 6603.0 6650.5 6426.5 6436.0 6443.5 6446.2 6468.4 6415.2 6428.8 6439.9 6446.2 6452.3 6105.7 6286.4 6303.9 6312.4 6312.7 6454.6 6461.9 6462.3 6474.0 6484.8 6181.1 6307.3 6318.5 6327.3 6327.6 20:17:55 INFO - PROCESS | 23765 | 20:17:55 INFO - PROCESS | 23765 | [#5] yui.html Cycles:180 Average:12978.84 Median:49460.26 stddev:14737.72 (29.8%) stddev-sans-first:14750.46 20:17:55 INFO - PROCESS | 23765 | Values: 750.8 775.6 813.5 866.5 870.3 12911.2 12982.8 13012.7 13021.0 13059.2 12453.9 12721.4 12723.5 12724.2 12725.4 675.0 687.2 829.5 842.1 845.9 833.7 834.7 841.1 842.7 842.9 824.8 865.1 873.5 876.0 876.6 704.3 712.7 853.7 873.7 874.9 646.5 648.9 649.3 649.6 649.8 13068.4 13433.3 13463.6 13472.4 13494.9 11571.6 12226.3 12764.9 12778.6 12828.4 10393.9 10439.4 10468.3 10581.9 10602.6 3560.2 3568.2 3590.6 3600.3 3701.1 44019.8 45351.5 45352.8 45465.5 45489.8 9217.9 9337.3 9362.8 9451.6 9500.9 18734.3 18749.7 18764.2 18809.2 18832.8 7539.1 7603.9 7764.1 7853.3 7933.9 3791.2 3920.8 3924.9 3936.2 3936.4 3032.7 3066.9 3069.5 3070.5 3073.4 537.8 549.1 558.5 558.7 560.7 603.5 647.7 656.1 661.8 690.7 7885.4 8097.7 8342.4 8374.7 8468.7 548.3 580.9 640.2 661.0 677.6 3660.2 3684.4 3905.6 4010.1 4068.3 51613.2 51941.2 52018.0 52394.7 52896.5 46298.3 47219.5 47259.3 47261.3 47307.3 43702.6 43723.6 44128.6 44166.0 44322.0 7789.3 7872.1 8034.9 8064.5 8082.9 32116.4 32684.5 32856.2 32906.2 33054.7 39038.4 39171.2 41322.4 42709.0 43187.1 9507.0 9730.2 9917.4 9959.3 10125.6 10395.6 11056.1 11120.4 11257.8 11310.5 9657.5 9765.3 9846.5 10009.3 10209.3 10440.4 10513.8 10612.8 10744.5 10817.0 9846.2 9874.7 10039.1 10463.3 10486.4 9409.4 9589.9 9769.1 9808.9 9830.7 8163.2 8603.2 8710.6 8790.3 9406.5 20:17:55 INFO - PROCESS | 23765 | -------- Summary: end -------- 20:17:55 INFO - PROCESS | 23765 | 20:17:56 INFO - TEST-INFO | 23765: exit 0 20:17:56 INFO - TEST-OK | dromaeo_css | took 1113869ms 20:17:56 INFO - TEST-START | kraken 20:17:56 INFO - operating with platform_type : linux_ 20:17:56 INFO - Initialising browser for kraken test... 20:17:56 INFO - TEST-INFO | started process 23950 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf1G0KC/profile http://localhost:56384/getInfo.html) 20:18:00 INFO - PROCESS | 23950 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 20:18:00 INFO - PROCESS | 23950 | __metrics Screen width/height:1600/1200 20:18:00 INFO - PROCESS | 23950 | colorDepth:24 20:18:00 INFO - PROCESS | 23950 | Browser inner width/height: 1024/697 20:18:00 INFO - PROCESS | 23950 | __metrics 20:18:00 INFO - PROCESS | 23950 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:18:00 INFO - PROCESS | 23950 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:01 INFO - TEST-INFO | 23950: exit 0 20:18:01 INFO - Browser initialized. 20:18:01 INFO - Running cycle 1/1 for kraken test... 20:18:01 INFO - TEST-INFO | started process 24032 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpf1G0KC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:13 INFO - PROCESS | 24032 | RSS: Main: 149958656 20:18:13 INFO - PROCESS | 24032 | 20:18:15 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56384/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:16 INFO - PROCESS | 24032 | RSS: Main: 186929152 20:18:16 INFO - PROCESS | 24032 | 20:18:18 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56384/tests/kraken/driver.html?testName=audio-dft) 20:18:19 INFO - PROCESS | 24032 | RSS: Main: 176394240 20:18:19 INFO - PROCESS | 24032 | 20:18:22 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56384/tests/kraken/driver.html?testName=audio-fft) 20:18:22 INFO - PROCESS | 24032 | RSS: Main: 159772672 20:18:22 INFO - PROCESS | 24032 | 20:18:24 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56384/tests/kraken/driver.html?testName=audio-oscillator) 20:18:25 INFO - PROCESS | 24032 | RSS: Main: 162381824 20:18:25 INFO - PROCESS | 24032 | 20:18:27 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:28 INFO - PROCESS | 24032 | RSS: Main: 163827712 20:18:28 INFO - PROCESS | 24032 | 20:18:30 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56384/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:31 INFO - PROCESS | 24032 | RSS: Main: 166178816 20:18:31 INFO - PROCESS | 24032 | 20:18:34 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56384/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:35 INFO - PROCESS | 24032 | RSS: Main: 166371328 20:18:35 INFO - PROCESS | 24032 | 20:18:38 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56384/tests/kraken/driver.html?testName=json-parse-financial) 20:18:38 INFO - PROCESS | 24032 | RSS: Main: 164671488 20:18:38 INFO - PROCESS | 24032 | 20:18:40 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:40 INFO - PROCESS | 24032 | RSS: Main: 176766976 20:18:40 INFO - PROCESS | 24032 | 20:18:42 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:43 INFO - PROCESS | 24032 | RSS: Main: 172539904 20:18:43 INFO - PROCESS | 24032 | 20:18:45 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:45 INFO - PROCESS | 24032 | RSS: Main: 187076608 20:18:45 INFO - PROCESS | 24032 | 20:18:48 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:49 INFO - PROCESS | 24032 | RSS: Main: 192872448 20:18:49 INFO - PROCESS | 24032 | 20:18:51 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:52 INFO - PROCESS | 24032 | RSS: Main: 189177856 20:18:52 INFO - PROCESS | 24032 | 20:18:53 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:56384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56384/tests/kraken/driver.html?testName=ai-astar) 20:18:54 INFO - PROCESS | 24032 | RSS: Main: 248758272 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | __start_tp_report 20:18:54 INFO - PROCESS | 24032 | _x_x_mozilla_page_load 20:18:54 INFO - PROCESS | 24032 | _x_x_mozilla_page_load_details 20:18:54 INFO - PROCESS | 24032 | |i|pagename|runs| 20:18:54 INFO - PROCESS | 24032 | |0;ai-astar;110;111;104;110;110;110;101;110;110;116 20:18:54 INFO - PROCESS | 24032 | |1;audio-beat-detection;147;123;154;157;127;145;150;122;160;130 20:18:54 INFO - PROCESS | 24032 | |2;audio-dft;161;160;161;160;160;162;159;163;161;160 20:18:54 INFO - PROCESS | 24032 | |3;audio-fft;71;73;75;97;72;72;77;95;91;73 20:18:54 INFO - PROCESS | 24032 | |4;audio-oscillator;95;94;140;94;94;94;134;93;93;135 20:18:54 INFO - PROCESS | 24032 | |5;imaging-gaussian-blur;109;109;109;110;109;110;110;112;109;109 20:18:54 INFO - PROCESS | 24032 | |6;imaging-darkroom;146;146;145;147;147;145;146;145;145;145 20:18:54 INFO - PROCESS | 24032 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 20:18:54 INFO - PROCESS | 24032 | |8;json-parse-financial;58;61;60;60;59;58;60;59;60;57 20:18:54 INFO - PROCESS | 24032 | |9;json-stringify-tinderbox;67;68;67;68;67;68;68;69;68;68 20:18:54 INFO - PROCESS | 24032 | |10;stanford-crypto-aes;83;83;84;83;83;84;84;84;87;85 20:18:54 INFO - PROCESS | 24032 | |11;stanford-crypto-ccm;124;119;123;122;124;117;125;115;132;119 20:18:54 INFO - PROCESS | 24032 | |12;stanford-crypto-pbkdf2;147;145;140;151;151;141;154;160;153;141 20:18:54 INFO - PROCESS | 24032 | |13;stanford-crypto-sha256-iterative;69;65;67;70;68;66;67;66;72;68 20:18:54 INFO - PROCESS | 24032 | __end_tp_report 20:18:54 INFO - PROCESS | 24032 | __start_cc_report 20:18:54 INFO - PROCESS | 24032 | _x_x_mozilla_cycle_collect,931 20:18:54 INFO - PROCESS | 24032 | __end_cc_report 20:18:54 INFO - PROCESS | 24032 | __startTimestamp1450757934060__endTimestamp 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | ------- Summary: start ------- 20:18:54 INFO - PROCESS | 24032 | Number of tests: 14 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:4.05 (3.7%) stddev-sans-first:4.28 20:18:54 INFO - PROCESS | 24032 | Values: 110.0 111.0 104.0 110.0 110.0 110.0 101.0 110.0 110.0 116.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:148.50 stddev:14.60 (9.8%) stddev-sans-first:15.35 20:18:54 INFO - PROCESS | 24032 | Values: 147.0 123.0 154.0 157.0 127.0 145.0 150.0 122.0 160.0 130.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 20:18:54 INFO - PROCESS | 24032 | Values: 161.0 160.0 161.0 160.0 160.0 162.0 159.0 163.0 161.0 160.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#3] audio-fft Cycles:10 Average:79.60 Median:76.00 stddev:10.41 (13.7%) stddev-sans-first:10.56 20:18:54 INFO - PROCESS | 24032 | Values: 71.0 73.0 75.0 97.0 72.0 72.0 77.0 95.0 91.0 73.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:94.00 stddev:20.58 (21.9%) stddev-sans-first:21.40 20:18:54 INFO - PROCESS | 24032 | Values: 95.0 94.0 140.0 94.0 94.0 94.0 134.0 93.0 93.0 135.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:109.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 20:18:54 INFO - PROCESS | 24032 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 110.0 112.0 109.0 109.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:18:54 INFO - PROCESS | 24032 | Values: 146.0 146.0 145.0 147.0 147.0 145.0 146.0 145.0 145.0 145.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:18:54 INFO - PROCESS | 24032 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:60.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 20:18:54 INFO - PROCESS | 24032 | Values: 58.0 61.0 60.0 60.0 59.0 58.0 60.0 59.0 60.0 57.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:18:54 INFO - PROCESS | 24032 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:1.27 20:18:54 INFO - PROCESS | 24032 | Values: 83.0 83.0 84.0 83.0 83.0 84.0 84.0 84.0 87.0 85.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:4.83 (3.9%) stddev-sans-first:5.07 20:18:54 INFO - PROCESS | 24032 | Values: 124.0 119.0 123.0 122.0 124.0 117.0 125.0 115.0 132.0 119.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:151.00 stddev:6.62 (4.4%) stddev-sans-first:7.00 20:18:54 INFO - PROCESS | 24032 | Values: 147.0 145.0 140.0 151.0 151.0 141.0 154.0 160.0 153.0 141.0 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - PROCESS | 24032 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:2.10 (3.1%) stddev-sans-first:2.18 20:18:54 INFO - PROCESS | 24032 | Values: 69.0 65.0 67.0 70.0 68.0 66.0 67.0 66.0 72.0 68.0 20:18:54 INFO - PROCESS | 24032 | -------- Summary: end -------- 20:18:54 INFO - PROCESS | 24032 | 20:18:54 INFO - TEST-INFO | 24032: exit 0 20:18:54 INFO - TEST-OK | kraken | took 58665ms 20:18:54 INFO - TEST-START | v8_7 20:18:54 INFO - operating with platform_type : linux_ 20:18:54 INFO - Initialising browser for v8_7 test... 20:18:54 INFO - TEST-INFO | started process 24284 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj6ugyW/profile http://localhost:56384/getInfo.html) 20:18:59 INFO - PROCESS | 24284 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 20:18:59 INFO - PROCESS | 24284 | __metrics Screen width/height:1600/1200 20:18:59 INFO - PROCESS | 24284 | colorDepth:24 20:18:59 INFO - PROCESS | 24284 | Browser inner width/height: 1024/697 20:18:59 INFO - PROCESS | 24284 | __metrics 20:18:59 INFO - PROCESS | 24284 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:18:59 INFO - PROCESS | 24284 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:59 ERROR - PROCESS | 24284 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:19:00 INFO - TEST-INFO | 24284: exit 0 20:19:00 INFO - Browser initialized. 20:19:00 INFO - Running cycle 1/1 for v8_7 test... 20:19:00 INFO - TEST-INFO | started process 24367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj6ugyW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:12 INFO - PROCESS | 24367 | RSS: Main: 149594112 20:19:12 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | Cycle 1(1): loaded http://localhost:56384/tests/v8_7/run.html (next: http://localhost:56384/tests/v8_7/run.html) 20:19:33 INFO - PROCESS | 24367 | RSS: Main: 549933056 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | __start_tp_report 20:19:33 INFO - PROCESS | 24367 | _x_x_mozilla_page_load 20:19:33 INFO - PROCESS | 24367 | _x_x_mozilla_page_load_details 20:19:33 INFO - PROCESS | 24367 | |i|pagename|runs| 20:19:33 INFO - PROCESS | 24367 | |0;Richards;167.5603217158177 20:19:33 INFO - PROCESS | 24367 | |1;DeltaBlue;189.9696048632219 20:19:33 INFO - PROCESS | 24367 | |2;Encrypt;280.58361391694723 20:19:33 INFO - PROCESS | 24367 | |3;Decrypt;5191.709844559586 20:19:33 INFO - PROCESS | 24367 | |4;RayTrace;1137.6564277588168 20:19:33 INFO - PROCESS | 24367 | |5;Earley;784.3137254901961 20:19:33 INFO - PROCESS | 24367 | |6;Boyer;12240.963855421687 20:19:33 INFO - PROCESS | 24367 | |7;RegExp;26605.263157894737 20:19:33 INFO - PROCESS | 24367 | |8;Splay;582.7505827505828 20:19:33 INFO - PROCESS | 24367 | |9;NavierStokes;4854.368932038835 20:19:33 INFO - PROCESS | 24367 | __end_tp_report 20:19:33 INFO - PROCESS | 24367 | __startTimestamp1450757973704__endTimestamp 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | ------- Summary: start ------- 20:19:33 INFO - PROCESS | 24367 | Number of tests: 10 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 167.6 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#1] DeltaBlue Cycles:1 Average:189.97 Median:189.97 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 190.0 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 280.6 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 5191.7 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#4] RayTrace Cycles:1 Average:1137.66 Median:1137.66 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 1137.7 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 784.3 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#6] Boyer Cycles:1 Average:12240.96 Median:12240.96 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 12241.0 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 26605.3 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#8] Splay Cycles:1 Average:582.75 Median:582.75 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 582.8 20:19:33 INFO - PROCESS | 24367 | 20:19:33 INFO - PROCESS | 24367 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 20:19:33 INFO - PROCESS | 24367 | Values: 4854.4 20:19:33 INFO - PROCESS | 24367 | -------- Summary: end -------- 20:19:33 INFO - PROCESS | 24367 | 20:19:34 INFO - TEST-INFO | 24367: exit 0 20:19:34 INFO - TEST-OK | v8_7 | took 39703ms 20:19:34 INFO - SUITE-END | took 1212s 20:19:34 INFO - Completed test suite (00:20:12) 20:19:34 INFO - Working with test: dromaeo_css 20:19:34 INFO - Generating results file: dromaeo_css 20:19:34 INFO - Working with test: kraken 20:19:34 INFO - Generating results file: kraken 20:19:34 INFO - javascript benchmark 20:19:34 INFO - Working with test: v8_7 20:19:34 INFO - Generating results file: v8_7 20:19:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:19:34 INFO - process_Request line: dromaeo_css 6873.43 graph.html#tests=[[72,64,35]] 20:19:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:34 INFO - process_Request line: kraken 1497.20 graph.html#tests=[[232,64,35]] 20:19:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:19:34 INFO - process_Request line: v8_7 20959.23 graph.html#tests=[[230,64,35]] 20:19:34 INFO - RETURN: dromaeo_css: 6873.43 20:19:34 INFO - RETURN: kraken: 1497.20 20:19:34 INFO - RETURN: v8_7: 20959.23 20:19:34 INFO - javascript benchmark 20:19:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.454970380183, 3218.5333126696614, 3249.837508124593, 3254.9837250813757, 3283.589551306087, 5153.845384638457, 5270.947290527093, 5392.2990011298525, 5418.91871621926, 5490.121580547113, 5258.526732594066, 5361.356637203541, 5378.354597448311, 5414.133738601825, 5416.945830541703, 4924.753762311897, 4927.384076990376, 4939.8024079036795, 4976.726280054596, 5025.874353141183, 4784.330193772875, 5076.492350764931, 5091.389033316007, 5119.872003199931, 5133.1786914093755, 4824.831130910401, 4906.092372911023, 4919.581835543983, 4929.088118698034, 4967.3542439482635, 4907.092187945242, 4916.70499770015, 4942.135126352874, 4942.827001054946, 4985.551300382983, 4736.431628204603, 4887.902241955177, 4903.779329930162, 4915.655904086715, 4981.053599816023, 5195.68825870449, 5201.505856943584, 5304.840854774363, 5315.627906046579, 5317.973410132963, 5777.335606405275, 5777.7977770777825, 5788.160716696098, 5801.158831969383, 5810.4189581041555, 5806.506446951972, 5808.07070868659, 5827.184194212814, 5827.592068555203, 5827.679477628729, 5250.238715386286, 5348.839534813962, 5349.7057661828585, 5381.89671117416, 5458.617896747269, 6012.6392416455155, 6030.879382412415, 6038.365971573009, 6039.7282122304605, 6043.184170137063, 5715.828525144252, 5813.215215945793, 5821.592488525763, 5827.737751801179, 5867.0, 5487.5609951203805, 5615.719214039364, 5782.3639399666, 5900.1739756434135, 5911.113332999998, 5788.0, 5789.94210057894, 5793.131030345482, 5797.971010145006, 5823.621464604787, 5770.826875193751, 5777.537796976232, 5779.682117483579, 5787.016207244778, 5788.131780232915, 4345.956540434619, 4444.933326000048, 4447.644188464979, 4450.5549445055885, 4467.419235499429, 3914.451976723261, 3924.4898163238595, 3964.940525892114, 3987.0829709166474, 4012.4181993610764, 5423.454315520058, 5482.698451585201, 5485.341758988947, 5486.533644640251, 5493.945060549423, 5852.736626851802, 5857.414258574108, 5858.150568167677, 5859.384764599741, 5860.120981852756, 5347.732613369316, 5356.7321633918145, 5465.808696695596, 5475.0, 5481.123020316731, 5082.0, 5083.491650834961, 5089.745512724349, 5112.923306150411, 5126.87182820425, 5865.765369385262, 5919.141724450017, 5925.496332811759, 5925.525957923356, 5986.102084687244, 5691.117876729114, 5773.451522105393, 5817.272840894888, 5822.155787410887, 5960.612560183574, 5914.260717410324, 5923.259592550931, 5925.4370834770625, 5926.051831706906, 5947.851303717442, 5760.135979603093, 5768.221290125779, 5769.538436924952, 5771.769129234784, 5772.422757724194, 5661.858453538694, 5780.913286300793, 5781.335146458211, 5785.623934444247, 5791.652500849962, 5551.666899986014, 5619.2133101365025, 5625.46558076982, 5628.155776633538, 5629.577781666309, 5574.5261652758345, 5616.326040875121, 5624.690642014729, 5625.662460252398, 5626.381098079126, 5535.944640553543, 5595.048841697003, 5702.5437964961875, 5704.8003319885265, 5712.885742285214, 5763.221965034834, 5831.7375718091935, 5833.241678581757, 5839.211706419579, 5890.646561206341, 5707.143928410772, 5710.229119068873, 5710.885782284414, 5712.314522257356, 5716.857078573069], "unit": "score", "name": "dojo.html", "value": 5351.990840355531}, {"lowerIsBetter": false, "replicates": [564.1380083313097, 607.2409488139825, 609.7012463892693, 615.3139249736545, 618.2982315072392, 29716.10851674448, 38247.0, 38490.4226436603, 38501.80749096258, 38518.614813851855, 42561.0, 43066.569334306645, 43183.3522497162, 43208.78395608017, 43233.135337293235, 7634.656440460192, 7735.922640773577, 7739.458237923348, 8636.69771557994, 8822.514761688104, 7687.308142267195, 9979.650712225073, 10166.59333626654, 10183.388996660187, 10187.694369168938, 10095.545700443461, 10165.390076595428, 10181.28730988831, 10185.388876667386, 10202.081812636861, 7843.294103530652, 8037.7588672339925, 10279.229057820656, 10393.22050846182, 10403.167746580293, 10337.276390652658, 10602.469876506144, 10607.893921060768, 10613.9469302653, 10617.0, 39784.40323395151, 40235.0, 40289.19421611581, 40401.191976160604, 40407.19185616301, 3241.724453421462, 3329.7336213103135, 3391.7286617070577, 3446.1212390840174, 3612.9999999999736, 29696.406071878657, 30208.09375718732, 30561.69438305633, 30563.08310750681, 30639.540406893913, 3791.696664266852, 3944.644981951609, 3987.6610488108545, 4020.0954785173103, 4036.0515278909434, 254109.0, 255081.0, 255221.0, 255243.0, 255414.0, 52449.475505245224, 53288.0, 58579.70710146507, 58857.0, 58949.41050589439, 69910.85401156961, 70961.64519177475, 71332.0, 71347.0, 71410.64294678494, 13547.525836595672, 13742.106763060368, 13774.586762397144, 13776.724465510633, 13801.792973105412, 10297.279190456746, 10353.74115647115, 10359.689209323733, 10375.27373083877, 10376.066154046172, 19951.401457956286, 20235.08942097609, 20303.796962030487, 20308.898455507628, 20384.592308153755, 8061.879071813927, 8070.798230044178, 8142.7557173284895, 8146.633401496947, 8203.343732501386, 846.4921047371528, 882.3162049411757, 975.8048390321964, 991.0683957080465, 1065.2915810985608, 27961.720382795913, 27964.0, 28202.15393538197, 28208.71791282102, 28453.146405607866, 994.7115336552464, 1021.5556233038652, 1154.2670404293167, 1188.3761025461702, 1188.5245901639414, 14796.485959302188, 14893.77659335111, 14950.327235274439, 15036.924815375853, 15057.94594378383, 307455.0, 311192.0, 311569.0, 312144.0, 312187.0, 49765.25352119721, 50145.49854501408, 50256.497435025914, 50417.49582504128, 50419.74790126099, 1307.3985966455537, 1311.6196303072193, 1313.0021183900305, 1313.1530163044974, 1314.4019471140607, 24638.0, 26669.59995600029, 27635.447291053664, 27866.44267114687, 28055.298617534725, 41015.0, 41350.0, 41409.1718165629, 41417.58582414258, 41444.0, 248068.0, 248775.0, 249793.0, 249806.0, 250029.0, 31382.372352553277, 31416.52875206828, 31506.52740208853, 31682.524762129047, 31697.683023170397, 42679.57320426756, 42817.14365712606, 42890.0, 43659.345109822745, 43933.121337573706, 36549.634503654626, 36860.81569592135, 37457.25085498329, 37560.43659345167, 37812.62187378091, 36211.09472263109, 36696.0, 36958.8152059238, 37229.62770372262, 41238.79380603078, 35349.82325088461, 36336.818315908255, 36371.0, 36401.817990909876, 36416.27167456689, 31338.0, 32771.50842737313, 33469.0, 33501.49747753737, 33605.49591756175, 25231.495370092864, 25469.87265063663, 25532.617010745224, 25616.743832561435, 25966.09118680837], "unit": "score", "name": "ext.html", "value": 18524.9277432533}, {"lowerIsBetter": false, "replicates": [359.05031192495863, 363.07959323115904, 363.29520729784207, 365.344207148169, 369.35547469665437, 13385.866141338583, 13407.932960335209, 16081.678366432665, 16631.501054968354, 16918.40785572505, 11512.13658975576, 12164.513419463234, 12620.93689531551, 14672.413103475848, 15547.92226038871, 4989.700617962925, 5122.129238029525, 5152.665076770017, 5155.613329000321, 5157.922631160535, 3630.818459077049, 3749.325121478133, 5075.898482030358, 5089.389273287211, 5094.2103973884105, 5321.3348331458565, 5432.266644003068, 5475.23346731456, 5486.945130548684, 5487.5609951203805, 5451.809186678447, 5454.990826697054, 5456.945430545684, 5647.237622920894, 5956.851078723023, 5294.285271488377, 5296.179092240709, 5301.310829592167, 5318.468153184689, 5320.414754377015, 13011.893989010945, 15163.469278575198, 16665.583360415967, 20509.794902051086, 20559.691604625943, 2067.5348046689523, 2068.617305798432, 2096.5702031083592, 2200.680901269323, 2314.6990891184205, 12290.385480725929, 13108.2135071896, 13376.598702038955, 13593.320333983262, 13754.31228438574, 1778.1909231299728, 1794.443722446046, 1823.8085001074828, 1829.0488945748136, 1840.944771656839, 58673.413265867224, 58971.41028589702, 59395.0, 60529.394706052815, 62602.99999999954, 10410.68767936963, 10479.21405894561, 10504.159667226604, 10528.736781580368, 10536.157107431387, 13587.45650173982, 13592.796108058386, 13603.183808971295, 13610.251436171106, 13623.0, 6773.085633439521, 6822.11312529368, 6907.447404207752, 7168.103987001625, 7227.27727227273, 6323.557350985387, 6389.616623002542, 6674.466042716668, 6720.798376048726, 6737.056812046318, 4499.505054444008, 4534.478534968521, 4550.362949187116, 4566.292224705176, 4591.03588246472, 1734.8612111031086, 1814.2039381012703, 1816.0465755478479, 1896.3268039845932, 1909.789923108457, 413.6339339684401, 419.3646625362578, 436.8733067410479, 833.1959658929042, 843.9029511606121, 10741.409222492837, 11166.106711463064, 11299.661010169708, 16455.83544164543, 17793.911030444764, 784.8626490364163, 860.8966923969039, 864.464032299978, 880.1682410122501, 882.179572997106, 9550.761230969281, 9893.307468477138, 9906.257030722725, 9967.850482242773, 10048.196144308438, 401679.0, 404135.0, 407935.0, 550716.0, 559270.0, 69477.0, 80916.19083809087, 82060.17939820644, 82227.0, 82824.58587707144, 1114.5374669512223, 1121.147927575049, 1125.2235957189514, 1145.524607287983, 1156.6125348008343, 15216.695666086838, 15262.3895044197, 15598.766018509505, 15752.684946301239, 15772.605684857512, 31755.682443175272, 32404.35191296208, 32686.83656581702, 34357.0, 35112.82443587766, 43785.56214437815, 44262.336064959694, 46677.76661116673, 47756.7612161937, 48354.54936351915, 9260.675876344296, 9802.509874506104, 9876.604935802487, 9888.950555247466, 9895.0, 16296.42962496307, 16786.66426671484, 17042.147892605073, 17067.658646827244, 17127.400540981005, 14263.786043209568, 14355.425782968981, 14610.342534585756, 14624.122552646875, 14638.853611463748, 14058.789118163031, 14199.503017394341, 14295.857041429868, 14395.064320819114, 14493.4927277549, 11603.593874214363, 14859.554213373616, 15077.321520531383, 15323.387064517294, 15445.691086178438, 9242.445453272825, 9391.29565282593, 9565.378250413702, 9714.222862171151, 9746.0, 10162.339447935861, 11521.308721476738, 14015.089019213718, 14373.568792936228, 14855.331510081856], "unit": "score", "name": "jquery.html", "value": 8532.32280568307}, {"lowerIsBetter": false, "replicates": [1358.130796290375, 1708.2995971651621, 1730.9653806923861, 1757.1302205408322, 1779.4038996936033, 6433.35666433357, 7108.18255900571, 7266.237045110267, 7282.126144862611, 7282.599457029861, 7199.856002879939, 7277.5269607475475, 7347.559146451216, 7353.191148973622, 7359.7056117755355, 1918.5299601597558, 1951.804819518051, 1954.0522846419476, 2233.21837356925, 2275.397019789757, 2222.544378402432, 2256.5261295128043, 2265.716785401825, 2271.0121097322717, 2271.4434963433982, 2182.3671135370723, 2214.5903007943502, 2246.921357752479, 2248.15694114707, 2249.0441562336023, 2202.592520383734, 2237.9104835806547, 2267.138487374795, 2273.874936878471, 2295.885205739723, 2232.5869714102782, 2267.7051983242236, 2299.356180269527, 2300.827437942161, 2303.7235531736133, 7252.274772522758, 7341.412686985029, 7347.853042939165, 7361.263873612649, 7367.963160184218, 4431.756253406062, 4507.661925355578, 4528.569785870337, 4538.478075021349, 4543.136804007228, 2963.836988965606, 3025.7276845084048, 3069.1406406206297, 3072.892448764305, 3084.98457507711, 961.8124465729186, 964.9035096490366, 969.6993931881069, 985.3447457440793, 1021.7752094539189, 9793.51032448382, 9856.260780441495, 9862.605495780232, 9865.852012219822, 9888.060634239735, 4054.1283624020975, 4082.5509193988637, 4129.504459464823, 4150.792460376969, 4154.50145982484, 8569.742907712778, 8574.657013719381, 8580.056193818675, 8581.914180858237, 8586.0, 4540.091981603627, 4546.909061818745, 4568.246239370533, 4574.199515084847, 4575.5424457554645, 4126.731762435432, 4143.751374917515, 4163.916721665611, 4169.437125988014, 4174.352975288835, 3339.3488269787645, 3385.8645654173556, 3483.8606455741487, 3541.0, 3623.80069096197, 1125.319181894958, 1126.6507382711222, 1132.592266783957, 1133.8469306643663, 1140.9429528523706, 995.4127065031666, 995.6067353395368, 1066.4347895615335, 1118.904893084097, 1329.8869596084442, 6683.565568238049, 6691.230508491489, 6746.257911629717, 6753.628550429774, 6753.763618273435, 1101.493313075978, 1124.505217704224, 1141.2410746853416, 1201.8497687789027, 1212.8665846756849, 5541.33503979525, 5581.162825576115, 5587.74855131512, 5593.972030139823, 5594.412586678422, 8498.107698691672, 8792.692255771017, 8846.513441760764, 8948.284137269004, 8948.373613847098, 8757.956210218908, 8771.956140219258, 8860.601272942733, 8869.600867960957, 8877.822443551093, 6874.587524748431, 6923.896141557881, 6960.582365058112, 7039.9296007039275, 7044.577325360392, 6604.174478190226, 6613.900791488228, 6623.238327592196, 6626.039224312544, 6635.402813746786, 7655.846883062419, 7797.064352277763, 7847.568383738949, 7969.3226075784205, 7971.481853679492, 7950.0, 8269.173082691683, 8272.875906861282, 8274.875876861972, 8298.170182981654, 6320.905186422116, 6331.050342448485, 6397.392247736458, 6520.054592084027, 6534.052562378523, 6217.96891015542, 6504.869902602016, 6603.9009414859775, 6780.525363224724, 6934.375906168469, 6599.9010014848855, 6659.2008958925235, 6724.7646332378135, 6749.628770417674, 6751.86496270062, 6591.307912669101, 6602.66986650656, 6661.933380666132, 6713.899291510729, 6743.696533656095, 6429.903551446639, 6439.45264652491, 6466.385693359123, 6476.773312934025, 6486.2216534016225, 5964.493018093511, 6010.7295171716505, 6016.909746353896, 6038.9396106038375, 6039.335673076046, 5666.263385759825, 5892.616979896293, 5933.2880054393745, 5940.1683764272175, 5944.464998150014], "unit": "score", "name": "mootools.html", "value": 4285.392715200355}, {"lowerIsBetter": false, "replicates": [337.22774845603567, 342.8268724294231, 346.47509023828917, 348.0, 350.85264189040583, 5914.497267732242, 5917.408259174081, 5941.5246780257585, 5948.196993405894, 5971.402859714021, 5654.434556544344, 5721.942780572193, 5785.27684039495, 5871.178035075093, 5907.970460147704, 4625.606823420013, 4641.582257596816, 4642.953570464286, 4652.162610730075, 4652.209124448852, 4354.0, 4644.164050470914, 4650.325702773096, 4650.837220697276, 4658.114958157956, 4405.779711014453, 4435.268180750172, 4502.167099086663, 4509.887252818673, 4527.071950250207, 4525.954740452619, 4528.97735511322, 4540.682152249344, 4543.659225558096, 4560.338750881104, 3957.584453632385, 3981.820818063165, 3995.720299579031, 3996.760194388346, 4005.5794141615293, 5564.8052318169075, 5581.49766521015, 5593.32880054392, 5599.188117722907, 5622.044252477089, 5305.151175811851, 5305.44292849253, 5314.92027619586, 5319.17552779316, 5320.547753440924, 6300.0, 6304.401081897213, 6304.464120549759, 6308.3060863305, 6308.873822523569, 4434.623057040156, 4439.223135951228, 4441.378207051015, 4442.0, 4464.17412778637, 6424.293327733945, 6572.737090516373, 6574.145361103074, 6574.342565743435, 6577.24361698406, 4534.047849951481, 4535.319702044654, 4536.931946020813, 4537.773111344485, 4538.704984176084, 4590.403247577793, 4591.311303304465, 4597.241455159861, 4598.747068911175, 4603.516630753789, 5289.656172348785, 5294.629375943724, 5295.126304159848, 5302.708351040653, 5310.787568497217, 6156.29202641693, 6353.174087368612, 6384.776532821329, 6394.296627370985, 6401.295857455676, 1602.9118398488195, 1614.4430171590782, 1614.8465895740121, 1615.539571222196, 1615.9353625854835, 1071.724647669271, 1083.8482612434266, 1085.218642577343, 1089.553283153919, 1104.2435931386865, 6127.5404344674325, 6130.724117414727, 6135.570510064253, 6135.7852475164045, 6141.324454310023, 6527.836804079936, 6531.836704082436, 6533.869322613521, 6535.150430444012, 6538.673066346759, 5959.523238140939, 6086.726097325631, 6092.329843717188, 6095.725692343855, 6102.633841969496, 3488.89533314001, 3559.359315323267, 3569.7679650822615, 3582.1044738815294, 3601.8019008954757, 6707.865842683119, 6720.731170753115, 6724.193096828314, 6724.3948044675235, 6736.090627765189, 6658.800235992928, 6774.288699686462, 6787.6266805325195, 6792.728290868409, 6794.524383293122, 6681.465482761368, 6705.720055181262, 6709.496787740939, 6719.42884854783, 6724.865502690017, 6560.507961902972, 6564.671766411565, 6599.307072757291, 6634.137562116894, 6636.568623039487, 6383.2978372378075, 6539.182602174728, 6540.149780528501, 6547.345265473415, 6551.50863685216, 6661.666916654051, 6664.633445160563, 6667.166604174478, 6673.366030227315, 6688.0, 4557.339185818104, 4583.289590113538, 4583.49581546023, 4584.564466375689, 4590.632749380108, 6409.359064093554, 6592.340765923369, 6602.019394181631, 6603.0, 6650.501212408992, 6426.485881129592, 6436.0, 6443.452306553995, 6446.161998940108, 6468.3855033771715, 6415.230172379344, 6428.8071357859335, 6439.871202576016, 6446.194225721785, 6452.322506136788, 6105.664188469676, 6286.371362863677, 6303.936960630335, 6312.368763123651, 6312.7159277833525, 6454.612723236621, 6461.903071454026, 6462.289148193789, 6473.967630161819, 6484.773032943825, 6181.072839074175, 6307.274663413583, 6318.494520438262, 6327.303996560283, 6327.620342779448], "unit": "score", "name": "prototype.html", "value": 4798.5100334025165}, {"lowerIsBetter": false, "replicates": [750.7897788619186, 775.6393277126135, 813.5444151275286, 866.5104216117896, 870.30810505648, 12911.225326480419, 12982.805257921138, 13012.674683132926, 13021.0, 13059.151155174906, 12453.937730311358, 12721.42753576089, 12723.491060357597, 12724.236545807235, 12725.363731813395, 675.0245894682187, 687.2131409536078, 829.4649950781742, 842.1241908415241, 845.9365547583956, 833.6540335760652, 834.70785225171, 841.1042240014395, 842.7219017724167, 842.8904242448473, 824.7855557555049, 865.0700496965787, 873.5195642396689, 876.0101085773067, 876.5529579914257, 704.2992222738383, 712.7113519024778, 853.6585365853678, 873.724776695339, 874.9212570868589, 646.5054233511368, 648.8864448721455, 649.2695717318018, 649.6102338596851, 649.8310439285773, 13068.411921463558, 13433.261170635611, 13463.596092117252, 13472.393742281622, 13494.86505134946, 11571.594994175164, 12226.266424014588, 12764.936175319064, 12778.552750653682, 12828.35858207086, 10393.9480302598, 10439.37363758177, 10468.267221294513, 10581.894181058167, 10602.628907988183, 3560.1989552350774, 3568.1628433983924, 3590.6409359064146, 3600.315939971423, 3701.0932321581117, 44019.77990110061, 45351.546484535065, 45352.77323613394, 45465.54534454646, 45489.77255113703, 9217.907820921839, 9337.253019758404, 9362.812743745088, 9451.621935122655, 9500.904990950141, 18734.25062997465, 18749.7187542187, 18764.15561299745, 18809.247630094917, 18832.811671883104, 7539.132999704994, 7603.885941710879, 7764.06831180262, 7853.253940875607, 7933.880991785128, 3791.2227993261317, 3920.8039598019986, 3924.9018774530864, 3936.193080418507, 3936.4488971544006, 3032.6815684352823, 3066.9386612268077, 3069.524223745323, 3070.5240687693445, 3073.4467795796522, 537.771447134966, 549.0583649041912, 558.5057224356474, 558.7290164270407, 560.6832139840977, 603.4542553929375, 647.7052940911874, 656.0978654350268, 661.8014595621295, 690.7325058517677, 7885.44801863864, 8097.716579919675, 8342.416030877901, 8374.706885258987, 8468.661253549912, 548.25984920358, 580.9448102430263, 640.1517988664945, 660.9900851487232, 677.6036018928884, 3660.249648821985, 3684.3552378333684, 3905.628965248297, 4010.057636455431, 4068.349064149722, 51613.22580161301, 51941.22088168681, 52018.0, 52394.73802630963, 52896.471035289156, 46298.30552541715, 47219.5278047222, 47259.29111063337, 47261.29108063382, 47307.290390644164, 43702.56297436985, 43723.56276437258, 44128.558714413084, 44166.0, 44322.0, 7789.298963093349, 7872.094709108525, 8034.879476807736, 8064.475809072392, 8082.87875681877, 32116.357672845945, 32684.50973235451, 32856.178595535304, 32906.17734556655, 33054.66945330612, 39038.4144237831, 39171.2165756689, 41322.380164296956, 42709.0, 43187.136257275306, 9506.95246523763, 9730.207433445472, 9917.404955702681, 9959.253056020683, 10125.59497620087, 10395.584176633152, 11056.060234880126, 11120.44397780124, 11257.831132532854, 11310.547578096784, 9657.46883921391, 9765.316427849983, 9846.458444785605, 10009.349392289478, 10209.285350025428, 10440.40974358694, 10513.789724205626, 10612.84080738805, 10744.51649675751, 10817.026467617638, 9846.163076138608, 9874.703758887244, 10039.096481316716, 10463.267571269938, 10486.423246721504, 9409.435433873989, 9589.90410095918, 9769.071938165864, 9808.921018687795, 9830.655927042519, 8163.1836816320265, 8603.182697643713, 8710.564471776259, 8790.296776258012, 9406.482643454676], "unit": "score", "name": "yui.html", "value": 6061.303826380264}], "name": "dromaeo_css", "value": 6873.432735574744}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 110.0, 110.0, 110.0, 101.0, 110.0, 110.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 123.0, 154.0, 157.0, 127.0, 145.0, 150.0, 122.0, 160.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 159.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 75.0, 97.0, 72.0, 72.0, 77.0, 95.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 140.0, 94.0, 94.0, 94.0, 134.0, 93.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 112.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 147.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 60.0, 60.0, 59.0, 58.0, 60.0, 59.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 123.0, 122.0, 124.0, 117.0, 125.0, 115.0, 132.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 140.0, 151.0, 151.0, 141.0, 154.0, 160.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 67.0, 70.0, 68.0, 66.0, 67.0, 66.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1497.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [189.9696048632219], "unit": "score", "name": "DeltaBlue", "value": 348.04515199999986}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1137.6564277588168], "unit": "score", "name": "RayTrace", "value": 650.4503309999998}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12240.963855421687], "unit": "score", "name": "Boyer", "value": 54.4453041338583}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [582.7505827505828], "unit": "score", "name": "Splay", "value": 139.838556}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 20959.22535433979}]} 20:19:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20959.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1497.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6873.43"}}} 20:19:34 INFO - Return code: 0 20:19:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:19:34 ERROR - # TBPL SUCCESS # 20:19:34 INFO - Running post-action listener: _resource_record_post_action 20:19:34 INFO - Running post-run listener: _resource_record_post_run 20:19:36 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557899776; Read time: 20; Write time: 633464 20:19:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245948416; Read time: 0; Write time: 302500 20:19:36 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311074816; Read time: 20; Write time: 330920 20:19:36 INFO - Running post-run listener: _upload_blobber_files 20:19:36 INFO - Blob upload gear active. 20:19:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:19:36 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 20:19:36 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'] 20:19:36 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 20:19:36 INFO - (blobuploader) - INFO - Open directory for files ... 20:19:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:19:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:37 INFO - (blobuploader) - INFO - Done attempting. 20:19:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:19:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:19:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:38 INFO - (blobuploader) - INFO - Done attempting. 20:19:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:38 INFO - Return code: 0 20:19:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:19:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c115038836013c067b717f85636e10d53a667375e9ca372245f795e45ecac63fce784c9a03f7beb8d2f92b44718a595bd1eb5d452d607592fe28128507f8c812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba4978639155cb3ebb00cd465c3da2b6356f22903974f13359610ed67c2c8e3ebde328cfab294cf0a5d3a083ecd8304974e3886972ada9428673241c8fc12919"} 20:19:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:19:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:19:38 INFO - Contents: 20:19:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c115038836013c067b717f85636e10d53a667375e9ca372245f795e45ecac63fce784c9a03f7beb8d2f92b44718a595bd1eb5d452d607592fe28128507f8c812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba4978639155cb3ebb00cd465c3da2b6356f22903974f13359610ed67c2c8e3ebde328cfab294cf0a5d3a083ecd8304974e3886972ada9428673241c8fc12919"} 20:19:38 INFO - Copying logs to upload dir... 20:19:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.512527 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 20:19:38.070188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 20:19:38.073824) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c115038836013c067b717f85636e10d53a667375e9ca372245f795e45ecac63fce784c9a03f7beb8d2f92b44718a595bd1eb5d452d607592fe28128507f8c812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba4978639155cb3ebb00cd465c3da2b6356f22903974f13359610ed67c2c8e3ebde328cfab294cf0a5d3a083ecd8304974e3886972ada9428673241c8fc12919"} build_url:https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/7baXyc9xSnG_pwLNqXq5iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c115038836013c067b717f85636e10d53a667375e9ca372245f795e45ecac63fce784c9a03f7beb8d2f92b44718a595bd1eb5d452d607592fe28128507f8c812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba4978639155cb3ebb00cd465c3da2b6356f22903974f13359610ed67c2c8e3ebde328cfab294cf0a5d3a083ecd8304974e3886972ada9428673241c8fc12919"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 20:19:38.101104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 20:19:38.101459) ========= 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=01deea79d00cc2c334834894000001d2-1450756599.157058-2055072682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 20:19:38.251549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 20:19:38.251869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 20:19:38.252149) ========= ========= Total master_lag: 0.30 =========